could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementNotInteractableError@chrome://marionette/content/error.js:315:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:183:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:392:12\nclickElement@chrome://marionette/content/listener.js:1312:5\n"},null]
12:44:10 INFO - 1499715850241 Marionette TRACE 352 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises')","sandbox":"simpletest","line":328}]
12:44:10 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499715850244 Marionette TRACE 352 <- [1,5,null,{"value":null}]
12:44:10 INFO - 1499715850245 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
12:44:10 INFO - 1499715850246 Marionette TRACE 352 <- [1,6,null,{}]
12:44:10 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 133ms
12:44:10 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
12:44:10 INFO - 1499715850248 Marionette DEBUG Closed connection 352
12:44:10 INFO - 1499715850249 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49770
12:44:10 INFO - 1499715850250 Marionette DEBUG Closed connection 353
12:44:10 INFO - 1499715850250 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49771
12:44:10 INFO - 1499715850251 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:10 INFO - 1499715850252 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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1499715850255 Marionette DEBUG Register listener.js for window 4294967297
12:44:10 INFO - 1499715850259 Marionette TRACE 354 <- [1,1,null,{"sessionId":"7cdf1192-bed0-4a95-b358-445388d027d6","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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1499715850260 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
12:44:10 INFO - 1499715850261 Marionette TRACE 354 <- [1,2,null,{}]
12:44:10 INFO - 1499715850262 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:44:10 INFO - 1499715850262 Marionette TRACE 354 <- [1,3,null,{}]
12:44:10 INFO - 1499715850263 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
12:44:10 INFO - 1499715850264 Marionette TRACE 354 <- [1,4,null,{}]
12:44:10 INFO - 1499715850265 Marionette TRACE 354 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":316}]
12:44:10 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499715850268 Marionette TRACE 354 <- [1,5,null,{"value":null}]
12:44:10 INFO - 1499715850269 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
12:44:10 INFO - 1499715850271 Marionette TRACE 354 <- [1,6,null,{}]
12:44:10 INFO - 1499715850273 Marionette DEBUG Closed connection 354
12:44:10 INFO - 1499715850273 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49772
12:44:10 INFO - 1499715850274 Marionette DEBUG Closed connection 355
12:44:10 INFO - 1499715850274 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49773
12:44:10 INFO - 1499715850275 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:10 INFO - 1499715850276 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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1499715850279 Marionette DEBUG Register listener.js for window 4294967297
12:44:10 INFO - 1499715850283 Marionette TRACE 356 <- [1,1,null,{"sessionId":"3da31ab4-a006-45a0-b287-021b22b6da6a","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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1499715850284 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
12:44:10 INFO - 1499715850286 Marionette TRACE 356 <- [1,2,null,{}]
12:44:10 INFO - 1499715850288 Marionette DEBUG Closed connection 356
12:44:10 INFO - 1499715850289 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49774
12:44:10 INFO - 1499715850290 Marionette DEBUG Closed connection 357
12:44:10 INFO - 1499715850290 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49775
12:44:10 INFO - 1499715850291 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:44:10 INFO - 1499715850292 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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1499715850295 Marionette DEBUG Register listener.js for window 4294967297
12:44:10 INFO - 1499715850298 Marionette TRACE 358 <- [1,1,null,{"sessionId":"4ffda452-1e71-4c68-b99d-ac6a095c6064","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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1499715850299 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49332/clicks.html"}]
12:44:10 INFO - 1499715850302 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49332/hidden.html"
12:44:10 INFO - 1499715850312 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49332/hidden.html"
12:44:10 INFO - 1499715850312 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49332/hidden.html"
12:44:10 INFO - 1499715850319 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49332/clicks.html"
12:44:10 INFO - 1499715850325 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49332/clicks.html"
12:44:10 INFO - 1499715850327 Marionette TRACE 358 <- [1,2,null,{}]
12:44:10 INFO - 1499715850331 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
12:44:10 INFO - 1499715850334 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a0cbf58f-23d6-40eb-b944-fd783382366c","ELEMENT":"a0cbf58f-23d6-40eb-b944-fd783382366c"}}]
12:44:10 INFO - 1499715850337 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"a0cbf58f-23d6-40eb-b944-fd783382366c"}]
12:44:10 INFO - 1499715850382 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49332/clicks.html"
12:44:10 INFO - 1499715850405 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49332/clicks.html"
12:44:10 INFO - 1499715850405 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49332/clicks.html"
12:44:10 INFO - 1499715850414 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49332/test.html"
12:44:10 INFO - 1499715850421 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49332/test.html"
12:44:10 INFO - 1499715850422 Marionette TRACE 358 <- [1,4,null,{}]
12:44:10 INFO - 1499715850429 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
12:44:10 INFO - 1499715850444 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"61d88ba4-6af6-4890-a384-b267ca5e6164","ELEMENT":"61d88ba4-6af6-4890-a384-b267ca5e6164"}}]
12:44:10 INFO - 1499715850445 Marionette TRACE 358 -> [0,6,"getTitle",{}]
12:44:10 INFO - 1499715850446 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
12:44:10 INFO - 1499715850447 Marionette TRACE 358 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":328}]
12:44:10 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499715850450 Marionette TRACE 358 <- [1,7,null,{"value":null}]
12:44:10 INFO - 1499715850451 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
12:44:10 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 205ms
12:44:10 INFO - 1499715850452 Marionette TRACE 358 <- [1,8,null,{}]
12:44:10 INFO - TEST-START | test_click.py TestClick.test_container_element
12:44:10 INFO - 1499715850454 Marionette DEBUG Closed connection 358
12:44:10 INFO - 1499715850455 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49778
12:44:10 INFO - 1499715850456 Marionette DEBUG Closed connection 359
12:44:10 INFO - 1499715850457 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49779
12:44:10 INFO - 1499715850458 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:10 INFO - 1499715850458 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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1499715850461 Marionette DEBUG Register listener.js for window 4294967297
12:44:10 INFO - 1499715850465 Marionette TRACE 360 <- [1,1,null,{"sessionId":"62fe6b43-6856-4f6a-9881-1384b84d3120","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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1499715850466 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
12:44:10 INFO - 1499715850466 Marionette TRACE 360 <- [1,2,null,{}]
12:44:10 INFO - 1499715850468 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:44:10 INFO - 1499715850468 Marionette TRACE 360 <- [1,3,null,{}]
12:44:10 INFO - 1499715850469 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
12:44:10 INFO - 1499715850470 Marionette TRACE 360 <- [1,4,null,{}]
12:44:10 INFO - 1499715850472 Marionette TRACE 360 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":316}]
12:44:10 INFO - TEST-START: test_click.py TestClick.test_container_element1499715850474 Marionette TRACE 360 <- [1,5,null,{"value":null}]
12:44:10 INFO - 1499715850476 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
12:44:10 INFO - 1499715850477 Marionette TRACE 360 <- [1,6,null,{}]
12:44:10 INFO - 1499715850479 Marionette DEBUG Closed connection 360
12:44:10 INFO - 1499715850480 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49780
12:44:10 INFO - 1499715850480 Marionette DEBUG Closed connection 361
12:44:10 INFO - 1499715850481 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49781
12:44:10 INFO - 1499715850482 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:10 INFO - 1499715850483 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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1499715850486 Marionette DEBUG Register listener.js for window 4294967297
12:44:10 INFO - 1499715850489 Marionette TRACE 362 <- [1,1,null,{"sessionId":"7d06d718-15a7-4ed8-9034-f9eabee02b5d","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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1499715850490 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
12:44:10 INFO - 1499715850492 Marionette TRACE 362 <- [1,2,null,{}]
12:44:10 INFO - 1499715850493 Marionette DEBUG Closed connection 362
12:44:10 INFO - 1499715850494 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49782
12:44:10 INFO - 1499715850495 Marionette DEBUG Closed connection 363
12:44:10 INFO - 1499715850495 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49783
12:44:10 INFO - 1499715850496 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:44:10 INFO - 1499715850497 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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1499715850505 Marionette DEBUG Register listener.js for window 4294967297
12:44:10 INFO - 1499715850510 Marionette TRACE 364 <- [1,1,null,{"sessionId":"94046397-b1a2-41e5-b4e1-b7ed5566a5d7","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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1499715850511 Marionette TRACE 364 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
12:44:10 INFO - 1499715850517 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49332/test.html"
12:44:10 INFO - 1499715850519 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49332/test.html"
12:44:10 INFO - 1499715850520 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49332/test.html"
12:44:10 INFO - 1499715850544 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"
12:44:10 INFO - 1499715850546 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"
12:44:10 INFO - 1499715850547 Marionette TRACE 364 <- [1,2,null,{}]
12:44:10 INFO - 1499715850549 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
12:44:10 INFO - 1499715850552 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"5c471256-6891-4350-9d22-cb66ef8cc29e","ELEMENT":"5c471256-6891-4350-9d22-cb66ef8cc29e"}}]
12:44:10 INFO - 1499715850553 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"5c471256-6891-4350-9d22-cb66ef8cc29e"}]
12:44:10 INFO - 1499715850797 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:44:10 INFO - 1499715850798 Marionette TRACE 364 <- [1,4,null,{}]
12:44:10 INFO - 1499715850800 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"5c471256-6891-4350-9d22-cb66ef8cc29e","name":"selected"}]
12:44:10 INFO - 1499715850804 Marionette TRACE 364 <- [1,5,null,{"value":true}]
12:44:10 INFO - 1499715850807 Marionette TRACE 364 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":328}]
12:44:10 INFO - TEST-END: test_click.py TestClick.test_container_element1499715850810 Marionette TRACE 364 <- [1,6,null,{"value":null}]
12:44:10 INFO - 1499715850811 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
12:44:10 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 359ms
12:44:10 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
12:44:10 INFO - 1499715850812 Marionette TRACE 364 <- [1,7,null,{}]
12:44:10 INFO - 1499715850814 Marionette DEBUG Closed connection 364
12:44:10 INFO - 1499715850815 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49784
12:44:10 INFO - 1499715850816 Marionette DEBUG Closed connection 365
12:44:10 INFO - 1499715850816 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49785
12:44:10 INFO - 1499715850817 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:10 INFO - 1499715850818 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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1499715850820 Marionette DEBUG Register listener.js for window 4294967297
12:44:10 INFO - 1499715850824 Marionette TRACE 366 <- [1,1,null,{"sessionId":"0deebf83-3551-4f91-ae78-024f7b6c9cef","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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1499715850825 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
12:44:10 INFO - 1499715850826 Marionette TRACE 366 <- [1,2,null,{}]
12:44:10 INFO - 1499715850827 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:44:10 INFO - 1499715850827 Marionette TRACE 366 <- [1,3,null,{}]
12:44:10 INFO - 1499715850828 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
12:44:10 INFO - 1499715850829 Marionette TRACE 366 <- [1,4,null,{}]
12:44:10 INFO - 1499715850831 Marionette TRACE 366 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":316}]
12:44:10 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499715850834 Marionette TRACE 366 <- [1,5,null,{"value":null}]
12:44:10 INFO - 1499715850834 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
12:44:10 INFO - 1499715850836 Marionette TRACE 366 <- [1,6,null,{}]
12:44:10 INFO - 1499715850837 Marionette DEBUG Closed connection 366
12:44:10 INFO - 1499715850838 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49786
12:44:10 INFO - 1499715850839 Marionette DEBUG Closed connection 367
12:44:10 INFO - 1499715850840 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49787
12:44:10 INFO - 1499715850841 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:10 INFO - 1499715850841 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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1499715850844 Marionette DEBUG Register listener.js for window 4294967297
12:44:10 INFO - 1499715850847 Marionette TRACE 368 <- [1,1,null,{"sessionId":"8dad7444-0876-4c2f-84d7-15badbbcb305","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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1499715850849 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
12:44:10 INFO - 1499715850850 Marionette TRACE 368 <- [1,2,null,{}]
12:44:10 INFO - 1499715850851 Marionette DEBUG Closed connection 368
12:44:10 INFO - 1499715850852 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49788
12:44:10 INFO - 1499715850853 Marionette DEBUG Closed connection 369
12:44:10 INFO - 1499715850854 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49789
12:44:10 INFO - 1499715850855 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:44:10 INFO - 1499715850862 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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1499715850865 Marionette DEBUG Register listener.js for window 4294967297
12:44:10 INFO - 1499715850869 Marionette TRACE 370 <- [1,1,null,{"sessionId":"ce5bc07f-28bb-4505-b29b-3b3f7503ee66","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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1499715850870 Marionette TRACE 370 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
12:44:10 INFO - 1499715850872 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"
12:44:10 INFO - 1499715850874 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"
12:44:10 INFO - 1499715850874 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"
12:44:10 INFO - 1499715850881 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"
12:44:10 INFO - 1499715850884 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"
12:44:10 INFO - 1499715850887 Marionette TRACE 370 <- [1,2,null,{}]
12:44:10 INFO - 1499715850895 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
12:44:10 INFO - 1499715850897 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"c2d18f77-8069-4551-83da-af6ef753b6c8","ELEMENT":"c2d18f77-8069-4551-83da-af6ef753b6c8"}}]
12:44:10 INFO - 1499715850898 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"c2d18f77-8069-4551-83da-af6ef753b6c8"}]
12:44:11 INFO - 1499715851144 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:44:11 INFO - 1499715851145 Marionette TRACE 370 <- [1,4,null,{}]
12:44:11 INFO - 1499715851147 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"c2d18f77-8069-4551-83da-af6ef753b6c8","name":"selected"}]
12:44:11 INFO - 1499715851151 Marionette TRACE 370 <- [1,5,null,{"value":true}]
12:44:11 INFO - 1499715851153 Marionette TRACE 370 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":328}]
12:44:11 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499715851155 Marionette TRACE 370 <- [1,6,null,{"value":null}]
12:44:11 INFO - 1499715851156 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
12:44:11 INFO - 1499715851158 Marionette TRACE 370 <- [1,7,null,{}]
12:44:11 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 345ms
12:44:11 INFO - TEST-START | test_click.py TestClick.test_css_transforms
12:44:11 INFO - 1499715851159 Marionette DEBUG Closed connection 370
12:44:11 INFO - 1499715851160 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49790
12:44:11 INFO - 1499715851161 Marionette DEBUG Closed connection 371
12:44:11 INFO - 1499715851161 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49791
12:44:11 INFO - 1499715851162 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:11 INFO - 1499715851163 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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}
12:44:11 INFO - 1499715851166 Marionette DEBUG Register listener.js for window 4294967297
12:44:11 INFO - 1499715851169 Marionette TRACE 372 <- [1,1,null,{"sessionId":"9b22f992-8479-43e4-a41b-b25c2032fdae","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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}}]
12:44:11 INFO - 1499715851171 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
12:44:11 INFO - 1499715851171 Marionette TRACE 372 <- [1,2,null,{}]
12:44:11 INFO - 1499715851172 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:44:11 INFO - 1499715851173 Marionette TRACE 372 <- [1,3,null,{}]
12:44:11 INFO - 1499715851174 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
12:44:11 INFO - 1499715851174 Marionette TRACE 372 <- [1,4,null,{}]
12:44:11 INFO - 1499715851176 Marionette TRACE 372 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":316}]
12:44:11 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499715851179 Marionette TRACE 372 <- [1,5,null,{"value":null}]
12:44:11 INFO - 1499715851180 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
12:44:11 INFO - 1499715851182 Marionette TRACE 372 <- [1,6,null,{}]
12:44:11 INFO - 1499715851183 Marionette DEBUG Closed connection 372
12:44:11 INFO - 1499715851184 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49792
12:44:11 INFO - 1499715851185 Marionette DEBUG Closed connection 373
12:44:11 INFO - 1499715851185 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49793
12:44:11 INFO - 1499715851186 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:11 INFO - 1499715851187 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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}
12:44:11 INFO - 1499715851190 Marionette DEBUG Register listener.js for window 4294967297
12:44:11 INFO - 1499715851193 Marionette TRACE 374 <- [1,1,null,{"sessionId":"f50012f9-7c1f-40ff-bc7a-9c255a05488e","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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}}]
12:44:11 INFO - 1499715851194 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
12:44:11 INFO - 1499715851195 Marionette TRACE 374 <- [1,2,null,{}]
12:44:11 INFO - 1499715851197 Marionette DEBUG Closed connection 374
12:44:11 INFO - 1499715851198 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49794
12:44:11 INFO - 1499715851199 Marionette DEBUG Closed connection 375
12:44:11 INFO - 1499715851199 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49795
12:44:11 INFO - 1499715851200 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:44:11 INFO - 1499715851201 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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}
12:44:11 INFO - 1499715851204 Marionette DEBUG Register listener.js for window 4294967297
12:44:11 INFO - 1499715851207 Marionette TRACE 376 <- [1,1,null,{"sessionId":"f288a9a4-2832-4ccc-8742-7e924a54914f","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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}}]
12:44:11 INFO - 1499715851209 Marionette TRACE 376 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"}]
12:44:11 INFO - 1499715851210 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"
12:44:11 INFO - 1499715851213 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"
12:44:11 INFO - 1499715851213 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"
12:44:11 INFO - 1499715851220 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"
12:44:11 INFO - 1499715851223 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"
12:44:11 INFO - 1499715851231 Marionette TRACE 376 <- [1,2,null,{}]
12:44:11 INFO - 1499715851234 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
12:44:11 INFO - 1499715851237 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"7cf97d13-257a-4911-820d-8ee3fa2b0828","ELEMENT":"7cf97d13-257a-4911-820d-8ee3fa2b0828"}}]
12:44:11 INFO - 1499715851238 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"7cf97d13-257a-4911-820d-8ee3fa2b0828"}]
12:44:11 INFO - 1499715851491 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:44:11 INFO - 1499715851492 Marionette TRACE 376 <- [1,4,null,{}]
12:44:11 INFO - 1499715851494 Marionette TRACE 376 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":328}]
12:44:11 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499715851497 Marionette TRACE 376 <- [1,5,null,{"value":null}]
12:44:11 INFO - 1499715851497 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
12:44:11 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 341ms
12:44:11 INFO - 1499715851499 Marionette TRACE 376 <- [1,6,null,{}]
12:44:11 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
12:44:11 INFO - 1499715851500 Marionette DEBUG Closed connection 376
12:44:11 INFO - 1499715851501 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49796
12:44:11 INFO - 1499715851502 Marionette DEBUG Closed connection 377
12:44:11 INFO - 1499715851503 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49797
12:44:11 INFO - 1499715851504 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:11 INFO - 1499715851505 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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}
12:44:11 INFO - 1499715851508 Marionette DEBUG Register listener.js for window 4294967297
12:44:11 INFO - 1499715851511 Marionette TRACE 378 <- [1,1,null,{"sessionId":"3a1b8f9e-e14c-4296-b1ed-3a445f60a329","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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}}]
12:44:11 INFO - 1499715851512 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
12:44:11 INFO - 1499715851513 Marionette TRACE 378 <- [1,2,null,{}]
12:44:11 INFO - 1499715851514 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:44:11 INFO - 1499715851514 Marionette TRACE 378 <- [1,3,null,{}]
12:44:11 INFO - 1499715851516 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
12:44:11 INFO - 1499715851516 Marionette TRACE 378 <- [1,4,null,{}]
12:44:11 INFO - 1499715851518 Marionette TRACE 378 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":316}]
12:44:11 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499715851520 Marionette TRACE 378 <- [1,5,null,{"value":null}]
12:44:11 INFO - 1499715851521 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
12:44:11 INFO - 1499715851523 Marionette TRACE 378 <- [1,6,null,{}]
12:44:11 INFO - 1499715851524 Marionette DEBUG Closed connection 378
12:44:11 INFO - 1499715851525 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49798
12:44:11 INFO - 1499715851587 Marionette DEBUG Closed connection 379
12:44:11 INFO - 1499715851589 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49799
12:44:11 INFO - 1499715851593 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:11 INFO - 1499715851597 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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}
12:44:11 INFO - 1499715851636 Marionette DEBUG Register listener.js for window 4294967297
12:44:11 INFO - 1499715851642 Marionette TRACE 380 <- [1,1,null,{"sessionId":"a6e85712-32a7-41f3-8323-e6ccc0695093","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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}}]
12:44:11 INFO - 1499715851644 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
12:44:11 INFO - 1499715851647 Marionette TRACE 380 <- [1,2,null,{}]
12:44:11 INFO - 1499715851650 Marionette DEBUG Closed connection 380
12:44:11 INFO - 1499715851651 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49800
12:44:11 INFO - 1499715851652 Marionette DEBUG Closed connection 381
12:44:11 INFO - 1499715851654 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49801
12:44:11 INFO - 1499715851657 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:44:11 INFO - 1499715851659 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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}
12:44:11 INFO - 1499715851672 Marionette DEBUG Register listener.js for window 4294967297
12:44:11 INFO - 1499715851678 Marionette TRACE 382 <- [1,1,null,{"sessionId":"07f07874-ee0f-4a9e-8065-98358275651a","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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}}]
12:44:11 INFO - 1499715851679 Marionette TRACE 382 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
12:44:11 INFO - 1499715851682 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"
12:44:11 INFO - 1499715851684 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"
12:44:11 INFO - 1499715851684 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"
12:44:11 INFO - 1499715851694 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"
12:44:11 INFO - 1499715851695 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"
12:44:11 INFO - 1499715851710 Marionette TRACE 382 <- [1,2,null,{}]
12:44:11 INFO - 1499715851716 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
12:44:11 INFO - 1499715851719 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"81faa1f4-96a5-4d81-b27a-d5848a4a5781","ELEMENT":"81faa1f4-96a5-4d81-b27a-d5848a4a5781"}}]
12:44:11 INFO - 1499715851720 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"81faa1f4-96a5-4d81-b27a-d5848a4a5781"}]
12:44:11 INFO - 1499715851966 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:44:11 INFO - 1499715851967 Marionette TRACE 382 <- [1,4,null,{}]
12:44:11 INFO - 1499715851969 Marionette TRACE 382 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":328}]
12:44:11 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499715851973 Marionette TRACE 382 <- [1,5,null,{"value":null}]
12:44:11 INFO - 1499715851974 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
12:44:11 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 476ms
12:44:11 INFO - 1499715851976 Marionette TRACE 382 <- [1,6,null,{}]
12:44:11 INFO - TEST-START | test_click.py TestClick.test_input_file
12:44:11 INFO - 1499715851979 Marionette DEBUG Closed connection 382
12:44:11 INFO - 1499715851980 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49802
12:44:11 INFO - 1499715851981 Marionette DEBUG Closed connection 383
12:44:11 INFO - 1499715851982 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49803
12:44:11 INFO - 1499715851983 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:11 INFO - 1499715851985 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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}
12:44:11 INFO - 1499715851988 Marionette DEBUG Register listener.js for window 4294967297
12:44:11 INFO - 1499715851992 Marionette TRACE 384 <- [1,1,null,{"sessionId":"db5ddb0d-dfcc-4629-ad81-8563369a6409","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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}}]
12:44:11 INFO - 1499715851994 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
12:44:11 INFO - 1499715851994 Marionette TRACE 384 <- [1,2,null,{}]
12:44:11 INFO - 1499715851997 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:44:12 INFO - 1499715851999 Marionette TRACE 384 <- [1,3,null,{}]
12:44:12 INFO - 1499715852000 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
12:44:12 INFO - 1499715852001 Marionette TRACE 384 <- [1,4,null,{}]
12:44:12 INFO - 1499715852003 Marionette TRACE 384 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":316}]
12:44:12 INFO - TEST-START: test_click.py TestClick.test_input_file1499715852006 Marionette TRACE 384 <- [1,5,null,{"value":null}]
12:44:12 INFO - 1499715852008 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
12:44:12 INFO - 1499715852009 Marionette TRACE 384 <- [1,6,null,{}]
12:44:12 INFO - 1499715852012 Marionette DEBUG Closed connection 384
12:44:12 INFO - 1499715852012 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49804
12:44:12 INFO - 1499715852013 Marionette DEBUG Closed connection 385
12:44:12 INFO - 1499715852014 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49805
12:44:12 INFO - 1499715852015 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:12 INFO - 1499715852016 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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}
12:44:12 INFO - 1499715852019 Marionette DEBUG Register listener.js for window 4294967297
12:44:12 INFO - 1499715852024 Marionette TRACE 386 <- [1,1,null,{"sessionId":"8c8eefa4-5798-4850-9c05-7d9a9e41fa1e","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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}}]
12:44:12 INFO - 1499715852026 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
12:44:12 INFO - 1499715852027 Marionette TRACE 386 <- [1,2,null,{}]
12:44:12 INFO - 1499715852029 Marionette DEBUG Closed connection 386
12:44:12 INFO - 1499715852029 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49806
12:44:12 INFO - 1499715852030 Marionette DEBUG Closed connection 387
12:44:12 INFO - 1499715852031 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49807
12:44:12 INFO - 1499715852032 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:44:12 INFO - 1499715852034 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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}
12:44:12 INFO - 1499715852036 Marionette DEBUG Register listener.js for window 4294967297
12:44:12 INFO - 1499715852042 Marionette TRACE 388 <- [1,1,null,{"sessionId":"ae7a3b82-5e74-4ea8-924d-66d228da688a","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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}}]
12:44:12 INFO - 1499715852044 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
12:44:12 INFO - 1499715852046 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"
12:44:12 INFO - 1499715852048 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"
12:44:12 INFO - 1499715852049 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"
12:44:12 INFO - 1499715852060 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:44:12 INFO - 1499715852062 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:44:12 INFO - 1499715852071 Marionette TRACE 388 <- [1,2,null,{}]
12:44:12 INFO - 1499715852078 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
12:44:12 INFO - 1499715852081 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"9bc79f91-4bb3-4519-b4e0-af38ae8c6e38","ELEMENT":"9bc79f91-4bb3-4519-b4e0-af38ae8c6e38"}}]
12:44:12 INFO - 1499715852082 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"9bc79f91-4bb3-4519-b4e0-af38ae8c6e38"}]
12:44:12 INFO - 1499715852118 Marionette TRACE 388 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:392:12\nclickElement@chrome://marionette/content/listener.js:1312:5\n"},null]
12:44:12 INFO - 1499715852120 Marionette TRACE 388 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":328}]
12:44:12 INFO - TEST-END: test_click.py TestClick.test_input_file1499715852123 Marionette TRACE 388 <- [1,5,null,{"value":null}]
12:44:12 INFO - 1499715852125 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
12:44:12 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 149ms
12:44:12 INFO - TEST-START | test_click.py TestClick.test_obscured_element
12:44:12 INFO - 1499715852126 Marionette TRACE 388 <- [1,6,null,{}]
12:44:12 INFO - 1499715852128 Marionette DEBUG Closed connection 388
12:44:12 INFO - 1499715852129 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49808
12:44:12 INFO - 1499715852131 Marionette DEBUG Closed connection 389
12:44:12 INFO - 1499715852133 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49809
12:44:12 INFO - 1499715852134 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:12 INFO - 1499715852135 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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}
12:44:12 INFO - 1499715852138 Marionette DEBUG Register listener.js for window 4294967297
12:44:12 INFO - 1499715852142 Marionette TRACE 390 <- [1,1,null,{"sessionId":"d0718f92-f9d0-4743-a77b-fcede6b4361f","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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}}]
12:44:12 INFO - 1499715852144 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
12:44:12 INFO - 1499715852144 Marionette TRACE 390 <- [1,2,null,{}]
12:44:12 INFO - 1499715852145 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:44:12 INFO - 1499715852146 Marionette TRACE 390 <- [1,3,null,{}]
12:44:12 INFO - 1499715852147 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
12:44:12 INFO - 1499715852148 Marionette TRACE 390 <- [1,4,null,{}]
12:44:12 INFO - 1499715852149 Marionette TRACE 390 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":316}]
12:44:12 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499715852153 Marionette TRACE 390 <- [1,5,null,{"value":null}]
12:44:12 INFO - 1499715852154 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
12:44:12 INFO - 1499715852156 Marionette TRACE 390 <- [1,6,null,{}]
12:44:12 INFO - 1499715852157 Marionette DEBUG Closed connection 390
12:44:12 INFO - 1499715852158 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49810
12:44:12 INFO - 1499715852159 Marionette DEBUG Closed connection 391
12:44:12 INFO - 1499715852160 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49811
12:44:12 INFO - 1499715852161 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:12 INFO - 1499715852162 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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}
12:44:12 INFO - 1499715852165 Marionette DEBUG Register listener.js for window 4294967297
12:44:12 INFO - 1499715852168 Marionette TRACE 392 <- [1,1,null,{"sessionId":"cae5d35a-b721-4734-b0c0-10e1f6165498","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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}}]
12:44:12 INFO - 1499715852170 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
12:44:12 INFO - 1499715852171 Marionette TRACE 392 <- [1,2,null,{}]
12:44:12 INFO - 1499715852173 Marionette DEBUG Closed connection 392
12:44:12 INFO - 1499715852173 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49812
12:44:12 INFO - 1499715852174 Marionette DEBUG Closed connection 393
12:44:12 INFO - 1499715852175 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49813
12:44:12 INFO - 1499715852176 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:44:12 INFO - 1499715852177 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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}
12:44:12 INFO - 1499715852180 Marionette DEBUG Register listener.js for window 4294967297
12:44:12 INFO - 1499715852183 Marionette TRACE 394 <- [1,1,null,{"sessionId":"a321c23b-82f4-4d6f-bc8f-4c2f58e09e60","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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}}]
12:44:12 INFO - 1499715852185 Marionette TRACE 394 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"}]
12:44:12 INFO - 1499715852187 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:44:12 INFO - 1499715852189 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:44:12 INFO - 1499715852190 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:44:12 INFO - 1499715852196 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"
12:44:12 INFO - 1499715852199 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"
12:44:12 INFO - 1499715852205 Marionette TRACE 394 <- [1,2,null,{}]
12:44:12 INFO - 1499715852214 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
12:44:12 INFO - 1499715852219 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"ae97fa98-9eb7-4389-9c18-6e4db9bb36e5","ELEMENT":"ae97fa98-9eb7-4389-9c18-6e4db9bb36e5"}}]
12:44:12 INFO - 1499715852220 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
12:44:12 INFO - 1499715852226 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"9ffca8ae-8a83-4c69-9c4c-9f844c4ca2f3","ELEMENT":"9ffca8ae-8a83-4c69-9c4c-9f844c4ca2f3"}}]
12:44:12 INFO - 1499715852227 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"ae97fa98-9eb7-4389-9c18-6e4db9bb36e5"}]
12:44:12 INFO - 1499715852472 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:44:12 INFO - 1499715852474 Marionette TRACE 394 <- [1,5,null,{}]
12:44:12 INFO - 1499715852475 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"9ffca8ae-8a83-4c69-9c4c-9f844c4ca2f3"}]
12:44:12 INFO - 1499715852492 Marionette TRACE 394 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:392:12\nclickElement@chrome://marionette/content/listener.js:1312:5\n"},null]
12:44:12 INFO - 1499715852493 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
12:44:12 INFO - 1499715852496 Marionette TRACE 394 <- [1,7,null,{"value":false}]
12:44:12 INFO - 1499715852498 Marionette TRACE 394 -> [0,8,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":328}]
12:44:12 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499715852500 Marionette TRACE 394 <- [1,8,null,{"value":null}]
12:44:12 INFO - 1499715852501 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
12:44:12 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 378ms
12:44:12 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
12:44:12 INFO - 1499715852503 Marionette TRACE 394 <- [1,9,null,{}]
12:44:12 INFO - 1499715852505 Marionette DEBUG Closed connection 394
12:44:12 INFO - 1499715852506 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49814
12:44:12 INFO - 1499715852507 Marionette DEBUG Closed connection 395
12:44:12 INFO - 1499715852507 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49815
12:44:12 INFO - 1499715852509 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:12 INFO - 1499715852509 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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}
12:44:12 INFO - 1499715852512 Marionette DEBUG Register listener.js for window 4294967297
12:44:12 INFO - 1499715852516 Marionette TRACE 396 <- [1,1,null,{"sessionId":"5f3740a3-5277-44f8-85a0-0dc7ccdfdff1","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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}}]
12:44:12 INFO - 1499715852517 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
12:44:12 INFO - 1499715852518 Marionette TRACE 396 <- [1,2,null,{}]
12:44:12 INFO - 1499715852519 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:44:12 INFO - 1499715852520 Marionette TRACE 396 <- [1,3,null,{}]
12:44:12 INFO - 1499715852521 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
12:44:12 INFO - 1499715852522 Marionette TRACE 396 <- [1,4,null,{}]
12:44:12 INFO - 1499715852524 Marionette TRACE 396 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_pointer_events_none')","sandbox":"simpletest","line":316}]
12:44:12 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499715852526 Marionette TRACE 396 <- [1,5,null,{"value":null}]
12:44:12 INFO - 1499715852527 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
12:44:12 INFO - 1499715852529 Marionette TRACE 396 <- [1,6,null,{}]
12:44:12 INFO - 1499715852530 Marionette DEBUG Closed connection 396
12:44:12 INFO - 1499715852531 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49816
12:44:12 INFO - 1499715852532 Marionette DEBUG Closed connection 397
12:44:12 INFO - 1499715852533 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49817
12:44:12 INFO - 1499715852534 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:12 INFO - 1499715852534 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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}
12:44:12 INFO - 1499715852537 Marionette DEBUG Register listener.js for window 4294967297
12:44:12 INFO - 1499715852541 Marionette TRACE 398 <- [1,1,null,{"sessionId":"96c8da06-c02f-4a4e-891f-cb61d7120dd7","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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}}]
12:44:12 INFO - 1499715852542 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
12:44:12 INFO - 1499715852543 Marionette TRACE 398 <- [1,2,null,{}]
12:44:12 INFO - 1499715852545 Marionette DEBUG Closed connection 398
12:44:12 INFO - 1499715852545 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49818
12:44:12 INFO - 1499715852546 Marionette DEBUG Closed connection 399
12:44:12 INFO - 1499715852548 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49819
12:44:12 INFO - 1499715852549 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:44:12 INFO - 1499715852551 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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}
12:44:12 INFO - 1499715852555 Marionette DEBUG Register listener.js for window 4294967297
12:44:12 INFO - 1499715852560 Marionette TRACE 400 <- [1,1,null,{"sessionId":"a018abe6-8f29-4d36-8e26-95984554aaa7","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":2436,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-341.001\\AppData\\Local\\Temp\\tmp5bwo08.mozrunner","moz:accessibilityChecks":false}}]
12:44:12 INFO - 1499715852561 Marionette TRACE 400 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"}]
12:44:12 INFO - 1499715852563 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"
12:44:12 INFO - 1499715852565 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"
12:44:12 INFO - 1499715852566 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"
12:44:12 INFO - 1499715852575 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"
12:44:12 INFO - 1499715852577 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"
12:44:12 INFO - 1499715852584 Marionette TRACE 400 <- [1,2,null,{}]
12:44:12 INFO - 1499715852588 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
12:44:12 INFO - 1499715852594 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"72594a46-f929-4c16-8731-05b5e87b4ba8","ELEMENT":"72594a46-f929-4c16-8731-05b5e87b4ba8"}}]
12:44:12 INFO - 1499715852595 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"72594a46-f929-4c16-8731-05b5e87b4ba8"}]
12:44:12 INFO - 1499715852621 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
12:44:12 INFO - 1499715852622 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"72594a46-f929-4c16-8731-05b5e87b4ba8"}]
12:44:12 INFO - 1499715852639 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element