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:393:12\nclickElement@chrome://marionette/content/listener.js:1330:5\n"},null]
20:01:05 INFO - 1498878065322 Marionette TRACE 359 -> [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}]
20:01:05 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1498878065327 Marionette TRACE 359 <- [1,5,null,{"value":null}]
20:01:05 INFO - 1498878065328 Marionette TRACE 359 -> [0,6,"deleteSession",{}]
20:01:05 INFO - 1498878065330 Marionette TRACE 359 <- [1,6,null,{}]
20:01:05 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 152ms
20:01:05 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
20:01:05 INFO - 1498878065332 Marionette DEBUG Closed connection 359
20:01:05 INFO - 1498878065333 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49684
20:01:05 INFO - 1498878065334 Marionette DEBUG Closed connection 360
20:01:05 INFO - 1498878065335 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49685
20:01:05 INFO - 1498878065336 Marionette TRACE 361 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
20:01:05 INFO - 1498878065337 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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}
20:01:05 INFO - 1498878065340 Marionette DEBUG Register listener.js for window 7
20:01:05 INFO - 1498878065343 Marionette TRACE 361 <- [1,1,null,{"sessionId":"6f0d8385-8724-4279-802b-ea57e4f98e21","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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}}]
20:01:05 INFO - 1498878065344 Marionette TRACE 361 -> [0,2,"setTimeouts",{"script":30000}]
20:01:05 INFO - 1498878065345 Marionette TRACE 361 <- [1,2,null,{}]
20:01:05 INFO - 1498878065346 Marionette TRACE 361 -> [0,3,"setTimeouts",{"pageLoad":300000}]
20:01:05 INFO - 1498878065346 Marionette TRACE 361 <- [1,3,null,{}]
20:01:05 INFO - 1498878065347 Marionette TRACE 361 -> [0,4,"setTimeouts",{"implicit":0}]
20:01:05 INFO - 1498878065348 Marionette TRACE 361 <- [1,4,null,{}]
20:01:05 INFO - 1498878065349 Marionette TRACE 361 -> [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}]
20:01:05 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1498878065352 Marionette TRACE 361 <- [1,5,null,{"value":null}]
20:01:05 INFO - 1498878065353 Marionette TRACE 361 -> [0,6,"deleteSession",{}]
20:01:05 INFO - 1498878065354 Marionette TRACE 361 <- [1,6,null,{}]
20:01:05 INFO - 1498878065357 Marionette DEBUG Closed connection 361
20:01:05 INFO - 1498878065357 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49686
20:01:05 INFO - 1498878065358 Marionette DEBUG Closed connection 362
20:01:05 INFO - 1498878065359 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49687
20:01:05 INFO - 1498878065360 Marionette TRACE 363 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
20:01:05 INFO - 1498878065360 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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}
20:01:05 INFO - 1498878065363 Marionette DEBUG Register listener.js for window 7
20:01:05 INFO - 1498878065367 Marionette TRACE 363 <- [1,1,null,{"sessionId":"02cc8db7-a9f7-4fcf-a433-886e4efb6314","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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}}]
20:01:05 INFO - 1498878065368 Marionette TRACE 363 -> [0,2,"deleteSession",{}]
20:01:05 INFO - 1498878065369 Marionette TRACE 363 <- [1,2,null,{}]
20:01:05 INFO - 1498878065371 Marionette DEBUG Closed connection 363
20:01:05 INFO - 1498878065372 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49688
20:01:05 INFO - 1498878065373 Marionette DEBUG Closed connection 364
20:01:05 INFO - 1498878065373 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49689
20:01:05 INFO - 1498878065374 Marionette TRACE 365 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
20:01:05 INFO - 1498878065375 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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}
20:01:05 INFO - 1498878065378 Marionette DEBUG Register listener.js for window 7
20:01:05 INFO - 1498878065381 Marionette TRACE 365 <- [1,1,null,{"sessionId":"3eda603f-bb6f-4837-a1e6-160a8fa6708a","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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}}]
20:01:05 INFO - 1498878065382 Marionette TRACE 365 -> [0,2,"get",{"url":"http://127.0.0.1:49291/clicks.html"}]
20:01:05 INFO - 1498878065383 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49291/hidden.html"
20:01:05 INFO - 1498878065389 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49291/hidden.html"
20:01:05 INFO - 1498878065389 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49291/hidden.html"
20:01:05 INFO - 1498878065411 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49291/clicks.html"
20:01:05 INFO - 1498878065413 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49291/clicks.html"
20:01:05 INFO - 1498878065417 Marionette TRACE 365 <- [1,2,null,{}]
20:01:05 INFO - 1498878065425 Marionette TRACE 365 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
20:01:05 INFO - 1498878065427 Marionette TRACE 365 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a6f85f59-b452-4d22-b4da-daecbb7df98d","ELEMENT":"a6f85f59-b452-4d22-b4da-daecbb7df98d"}}]
20:01:05 INFO - 1498878065429 Marionette TRACE 365 -> [0,4,"clickElement",{"id":"a6f85f59-b452-4d22-b4da-daecbb7df98d"}]
20:01:05 INFO - 1498878065473 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49291/clicks.html"
20:01:05 INFO - 1498878065480 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49291/clicks.html"
20:01:05 INFO - 1498878065481 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49291/clicks.html"
20:01:05 INFO - 1498878065525 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49291/test.html"
20:01:05 INFO - 1498878065529 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49291/test.html"
20:01:05 INFO - 1498878065533 Marionette TRACE 365 <- [1,4,null,{}]
20:01:05 INFO - 1498878065539 Marionette TRACE 365 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
20:01:05 INFO - 1498878065542 Marionette TRACE 365 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"edbd3619-5e30-4ea6-92d6-c437ede83853","ELEMENT":"edbd3619-5e30-4ea6-92d6-c437ede83853"}}]
20:01:05 INFO - 1498878065544 Marionette TRACE 365 -> [0,6,"getTitle",{}]
20:01:05 INFO - 1498878065545 Marionette TRACE 365 <- [1,6,null,{"value":"Marionette Test"}]
20:01:05 INFO - 1498878065547 Marionette TRACE 365 -> [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}]
20:01:05 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1498878065549 Marionette TRACE 365 <- [1,7,null,{"value":null}]
20:01:05 INFO - 1498878065550 Marionette TRACE 365 -> [0,8,"deleteSession",{}]
20:01:05 INFO - 1498878065552 Marionette TRACE 365 <- [1,8,null,{}]
20:01:05 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 222ms
20:01:05 INFO - TEST-START | test_click.py TestClick.test_container_element
20:01:05 INFO - 1498878065555 Marionette DEBUG Closed connection 365
20:01:05 INFO - 1498878065555 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49692
20:01:05 INFO - 1498878065556 Marionette DEBUG Closed connection 366
20:01:05 INFO - 1498878065557 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49693
20:01:05 INFO - 1498878065558 Marionette TRACE 367 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
20:01:05 INFO - 1498878065559 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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}
20:01:05 INFO - 1498878065562 Marionette DEBUG Register listener.js for window 7
20:01:05 INFO - 1498878065565 Marionette TRACE 367 <- [1,1,null,{"sessionId":"5ab9a7c8-e431-49fa-9f0e-f8f47a4814d5","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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}}]
20:01:05 INFO - 1498878065566 Marionette TRACE 367 -> [0,2,"setTimeouts",{"script":30000}]
20:01:05 INFO - 1498878065567 Marionette TRACE 367 <- [1,2,null,{}]
20:01:05 INFO - 1498878065569 Marionette TRACE 367 -> [0,3,"setTimeouts",{"pageLoad":300000}]
20:01:05 INFO - 1498878065570 Marionette TRACE 367 <- [1,3,null,{}]
20:01:05 INFO - 1498878065571 Marionette TRACE 367 -> [0,4,"setTimeouts",{"implicit":0}]
20:01:05 INFO - 1498878065571 Marionette TRACE 367 <- [1,4,null,{}]
20:01:05 INFO - 1498878065573 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')","sandbox":"simpletest","line":316}]
20:01:05 INFO - TEST-START: test_click.py TestClick.test_container_element1498878065575 Marionette TRACE 367 <- [1,5,null,{"value":null}]
20:01:05 INFO - 1498878065577 Marionette TRACE 367 -> [0,6,"deleteSession",{}]
20:01:05 INFO - 1498878065578 Marionette TRACE 367 <- [1,6,null,{}]
20:01:05 INFO - 1498878065581 Marionette DEBUG Closed connection 367
20:01:05 INFO - 1498878065582 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49694
20:01:05 INFO - 1498878065583 Marionette DEBUG Closed connection 368
20:01:05 INFO - 1498878065583 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49695
20:01:05 INFO - 1498878065586 Marionette TRACE 369 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
20:01:05 INFO - 1498878065586 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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}
20:01:05 INFO - 1498878065589 Marionette DEBUG Register listener.js for window 7
20:01:05 INFO - 1498878065593 Marionette TRACE 369 <- [1,1,null,{"sessionId":"ceca83a2-cae4-4ef8-971b-7e84c215601d","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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}}]
20:01:05 INFO - 1498878065595 Marionette TRACE 369 -> [0,2,"deleteSession",{}]
20:01:05 INFO - 1498878065596 Marionette TRACE 369 <- [1,2,null,{}]
20:01:05 INFO - 1498878065598 Marionette DEBUG Closed connection 369
20:01:05 INFO - 1498878065599 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49696
20:01:05 INFO - 1498878065600 Marionette DEBUG Closed connection 370
20:01:05 INFO - 1498878065602 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49697
20:01:05 INFO - 1498878065603 Marionette TRACE 371 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
20:01:05 INFO - 1498878065604 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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}
20:01:05 INFO - 1498878065607 Marionette DEBUG Register listener.js for window 7
20:01:05 INFO - 1498878065610 Marionette TRACE 371 <- [1,1,null,{"sessionId":"094398d9-9810-4a7d-acd4-5feb50ad9106","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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}}]
20:01:05 INFO - 1498878065612 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%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"}]
20:01:05 INFO - 1498878065614 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49291/test.html"
20:01:05 INFO - 1498878065616 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49291/test.html"
20:01:05 INFO - 1498878065616 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49291/test.html"
20:01:05 INFO - 1498878065646 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"
20:01:05 INFO - 1498878065652 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"
20:01:05 INFO - 1498878065660 Marionette TRACE 371 <- [1,2,null,{}]
20:01:05 INFO - 1498878065662 Marionette TRACE 371 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
20:01:05 INFO - 1498878065664 Marionette TRACE 371 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"ed1dfdd5-c84d-4e39-81cf-595a5b0b15e2","ELEMENT":"ed1dfdd5-c84d-4e39-81cf-595a5b0b15e2"}}]
20:01:05 INFO - 1498878065665 Marionette TRACE 371 -> [0,4,"clickElement",{"id":"ed1dfdd5-c84d-4e39-81cf-595a5b0b15e2"}]
20:01:05 INFO - 1498878065916 Marionette DEBUG Canceled page load listener because no navigation has been detected
20:01:05 INFO - 1498878065917 Marionette TRACE 371 <- [1,4,null,{}]
20:01:05 INFO - 1498878065918 Marionette TRACE 371 -> [0,5,"getElementProperty",{"id":"ed1dfdd5-c84d-4e39-81cf-595a5b0b15e2","name":"selected"}]
20:01:05 INFO - 1498878065932 Marionette TRACE 371 <- [1,5,null,{"value":true}]
20:01:05 INFO - 1498878065960 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')","sandbox":"simpletest","line":328}]
20:01:05 INFO - TEST-END: test_click.py TestClick.test_container_element1498878065963 Marionette TRACE 371 <- [1,6,null,{"value":null}]
20:01:05 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 424ms
20:01:05 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
20:01:05 INFO - 1498878065975 Marionette TRACE 371 -> [0,7,"deleteSession",{}]
20:01:05 INFO - 1498878065976 Marionette TRACE 371 <- [1,7,null,{}]
20:01:05 INFO - 1498878065979 Marionette DEBUG Closed connection 371
20:01:05 INFO - 1498878065980 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49698
20:01:05 INFO - 1498878065981 Marionette DEBUG Closed connection 372
20:01:05 INFO - 1498878065981 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49699
20:01:05 INFO - 1498878065982 Marionette TRACE 373 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
20:01:05 INFO - 1498878065983 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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}
20:01:05 INFO - 1498878065986 Marionette DEBUG Register listener.js for window 7
20:01:05 INFO - 1498878065990 Marionette TRACE 373 <- [1,1,null,{"sessionId":"4c93542f-a258-4097-a761-918d3b5f7cbb","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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}}]
20:01:05 INFO - 1498878065991 Marionette TRACE 373 -> [0,2,"setTimeouts",{"script":30000}]
20:01:05 INFO - 1498878065992 Marionette TRACE 373 <- [1,2,null,{}]
20:01:05 INFO - 1498878065992 Marionette TRACE 373 -> [0,3,"setTimeouts",{"pageLoad":300000}]
20:01:05 INFO - 1498878065993 Marionette TRACE 373 <- [1,3,null,{}]
20:01:05 INFO - 1498878065994 Marionette TRACE 373 -> [0,4,"setTimeouts",{"implicit":0}]
20:01:05 INFO - 1498878065994 Marionette TRACE 373 <- [1,4,null,{}]
20:01:05 INFO - 1498878065996 Marionette TRACE 373 -> [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}]
20:01:06 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1498878065999 Marionette TRACE 373 <- [1,5,null,{"value":null}]
20:01:06 INFO - 1498878066000 Marionette TRACE 373 -> [0,6,"deleteSession",{}]
20:01:06 INFO - 1498878066001 Marionette TRACE 373 <- [1,6,null,{}]
20:01:06 INFO - 1498878066003 Marionette DEBUG Closed connection 373
20:01:06 INFO - 1498878066004 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49700
20:01:06 INFO - 1498878066005 Marionette DEBUG Closed connection 374
20:01:06 INFO - 1498878066005 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49701
20:01:06 INFO - 1498878066006 Marionette TRACE 375 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
20:01:06 INFO - 1498878066007 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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}
20:01:06 INFO - 1498878066010 Marionette DEBUG Register listener.js for window 7
20:01:06 INFO - 1498878066013 Marionette TRACE 375 <- [1,1,null,{"sessionId":"cd6dbb93-79b5-4802-b04c-59421a78c9f3","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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}}]
20:01:06 INFO - 1498878066014 Marionette TRACE 375 -> [0,2,"deleteSession",{}]
20:01:06 INFO - 1498878066015 Marionette TRACE 375 <- [1,2,null,{}]
20:01:06 INFO - 1498878066018 Marionette DEBUG Closed connection 375
20:01:06 INFO - 1498878066018 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49702
20:01:06 INFO - 1498878066019 Marionette DEBUG Closed connection 376
20:01:06 INFO - 1498878066020 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49703
20:01:06 INFO - 1498878066021 Marionette TRACE 377 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
20:01:06 INFO - 1498878066021 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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}
20:01:06 INFO - 1498878066024 Marionette DEBUG Register listener.js for window 7
20:01:06 INFO - 1498878066027 Marionette TRACE 377 <- [1,1,null,{"sessionId":"7c5a159f-7d41-461d-b21d-9c8ea3291f6a","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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}}]
20:01:06 INFO - 1498878066029 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%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"}]
20:01:06 INFO - 1498878066030 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"
20:01:06 INFO - 1498878066033 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"
20:01:06 INFO - 1498878066034 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"
20:01:06 INFO - 1498878066056 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"
20:01:06 INFO - 1498878066058 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"
20:01:06 INFO - 1498878066061 Marionette TRACE 377 <- [1,2,null,{}]
20:01:06 INFO - 1498878066062 Marionette TRACE 377 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
20:01:06 INFO - 1498878066064 Marionette TRACE 377 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"12e9eb8c-6615-459d-94b6-98fbc8f8a337","ELEMENT":"12e9eb8c-6615-459d-94b6-98fbc8f8a337"}}]
20:01:06 INFO - 1498878066065 Marionette TRACE 377 -> [0,4,"clickElement",{"id":"12e9eb8c-6615-459d-94b6-98fbc8f8a337"}]
20:01:06 INFO - 1498878066317 Marionette DEBUG Canceled page load listener because no navigation has been detected
20:01:06 INFO - 1498878066318 Marionette TRACE 377 <- [1,4,null,{}]
20:01:06 INFO - 1498878066319 Marionette TRACE 377 -> [0,5,"getElementProperty",{"id":"12e9eb8c-6615-459d-94b6-98fbc8f8a337","name":"selected"}]
20:01:06 INFO - 1498878066323 Marionette TRACE 377 <- [1,5,null,{"value":true}]
20:01:06 INFO - 1498878066325 Marionette TRACE 377 -> [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}]
20:01:06 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1498878066328 Marionette TRACE 377 <- [1,6,null,{"value":null}]
20:01:06 INFO - 1498878066328 Marionette TRACE 377 -> [0,7,"deleteSession",{}]
20:01:06 INFO - 1498878066330 Marionette TRACE 377 <- [1,7,null,{}]
20:01:06 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 354ms
20:01:06 INFO - TEST-START | test_click.py TestClick.test_css_transforms
20:01:06 INFO - 1498878066332 Marionette DEBUG Closed connection 377
20:01:06 INFO - 1498878066333 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49704
20:01:06 INFO - 1498878066334 Marionette DEBUG Closed connection 378
20:01:06 INFO - 1498878066334 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49705
20:01:06 INFO - 1498878066336 Marionette TRACE 379 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
20:01:06 INFO - 1498878066336 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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}
20:01:06 INFO - 1498878066339 Marionette DEBUG Register listener.js for window 7
20:01:06 INFO - 1498878066343 Marionette TRACE 379 <- [1,1,null,{"sessionId":"a2e838b9-8f68-4171-823d-cff774153aeb","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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}}]
20:01:06 INFO - 1498878066344 Marionette TRACE 379 -> [0,2,"setTimeouts",{"script":30000}]
20:01:06 INFO - 1498878066344 Marionette TRACE 379 <- [1,2,null,{}]
20:01:06 INFO - 1498878066345 Marionette TRACE 379 -> [0,3,"setTimeouts",{"pageLoad":300000}]
20:01:06 INFO - 1498878066346 Marionette TRACE 379 <- [1,3,null,{}]
20:01:06 INFO - 1498878066347 Marionette TRACE 379 -> [0,4,"setTimeouts",{"implicit":0}]
20:01:06 INFO - 1498878066347 Marionette TRACE 379 <- [1,4,null,{}]
20:01:06 INFO - 1498878066349 Marionette TRACE 379 -> [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}]
20:01:06 INFO - TEST-START: test_click.py TestClick.test_css_transforms1498878066352 Marionette TRACE 379 <- [1,5,null,{"value":null}]
20:01:06 INFO - 1498878066353 Marionette TRACE 379 -> [0,6,"deleteSession",{}]
20:01:06 INFO - 1498878066354 Marionette TRACE 379 <- [1,6,null,{}]
20:01:06 INFO - 1498878066356 Marionette DEBUG Closed connection 379
20:01:06 INFO - 1498878066357 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49706
20:01:06 INFO - 1498878066358 Marionette DEBUG Closed connection 380
20:01:06 INFO - 1498878066358 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49707
20:01:06 INFO - 1498878066360 Marionette TRACE 381 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
20:01:06 INFO - 1498878066360 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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}
20:01:06 INFO - 1498878066363 Marionette DEBUG Register listener.js for window 7
20:01:06 INFO - 1498878066373 Marionette TRACE 381 <- [1,1,null,{"sessionId":"6a759c39-31cd-4921-bb43-76d91111baf9","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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}}]
20:01:06 INFO - 1498878066374 Marionette TRACE 381 -> [0,2,"deleteSession",{}]
20:01:06 INFO - 1498878066375 Marionette TRACE 381 <- [1,2,null,{}]
20:01:06 INFO - 1498878066378 Marionette DEBUG Closed connection 381
20:01:06 INFO - 1498878066379 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49708
20:01:06 INFO - 1498878066380 Marionette DEBUG Closed connection 382
20:01:06 INFO - 1498878066380 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49709
20:01:06 INFO - 1498878066381 Marionette TRACE 383 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
20:01:06 INFO - 1498878066382 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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}
20:01:06 INFO - 1498878066385 Marionette DEBUG Register listener.js for window 7
20:01:06 INFO - 1498878066388 Marionette TRACE 383 <- [1,1,null,{"sessionId":"80e6b335-f6a9-4159-b94b-61bded5d6b68","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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}}]
20:01:06 INFO - 1498878066390 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%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"}]
20:01:06 INFO - 1498878066391 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"
20:01:06 INFO - 1498878066393 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"
20:01:06 INFO - 1498878066394 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"
20:01:06 INFO - 1498878066412 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"
20:01:06 INFO - 1498878066415 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"
20:01:06 INFO - 1498878066419 Marionette TRACE 383 <- [1,2,null,{}]
20:01:06 INFO - 1498878066425 Marionette TRACE 383 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
20:01:06 INFO - 1498878066428 Marionette TRACE 383 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"9261261f-776a-4862-a1c5-db9eda0e86ae","ELEMENT":"9261261f-776a-4862-a1c5-db9eda0e86ae"}}]
20:01:06 INFO - 1498878066429 Marionette TRACE 383 -> [0,4,"clickElement",{"id":"9261261f-776a-4862-a1c5-db9eda0e86ae"}]
20:01:06 INFO - 1498878066671 Marionette DEBUG Canceled page load listener because no navigation has been detected
20:01:06 INFO - 1498878066672 Marionette TRACE 383 <- [1,4,null,{}]
20:01:06 INFO - 1498878066673 Marionette TRACE 383 -> [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}]
20:01:06 INFO - TEST-END: test_click.py TestClick.test_css_transforms1498878066676 Marionette TRACE 383 <- [1,5,null,{"value":null}]
20:01:06 INFO - 1498878066677 Marionette TRACE 383 -> [0,6,"deleteSession",{}]
20:01:06 INFO - 1498878066678 Marionette TRACE 383 <- [1,6,null,{}]
20:01:06 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 348ms
20:01:06 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
20:01:06 INFO - 1498878066681 Marionette DEBUG Closed connection 383
20:01:06 INFO - 1498878066681 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49710
20:01:06 INFO - 1498878066682 Marionette DEBUG Closed connection 384
20:01:06 INFO - 1498878066683 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49711
20:01:06 INFO - 1498878066684 Marionette TRACE 385 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
20:01:06 INFO - 1498878066685 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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}
20:01:06 INFO - 1498878066688 Marionette DEBUG Register listener.js for window 7
20:01:06 INFO - 1498878066691 Marionette TRACE 385 <- [1,1,null,{"sessionId":"6ad5f292-d42d-4f64-8e18-fa27ce9b946b","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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}}]
20:01:06 INFO - 1498878066692 Marionette TRACE 385 -> [0,2,"setTimeouts",{"script":30000}]
20:01:06 INFO - 1498878066693 Marionette TRACE 385 <- [1,2,null,{}]
20:01:06 INFO - 1498878066694 Marionette TRACE 385 -> [0,3,"setTimeouts",{"pageLoad":300000}]
20:01:06 INFO - 1498878066694 Marionette TRACE 385 <- [1,3,null,{}]
20:01:06 INFO - 1498878066695 Marionette TRACE 385 -> [0,4,"setTimeouts",{"implicit":0}]
20:01:06 INFO - 1498878066695 Marionette TRACE 385 <- [1,4,null,{}]
20:01:06 INFO - 1498878066697 Marionette TRACE 385 -> [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}]
20:01:06 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1498878066700 Marionette TRACE 385 <- [1,5,null,{"value":null}]
20:01:06 INFO - 1498878066701 Marionette TRACE 385 -> [0,6,"deleteSession",{}]
20:01:06 INFO - 1498878066702 Marionette TRACE 385 <- [1,6,null,{}]
20:01:06 INFO - 1498878066704 Marionette DEBUG Closed connection 385
20:01:06 INFO - 1498878066705 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49712
20:01:06 INFO - 1498878066706 Marionette DEBUG Closed connection 386
20:01:06 INFO - 1498878066706 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49713
20:01:06 INFO - 1498878066707 Marionette TRACE 387 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
20:01:06 INFO - 1498878066708 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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}
20:01:06 INFO - 1498878066711 Marionette DEBUG Register listener.js for window 7
20:01:06 INFO - 1498878066714 Marionette TRACE 387 <- [1,1,null,{"sessionId":"1e87ee0b-8e4f-448a-9961-221f2bd8d3f3","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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}}]
20:01:06 INFO - 1498878066715 Marionette TRACE 387 -> [0,2,"deleteSession",{}]
20:01:06 INFO - 1498878066717 Marionette TRACE 387 <- [1,2,null,{}]
20:01:06 INFO - 1498878066719 Marionette DEBUG Closed connection 387
20:01:06 INFO - 1498878066719 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49714
20:01:06 INFO - 1498878066720 Marionette DEBUG Closed connection 388
20:01:06 INFO - 1498878066721 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49715
20:01:06 INFO - 1498878066722 Marionette TRACE 389 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
20:01:06 INFO - 1498878066723 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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}
20:01:06 INFO - 1498878066725 Marionette DEBUG Register listener.js for window 7
20:01:06 INFO - 1498878066729 Marionette TRACE 389 <- [1,1,null,{"sessionId":"e478e74b-8241-412e-b76f-11c548e7633e","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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}}]
20:01:06 INFO - 1498878066730 Marionette TRACE 389 -> [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"}]
20:01:06 INFO - 1498878066731 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"
20:01:06 INFO - 1498878066733 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"
20:01:06 INFO - 1498878066734 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"
20:01:06 INFO - 1498878066756 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"
20:01:06 INFO - 1498878066758 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"
20:01:06 INFO - 1498878066762 Marionette TRACE 389 <- [1,2,null,{}]
20:01:06 INFO - 1498878066763 Marionette TRACE 389 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
20:01:06 INFO - 1498878066765 Marionette TRACE 389 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"7dd6af66-70ce-4ff6-bd48-c99715aeb23e","ELEMENT":"7dd6af66-70ce-4ff6-bd48-c99715aeb23e"}}]
20:01:06 INFO - 1498878066766 Marionette TRACE 389 -> [0,4,"clickElement",{"id":"7dd6af66-70ce-4ff6-bd48-c99715aeb23e"}]
20:01:07 INFO - 1498878067022 Marionette DEBUG Canceled page load listener because no navigation has been detected
20:01:07 INFO - 1498878067023 Marionette TRACE 389 <- [1,4,null,{}]
20:01:07 INFO - 1498878067025 Marionette TRACE 389 -> [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}]
20:01:07 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1498878067027 Marionette TRACE 389 <- [1,5,null,{"value":null}]
20:01:07 INFO - 1498878067028 Marionette TRACE 389 -> [0,6,"deleteSession",{}]
20:01:07 INFO - 1498878067030 Marionette TRACE 389 <- [1,6,null,{}]
20:01:07 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 351ms
20:01:07 INFO - TEST-START | test_click.py TestClick.test_input_file
20:01:07 INFO - 1498878067032 Marionette DEBUG Closed connection 389
20:01:07 INFO - 1498878067033 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49716
20:01:07 INFO - 1498878067034 Marionette DEBUG Closed connection 390
20:01:07 INFO - 1498878067034 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49717
20:01:07 INFO - 1498878067035 Marionette TRACE 391 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
20:01:07 INFO - 1498878067036 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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}
20:01:07 INFO - 1498878067039 Marionette DEBUG Register listener.js for window 7
20:01:07 INFO - 1498878067042 Marionette TRACE 391 <- [1,1,null,{"sessionId":"3bf5fcd4-2456-4268-a598-8430df4898b7","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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}}]
20:01:07 INFO - 1498878067043 Marionette TRACE 391 -> [0,2,"setTimeouts",{"script":30000}]
20:01:07 INFO - 1498878067043 Marionette TRACE 391 <- [1,2,null,{}]
20:01:07 INFO - 1498878067044 Marionette TRACE 391 -> [0,3,"setTimeouts",{"pageLoad":300000}]
20:01:07 INFO - 1498878067044 Marionette TRACE 391 <- [1,3,null,{}]
20:01:07 INFO - 1498878067045 Marionette TRACE 391 -> [0,4,"setTimeouts",{"implicit":0}]
20:01:07 INFO - 1498878067046 Marionette TRACE 391 <- [1,4,null,{}]
20:01:07 INFO - 1498878067047 Marionette TRACE 391 -> [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}]
20:01:07 INFO - TEST-START: test_click.py TestClick.test_input_file1498878067050 Marionette TRACE 391 <- [1,5,null,{"value":null}]
20:01:07 INFO - 1498878067051 Marionette TRACE 391 -> [0,6,"deleteSession",{}]
20:01:07 INFO - 1498878067052 Marionette TRACE 391 <- [1,6,null,{}]
20:01:07 INFO - 1498878067054 Marionette DEBUG Closed connection 391
20:01:07 INFO - 1498878067055 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49718
20:01:07 INFO - 1498878067056 Marionette DEBUG Closed connection 392
20:01:07 INFO - 1498878067056 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49719
20:01:07 INFO - 1498878067057 Marionette TRACE 393 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
20:01:07 INFO - 1498878067058 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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}
20:01:07 INFO - 1498878067060 Marionette DEBUG Register listener.js for window 7
20:01:07 INFO - 1498878067064 Marionette TRACE 393 <- [1,1,null,{"sessionId":"7f07f51d-fc94-404e-a75d-73aecec6327b","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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}}]
20:01:07 INFO - 1498878067065 Marionette TRACE 393 -> [0,2,"deleteSession",{}]
20:01:07 INFO - 1498878067066 Marionette TRACE 393 <- [1,2,null,{}]
20:01:07 INFO - 1498878067068 Marionette DEBUG Closed connection 393
20:01:07 INFO - 1498878067069 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49720
20:01:07 INFO - 1498878067070 Marionette DEBUG Closed connection 394
20:01:07 INFO - 1498878067070 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49721
20:01:07 INFO - 1498878067071 Marionette TRACE 395 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
20:01:07 INFO - 1498878067072 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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}
20:01:07 INFO - 1498878067075 Marionette DEBUG Register listener.js for window 7
20:01:07 INFO - 1498878067078 Marionette TRACE 395 <- [1,1,null,{"sessionId":"34ef4b99-5f25-4360-890c-e1c7596afb1b","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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}}]
20:01:07 INFO - 1498878067079 Marionette TRACE 395 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
20:01:07 INFO - 1498878067080 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"
20:01:07 INFO - 1498878067083 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"
20:01:07 INFO - 1498878067083 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"
20:01:07 INFO - 1498878067106 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
20:01:07 INFO - 1498878067108 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
20:01:07 INFO - 1498878067111 Marionette TRACE 395 <- [1,2,null,{}]
20:01:07 INFO - 1498878067113 Marionette TRACE 395 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
20:01:07 INFO - 1498878067116 Marionette TRACE 395 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"154f373d-9e97-4059-9e2f-7dc7ceedc7aa","ELEMENT":"154f373d-9e97-4059-9e2f-7dc7ceedc7aa"}}]
20:01:07 INFO - 1498878067123 Marionette TRACE 395 -> [0,4,"clickElement",{"id":"154f373d-9e97-4059-9e2f-7dc7ceedc7aa"}]
20:01:07 INFO - 1498878067151 Marionette TRACE 395 <- [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:393:12\nclickElement@chrome://marionette/content/listener.js:1330:5\n"},null]
20:01:07 INFO - 1498878067153 Marionette TRACE 395 -> [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}]
20:01:07 INFO - TEST-END: test_click.py TestClick.test_input_file1498878067156 Marionette TRACE 395 <- [1,5,null,{"value":null}]
20:01:07 INFO - 1498878067157 Marionette TRACE 395 -> [0,6,"deleteSession",{}]
20:01:07 INFO - 1498878067158 Marionette TRACE 395 <- [1,6,null,{}]
20:01:07 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 128ms
20:01:07 INFO - TEST-START | test_click.py TestClick.test_obscured_element
20:01:07 INFO - 1498878067160 Marionette DEBUG Closed connection 395
20:01:07 INFO - 1498878067161 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49722
20:01:07 INFO - 1498878067162 Marionette DEBUG Closed connection 396
20:01:07 INFO - 1498878067163 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49723
20:01:07 INFO - 1498878067164 Marionette TRACE 397 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
20:01:07 INFO - 1498878067165 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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}
20:01:07 INFO - 1498878067167 Marionette DEBUG Register listener.js for window 7
20:01:07 INFO - 1498878067171 Marionette TRACE 397 <- [1,1,null,{"sessionId":"75356eeb-7698-4aff-ac94-6249d5d568b4","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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}}]
20:01:07 INFO - 1498878067172 Marionette TRACE 397 -> [0,2,"setTimeouts",{"script":30000}]
20:01:07 INFO - 1498878067173 Marionette TRACE 397 <- [1,2,null,{}]
20:01:07 INFO - 1498878067174 Marionette TRACE 397 -> [0,3,"setTimeouts",{"pageLoad":300000}]
20:01:07 INFO - 1498878067174 Marionette TRACE 397 <- [1,3,null,{}]
20:01:07 INFO - 1498878067175 Marionette TRACE 397 -> [0,4,"setTimeouts",{"implicit":0}]
20:01:07 INFO - 1498878067176 Marionette TRACE 397 <- [1,4,null,{}]
20:01:07 INFO - 1498878067177 Marionette TRACE 397 -> [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}]
20:01:07 INFO - TEST-START: test_click.py TestClick.test_obscured_element1498878067180 Marionette TRACE 397 <- [1,5,null,{"value":null}]
20:01:07 INFO - 1498878067181 Marionette TRACE 397 -> [0,6,"deleteSession",{}]
20:01:07 INFO - 1498878067182 Marionette TRACE 397 <- [1,6,null,{}]
20:01:07 INFO - 1498878067185 Marionette DEBUG Closed connection 397
20:01:07 INFO - 1498878067185 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49724
20:01:07 INFO - 1498878067186 Marionette DEBUG Closed connection 398
20:01:07 INFO - 1498878067187 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49725
20:01:07 INFO - 1498878067188 Marionette TRACE 399 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
20:01:07 INFO - 1498878067188 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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}
20:01:07 INFO - 1498878067191 Marionette DEBUG Register listener.js for window 7
20:01:07 INFO - 1498878067194 Marionette TRACE 399 <- [1,1,null,{"sessionId":"25812783-c4a6-4c64-a9ca-79c5b8cae16d","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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}}]
20:01:07 INFO - 1498878067195 Marionette TRACE 399 -> [0,2,"deleteSession",{}]
20:01:07 INFO - 1498878067197 Marionette TRACE 399 <- [1,2,null,{}]
20:01:07 INFO - 1498878067199 Marionette DEBUG Closed connection 399
20:01:07 INFO - 1498878067199 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49726
20:01:07 INFO - 1498878067200 Marionette DEBUG Closed connection 400
20:01:07 INFO - 1498878067201 Marionette DEBUG Accepted connection 401 from 127.0.0.1:49727
20:01:07 INFO - 1498878067202 Marionette TRACE 401 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
20:01:07 INFO - 1498878067202 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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}
20:01:07 INFO - 1498878067205 Marionette DEBUG Register listener.js for window 7
20:01:07 INFO - 1498878067208 Marionette TRACE 401 <- [1,1,null,{"sessionId":"9ca6254f-348a-4cbf-9c47-d8d8479b84ce","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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}}]
20:01:07 INFO - 1498878067209 Marionette TRACE 401 -> [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"}]
20:01:07 INFO - 1498878067211 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
20:01:07 INFO - 1498878067213 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
20:01:07 INFO - 1498878067213 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
20:01:07 INFO - 1498878067232 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"
20:01:07 INFO - 1498878067236 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"
20:01:07 INFO - 1498878067244 Marionette TRACE 401 <- [1,2,null,{}]
20:01:07 INFO - 1498878067245 Marionette TRACE 401 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
20:01:07 INFO - 1498878067248 Marionette TRACE 401 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e5d2a6e5-81c8-4881-9c3f-5df958e98927","ELEMENT":"e5d2a6e5-81c8-4881-9c3f-5df958e98927"}}]
20:01:07 INFO - 1498878067248 Marionette TRACE 401 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
20:01:07 INFO - 1498878067251 Marionette TRACE 401 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"f7fdcc70-ccf6-4830-b49b-adec859cf4a2","ELEMENT":"f7fdcc70-ccf6-4830-b49b-adec859cf4a2"}}]
20:01:07 INFO - 1498878067253 Marionette TRACE 401 -> [0,5,"clickElement",{"id":"e5d2a6e5-81c8-4881-9c3f-5df958e98927"}]
20:01:07 INFO - 1498878067498 Marionette DEBUG Canceled page load listener because no navigation has been detected
20:01:07 INFO - 1498878067499 Marionette TRACE 401 <- [1,5,null,{}]
20:01:07 INFO - 1498878067500 Marionette TRACE 401 -> [0,6,"clickElement",{"id":"f7fdcc70-ccf6-4830-b49b-adec859cf4a2"}]
20:01:07 INFO - 1498878067517 Marionette TRACE 401 <- [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:393:12\nclickElement@chrome://marionette/content/listener.js:1330:5\n"},null]
20:01:07 INFO - 1498878067518 Marionette TRACE 401 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
20:01:07 INFO - 1498878067521 Marionette TRACE 401 <- [1,7,null,{"value":false}]
20:01:07 INFO - 1498878067522 Marionette TRACE 401 -> [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}]
20:01:07 INFO - TEST-END: test_click.py TestClick.test_obscured_element1498878067525 Marionette TRACE 401 <- [1,8,null,{"value":null}]
20:01:07 INFO - 1498878067526 Marionette TRACE 401 -> [0,9,"deleteSession",{}]
20:01:07 INFO - 1498878067527 Marionette TRACE 401 <- [1,9,null,{}]
20:01:07 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 368ms
20:01:07 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
20:01:07 INFO - 1498878067530 Marionette DEBUG Closed connection 401
20:01:07 INFO - 1498878067530 Marionette DEBUG Accepted connection 402 from 127.0.0.1:49728
20:01:07 INFO - 1498878067531 Marionette DEBUG Closed connection 402
20:01:07 INFO - 1498878067532 Marionette DEBUG Accepted connection 403 from 127.0.0.1:49729
20:01:07 INFO - 1498878067533 Marionette TRACE 403 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
20:01:07 INFO - 1498878067533 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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}
20:01:07 INFO - 1498878067536 Marionette DEBUG Register listener.js for window 7
20:01:07 INFO - 1498878067539 Marionette TRACE 403 <- [1,1,null,{"sessionId":"952b5b6b-adad-4fe2-a1ed-0b8ecb80d62e","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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}}]
20:01:07 INFO - 1498878067541 Marionette TRACE 403 -> [0,2,"setTimeouts",{"script":30000}]
20:01:07 INFO - 1498878067541 Marionette TRACE 403 <- [1,2,null,{}]
20:01:07 INFO - 1498878067542 Marionette TRACE 403 -> [0,3,"setTimeouts",{"pageLoad":300000}]
20:01:07 INFO - 1498878067543 Marionette TRACE 403 <- [1,3,null,{}]
20:01:07 INFO - 1498878067543 Marionette TRACE 403 -> [0,4,"setTimeouts",{"implicit":0}]
20:01:07 INFO - 1498878067544 Marionette TRACE 403 <- [1,4,null,{}]
20:01:07 INFO - 1498878067546 Marionette TRACE 403 -> [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}]
20:01:07 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1498878067548 Marionette TRACE 403 <- [1,5,null,{"value":null}]
20:01:07 INFO - 1498878067549 Marionette TRACE 403 -> [0,6,"deleteSession",{}]
20:01:07 INFO - 1498878067550 Marionette TRACE 403 <- [1,6,null,{}]
20:01:07 INFO - 1498878067552 Marionette DEBUG Closed connection 403
20:01:07 INFO - 1498878067553 Marionette DEBUG Accepted connection 404 from 127.0.0.1:49730
20:01:07 INFO - 1498878067554 Marionette DEBUG Closed connection 404
20:01:07 INFO - 1498878067554 Marionette DEBUG Accepted connection 405 from 127.0.0.1:49731
20:01:07 INFO - 1498878067555 Marionette TRACE 405 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
20:01:07 INFO - 1498878067556 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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}
20:01:07 INFO - 1498878067558 Marionette DEBUG Register listener.js for window 7
20:01:07 INFO - 1498878067562 Marionette TRACE 405 <- [1,1,null,{"sessionId":"c991ea62-424f-4f12-b052-5cb5155cd211","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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}}]
20:01:07 INFO - 1498878067563 Marionette TRACE 405 -> [0,2,"deleteSession",{}]
20:01:07 INFO - 1498878067564 Marionette TRACE 405 <- [1,2,null,{}]
20:01:07 INFO - 1498878067566 Marionette DEBUG Closed connection 405
20:01:07 INFO - 1498878067567 Marionette DEBUG Accepted connection 406 from 127.0.0.1:49732
20:01:07 INFO - 1498878067571 Marionette DEBUG Closed connection 406
20:01:07 INFO - 1498878067571 Marionette DEBUG Accepted connection 407 from 127.0.0.1:49733
20:01:07 INFO - 1498878067583 Marionette TRACE 407 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
20:01:07 INFO - 1498878067584 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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}
20:01:07 INFO - 1498878067587 Marionette DEBUG Register listener.js for window 7
20:01:07 INFO - 1498878067590 Marionette TRACE 407 <- [1,1,null,{"sessionId":"48f29593-7116-4b9b-8099-3c4a439a8455","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":316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-135.001\\AppData\\Local\\Temp\\tmpzc8ljn.mozrunner","moz:accessibilityChecks":false}}]
20:01:07 INFO - 1498878067600 Marionette TRACE 407 -> [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"}]
20:01:07 INFO - 1498878067602 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"
20:01:07 INFO - 1498878067604 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"
20:01:07 INFO - 1498878067605 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"
20:01:07 INFO - 1498878067626 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"
20:01:07 INFO - 1498878067628 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"
20:01:07 INFO - 1498878067631 Marionette TRACE 407 <- [1,2,null,{}]
20:01:07 INFO - 1498878067632 Marionette TRACE 407 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
20:01:07 INFO - 1498878067641 Marionette TRACE 407 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"27bbe161-9de0-4741-84d8-e2f8fca61530","ELEMENT":"27bbe161-9de0-4741-84d8-e2f8fca61530"}}]
20:01:07 INFO - 1498878067642 Marionette TRACE 407 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"27bbe161-9de0-4741-84d8-e2f8fca61530"}]
20:01:07 INFO - 1498878067674 Marionette TRACE 407 <- [1,4,null,{"value":"none"}]
20:01:07 INFO - 1498878067684 Marionette TRACE 407 -> [0,5,"clickElement",{"id":"27bbe161-9de0-4741-84d8-e2f8fca61530"}]
20:01:07 INFO - 1498878067704 Marionette TRACE 407 <- [1,5,{"error":"element click intercepted","message":"Element