could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementNotInteractableError@chrome://marionette/content/error.js:315:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:183:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
06:14:37 INFO - 1500297277382 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}]
06:14:37 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1500297277390 Marionette TRACE 352 <- [1,5,null,{"value":null}]
06:14:37 INFO - 1500297277392 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
06:14:37 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:37 INFO - 1500297277396 Marionette TRACE 352 <- [1,6,null,{}]
06:14:37 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 656ms
06:14:37 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
06:14:37 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:37 INFO - 1500297277418 Marionette DEBUG Closed connection 352
06:14:37 INFO - 1500297277420 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49795
06:14:37 INFO - 1500297277422 Marionette DEBUG Closed connection 353
06:14:37 INFO - 1500297277423 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49796
06:14:37 INFO - 1500297277425 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:14:37 INFO - 1500297277428 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}
06:14:37 INFO - 1500297277449 Marionette DEBUG Register listener.js for window 15
06:14:37 INFO - 1500297277461 Marionette TRACE 354 <- [1,1,null,{"sessionId":"fe1f72a1-3ca0-42f5-a15a-5d890d2e7697","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}}]
06:14:37 INFO - 1500297277473 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
06:14:37 INFO - 1500297277475 Marionette TRACE 354 <- [1,2,null,{}]
06:14:37 INFO - 1500297277477 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
06:14:37 INFO - 1500297277479 Marionette TRACE 354 <- [1,3,null,{}]
06:14:37 INFO - 1500297277481 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
06:14:37 INFO - 1500297277483 Marionette TRACE 354 <- [1,4,null,{}]
06:14:37 INFO - 1500297277485 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}]
06:14:37 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1500297277494 Marionette TRACE 354 <- [1,5,null,{"value":null}]
06:14:37 INFO - 1500297277495 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
06:14:37 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:37 INFO - 1500297277500 Marionette TRACE 354 <- [1,6,null,{}]
06:14:37 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:37 INFO - 1500297277524 Marionette DEBUG Closed connection 354
06:14:37 INFO - 1500297277526 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49797
06:14:37 INFO - 1500297277529 Marionette DEBUG Closed connection 355
06:14:37 INFO - 1500297277531 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49798
06:14:38 INFO - 1500297278118 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:14:38 INFO - 1500297278130 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}
06:14:38 INFO - 1500297278154 Marionette DEBUG Register listener.js for window 15
06:14:38 INFO - 1500297278169 Marionette TRACE 356 <- [1,1,null,{"sessionId":"ff3a8a65-3f87-47e6-a3c6-96d98adc844d","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}}]
06:14:38 INFO - 1500297278213 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
06:14:38 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:38 INFO - 1500297278217 Marionette TRACE 356 <- [1,2,null,{}]
06:14:38 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:38 INFO - 1500297278258 Marionette DEBUG Closed connection 356
06:14:38 INFO - 1500297278259 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49799
06:14:38 INFO - 1500297278290 Marionette DEBUG Closed connection 357
06:14:38 INFO - 1500297278291 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49800
06:14:38 INFO - 1500297278294 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
06:14:38 INFO - 1500297278296 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}
06:14:38 INFO - 1500297278317 Marionette DEBUG Register listener.js for window 15
06:14:38 INFO - 1500297278328 Marionette TRACE 358 <- [1,1,null,{"sessionId":"8332113a-4f2f-419b-a956-c2a8c713f2c8","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}}]
06:14:38 INFO - 1500297278334 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49332/clicks.html"}]
06:14:38 INFO - 1500297278338 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49332/hidden.html"
06:14:38 INFO - 1500297278351 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49332/hidden.html"
06:14:38 INFO - 1500297278352 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49332/hidden.html"
06:14:38 INFO - ++DOMWINDOW == 21 (000000E787670800) [pid = 3708] [serial = 40] [outer = 000000E78FB13000]
06:14:38 INFO - 1500297278425 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49332/clicks.html"
06:14:38 INFO - 1500297278430 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49332/clicks.html"
06:14:38 INFO - 1500297278451 Marionette TRACE 358 <- [1,2,null,{}]
06:14:38 INFO - 1500297278460 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
06:14:38 INFO - 1500297278471 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"826ae9f6-17b9-42c6-a520-5748740386c4","ELEMENT":"826ae9f6-17b9-42c6-a520-5748740386c4"}}]
06:14:38 INFO - 1500297278473 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"826ae9f6-17b9-42c6-a520-5748740386c4"}]
06:14:38 INFO - 1500297278705 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49332/clicks.html"
06:14:38 INFO - [Parent 3708] WARNING: Cannot switch to prerendered document in the parent process: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/xpfe/appshell/nsContentTreeOwner.cpp, line 446
06:14:38 INFO - 1500297278750 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49332/clicks.html"
06:14:38 INFO - 1500297278753 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49332/clicks.html"
06:14:38 INFO - ++DOMWINDOW == 22 (000000E78F622800) [pid = 3708] [serial = 41] [outer = 000000E78FB13000]
06:14:38 INFO - 1500297278823 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49332/test.html"
06:14:38 INFO - 1500297278830 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49332/test.html"
06:14:38 INFO - 1500297278847 Marionette TRACE 358 <- [1,4,null,{}]
06:14:38 INFO - 1500297278853 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
06:14:38 INFO - 1500297278860 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"3d850486-58df-4321-b652-fb472e4769f0","ELEMENT":"3d850486-58df-4321-b652-fb472e4769f0"}}]
06:14:38 INFO - 1500297278862 Marionette TRACE 358 -> [0,6,"getTitle",{}]
06:14:38 INFO - 1500297278864 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
06:14:38 INFO - 1500297278868 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}]
06:14:38 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1500297278876 Marionette TRACE 358 <- [1,7,null,{"value":null}]
06:14:38 INFO - 1500297278878 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
06:14:38 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:38 INFO - 1500297278882 Marionette TRACE 358 <- [1,8,null,{}]
06:14:38 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 1485ms
06:14:38 INFO - TEST-START | test_click.py TestClick.test_container_element
06:14:38 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:38 INFO - 1500297278888 Marionette DEBUG Closed connection 358
06:14:38 INFO - 1500297278890 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49803
06:14:38 INFO - 1500297278892 Marionette DEBUG Closed connection 359
06:14:38 INFO - 1500297278893 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49804
06:14:38 INFO - 1500297278896 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:14:38 INFO - 1500297278898 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}
06:14:38 INFO - 1500297278918 Marionette DEBUG Register listener.js for window 15
06:14:38 INFO - 1500297278930 Marionette TRACE 360 <- [1,1,null,{"sessionId":"81b96f75-800b-43f4-823e-a00b942f287e","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}}]
06:14:38 INFO - 1500297278958 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
06:14:38 INFO - 1500297278959 Marionette TRACE 360 <- [1,2,null,{}]
06:14:38 INFO - 1500297278962 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
06:14:38 INFO - 1500297278963 Marionette TRACE 360 <- [1,3,null,{}]
06:14:38 INFO - 1500297278965 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
06:14:38 INFO - 1500297278967 Marionette TRACE 360 <- [1,4,null,{}]
06:14:38 INFO - 1500297278970 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}]
06:14:38 INFO - TEST-START: test_click.py TestClick.test_container_element1500297278981 Marionette TRACE 360 <- [1,5,null,{"value":null}]
06:14:38 INFO - 1500297278983 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
06:14:38 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:38 INFO - 1500297278987 Marionette TRACE 360 <- [1,6,null,{}]
06:14:39 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:39 INFO - 1500297279011 Marionette DEBUG Closed connection 360
06:14:39 INFO - 1500297279013 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49805
06:14:39 INFO - 1500297279017 Marionette DEBUG Closed connection 361
06:14:39 INFO - 1500297279018 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49806
06:14:39 INFO - 1500297279072 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:14:39 INFO - 1500297279085 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}
06:14:39 INFO - 1500297279133 Marionette DEBUG Register listener.js for window 15
06:14:39 INFO - 1500297279157 Marionette TRACE 362 <- [1,1,null,{"sessionId":"7bc95628-58a7-4971-8d08-8d597d7ddc2b","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}}]
06:14:39 INFO - 1500297279176 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
06:14:39 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:39 INFO - 1500297279183 Marionette TRACE 362 <- [1,2,null,{}]
06:14:39 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:39 INFO - 1500297279243 Marionette DEBUG Closed connection 362
06:14:39 INFO - 1500297279246 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49807
06:14:39 INFO - 1500297279266 Marionette DEBUG Closed connection 363
06:14:39 INFO - 1500297279269 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49808
06:14:39 INFO - 1500297279276 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
06:14:39 INFO - 1500297279282 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}
06:14:39 INFO - 1500297279330 Marionette DEBUG Register listener.js for window 15
06:14:39 INFO - 1500297279370 Marionette TRACE 364 <- [1,1,null,{"sessionId":"d3a86862-d95d-42c4-a805-048a240c6259","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}}]
06:14:39 INFO - 1500297279401 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"}]
06:14:39 INFO - 1500297279410 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49332/test.html"
06:14:39 INFO - 1500297279422 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49332/test.html"
06:14:39 INFO - 1500297279423 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49332/test.html"
06:14:39 INFO - ++DOMWINDOW == 23 (000000E783412000) [pid = 3708] [serial = 42] [outer = 000000E78FB13000]
06:14:39 INFO - 1500297279494 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"
06:14:39 INFO - 1500297279503 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"
06:14:39 INFO - 1500297279537 Marionette TRACE 364 <- [1,2,null,{}]
06:14:39 INFO - 1500297279543 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
06:14:39 INFO - 1500297279556 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"4a141003-610c-4100-8fc6-e7936417f00e","ELEMENT":"4a141003-610c-4100-8fc6-e7936417f00e"}}]
06:14:39 INFO - 1500297279560 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"4a141003-610c-4100-8fc6-e7936417f00e"}]
06:14:39 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
06:14:39 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
06:14:39 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
06:14:40 INFO - 1500297280202 Marionette DEBUG Canceled page load listener because no navigation has been detected
06:14:40 INFO - 1500297280205 Marionette TRACE 364 <- [1,4,null,{}]
06:14:40 INFO - 1500297280212 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"4a141003-610c-4100-8fc6-e7936417f00e","name":"selected"}]
06:14:40 INFO - 1500297280275 Marionette TRACE 364 <- [1,5,null,{"value":true}]
06:14:40 INFO - 1500297280278 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}]
06:14:40 INFO - TEST-END: test_click.py TestClick.test_container_element1500297280290 Marionette TRACE 364 <- [1,6,null,{"value":null}]
06:14:40 INFO - 1500297280294 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
06:14:40 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:40 INFO - 1500297280300 Marionette TRACE 364 <- [1,7,null,{}]
06:14:40 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 1418ms
06:14:40 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
06:14:40 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:40 INFO - 1500297280309 Marionette DEBUG Closed connection 364
06:14:40 INFO - 1500297280312 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49809
06:14:40 INFO - 1500297280340 Marionette DEBUG Closed connection 365
06:14:40 INFO - 1500297280342 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49810
06:14:40 INFO - 1500297280374 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:14:40 INFO - 1500297280378 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}
06:14:40 INFO - 1500297280426 Marionette DEBUG Register listener.js for window 15
06:14:40 INFO - 1500297280468 Marionette TRACE 366 <- [1,1,null,{"sessionId":"ecfe7067-0231-4a0e-a2c1-0e462b624145","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}}]
06:14:40 INFO - 1500297280490 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
06:14:40 INFO - 1500297280496 Marionette TRACE 366 <- [1,2,null,{}]
06:14:40 INFO - 1500297280512 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
06:14:40 INFO - 1500297280515 Marionette TRACE 366 <- [1,3,null,{}]
06:14:40 INFO - 1500297280518 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
06:14:40 INFO - 1500297280520 Marionette TRACE 366 <- [1,4,null,{}]
06:14:40 INFO - 1500297280523 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}]
06:14:40 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1500297280534 Marionette TRACE 366 <- [1,5,null,{"value":null}]
06:14:40 INFO - 1500297280574 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
06:14:40 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:40 INFO - 1500297280580 Marionette TRACE 366 <- [1,6,null,{}]
06:14:40 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:40 INFO - 1500297280606 Marionette DEBUG Closed connection 366
06:14:40 INFO - 1500297280608 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49811
06:14:40 INFO - 1500297280620 Marionette DEBUG Closed connection 367
06:14:40 INFO - 1500297280622 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49812
06:14:40 INFO - 1500297280628 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:14:40 INFO - 1500297280631 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}
06:14:40 INFO - 1500297280679 Marionette DEBUG Register listener.js for window 15
06:14:40 INFO - 1500297280696 Marionette TRACE 368 <- [1,1,null,{"sessionId":"153730c5-d29c-4e8e-ab3a-4876bd63a6b1","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}}]
06:14:40 INFO - 1500297280708 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
06:14:40 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:40 INFO - 1500297280713 Marionette TRACE 368 <- [1,2,null,{}]
06:14:40 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:40 INFO - 1500297280894 Marionette DEBUG Closed connection 368
06:14:40 INFO - 1500297280897 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49813
06:14:40 INFO - 1500297280919 Marionette DEBUG Closed connection 369
06:14:40 INFO - 1500297280922 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49814
06:14:40 INFO - 1500297280927 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
06:14:40 INFO - 1500297280939 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}
06:14:40 INFO - 1500297280964 Marionette DEBUG Register listener.js for window 15
06:14:40 INFO - 1500297280986 Marionette TRACE 370 <- [1,1,null,{"sessionId":"b0c6f3dd-1a29-4da4-a996-6f8affa7abf9","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}}]
06:14:41 INFO - 1500297281025 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"}]
06:14:41 INFO - 1500297281032 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"
06:14:41 INFO - 1500297281043 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"
06:14:41 INFO - 1500297281045 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"
06:14:41 INFO - ++DOMWINDOW == 24 (000000E783420800) [pid = 3708] [serial = 43] [outer = 000000E78FB13000]
06:14:41 INFO - 1500297281106 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"
06:14:41 INFO - 1500297281113 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"
06:14:41 INFO - 1500297281136 Marionette TRACE 370 <- [1,2,null,{}]
06:14:41 INFO - 1500297281141 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
06:14:41 INFO - 1500297281153 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"807bf088-1f26-4bf9-8311-9b751c980a25","ELEMENT":"807bf088-1f26-4bf9-8311-9b751c980a25"}}]
06:14:41 INFO - 1500297281157 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"807bf088-1f26-4bf9-8311-9b751c980a25"}]
06:14:41 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
06:14:41 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
06:14:41 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
06:14:41 INFO - 1500297281620 Marionette DEBUG Canceled page load listener because no navigation has been detected
06:14:41 INFO - 1500297281623 Marionette TRACE 370 <- [1,4,null,{}]
06:14:41 INFO - 1500297281628 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"807bf088-1f26-4bf9-8311-9b751c980a25","name":"selected"}]
06:14:41 INFO - 1500297281662 Marionette TRACE 370 <- [1,5,null,{"value":true}]
06:14:41 INFO - 1500297281667 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}]
06:14:41 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1500297281680 Marionette TRACE 370 <- [1,6,null,{"value":null}]
06:14:41 INFO - 1500297281689 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
06:14:41 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:41 INFO - 1500297281695 Marionette TRACE 370 <- [1,7,null,{}]
06:14:41 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 1393ms
06:14:41 INFO - TEST-START | test_click.py TestClick.test_css_transforms
06:14:41 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:41 INFO - 1500297281704 Marionette DEBUG Closed connection 370
06:14:41 INFO - 1500297281708 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49815
06:14:41 INFO - --DOMWINDOW == 23 (000000E78351E800) [pid = 3708] [serial = 31] [outer = 0000000000000000] [url = http://127.0.0.1:49332/test_accessibility.html]
06:14:41 INFO - --DOMWINDOW == 22 (000000E7F475D800) [pid = 3708] [serial = 30] [outer = 0000000000000000] [url = http://127.0.0.1:49332/test_accessibility.html]
06:14:41 INFO - --DOMWINDOW == 21 (000000E798811800) [pid = 3708] [serial = 29] [outer = 0000000000000000] [url = http://127.0.0.1:49332/test_accessibility.html]
06:14:41 INFO - --DOMWINDOW == 20 (000000E789323000) [pid = 3708] [serial = 32] [outer = 0000000000000000] [url = data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20position%3A%20absolute%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20/%2A%20move%20centre%20point%20off%20viewport%20%2A/%0A%20%20%20%20%20%20%20%20%20%20%20%20%20left%3A%20-105px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20top%3A%20-105px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E]
06:14:41 INFO - 1500297281735 Marionette DEBUG Closed connection 371
06:14:41 INFO - 1500297281738 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49816
06:14:41 INFO - 1500297281745 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:14:41 INFO - 1500297281749 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}
06:14:41 INFO - 1500297281772 Marionette DEBUG Register listener.js for window 15
06:14:41 INFO - 1500297281794 Marionette TRACE 372 <- [1,1,null,{"sessionId":"5e0a3a90-b753-43f7-9e7f-75e20dd617fe","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}}]
06:14:41 INFO - 1500297281803 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
06:14:41 INFO - 1500297281805 Marionette TRACE 372 <- [1,2,null,{}]
06:14:41 INFO - 1500297281807 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
06:14:41 INFO - 1500297281810 Marionette TRACE 372 <- [1,3,null,{}]
06:14:41 INFO - 1500297281817 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
06:14:41 INFO - 1500297281822 Marionette TRACE 372 <- [1,4,null,{}]
06:14:41 INFO - 1500297281825 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}]
06:14:41 INFO - TEST-START: test_click.py TestClick.test_css_transforms1500297281835 Marionette TRACE 372 <- [1,5,null,{"value":null}]
06:14:41 INFO - 1500297281844 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
06:14:41 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:41 INFO - 1500297281850 Marionette TRACE 372 <- [1,6,null,{}]
06:14:41 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:41 INFO - 1500297281859 Marionette DEBUG Closed connection 372
06:14:41 INFO - 1500297281862 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49817
06:14:41 INFO - 1500297281882 Marionette DEBUG Closed connection 373
06:14:41 INFO - 1500297281884 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49818
06:14:42 INFO - 1500297281996 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:14:42 INFO - 1500297281999 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}
06:14:42 INFO - 1500297282021 Marionette DEBUG Register listener.js for window 15
06:14:42 INFO - 1500297282038 Marionette TRACE 374 <- [1,1,null,{"sessionId":"d26e5627-d949-444c-bf17-8b18e420f798","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}}]
06:14:42 INFO - 1500297282067 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
06:14:42 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:42 INFO - 1500297282071 Marionette TRACE 374 <- [1,2,null,{}]
06:14:42 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:42 INFO - 1500297282097 Marionette DEBUG Closed connection 374
06:14:42 INFO - 1500297282099 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49819
06:14:42 INFO - 1500297282103 Marionette DEBUG Closed connection 375
06:14:42 INFO - 1500297282105 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49820
06:14:42 INFO - 1500297282110 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
06:14:42 INFO - 1500297282113 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}
06:14:42 INFO - 1500297282137 Marionette DEBUG Register listener.js for window 15
06:14:42 INFO - 1500297282151 Marionette TRACE 376 <- [1,1,null,{"sessionId":"816445ed-fbcc-40e9-94ea-1e61aab7a73f","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}}]
06:14:42 INFO - 1500297282160 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"}]
06:14:42 INFO - 1500297282166 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"
06:14:42 INFO - 1500297282174 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"
06:14:42 INFO - 1500297282175 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"
06:14:42 INFO - ++DOMWINDOW == 21 (000000E783513000) [pid = 3708] [serial = 44] [outer = 000000E78FB13000]
06:14:42 INFO - 1500297282239 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"
06:14:42 INFO - 1500297282245 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"
06:14:42 INFO - 1500297282266 Marionette TRACE 376 <- [1,2,null,{}]
06:14:42 INFO - 1500297282275 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
06:14:42 INFO - 1500297282284 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"2a308c71-a3b9-4bfd-92d0-347148126419","ELEMENT":"2a308c71-a3b9-4bfd-92d0-347148126419"}}]
06:14:42 INFO - 1500297282286 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"2a308c71-a3b9-4bfd-92d0-347148126419"}]
06:14:43 INFO - 1500297283227 Marionette DEBUG Canceled page load listener because no navigation has been detected
06:14:43 INFO - 1500297283248 Marionette TRACE 376 <- [1,4,null,{}]
06:14:43 INFO - 1500297283254 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}]
06:14:43 INFO - TEST-END: test_click.py TestClick.test_css_transforms1500297283262 Marionette TRACE 376 <- [1,5,null,{"value":null}]
06:14:43 INFO - 1500297283301 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
06:14:43 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:43 INFO - 1500297283306 Marionette TRACE 376 <- [1,6,null,{}]
06:14:43 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 1611ms
06:14:43 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
06:14:43 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:43 INFO - 1500297283366 Marionette DEBUG Closed connection 376
06:14:43 INFO - 1500297283368 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49821
06:14:43 INFO - 1500297283420 Marionette DEBUG Closed connection 377
06:14:43 INFO - 1500297283422 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49822
06:14:43 INFO - 1500297283475 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:14:43 INFO - 1500297283480 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}
06:14:43 INFO - 1500297283502 Marionette DEBUG Register listener.js for window 15
06:14:43 INFO - 1500297283520 Marionette TRACE 378 <- [1,1,null,{"sessionId":"181e4fa2-9bc4-4d91-8479-608bcee45a51","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}}]
06:14:43 INFO - 1500297283547 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
06:14:43 INFO - 1500297283549 Marionette TRACE 378 <- [1,2,null,{}]
06:14:43 INFO - 1500297283551 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
06:14:43 INFO - 1500297283552 Marionette TRACE 378 <- [1,3,null,{}]
06:14:43 INFO - 1500297283554 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
06:14:43 INFO - 1500297283556 Marionette TRACE 378 <- [1,4,null,{}]
06:14:43 INFO - 1500297283558 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}]
06:14:43 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1500297283571 Marionette TRACE 378 <- [1,5,null,{"value":null}]
06:14:43 INFO - 1500297283573 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
06:14:43 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:43 INFO - 1500297283577 Marionette TRACE 378 <- [1,6,null,{}]
06:14:43 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:43 INFO - 1500297283586 Marionette DEBUG Closed connection 378
06:14:43 INFO - 1500297283591 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49823
06:14:43 INFO - 1500297283593 Marionette DEBUG Closed connection 379
06:14:43 INFO - 1500297283595 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49824
06:14:43 INFO - 1500297283597 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:14:43 INFO - 1500297283600 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}
06:14:43 INFO - 1500297283622 Marionette DEBUG Register listener.js for window 15
06:14:43 INFO - 1500297283671 Marionette TRACE 380 <- [1,1,null,{"sessionId":"8871bc5c-1b08-4b08-9d36-fa28383bcedf","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}}]
06:14:43 INFO - 1500297283680 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
06:14:43 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:43 INFO - 1500297283685 Marionette TRACE 380 <- [1,2,null,{}]
06:14:43 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:43 INFO - 1500297283709 Marionette DEBUG Closed connection 380
06:14:43 INFO - 1500297283711 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49825
06:14:43 INFO - 1500297283715 Marionette DEBUG Closed connection 381
06:14:43 INFO - 1500297283716 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49826
06:14:43 INFO - 1500297283719 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
06:14:43 INFO - 1500297283722 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}
06:14:43 INFO - 1500297283745 Marionette DEBUG Register listener.js for window 15
06:14:43 INFO - 1500297283757 Marionette TRACE 382 <- [1,1,null,{"sessionId":"3e6c8c85-57f5-48ef-9a4e-276e5a4bd9ac","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}}]
06:14:43 INFO - 1500297283767 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"}]
06:14:43 INFO - 1500297283772 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"
06:14:43 INFO - 1500297283780 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"
06:14:43 INFO - 1500297283781 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"
06:14:43 INFO - ++DOMWINDOW == 22 (000000E78AD76000) [pid = 3708] [serial = 45] [outer = 000000E78FB13000]
06:14:43 INFO - 1500297283838 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"
06:14:43 INFO - 1500297283844 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"
06:14:43 INFO - 1500297283862 Marionette TRACE 382 <- [1,2,null,{}]
06:14:43 INFO - 1500297283869 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
06:14:43 INFO - 1500297283878 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"03d70918-8b7a-4861-93eb-ab6fa0ca14e0","ELEMENT":"03d70918-8b7a-4861-93eb-ab6fa0ca14e0"}}]
06:14:43 INFO - 1500297283880 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"03d70918-8b7a-4861-93eb-ab6fa0ca14e0"}]
06:14:44 INFO - 1500297284344 Marionette DEBUG Canceled page load listener because no navigation has been detected
06:14:44 INFO - 1500297284346 Marionette TRACE 382 <- [1,4,null,{}]
06:14:44 INFO - 1500297284349 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}]
06:14:44 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1500297284357 Marionette TRACE 382 <- [1,5,null,{"value":null}]
06:14:44 INFO - 1500297284359 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
06:14:44 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:44 INFO - 1500297284363 Marionette TRACE 382 <- [1,6,null,{}]
06:14:44 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 1055ms
06:14:44 INFO - TEST-START | test_click.py TestClick.test_input_file
06:14:44 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:44 INFO - 1500297284369 Marionette DEBUG Closed connection 382
06:14:44 INFO - 1500297284370 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49827
06:14:44 INFO - 1500297284372 Marionette DEBUG Closed connection 383
06:14:44 INFO - 1500297284374 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49828
06:14:44 INFO - 1500297284376 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:14:44 INFO - 1500297284380 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}
06:14:44 INFO - 1500297284402 Marionette DEBUG Register listener.js for window 15
06:14:44 INFO - 1500297284414 Marionette TRACE 384 <- [1,1,null,{"sessionId":"f75140e5-17fe-419d-95b6-001ec11494e3","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}}]
06:14:44 INFO - 1500297284446 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
06:14:44 INFO - 1500297284448 Marionette TRACE 384 <- [1,2,null,{}]
06:14:44 INFO - 1500297284450 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
06:14:44 INFO - 1500297284452 Marionette TRACE 384 <- [1,3,null,{}]
06:14:44 INFO - 1500297284454 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
06:14:44 INFO - 1500297284455 Marionette TRACE 384 <- [1,4,null,{}]
06:14:44 INFO - 1500297284458 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}]
06:14:44 INFO - TEST-START: test_click.py TestClick.test_input_file1500297284468 Marionette TRACE 384 <- [1,5,null,{"value":null}]
06:14:44 INFO - 1500297284470 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
06:14:44 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:44 INFO - 1500297284474 Marionette TRACE 384 <- [1,6,null,{}]
06:14:44 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:44 INFO - 1500297284480 Marionette DEBUG Closed connection 384
06:14:44 INFO - 1500297284482 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49829
06:14:44 INFO - 1500297284483 Marionette DEBUG Closed connection 385
06:14:44 INFO - 1500297284485 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49830
06:14:44 INFO - 1500297284487 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:14:44 INFO - 1500297284489 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}
06:14:44 INFO - 1500297284512 Marionette DEBUG Register listener.js for window 15
06:14:44 INFO - 1500297284523 Marionette TRACE 386 <- [1,1,null,{"sessionId":"d36e7a08-109e-4ebd-89a8-9f6c924ddd5d","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}}]
06:14:44 INFO - 1500297284553 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
06:14:44 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:44 INFO - 1500297284557 Marionette TRACE 386 <- [1,2,null,{}]
06:14:44 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:44 INFO - 1500297284578 Marionette DEBUG Closed connection 386
06:14:44 INFO - 1500297284580 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49831
06:14:44 INFO - 1500297284584 Marionette DEBUG Closed connection 387
06:14:44 INFO - 1500297284585 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49832
06:14:44 INFO - 1500297284588 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
06:14:44 INFO - 1500297284591 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}
06:14:44 INFO - 1500297284613 Marionette DEBUG Register listener.js for window 15
06:14:44 INFO - 1500297284625 Marionette TRACE 388 <- [1,1,null,{"sessionId":"0a04bd47-6d49-42f9-8393-ea44edb58990","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}}]
06:14:44 INFO - 1500297284635 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
06:14:44 INFO - 1500297284640 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"
06:14:44 INFO - 1500297284649 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"
06:14:44 INFO - 1500297284651 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"
06:14:44 INFO - ++DOMWINDOW == 23 (000000E78B9C0000) [pid = 3708] [serial = 46] [outer = 000000E78FB13000]
06:14:44 INFO - 1500297284710 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
06:14:44 INFO - 1500297284716 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
06:14:44 INFO - 1500297284734 Marionette TRACE 388 <- [1,2,null,{}]
06:14:44 INFO - 1500297284740 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
06:14:44 INFO - 1500297284750 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"4098cf54-fd52-4aae-b7fe-a092954ff6cc","ELEMENT":"4098cf54-fd52-4aae-b7fe-a092954ff6cc"}}]
06:14:44 INFO - 1500297284752 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"4098cf54-fd52-4aae-b7fe-a092954ff6cc"}]
06:14:44 INFO - 1500297284941 Marionette TRACE 388 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
06:14:44 INFO - 1500297284947 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}]
06:14:44 INFO - TEST-END: test_click.py TestClick.test_input_file1500297284956 Marionette TRACE 388 <- [1,5,null,{"value":null}]
06:14:44 INFO - 1500297284957 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
06:14:44 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:44 INFO - 1500297284962 Marionette TRACE 388 <- [1,6,null,{}]
06:14:44 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 599ms
06:14:44 INFO - TEST-START | test_click.py TestClick.test_obscured_element
06:14:44 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:44 INFO - 1500297284968 Marionette DEBUG Closed connection 388
06:14:44 INFO - 1500297284970 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49833
06:14:44 INFO - 1500297284971 Marionette DEBUG Closed connection 389
06:14:44 INFO - 1500297284973 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49834
06:14:44 INFO - 1500297284995 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:14:45 INFO - 1500297284998 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}
06:14:45 INFO - 1500297285025 Marionette DEBUG Register listener.js for window 15
06:14:45 INFO - 1500297285039 Marionette TRACE 390 <- [1,1,null,{"sessionId":"17077632-c4a1-483f-9ce5-a92452f22629","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}}]
06:14:45 INFO - 1500297285049 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
06:14:45 INFO - 1500297285051 Marionette TRACE 390 <- [1,2,null,{}]
06:14:45 INFO - 1500297285053 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
06:14:45 INFO - 1500297285056 Marionette TRACE 390 <- [1,3,null,{}]
06:14:45 INFO - 1500297285058 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
06:14:45 INFO - 1500297285059 Marionette TRACE 390 <- [1,4,null,{}]
06:14:45 INFO - 1500297285062 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}]
06:14:45 INFO - TEST-START: test_click.py TestClick.test_obscured_element1500297285070 Marionette TRACE 390 <- [1,5,null,{"value":null}]
06:14:45 INFO - 1500297285072 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
06:14:45 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:45 INFO - 1500297285076 Marionette TRACE 390 <- [1,6,null,{}]
06:14:45 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:45 INFO - 1500297285100 Marionette DEBUG Closed connection 390
06:14:45 INFO - 1500297285101 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49835
06:14:45 INFO - 1500297285105 Marionette DEBUG Closed connection 391
06:14:45 INFO - 1500297285106 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49836
06:14:45 INFO - 1500297285109 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:14:45 INFO - 1500297285111 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}
06:14:45 INFO - 1500297285133 Marionette DEBUG Register listener.js for window 15
06:14:45 INFO - 1500297285144 Marionette TRACE 392 <- [1,1,null,{"sessionId":"3cc6cea1-084e-4d1e-89ee-e5b872e77754","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}}]
06:14:45 INFO - 1500297285155 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
06:14:45 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:45 INFO - 1500297285160 Marionette TRACE 392 <- [1,2,null,{}]
06:14:45 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:45 INFO - 1500297285181 Marionette DEBUG Closed connection 392
06:14:45 INFO - 1500297285182 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49837
06:14:45 INFO - 1500297285186 Marionette DEBUG Closed connection 393
06:14:45 INFO - 1500297285188 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49838
06:14:45 INFO - 1500297285190 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
06:14:45 INFO - 1500297285193 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}
06:14:45 INFO - 1500297285215 Marionette DEBUG Register listener.js for window 15
06:14:45 INFO - 1500297285226 Marionette TRACE 394 <- [1,1,null,{"sessionId":"cf5d55e6-3a2f-4059-8f28-c123400f4bf4","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}}]
06:14:45 INFO - 1500297285236 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"}]
06:14:45 INFO - 1500297285240 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
06:14:45 INFO - 1500297285247 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
06:14:45 INFO - 1500297285247 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
06:14:45 INFO - ++DOMWINDOW == 24 (000000E78D099000) [pid = 3708] [serial = 47] [outer = 000000E78FB13000]
06:14:45 INFO - 1500297285304 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"
06:14:45 INFO - 1500297285310 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"
06:14:45 INFO - 1500297285326 Marionette TRACE 394 <- [1,2,null,{}]
06:14:45 INFO - 1500297285333 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
06:14:45 INFO - 1500297285340 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"9f9a9456-a07e-44a7-aae6-5b2d4e1034f9","ELEMENT":"9f9a9456-a07e-44a7-aae6-5b2d4e1034f9"}}]
06:14:45 INFO - 1500297285342 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
06:14:45 INFO - 1500297285350 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"4faba314-6740-4396-b19d-e78e3ba795d5","ELEMENT":"4faba314-6740-4396-b19d-e78e3ba795d5"}}]
06:14:45 INFO - 1500297285352 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"9f9a9456-a07e-44a7-aae6-5b2d4e1034f9"}]
06:14:46 INFO - 1500297286301 Marionette DEBUG Canceled page load listener because no navigation has been detected
06:14:46 INFO - 1500297286315 Marionette TRACE 394 <- [1,5,null,{}]
06:14:46 INFO - 1500297286333 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"4faba314-6740-4396-b19d-e78e3ba795d5"}]
06:14:46 INFO - 1500297286468 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:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
06:14:46 INFO - 1500297286495 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
06:14:46 INFO - 1500297286504 Marionette TRACE 394 <- [1,7,null,{"value":false}]
06:14:46 INFO - 1500297286506 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}]
06:14:46 INFO - TEST-END: test_click.py TestClick.test_obscured_element1500297286513 Marionette TRACE 394 <- [1,8,null,{"value":null}]
06:14:46 INFO - 1500297286518 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
06:14:46 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:46 INFO - 1500297286523 Marionette TRACE 394 <- [1,9,null,{}]
06:14:46 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 1560ms
06:14:46 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
06:14:46 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:46 INFO - 1500297286529 Marionette DEBUG Closed connection 394
06:14:46 INFO - 1500297286531 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49839
06:14:46 INFO - 1500297286532 Marionette DEBUG Closed connection 395
06:14:46 INFO - 1500297286533 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49840
06:14:46 INFO - 1500297286536 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:14:46 INFO - 1500297286538 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}
06:14:46 INFO - 1500297286560 Marionette DEBUG Register listener.js for window 15
06:14:46 INFO - 1500297286571 Marionette TRACE 396 <- [1,1,null,{"sessionId":"cde8516a-2ae4-4083-bc07-5abd6ec1ef6e","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}}]
06:14:46 INFO - 1500297286600 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
06:14:46 INFO - 1500297286602 Marionette TRACE 396 <- [1,2,null,{}]
06:14:46 INFO - 1500297286604 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
06:14:46 INFO - 1500297286606 Marionette TRACE 396 <- [1,3,null,{}]
06:14:46 INFO - 1500297286659 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
06:14:46 INFO - 1500297286664 Marionette TRACE 396 <- [1,4,null,{}]
06:14:46 INFO - 1500297286669 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}]
06:14:46 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1500297286682 Marionette TRACE 396 <- [1,5,null,{"value":null}]
06:14:46 INFO - 1500297286688 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
06:14:46 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:46 INFO - 1500297286699 Marionette TRACE 396 <- [1,6,null,{}]
06:14:46 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:46 INFO - 1500297286746 Marionette DEBUG Closed connection 396
06:14:46 INFO - 1500297286749 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49841
06:14:46 INFO - 1500297286770 Marionette DEBUG Closed connection 397
06:14:46 INFO - 1500297286773 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49842
06:14:46 INFO - 1500297286779 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:14:46 INFO - 1500297286791 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}
06:14:46 INFO - 1500297286841 Marionette DEBUG Register listener.js for window 15
06:14:46 INFO - 1500297286864 Marionette TRACE 398 <- [1,1,null,{"sessionId":"6e20f9b7-7e58-411e-87f1-2d364d295a15","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}}]
06:14:46 INFO - 1500297286888 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
06:14:46 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:46 INFO - 1500297286896 Marionette TRACE 398 <- [1,2,null,{}]
06:14:46 INFO - [Parent 3708] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
06:14:46 INFO - 1500297286924 Marionette DEBUG Closed connection 398
06:14:46 INFO - 1500297286928 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49843
06:14:46 INFO - 1500297286932 Marionette DEBUG Closed connection 399
06:14:46 INFO - 1500297286935 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49844
06:14:46 INFO - 1500297286989 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
06:14:46 INFO - 1500297286994 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}
06:14:47 INFO - 1500297287045 Marionette DEBUG Register listener.js for window 15
06:14:47 INFO - 1500297287063 Marionette TRACE 400 <- [1,1,null,{"sessionId":"b8bcc54b-d21c-45a7-9517-ae0a2e163544","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-096.000\\AppData\\Local\\Temp\\tmpbpx84f.mozrunner","moz:accessibilityChecks":false}}]
06:14:47 INFO - 1500297287077 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"}]
06:14:47 INFO - 1500297287084 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"
06:14:47 INFO - 1500297287095 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"
06:14:47 INFO - 1500297287096 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"
06:14:47 INFO - ++DOMWINDOW == 25 (000000E78351B800) [pid = 3708] [serial = 48] [outer = 000000E78FB13000]
06:14:47 INFO - 1500297287179 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"
06:14:47 INFO - 1500297287187 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"
06:14:47 INFO - 1500297287208 Marionette TRACE 400 <- [1,2,null,{}]
06:14:47 INFO - 1500297287214 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
06:14:47 INFO - 1500297287225 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"6d1c6a8e-24c4-401a-9f62-1209c20dc01a","ELEMENT":"6d1c6a8e-24c4-401a-9f62-1209c20dc01a"}}]
06:14:47 INFO - 1500297287228 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"6d1c6a8e-24c4-401a-9f62-1209c20dc01a"}]
06:14:47 INFO - 1500297287446 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
06:14:47 INFO - 1500297287460 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"6d1c6a8e-24c4-401a-9f62-1209c20dc01a"}]
06:14:47 INFO - 1500297287791 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element