could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementNotInteractableError@chrome://marionette/content/error.js:315:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:183:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
03:46:15 INFO - 1500720375434 Marionette TRACE 353 -> [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}]
03:46:15 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1500720375441 Marionette TRACE 353 <- [1,5,null,{"value":null}]
03:46:15 INFO - 1500720375443 Marionette TRACE 353 -> [0,6,"deleteSession",{}]
03:46:15 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:15 INFO - 1500720375447 Marionette TRACE 353 <- [1,6,null,{}]
03:46:15 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 555ms
03:46:15 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
03:46:15 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:15 INFO - 1500720375453 Marionette DEBUG Closed connection 353
03:46:15 INFO - 1500720375455 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49809
03:46:15 INFO - 1500720375456 Marionette DEBUG Closed connection 354
03:46:15 INFO - 1500720375458 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49810
03:46:15 INFO - 1500720375460 Marionette TRACE 355 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:46:15 INFO - 1500720375462 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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}
03:46:15 INFO - 1500720375484 Marionette DEBUG Register listener.js for window 15
03:46:15 INFO - 1500720375496 Marionette TRACE 355 <- [1,1,null,{"sessionId":"864e12bc-5baf-49cf-8b76-5cee0cd177fb","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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}}]
03:46:15 INFO - 1500720375503 Marionette TRACE 355 -> [0,2,"setTimeouts",{"script":30000}]
03:46:15 INFO - 1500720375505 Marionette TRACE 355 <- [1,2,null,{}]
03:46:15 INFO - 1500720375506 Marionette TRACE 355 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:46:15 INFO - 1500720375508 Marionette TRACE 355 <- [1,3,null,{}]
03:46:15 INFO - 1500720375510 Marionette TRACE 355 -> [0,4,"setTimeouts",{"implicit":0}]
03:46:15 INFO - 1500720375512 Marionette TRACE 355 <- [1,4,null,{}]
03:46:15 INFO - 1500720375515 Marionette TRACE 355 -> [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}]
03:46:15 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1500720375523 Marionette TRACE 355 <- [1,5,null,{"value":null}]
03:46:15 INFO - 1500720375525 Marionette TRACE 355 -> [0,6,"deleteSession",{}]
03:46:15 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:15 INFO - 1500720375530 Marionette TRACE 355 <- [1,6,null,{}]
03:46:15 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:15 INFO - 1500720375536 Marionette DEBUG Closed connection 355
03:46:15 INFO - 1500720375537 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49811
03:46:15 INFO - 1500720375539 Marionette DEBUG Closed connection 356
03:46:15 INFO - 1500720375541 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49812
03:46:15 INFO - 1500720375543 Marionette TRACE 357 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:46:15 INFO - 1500720375546 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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}
03:46:15 INFO - 1500720375572 Marionette DEBUG Register listener.js for window 15
03:46:15 INFO - 1500720375586 Marionette TRACE 357 <- [1,1,null,{"sessionId":"dbc30b9c-550d-41a3-902f-77f1c3f86d8e","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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}}]
03:46:15 INFO - 1500720375593 Marionette TRACE 357 -> [0,2,"deleteSession",{}]
03:46:15 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:15 INFO - 1500720375597 Marionette TRACE 357 <- [1,2,null,{}]
03:46:15 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:15 INFO - 1500720375603 Marionette DEBUG Closed connection 357
03:46:15 INFO - 1500720375604 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49813
03:46:15 INFO - 1500720375606 Marionette DEBUG Closed connection 358
03:46:15 INFO - 1500720375608 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49814
03:46:15 INFO - 1500720375611 Marionette TRACE 359 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:46:15 INFO - 1500720375613 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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}
03:46:15 INFO - 1500720375644 Marionette DEBUG Register listener.js for window 15
03:46:15 INFO - 1500720375656 Marionette TRACE 359 <- [1,1,null,{"sessionId":"5e69e067-8ff4-43c4-bfa4-501e8b0c146c","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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}}]
03:46:15 INFO - 1500720375663 Marionette TRACE 359 -> [0,2,"get",{"url":"http://127.0.0.1:49356/clicks.html"}]
03:46:15 INFO - 1500720375667 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49356/hidden.html"
03:46:15 INFO - 1500720375680 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49356/hidden.html"
03:46:15 INFO - 1500720375681 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49356/hidden.html"
03:46:15 INFO - ++DOMWINDOW == 20 (00000026DDDC1800) [pid = 3568] [serial = 40] [outer = 00000026DF0B6000]
03:46:15 INFO - 1500720375758 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49356/clicks.html"
03:46:15 INFO - 1500720375763 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49356/clicks.html"
03:46:15 INFO - 1500720375783 Marionette TRACE 359 <- [1,2,null,{}]
03:46:15 INFO - 1500720375786 Marionette TRACE 359 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
03:46:15 INFO - 1500720375793 Marionette TRACE 359 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a6e3c793-a365-4cca-a695-402dd135efd7","ELEMENT":"a6e3c793-a365-4cca-a695-402dd135efd7"}}]
03:46:15 INFO - 1500720375795 Marionette TRACE 359 -> [0,4,"clickElement",{"id":"a6e3c793-a365-4cca-a695-402dd135efd7"}]
03:46:16 INFO - 1500720376026 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49356/clicks.html"
03:46:16 INFO - [Parent 3568] 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
03:46:16 INFO - 1500720376047 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49356/clicks.html"
03:46:16 INFO - 1500720376049 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49356/clicks.html"
03:46:16 INFO - ++DOMWINDOW == 21 (00000026E491E800) [pid = 3568] [serial = 41] [outer = 00000026DF0B6000]
03:46:16 INFO - 1500720376125 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49356/test.html"
03:46:16 INFO - 1500720376131 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49356/test.html"
03:46:16 INFO - 1500720376148 Marionette TRACE 359 <- [1,4,null,{}]
03:46:16 INFO - 1500720376152 Marionette TRACE 359 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
03:46:16 INFO - 1500720376158 Marionette TRACE 359 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"9ba8b5ed-4fab-4732-a494-18ea5fcc96f0","ELEMENT":"9ba8b5ed-4fab-4732-a494-18ea5fcc96f0"}}]
03:46:16 INFO - 1500720376160 Marionette TRACE 359 -> [0,6,"getTitle",{}]
03:46:16 INFO - 1500720376162 Marionette TRACE 359 <- [1,6,null,{"value":"Marionette Test"}]
03:46:16 INFO - 1500720376167 Marionette TRACE 359 -> [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}]
03:46:16 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1500720376174 Marionette TRACE 359 <- [1,7,null,{"value":null}]
03:46:16 INFO - 1500720376176 Marionette TRACE 359 -> [0,8,"deleteSession",{}]
03:46:16 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:16 INFO - 1500720376181 Marionette TRACE 359 <- [1,8,null,{}]
03:46:16 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 733ms
03:46:16 INFO - TEST-START | test_click.py TestClick.test_container_element
03:46:16 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:16 INFO - 1500720376187 Marionette DEBUG Closed connection 359
03:46:16 INFO - 1500720376189 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49817
03:46:16 INFO - 1500720376191 Marionette DEBUG Closed connection 360
03:46:16 INFO - 1500720376192 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49818
03:46:16 INFO - 1500720376194 Marionette TRACE 361 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:46:16 INFO - 1500720376196 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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}
03:46:16 INFO - 1500720376218 Marionette DEBUG Register listener.js for window 15
03:46:16 INFO - 1500720376229 Marionette TRACE 361 <- [1,1,null,{"sessionId":"cded5706-2b78-4307-876b-9ba7e19f92af","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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}}]
03:46:16 INFO - 1500720376236 Marionette TRACE 361 -> [0,2,"setTimeouts",{"script":30000}]
03:46:16 INFO - 1500720376237 Marionette TRACE 361 <- [1,2,null,{}]
03:46:16 INFO - 1500720376239 Marionette TRACE 361 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:46:16 INFO - 1500720376240 Marionette TRACE 361 <- [1,3,null,{}]
03:46:16 INFO - 1500720376242 Marionette TRACE 361 -> [0,4,"setTimeouts",{"implicit":0}]
03:46:16 INFO - 1500720376244 Marionette TRACE 361 <- [1,4,null,{}]
03:46:16 INFO - 1500720376246 Marionette TRACE 361 -> [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}]
03:46:16 INFO - TEST-START: test_click.py TestClick.test_container_element1500720376257 Marionette TRACE 361 <- [1,5,null,{"value":null}]
03:46:16 INFO - 1500720376259 Marionette TRACE 361 -> [0,6,"deleteSession",{}]
03:46:16 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:16 INFO - 1500720376263 Marionette TRACE 361 <- [1,6,null,{}]
03:46:16 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:16 INFO - 1500720376269 Marionette DEBUG Closed connection 361
03:46:16 INFO - 1500720376270 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49819
03:46:16 INFO - 1500720376272 Marionette DEBUG Closed connection 362
03:46:16 INFO - 1500720376273 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49820
03:46:16 INFO - 1500720376276 Marionette TRACE 363 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:46:16 INFO - 1500720376278 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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}
03:46:16 INFO - 1500720376300 Marionette DEBUG Register listener.js for window 15
03:46:16 INFO - 1500720376311 Marionette TRACE 363 <- [1,1,null,{"sessionId":"de092112-06f8-4ee3-baf0-33f6859cf85e","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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}}]
03:46:16 INFO - 1500720376318 Marionette TRACE 363 -> [0,2,"deleteSession",{}]
03:46:16 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:16 INFO - 1500720376322 Marionette TRACE 363 <- [1,2,null,{}]
03:46:16 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:16 INFO - 1500720376328 Marionette DEBUG Closed connection 363
03:46:16 INFO - 1500720376329 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49821
03:46:16 INFO - 1500720376331 Marionette DEBUG Closed connection 364
03:46:16 INFO - 1500720376333 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49822
03:46:16 INFO - 1500720376335 Marionette TRACE 365 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:46:16 INFO - 1500720376337 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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}
03:46:16 INFO - 1500720376359 Marionette DEBUG Register listener.js for window 15
03:46:16 INFO - 1500720376371 Marionette TRACE 365 <- [1,1,null,{"sessionId":"53ee13fd-0ed5-4cf5-befa-7859a5f5627e","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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}}]
03:46:16 INFO - 1500720376377 Marionette TRACE 365 -> [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"}]
03:46:16 INFO - 1500720376381 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49356/test.html"
03:46:16 INFO - 1500720376387 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49356/test.html"
03:46:16 INFO - 1500720376387 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49356/test.html"
03:46:16 INFO - ++DOMWINDOW == 22 (00000026D505E800) [pid = 3568] [serial = 42] [outer = 00000026DF0B6000]
03:46:16 INFO - 1500720376443 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"
03:46:16 INFO - 1500720376448 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"
03:46:16 INFO - 1500720376466 Marionette TRACE 365 <- [1,2,null,{}]
03:46:16 INFO - 1500720376468 Marionette TRACE 365 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
03:46:16 INFO - 1500720376475 Marionette TRACE 365 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"db512a22-98b4-4a3a-aa20-f6d34a57d74a","ELEMENT":"db512a22-98b4-4a3a-aa20-f6d34a57d74a"}}]
03:46:16 INFO - 1500720376477 Marionette TRACE 365 -> [0,4,"clickElement",{"id":"db512a22-98b4-4a3a-aa20-f6d34a57d74a"}]
03:46:16 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
03:46:16 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
03:46:16 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
03:46:17 INFO - 1500720377215 Marionette DEBUG Canceled page load listener because no navigation has been detected
03:46:17 INFO - 1500720377242 Marionette TRACE 365 <- [1,4,null,{}]
03:46:17 INFO - 1500720377342 Marionette TRACE 365 -> [0,5,"getElementProperty",{"id":"db512a22-98b4-4a3a-aa20-f6d34a57d74a","name":"selected"}]
03:46:17 INFO - 1500720377373 Marionette TRACE 365 <- [1,5,null,{"value":true}]
03:46:17 INFO - 1500720377375 Marionette TRACE 365 -> [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}]
03:46:17 INFO - TEST-END: test_click.py TestClick.test_container_element1500720377384 Marionette TRACE 365 <- [1,6,null,{"value":null}]
03:46:17 INFO - 1500720377395 Marionette TRACE 365 -> [0,7,"deleteSession",{}]
03:46:17 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:17 INFO - 1500720377400 Marionette TRACE 365 <- [1,7,null,{}]
03:46:17 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 1218ms
03:46:17 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
03:46:17 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:17 INFO - 1500720377406 Marionette DEBUG Closed connection 365
03:46:17 INFO - 1500720377407 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49823
03:46:17 INFO - 1500720377409 Marionette DEBUG Closed connection 366
03:46:17 INFO - 1500720377410 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49824
03:46:17 INFO - 1500720377412 Marionette TRACE 367 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:46:17 INFO - 1500720377415 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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}
03:46:17 INFO - 1500720377436 Marionette DEBUG Register listener.js for window 15
03:46:17 INFO - 1500720377447 Marionette TRACE 367 <- [1,1,null,{"sessionId":"8a04b798-c742-4144-97ea-d86b5155b510","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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}}]
03:46:17 INFO - 1500720377453 Marionette TRACE 367 -> [0,2,"setTimeouts",{"script":30000}]
03:46:17 INFO - 1500720377455 Marionette TRACE 367 <- [1,2,null,{}]
03:46:17 INFO - 1500720377459 Marionette TRACE 367 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:46:17 INFO - 1500720377461 Marionette TRACE 367 <- [1,3,null,{}]
03:46:17 INFO - 1500720377464 Marionette TRACE 367 -> [0,4,"setTimeouts",{"implicit":0}]
03:46:17 INFO - 1500720377465 Marionette TRACE 367 <- [1,4,null,{}]
03:46:17 INFO - 1500720377491 Marionette TRACE 367 -> [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}]
03:46:17 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1500720377498 Marionette TRACE 367 <- [1,5,null,{"value":null}]
03:46:17 INFO - 1500720377502 Marionette TRACE 367 -> [0,6,"deleteSession",{}]
03:46:17 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:17 INFO - 1500720377506 Marionette TRACE 367 <- [1,6,null,{}]
03:46:17 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:17 INFO - 1500720377512 Marionette DEBUG Closed connection 367
03:46:17 INFO - 1500720377514 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49825
03:46:17 INFO - 1500720377515 Marionette DEBUG Closed connection 368
03:46:17 INFO - 1500720377517 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49826
03:46:17 INFO - 1500720377519 Marionette TRACE 369 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:46:17 INFO - 1500720377521 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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}
03:46:17 INFO - 1500720377544 Marionette DEBUG Register listener.js for window 15
03:46:17 INFO - 1500720377555 Marionette TRACE 369 <- [1,1,null,{"sessionId":"51737d75-8175-4266-bc5b-392920ac55f4","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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}}]
03:46:17 INFO - 1500720377584 Marionette TRACE 369 -> [0,2,"deleteSession",{}]
03:46:17 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:17 INFO - 1500720377589 Marionette TRACE 369 <- [1,2,null,{}]
03:46:17 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:17 INFO - 1500720377611 Marionette DEBUG Closed connection 369
03:46:17 INFO - 1500720377612 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49827
03:46:17 INFO - 1500720377617 Marionette DEBUG Closed connection 370
03:46:17 INFO - 1500720377619 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49828
03:46:17 INFO - 1500720377622 Marionette TRACE 371 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:46:17 INFO - 1500720377628 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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}
03:46:17 INFO - 1500720377653 Marionette DEBUG Register listener.js for window 15
03:46:17 INFO - 1500720377666 Marionette TRACE 371 <- [1,1,null,{"sessionId":"955090e0-83fe-4c3f-8188-dce16347edb3","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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}}]
03:46:17 INFO - 1500720377681 Marionette TRACE 371 -> [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"}]
03:46:17 INFO - 1500720377686 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"
03:46:17 INFO - 1500720377693 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"
03:46:17 INFO - 1500720377694 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"
03:46:17 INFO - ++DOMWINDOW == 23 (00000026E490A000) [pid = 3568] [serial = 43] [outer = 00000026DF0B6000]
03:46:17 INFO - 1500720377752 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"
03:46:17 INFO - 1500720377758 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"
03:46:17 INFO - 1500720377767 Marionette TRACE 371 <- [1,2,null,{}]
03:46:17 INFO - 1500720377779 Marionette TRACE 371 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
03:46:17 INFO - 1500720377787 Marionette TRACE 371 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"2beaf854-4651-4653-a64f-9d88ce9178b2","ELEMENT":"2beaf854-4651-4653-a64f-9d88ce9178b2"}}]
03:46:17 INFO - 1500720377795 Marionette TRACE 371 -> [0,4,"clickElement",{"id":"2beaf854-4651-4653-a64f-9d88ce9178b2"}]
03:46:18 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
03:46:18 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
03:46:18 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
03:46:18 INFO - 1500720378263 Marionette DEBUG Canceled page load listener because no navigation has been detected
03:46:18 INFO - 1500720378265 Marionette TRACE 371 <- [1,4,null,{}]
03:46:18 INFO - 1500720378267 Marionette TRACE 371 -> [0,5,"getElementProperty",{"id":"2beaf854-4651-4653-a64f-9d88ce9178b2","name":"selected"}]
03:46:18 INFO - 1500720378295 Marionette TRACE 371 <- [1,5,null,{"value":true}]
03:46:18 INFO - 1500720378298 Marionette TRACE 371 -> [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}]
03:46:18 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1500720378305 Marionette TRACE 371 <- [1,6,null,{"value":null}]
03:46:18 INFO - 1500720378307 Marionette TRACE 371 -> [0,7,"deleteSession",{}]
03:46:18 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:18 INFO - 1500720378311 Marionette TRACE 371 <- [1,7,null,{}]
03:46:18 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 911ms
03:46:18 INFO - TEST-START | test_click.py TestClick.test_css_transforms
03:46:18 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:18 INFO - 1500720378317 Marionette DEBUG Closed connection 371
03:46:18 INFO - 1500720378319 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49829
03:46:18 INFO - 1500720378321 Marionette DEBUG Closed connection 372
03:46:18 INFO - 1500720378322 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49830
03:46:18 INFO - 1500720378324 Marionette TRACE 373 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:46:18 INFO - 1500720378328 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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}
03:46:18 INFO - 1500720378351 Marionette DEBUG Register listener.js for window 15
03:46:18 INFO - 1500720378362 Marionette TRACE 373 <- [1,1,null,{"sessionId":"65403084-610e-41f7-84d8-9aa1863bf756","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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}}]
03:46:18 INFO - 1500720378402 Marionette TRACE 373 -> [0,2,"setTimeouts",{"script":30000}]
03:46:18 INFO - 1500720378404 Marionette TRACE 373 <- [1,2,null,{}]
03:46:18 INFO - 1500720378406 Marionette TRACE 373 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:46:18 INFO - 1500720378407 Marionette TRACE 373 <- [1,3,null,{}]
03:46:18 INFO - 1500720378409 Marionette TRACE 373 -> [0,4,"setTimeouts",{"implicit":0}]
03:46:18 INFO - 1500720378411 Marionette TRACE 373 <- [1,4,null,{}]
03:46:18 INFO - 1500720378413 Marionette TRACE 373 -> [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}]
03:46:18 INFO - TEST-START: test_click.py TestClick.test_css_transforms1500720378421 Marionette TRACE 373 <- [1,5,null,{"value":null}]
03:46:18 INFO - 1500720378423 Marionette TRACE 373 -> [0,6,"deleteSession",{}]
03:46:18 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:18 INFO - 1500720378427 Marionette TRACE 373 <- [1,6,null,{}]
03:46:18 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:18 INFO - 1500720378433 Marionette DEBUG Closed connection 373
03:46:18 INFO - 1500720378434 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49831
03:46:18 INFO - 1500720378436 Marionette DEBUG Closed connection 374
03:46:18 INFO - 1500720378437 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49832
03:46:18 INFO - 1500720378440 Marionette TRACE 375 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:46:18 INFO - 1500720378442 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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}
03:46:18 INFO - 1500720378464 Marionette DEBUG Register listener.js for window 15
03:46:18 INFO - 1500720378476 Marionette TRACE 375 <- [1,1,null,{"sessionId":"336852cd-4470-4616-8ea0-4b020e3d9505","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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}}]
03:46:18 INFO - 1500720378482 Marionette TRACE 375 -> [0,2,"deleteSession",{}]
03:46:18 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:18 INFO - 1500720378486 Marionette TRACE 375 <- [1,2,null,{}]
03:46:18 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:18 INFO - 1500720378492 Marionette DEBUG Closed connection 375
03:46:18 INFO - 1500720378494 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49833
03:46:18 INFO - 1500720378495 Marionette DEBUG Closed connection 376
03:46:18 INFO - 1500720378497 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49834
03:46:18 INFO - 1500720378499 Marionette TRACE 377 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:46:18 INFO - 1500720378501 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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}
03:46:18 INFO - 1500720378523 Marionette DEBUG Register listener.js for window 15
03:46:18 INFO - 1500720378546 Marionette TRACE 377 <- [1,1,null,{"sessionId":"a7fa9d0a-d0a6-4c25-a0ef-ca4a1fdd80a2","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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}}]
03:46:18 INFO - 1500720378553 Marionette TRACE 377 -> [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"}]
03:46:18 INFO - 1500720378557 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"
03:46:18 INFO - 1500720378563 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"
03:46:18 INFO - 1500720378564 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"
03:46:18 INFO - ++DOMWINDOW == 24 (00000026E13A2800) [pid = 3568] [serial = 44] [outer = 00000026DF0B6000]
03:46:18 INFO - 1500720378613 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"
03:46:18 INFO - 1500720378619 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"
03:46:18 INFO - 1500720378634 Marionette TRACE 377 <- [1,2,null,{}]
03:46:18 INFO - 1500720378701 Marionette TRACE 377 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
03:46:18 INFO - 1500720378710 Marionette TRACE 377 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"249da206-57d2-40d5-91de-c7a82ff9f636","ELEMENT":"249da206-57d2-40d5-91de-c7a82ff9f636"}}]
03:46:18 INFO - 1500720378712 Marionette TRACE 377 -> [0,4,"clickElement",{"id":"249da206-57d2-40d5-91de-c7a82ff9f636"}]
03:46:19 INFO - 1500720379826 Marionette DEBUG Canceled page load listener because no navigation has been detected
03:46:19 INFO - 1500720379829 Marionette TRACE 377 <- [1,4,null,{}]
03:46:19 INFO - 1500720379876 Marionette TRACE 377 -> [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}]
03:46:19 INFO - TEST-END: test_click.py TestClick.test_css_transforms1500720379884 Marionette TRACE 377 <- [1,5,null,{"value":null}]
03:46:19 INFO - 1500720379886 Marionette TRACE 377 -> [0,6,"deleteSession",{}]
03:46:19 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:19 INFO - 1500720379891 Marionette TRACE 377 <- [1,6,null,{}]
03:46:19 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 1580ms
03:46:19 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
03:46:19 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:19 INFO - 1500720379898 Marionette DEBUG Closed connection 377
03:46:19 INFO - 1500720379899 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49835
03:46:19 INFO - 1500720379901 Marionette DEBUG Closed connection 378
03:46:19 INFO - 1500720379902 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49836
03:46:19 INFO - 1500720379905 Marionette TRACE 379 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:46:19 INFO - 1500720379907 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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}
03:46:19 INFO - 1500720379930 Marionette DEBUG Register listener.js for window 15
03:46:19 INFO - 1500720379941 Marionette TRACE 379 <- [1,1,null,{"sessionId":"d0e21285-c539-49de-8467-519bf91d91c3","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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}}]
03:46:20 INFO - 1500720380018 Marionette TRACE 379 -> [0,2,"setTimeouts",{"script":30000}]
03:46:20 INFO - 1500720380020 Marionette TRACE 379 <- [1,2,null,{}]
03:46:20 INFO - 1500720380029 Marionette TRACE 379 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:46:20 INFO - 1500720380031 Marionette TRACE 379 <- [1,3,null,{}]
03:46:20 INFO - 1500720380034 Marionette TRACE 379 -> [0,4,"setTimeouts",{"implicit":0}]
03:46:20 INFO - 1500720380036 Marionette TRACE 379 <- [1,4,null,{}]
03:46:20 INFO - 1500720380038 Marionette TRACE 379 -> [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}]
03:46:20 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1500720380046 Marionette TRACE 379 <- [1,5,null,{"value":null}]
03:46:20 INFO - 1500720380049 Marionette TRACE 379 -> [0,6,"deleteSession",{}]
03:46:20 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:20 INFO - 1500720380054 Marionette TRACE 379 <- [1,6,null,{}]
03:46:20 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:20 INFO - 1500720380076 Marionette DEBUG Closed connection 379
03:46:20 INFO - 1500720380077 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49837
03:46:20 INFO - 1500720380081 Marionette DEBUG Closed connection 380
03:46:20 INFO - 1500720380083 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49838
03:46:20 INFO - 1500720380085 Marionette TRACE 381 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:46:20 INFO - 1500720380088 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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}
03:46:20 INFO - 1500720380110 Marionette DEBUG Register listener.js for window 15
03:46:20 INFO - 1500720380121 Marionette TRACE 381 <- [1,1,null,{"sessionId":"0f44b569-4d7c-458d-9727-fd81cfab2028","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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}}]
03:46:20 INFO - 1500720380131 Marionette TRACE 381 -> [0,2,"deleteSession",{}]
03:46:20 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:20 INFO - 1500720380135 Marionette TRACE 381 <- [1,2,null,{}]
03:46:20 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:20 INFO - 1500720380157 Marionette DEBUG Closed connection 381
03:46:20 INFO - 1500720380159 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49839
03:46:20 INFO - 1500720380163 Marionette DEBUG Closed connection 382
03:46:20 INFO - 1500720380165 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49840
03:46:20 INFO - 1500720380167 Marionette TRACE 383 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:46:20 INFO - 1500720380170 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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}
03:46:20 INFO - 1500720380192 Marionette DEBUG Register listener.js for window 15
03:46:20 INFO - 1500720380203 Marionette TRACE 383 <- [1,1,null,{"sessionId":"0b671e83-c394-4f05-9a13-2980fc3061f9","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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}}]
03:46:20 INFO - 1500720380213 Marionette TRACE 383 -> [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"}]
03:46:20 INFO - 1500720380217 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"
03:46:20 INFO - 1500720380223 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"
03:46:20 INFO - 1500720380224 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"
03:46:20 INFO - ++DOMWINDOW == 25 (00000026E7CB0000) [pid = 3568] [serial = 45] [outer = 00000026DF0B6000]
03:46:20 INFO - 1500720380292 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"
03:46:20 INFO - 1500720380296 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"
03:46:20 INFO - 1500720380313 Marionette TRACE 383 <- [1,2,null,{}]
03:46:20 INFO - 1500720380321 Marionette TRACE 383 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
03:46:20 INFO - 1500720380333 Marionette TRACE 383 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"919d97fa-77e0-41d0-95a1-f1ea7015b384","ELEMENT":"919d97fa-77e0-41d0-95a1-f1ea7015b384"}}]
03:46:20 INFO - 1500720380335 Marionette TRACE 383 -> [0,4,"clickElement",{"id":"919d97fa-77e0-41d0-95a1-f1ea7015b384"}]
03:46:20 INFO - 1500720380814 Marionette DEBUG Canceled page load listener because no navigation has been detected
03:46:20 INFO - 1500720380816 Marionette TRACE 383 <- [1,4,null,{}]
03:46:20 INFO - 1500720380818 Marionette TRACE 383 -> [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}]
03:46:20 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1500720380826 Marionette TRACE 383 <- [1,5,null,{"value":null}]
03:46:20 INFO - 1500720380828 Marionette TRACE 383 -> [0,6,"deleteSession",{}]
03:46:20 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:20 INFO - 1500720380832 Marionette TRACE 383 <- [1,6,null,{}]
03:46:20 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 942ms
03:46:20 INFO - TEST-START | test_click.py TestClick.test_input_file
03:46:20 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:20 INFO - 1500720380838 Marionette DEBUG Closed connection 383
03:46:20 INFO - 1500720380840 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49841
03:46:20 INFO - 1500720380841 Marionette DEBUG Closed connection 384
03:46:20 INFO - 1500720380843 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49842
03:46:20 INFO - 1500720380845 Marionette TRACE 385 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:46:20 INFO - 1500720380847 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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}
03:46:20 INFO - 1500720380869 Marionette DEBUG Register listener.js for window 15
03:46:20 INFO - 1500720380880 Marionette TRACE 385 <- [1,1,null,{"sessionId":"64947679-098d-4305-98aa-5eeaa9acf97a","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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}}]
03:46:20 INFO - 1500720380886 Marionette TRACE 385 -> [0,2,"setTimeouts",{"script":30000}]
03:46:20 INFO - 1500720380888 Marionette TRACE 385 <- [1,2,null,{}]
03:46:20 INFO - 1500720380918 Marionette TRACE 385 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:46:20 INFO - 1500720380919 Marionette TRACE 385 <- [1,3,null,{}]
03:46:20 INFO - 1500720380922 Marionette TRACE 385 -> [0,4,"setTimeouts",{"implicit":0}]
03:46:20 INFO - 1500720380923 Marionette TRACE 385 <- [1,4,null,{}]
03:46:20 INFO - 1500720380925 Marionette TRACE 385 -> [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}]
03:46:20 INFO - TEST-START: test_click.py TestClick.test_input_file1500720380933 Marionette TRACE 385 <- [1,5,null,{"value":null}]
03:46:20 INFO - 1500720380935 Marionette TRACE 385 -> [0,6,"deleteSession",{}]
03:46:20 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:20 INFO - 1500720380942 Marionette TRACE 385 <- [1,6,null,{}]
03:46:20 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:20 INFO - 1500720380948 Marionette DEBUG Closed connection 385
03:46:20 INFO - 1500720380950 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49843
03:46:20 INFO - 1500720380953 Marionette DEBUG Closed connection 386
03:46:20 INFO - 1500720380954 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49844
03:46:20 INFO - 1500720380956 Marionette TRACE 387 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:46:20 INFO - 1500720380958 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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}
03:46:20 INFO - 1500720380981 Marionette DEBUG Register listener.js for window 15
03:46:21 INFO - 1500720380992 Marionette TRACE 387 <- [1,1,null,{"sessionId":"f15fd4e4-7586-40b2-afd2-4bafe2abfb4b","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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}}]
03:46:21 INFO - 1500720380998 Marionette TRACE 387 -> [0,2,"deleteSession",{}]
03:46:21 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:21 INFO - 1500720381002 Marionette TRACE 387 <- [1,2,null,{}]
03:46:21 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:21 INFO - 1500720381008 Marionette DEBUG Closed connection 387
03:46:21 INFO - 1500720381010 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49845
03:46:21 INFO - 1500720381011 Marionette DEBUG Closed connection 388
03:46:21 INFO - 1500720381013 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49846
03:46:21 INFO - 1500720381015 Marionette TRACE 389 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:46:21 INFO - 1500720381017 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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}
03:46:21 INFO - 1500720381040 Marionette DEBUG Register listener.js for window 15
03:46:21 INFO - 1500720381051 Marionette TRACE 389 <- [1,1,null,{"sessionId":"bb57b49f-0f24-43a0-8db0-cebeb5b8a21f","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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}}]
03:46:21 INFO - 1500720381057 Marionette TRACE 389 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
03:46:21 INFO - 1500720381061 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"
03:46:21 INFO - 1500720381070 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"
03:46:21 INFO - 1500720381072 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"
03:46:21 INFO - ++DOMWINDOW == 26 (00000026E7D2F000) [pid = 3568] [serial = 46] [outer = 00000026DF0B6000]
03:46:21 INFO - 1500720381163 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
03:46:21 INFO - 1500720381173 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
03:46:21 INFO - 1500720381193 Marionette TRACE 389 <- [1,2,null,{}]
03:46:21 INFO - 1500720381198 Marionette TRACE 389 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
03:46:21 INFO - 1500720381258 Marionette TRACE 389 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"bb93790f-636d-4f0b-aa88-a81e3093f434","ELEMENT":"bb93790f-636d-4f0b-aa88-a81e3093f434"}}]
03:46:21 INFO - 1500720381273 Marionette TRACE 389 -> [0,4,"clickElement",{"id":"bb93790f-636d-4f0b-aa88-a81e3093f434"}]
03:46:21 INFO - 1500720381430 Marionette TRACE 389 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
03:46:21 INFO - 1500720381446 Marionette TRACE 389 -> [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}]
03:46:21 INFO - TEST-END: test_click.py TestClick.test_input_file1500720381454 Marionette TRACE 389 <- [1,5,null,{"value":null}]
03:46:21 INFO - 1500720381457 Marionette TRACE 389 -> [0,6,"deleteSession",{}]
03:46:21 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:21 INFO - 1500720381461 Marionette TRACE 389 <- [1,6,null,{}]
03:46:21 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 629ms
03:46:21 INFO - TEST-START | test_click.py TestClick.test_obscured_element
03:46:21 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:21 INFO - 1500720381522 Marionette DEBUG Closed connection 389
03:46:21 INFO - 1500720381525 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49847
03:46:21 INFO - 1500720381548 Marionette DEBUG Closed connection 390
03:46:21 INFO - 1500720381551 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49848
03:46:21 INFO - 1500720381556 Marionette TRACE 391 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:46:21 INFO - 1500720381567 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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}
03:46:21 INFO - 1500720381613 Marionette DEBUG Register listener.js for window 15
03:46:21 INFO - 1500720381636 Marionette TRACE 391 <- [1,1,null,{"sessionId":"beabb176-2fee-4b9a-88a9-2d3659198ba3","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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}}]
03:46:21 INFO - 1500720381651 Marionette TRACE 391 -> [0,2,"setTimeouts",{"script":30000}]
03:46:21 INFO - 1500720381654 Marionette TRACE 391 <- [1,2,null,{}]
03:46:21 INFO - 1500720381673 Marionette TRACE 391 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:46:21 INFO - 1500720381678 Marionette TRACE 391 <- [1,3,null,{}]
03:46:21 INFO - 1500720381687 Marionette TRACE 391 -> [0,4,"setTimeouts",{"implicit":0}]
03:46:21 INFO - 1500720381691 Marionette TRACE 391 <- [1,4,null,{}]
03:46:21 INFO - 1500720381695 Marionette TRACE 391 -> [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}]
03:46:21 INFO - TEST-START: test_click.py TestClick.test_obscured_element1500720381709 Marionette TRACE 391 <- [1,5,null,{"value":null}]
03:46:21 INFO - 1500720381712 Marionette TRACE 391 -> [0,6,"deleteSession",{}]
03:46:21 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:21 INFO - 1500720381721 Marionette TRACE 391 <- [1,6,null,{}]
03:46:21 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:21 INFO - 1500720381729 Marionette DEBUG Closed connection 391
03:46:21 INFO - 1500720381734 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49849
03:46:21 INFO - 1500720381758 Marionette DEBUG Closed connection 392
03:46:21 INFO - 1500720381760 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49850
03:46:21 INFO - 1500720381787 Marionette TRACE 393 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:46:21 INFO - 1500720381791 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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}
03:46:21 INFO - 1500720381835 Marionette DEBUG Register listener.js for window 15
03:46:21 INFO - 1500720381853 Marionette TRACE 393 <- [1,1,null,{"sessionId":"acf514d3-3a1d-4fb3-94b9-f4c59036eda2","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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}}]
03:46:21 INFO - 1500720381864 Marionette TRACE 393 -> [0,2,"deleteSession",{}]
03:46:21 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:21 INFO - 1500720381869 Marionette TRACE 393 <- [1,2,null,{}]
03:46:21 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:21 INFO - 1500720381898 Marionette DEBUG Closed connection 393
03:46:21 INFO - 1500720381900 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49851
03:46:21 INFO - 1500720381950 Marionette DEBUG Closed connection 394
03:46:21 INFO - 1500720381952 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49852
03:46:21 INFO - 1500720381958 Marionette TRACE 395 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:46:21 INFO - 1500720381962 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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}
03:46:22 INFO - 1500720382007 Marionette DEBUG Register listener.js for window 15
03:46:22 INFO - 1500720382024 Marionette TRACE 395 <- [1,1,null,{"sessionId":"702037ce-529c-4cd7-8d26-0b844555bc95","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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}}]
03:46:22 INFO - 1500720382037 Marionette TRACE 395 -> [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"}]
03:46:22 INFO - 1500720382043 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
03:46:22 INFO - 1500720382053 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
03:46:22 INFO - 1500720382054 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
03:46:22 INFO - ++DOMWINDOW == 27 (00000026D3464000) [pid = 3568] [serial = 47] [outer = 00000026DF0B6000]
03:46:22 INFO - 1500720382139 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"
03:46:22 INFO - 1500720382146 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"
03:46:22 INFO - 1500720382166 Marionette TRACE 395 <- [1,2,null,{}]
03:46:22 INFO - 1500720382175 Marionette TRACE 395 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
03:46:22 INFO - 1500720382189 Marionette TRACE 395 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"d0552f06-8384-4c6b-a8ea-d8a04e94fb2f","ELEMENT":"d0552f06-8384-4c6b-a8ea-d8a04e94fb2f"}}]
03:46:22 INFO - 1500720382192 Marionette TRACE 395 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
03:46:22 INFO - 1500720382202 Marionette TRACE 395 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"43e0d2f2-82c8-4188-847c-3801322079a0","ELEMENT":"43e0d2f2-82c8-4188-847c-3801322079a0"}}]
03:46:22 INFO - 1500720382204 Marionette TRACE 395 -> [0,5,"clickElement",{"id":"d0552f06-8384-4c6b-a8ea-d8a04e94fb2f"}]
03:46:22 INFO - 1500720382816 Marionette DEBUG Canceled page load listener because no navigation has been detected
03:46:22 INFO - 1500720382819 Marionette TRACE 395 <- [1,5,null,{}]
03:46:22 INFO - 1500720382823 Marionette TRACE 395 -> [0,6,"clickElement",{"id":"43e0d2f2-82c8-4188-847c-3801322079a0"}]
03:46:23 INFO - 1500720383126 Marionette TRACE 395 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
03:46:23 INFO - 1500720383132 Marionette TRACE 395 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
03:46:23 INFO - 1500720383142 Marionette TRACE 395 <- [1,7,null,{"value":false}]
03:46:23 INFO - 1500720383145 Marionette TRACE 395 -> [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}]
03:46:23 INFO - TEST-END: test_click.py TestClick.test_obscured_element1500720383157 Marionette TRACE 395 <- [1,8,null,{"value":null}]
03:46:23 INFO - 1500720383159 Marionette TRACE 395 -> [0,9,"deleteSession",{}]
03:46:23 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:23 INFO - 1500720383165 Marionette TRACE 395 <- [1,9,null,{}]
03:46:23 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 1702ms
03:46:23 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
03:46:23 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:23 INFO - 1500720383216 Marionette DEBUG Closed connection 395
03:46:23 INFO - 1500720383218 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49853
03:46:23 INFO - 1500720383234 Marionette DEBUG Closed connection 396
03:46:23 INFO - 1500720383237 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49854
03:46:23 INFO - 1500720383240 Marionette TRACE 397 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:46:23 INFO - 1500720383243 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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}
03:46:23 INFO - 1500720383288 Marionette DEBUG Register listener.js for window 15
03:46:23 INFO - 1500720383304 Marionette TRACE 397 <- [1,1,null,{"sessionId":"b90d2e2b-ed31-47d5-bb50-7c9b95804158","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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}}]
03:46:23 INFO - 1500720383361 Marionette TRACE 397 -> [0,2,"setTimeouts",{"script":30000}]
03:46:23 INFO - 1500720383363 Marionette TRACE 397 <- [1,2,null,{}]
03:46:23 INFO - 1500720383369 Marionette TRACE 397 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:46:23 INFO - 1500720383371 Marionette TRACE 397 <- [1,3,null,{}]
03:46:23 INFO - 1500720383374 Marionette TRACE 397 -> [0,4,"setTimeouts",{"implicit":0}]
03:46:23 INFO - 1500720383376 Marionette TRACE 397 <- [1,4,null,{}]
03:46:23 INFO - 1500720383378 Marionette TRACE 397 -> [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}]
03:46:23 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1500720383388 Marionette TRACE 397 <- [1,5,null,{"value":null}]
03:46:23 INFO - 1500720383422 Marionette TRACE 397 -> [0,6,"deleteSession",{}]
03:46:23 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:23 INFO - 1500720383427 Marionette TRACE 397 <- [1,6,null,{}]
03:46:23 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:23 INFO - 1500720383453 Marionette DEBUG Closed connection 397
03:46:23 INFO - 1500720383455 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49855
03:46:23 INFO - 1500720383459 Marionette DEBUG Closed connection 398
03:46:23 INFO - 1500720383462 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49856
03:46:23 INFO - 1500720383674 Marionette TRACE 399 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:46:23 INFO - 1500720383690 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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}
03:46:23 INFO - 1500720383719 Marionette DEBUG Register listener.js for window 15
03:46:23 INFO - 1500720383741 Marionette TRACE 399 <- [1,1,null,{"sessionId":"0ec6fae9-9933-4b6f-9c4c-e3c6b8efbb88","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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}}]
03:46:23 INFO - 1500720383758 Marionette TRACE 399 -> [0,2,"deleteSession",{}]
03:46:23 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:23 INFO - 1500720383766 Marionette TRACE 399 <- [1,2,null,{}]
03:46:23 INFO - [Parent 3568] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:46:23 INFO - 1500720383824 Marionette DEBUG Closed connection 399
03:46:23 INFO - 1500720383827 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49857
03:46:23 INFO - 1500720383853 Marionette DEBUG Closed connection 400
03:46:23 INFO - 1500720383855 Marionette DEBUG Accepted connection 401 from 127.0.0.1:49858
03:46:23 INFO - 1500720383861 Marionette TRACE 401 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:46:23 INFO - 1500720383867 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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}
03:46:23 INFO - 1500720383895 Marionette DEBUG Register listener.js for window 15
03:46:23 INFO - 1500720383913 Marionette TRACE 401 <- [1,1,null,{"sessionId":"ca370680-e1ba-4199-a62f-4f3a22b449d5","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":3568,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-274.001\\AppData\\Local\\Temp\\tmpo83w26.mozrunner","moz:accessibilityChecks":false}}]
03:46:23 INFO - 1500720383964 Marionette TRACE 401 -> [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"}]
03:46:23 INFO - 1500720383971 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"
03:46:23 INFO - 1500720383981 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"
03:46:23 INFO - 1500720383982 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"
03:46:23 INFO - ++DOMWINDOW == 28 (00000026D35A7800) [pid = 3568] [serial = 48] [outer = 00000026DF0B6000]
03:46:24 INFO - 1500720384049 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"
03:46:24 INFO - 1500720384055 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"
03:46:24 INFO - 1500720384075 Marionette TRACE 401 <- [1,2,null,{}]
03:46:24 INFO - 1500720384079 Marionette TRACE 401 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
03:46:24 INFO - 1500720384091 Marionette TRACE 401 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"93ee75d4-052b-4fd8-aa5a-ec34f0911b80","ELEMENT":"93ee75d4-052b-4fd8-aa5a-ec34f0911b80"}}]
03:46:24 INFO - 1500720384093 Marionette TRACE 401 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"93ee75d4-052b-4fd8-aa5a-ec34f0911b80"}]
03:46:24 INFO - 1500720384228 Marionette TRACE 401 <- [1,4,null,{"value":"none"}]
03:46:24 INFO - 1500720384248 Marionette TRACE 401 -> [0,5,"clickElement",{"id":"93ee75d4-052b-4fd8-aa5a-ec34f0911b80"}]
03:46:24 INFO - 1500720384403 Marionette TRACE 401 <- [1,5,{"error":"element click intercepted","message":"Element