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:1318:5\n"},null]
00:34:25 INFO - 1499240065510 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}]
00:34:25 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499240065512 Marionette TRACE 352 <- [1,5,null,{"value":null}]
00:34:25 INFO - 1499240065513 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
00:34:25 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 119ms
00:34:25 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
00:34:25 INFO - 1499240065514 Marionette TRACE 352 <- [1,6,null,{}]
00:34:25 INFO - 1499240065515 Marionette DEBUG Closed connection 352
00:34:25 INFO - 1499240065516 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49775
00:34:25 INFO - 1499240065517 Marionette DEBUG Closed connection 353
00:34:25 INFO - 1499240065517 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49776
00:34:25 INFO - 1499240065518 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:34:25 INFO - 1499240065519 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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}
00:34:25 INFO - 1499240065521 Marionette DEBUG Register listener.js for window 4294967297
00:34:25 INFO - 1499240065523 Marionette TRACE 354 <- [1,1,null,{"sessionId":"d7dd647d-7b80-4e66-b651-720a855649d9","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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}}]
00:34:25 INFO - 1499240065525 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
00:34:25 INFO - 1499240065525 Marionette TRACE 354 <- [1,2,null,{}]
00:34:25 INFO - 1499240065526 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
00:34:25 INFO - 1499240065526 Marionette TRACE 354 <- [1,3,null,{}]
00:34:25 INFO - 1499240065527 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
00:34:25 INFO - 1499240065527 Marionette TRACE 354 <- [1,4,null,{}]
00:34:25 INFO - 1499240065529 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}]
00:34:25 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499240065531 Marionette TRACE 354 <- [1,5,null,{"value":null}]
00:34:25 INFO - 1499240065532 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
00:34:25 INFO - 1499240065533 Marionette TRACE 354 <- [1,6,null,{}]
00:34:25 INFO - 1499240065535 Marionette DEBUG Closed connection 354
00:34:25 INFO - 1499240065535 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49777
00:34:25 INFO - 1499240065536 Marionette DEBUG Closed connection 355
00:34:25 INFO - 1499240065537 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49778
00:34:25 INFO - 1499240065537 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:34:25 INFO - 1499240065538 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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}
00:34:25 INFO - 1499240065540 Marionette DEBUG Register listener.js for window 4294967297
00:34:25 INFO - 1499240065543 Marionette TRACE 356 <- [1,1,null,{"sessionId":"d1792173-8079-4b24-90ee-f8b9ba0ac310","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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}}]
00:34:25 INFO - 1499240065544 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
00:34:25 INFO - 1499240065545 Marionette TRACE 356 <- [1,2,null,{}]
00:34:25 INFO - 1499240065546 Marionette DEBUG Closed connection 356
00:34:25 INFO - 1499240065546 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49779
00:34:25 INFO - 1499240065547 Marionette DEBUG Closed connection 357
00:34:25 INFO - 1499240065548 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49780
00:34:25 INFO - 1499240065549 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
00:34:25 INFO - 1499240065549 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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}
00:34:25 INFO - 1499240065551 Marionette DEBUG Register listener.js for window 4294967297
00:34:25 INFO - 1499240065554 Marionette TRACE 358 <- [1,1,null,{"sessionId":"6091d6d8-2dba-42cb-bb6e-387a18e9891b","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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}}]
00:34:25 INFO - 1499240065555 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49340/clicks.html"}]
00:34:25 INFO - 1499240065556 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49340/hidden.html"
00:34:25 INFO - 1499240065562 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49340/hidden.html"
00:34:25 INFO - 1499240065562 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49340/hidden.html"
00:34:25 INFO - 1499240065572 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49340/clicks.html"
00:34:25 INFO - 1499240065573 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49340/clicks.html"
00:34:25 INFO - 1499240065575 Marionette TRACE 358 <- [1,2,null,{}]
00:34:25 INFO - 1499240065579 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
00:34:25 INFO - 1499240065581 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"d40f8b62-d130-4110-abf1-c2ee6e62374e","ELEMENT":"d40f8b62-d130-4110-abf1-c2ee6e62374e"}}]
00:34:25 INFO - 1499240065582 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"d40f8b62-d130-4110-abf1-c2ee6e62374e"}]
00:34:25 INFO - 1499240065619 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49340/clicks.html"
00:34:25 INFO - 1499240065626 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49340/clicks.html"
00:34:25 INFO - 1499240065627 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49340/clicks.html"
00:34:25 INFO - 1499240065636 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49340/test.html"
00:34:25 INFO - 1499240065639 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49340/test.html"
00:34:25 INFO - 1499240065642 Marionette TRACE 358 <- [1,4,null,{}]
00:34:25 INFO - 1499240065645 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
00:34:25 INFO - 1499240065647 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"d71d9bd0-8aef-4ddf-8cbd-456d5fce35f2","ELEMENT":"d71d9bd0-8aef-4ddf-8cbd-456d5fce35f2"}}]
00:34:25 INFO - 1499240065648 Marionette TRACE 358 -> [0,6,"getTitle",{}]
00:34:25 INFO - 1499240065649 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
00:34:25 INFO - 1499240065650 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}]
00:34:25 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499240065655 Marionette TRACE 358 <- [1,7,null,{"value":null}]
00:34:25 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 142ms
00:34:25 INFO - 1499240065655 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
00:34:25 INFO - 1499240065657 Marionette TRACE 358 <- [1,8,null,{}]
00:34:25 INFO - TEST-START | test_click.py TestClick.test_container_element
00:34:25 INFO - 1499240065658 Marionette DEBUG Closed connection 358
00:34:25 INFO - 1499240065659 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49783
00:34:25 INFO - 1499240065660 Marionette DEBUG Closed connection 359
00:34:25 INFO - 1499240065660 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49784
00:34:25 INFO - 1499240065661 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:34:25 INFO - 1499240065661 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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}
00:34:25 INFO - 1499240065664 Marionette DEBUG Register listener.js for window 4294967297
00:34:25 INFO - 1499240065667 Marionette TRACE 360 <- [1,1,null,{"sessionId":"634193c1-02af-4abe-b2d1-711f314c31b0","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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}}]
00:34:25 INFO - 1499240065668 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
00:34:25 INFO - 1499240065669 Marionette TRACE 360 <- [1,2,null,{}]
00:34:25 INFO - 1499240065669 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
00:34:25 INFO - 1499240065670 Marionette TRACE 360 <- [1,3,null,{}]
00:34:25 INFO - 1499240065671 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
00:34:25 INFO - 1499240065671 Marionette TRACE 360 <- [1,4,null,{}]
00:34:25 INFO - 1499240065672 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}]
00:34:25 INFO - TEST-START: test_click.py TestClick.test_container_element1499240065675 Marionette TRACE 360 <- [1,5,null,{"value":null}]
00:34:25 INFO - 1499240065676 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
00:34:25 INFO - 1499240065677 Marionette TRACE 360 <- [1,6,null,{}]
00:34:25 INFO - 1499240065678 Marionette DEBUG Closed connection 360
00:34:25 INFO - 1499240065679 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49785
00:34:25 INFO - 1499240065679 Marionette DEBUG Closed connection 361
00:34:25 INFO - 1499240065680 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49786
00:34:25 INFO - 1499240065680 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:34:25 INFO - 1499240065681 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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}
00:34:25 INFO - 1499240065684 Marionette DEBUG Register listener.js for window 4294967297
00:34:25 INFO - 1499240065686 Marionette TRACE 362 <- [1,1,null,{"sessionId":"e76efa8a-1741-46b4-90c3-9c165f3ba0cd","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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}}]
00:34:25 INFO - 1499240065695 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
00:34:25 INFO - 1499240065697 Marionette TRACE 362 <- [1,2,null,{}]
00:34:25 INFO - 1499240065698 Marionette DEBUG Closed connection 362
00:34:25 INFO - 1499240065698 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49787
00:34:25 INFO - 1499240065699 Marionette DEBUG Closed connection 363
00:34:25 INFO - 1499240065700 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49788
00:34:25 INFO - 1499240065700 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
00:34:25 INFO - 1499240065701 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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}
00:34:25 INFO - 1499240065703 Marionette DEBUG Register listener.js for window 4294967297
00:34:25 INFO - 1499240065706 Marionette TRACE 364 <- [1,1,null,{"sessionId":"977bc8bb-df32-468e-bb7e-430b7e191d99","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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}}]
00:34:25 INFO - 1499240065707 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"}]
00:34:25 INFO - 1499240065709 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49340/test.html"
00:34:25 INFO - 1499240065710 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49340/test.html"
00:34:25 INFO - 1499240065710 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49340/test.html"
00:34:25 INFO - 1499240065716 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"
00:34:25 INFO - 1499240065719 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"
00:34:25 INFO - 1499240065727 Marionette TRACE 364 <- [1,2,null,{}]
00:34:25 INFO - 1499240065731 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
00:34:25 INFO - 1499240065733 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a89ae4e7-1b6b-4130-abb7-1bd38b03a442","ELEMENT":"a89ae4e7-1b6b-4130-abb7-1bd38b03a442"}}]
00:34:25 INFO - 1499240065737 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"a89ae4e7-1b6b-4130-abb7-1bd38b03a442"}]
00:34:25 INFO - 1499240065973 Marionette DEBUG Canceled page load listener because no navigation has been detected
00:34:25 INFO - 1499240065974 Marionette TRACE 364 <- [1,4,null,{}]
00:34:25 INFO - 1499240065975 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"a89ae4e7-1b6b-4130-abb7-1bd38b03a442","name":"selected"}]
00:34:25 INFO - 1499240065979 Marionette TRACE 364 <- [1,5,null,{"value":true}]
00:34:25 INFO - 1499240065980 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}]
00:34:25 INFO - TEST-END: test_click.py TestClick.test_container_element1499240065983 Marionette TRACE 364 <- [1,6,null,{"value":null}]
00:34:25 INFO - 1499240065984 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
00:34:25 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 328ms
00:34:25 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
00:34:25 INFO - 1499240065985 Marionette TRACE 364 <- [1,7,null,{}]
00:34:25 INFO - 1499240065986 Marionette DEBUG Closed connection 364
00:34:25 INFO - 1499240065987 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49789
00:34:25 INFO - 1499240065988 Marionette DEBUG Closed connection 365
00:34:25 INFO - 1499240065989 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49790
00:34:25 INFO - 1499240065990 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:34:25 INFO - 1499240065990 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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}
00:34:25 INFO - 1499240065992 Marionette DEBUG Register listener.js for window 4294967297
00:34:25 INFO - 1499240065995 Marionette TRACE 366 <- [1,1,null,{"sessionId":"ce34d803-387d-4fc7-9608-b660707527c1","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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}}]
00:34:25 INFO - 1499240065996 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
00:34:25 INFO - 1499240065996 Marionette TRACE 366 <- [1,2,null,{}]
00:34:25 INFO - 1499240065997 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
00:34:25 INFO - 1499240065997 Marionette TRACE 366 <- [1,3,null,{}]
00:34:26 INFO - 1499240065998 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
00:34:26 INFO - 1499240065998 Marionette TRACE 366 <- [1,4,null,{}]
00:34:26 INFO - 1499240065999 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}]
00:34:26 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499240066002 Marionette TRACE 366 <- [1,5,null,{"value":null}]
00:34:26 INFO - 1499240066003 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
00:34:26 INFO - 1499240066004 Marionette TRACE 366 <- [1,6,null,{}]
00:34:26 INFO - 1499240066005 Marionette DEBUG Closed connection 366
00:34:26 INFO - 1499240066005 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49791
00:34:26 INFO - 1499240066006 Marionette DEBUG Closed connection 367
00:34:26 INFO - 1499240066007 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49792
00:34:26 INFO - 1499240066007 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:34:26 INFO - 1499240066008 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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}
00:34:26 INFO - 1499240066010 Marionette DEBUG Register listener.js for window 4294967297
00:34:26 INFO - 1499240066013 Marionette TRACE 368 <- [1,1,null,{"sessionId":"dddcdb0c-2039-4248-b6c3-ac1b64a653f5","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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}}]
00:34:26 INFO - 1499240066014 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
00:34:26 INFO - 1499240066014 Marionette TRACE 368 <- [1,2,null,{}]
00:34:26 INFO - 1499240066016 Marionette DEBUG Closed connection 368
00:34:26 INFO - 1499240066016 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49793
00:34:26 INFO - 1499240066017 Marionette DEBUG Closed connection 369
00:34:26 INFO - 1499240066018 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49794
00:34:26 INFO - 1499240066019 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
00:34:26 INFO - 1499240066019 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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}
00:34:26 INFO - 1499240066021 Marionette DEBUG Register listener.js for window 4294967297
00:34:26 INFO - 1499240066024 Marionette TRACE 370 <- [1,1,null,{"sessionId":"73f55551-a54d-4b8f-9685-73befb86b20e","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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}}]
00:34:26 INFO - 1499240066025 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"}]
00:34:26 INFO - 1499240066026 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"
00:34:26 INFO - 1499240066028 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"
00:34:26 INFO - 1499240066028 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"
00:34:26 INFO - 1499240066033 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"
00:34:26 INFO - 1499240066036 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"
00:34:26 INFO - 1499240066041 Marionette TRACE 370 <- [1,2,null,{}]
00:34:26 INFO - 1499240066043 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
00:34:26 INFO - 1499240066046 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"66059f53-0255-427b-9707-82c7b78d925f","ELEMENT":"66059f53-0255-427b-9707-82c7b78d925f"}}]
00:34:26 INFO - 1499240066047 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"66059f53-0255-427b-9707-82c7b78d925f"}]
00:34:26 INFO - 1499240066301 Marionette DEBUG Canceled page load listener because no navigation has been detected
00:34:26 INFO - 1499240066302 Marionette TRACE 370 <- [1,4,null,{}]
00:34:26 INFO - 1499240066303 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"66059f53-0255-427b-9707-82c7b78d925f","name":"selected"}]
00:34:26 INFO - 1499240066306 Marionette TRACE 370 <- [1,5,null,{"value":true}]
00:34:26 INFO - 1499240066308 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}]
00:34:26 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499240066310 Marionette TRACE 370 <- [1,6,null,{"value":null}]
00:34:26 INFO - 1499240066311 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
00:34:26 INFO - 1499240066312 Marionette TRACE 370 <- [1,7,null,{}]
00:34:26 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 327ms
00:34:26 INFO - TEST-START | test_click.py TestClick.test_css_transforms
00:34:26 INFO - 1499240066313 Marionette DEBUG Closed connection 370
00:34:26 INFO - 1499240066315 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49795
00:34:26 INFO - 1499240066316 Marionette DEBUG Closed connection 371
00:34:26 INFO - 1499240066316 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49796
00:34:26 INFO - 1499240066317 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:34:26 INFO - 1499240066318 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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}
00:34:26 INFO - 1499240066320 Marionette DEBUG Register listener.js for window 4294967297
00:34:26 INFO - 1499240066323 Marionette TRACE 372 <- [1,1,null,{"sessionId":"2cc14e00-f8fc-4f74-831b-67d05d510396","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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}}]
00:34:26 INFO - 1499240066324 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
00:34:26 INFO - 1499240066324 Marionette TRACE 372 <- [1,2,null,{}]
00:34:26 INFO - 1499240066325 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
00:34:26 INFO - 1499240066325 Marionette TRACE 372 <- [1,3,null,{}]
00:34:26 INFO - 1499240066326 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
00:34:26 INFO - 1499240066327 Marionette TRACE 372 <- [1,4,null,{}]
00:34:26 INFO - 1499240066328 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}]
00:34:26 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499240066331 Marionette TRACE 372 <- [1,5,null,{"value":null}]
00:34:26 INFO - 1499240066332 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
00:34:26 INFO - 1499240066333 Marionette TRACE 372 <- [1,6,null,{}]
00:34:26 INFO - 1499240066334 Marionette DEBUG Closed connection 372
00:34:26 INFO - 1499240066335 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49797
00:34:26 INFO - 1499240066335 Marionette DEBUG Closed connection 373
00:34:26 INFO - 1499240066336 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49798
00:34:26 INFO - 1499240066337 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:34:26 INFO - 1499240066337 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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}
00:34:26 INFO - 1499240066339 Marionette DEBUG Register listener.js for window 4294967297
00:34:26 INFO - 1499240066342 Marionette TRACE 374 <- [1,1,null,{"sessionId":"d64fde29-fe3c-412f-9438-1a901edec707","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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}}]
00:34:26 INFO - 1499240066343 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
00:34:26 INFO - 1499240066344 Marionette TRACE 374 <- [1,2,null,{}]
00:34:26 INFO - 1499240066346 Marionette DEBUG Closed connection 374
00:34:26 INFO - 1499240066346 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49799
00:34:26 INFO - 1499240066347 Marionette DEBUG Closed connection 375
00:34:26 INFO - 1499240066347 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49800
00:34:26 INFO - 1499240066348 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
00:34:26 INFO - 1499240066349 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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}
00:34:26 INFO - 1499240066351 Marionette DEBUG Register listener.js for window 4294967297
00:34:26 INFO - 1499240066353 Marionette TRACE 376 <- [1,1,null,{"sessionId":"d77eeca2-3cb5-4c3a-972b-239d2425f1a8","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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}}]
00:34:26 INFO - 1499240066354 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"}]
00:34:26 INFO - 1499240066356 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"
00:34:26 INFO - 1499240066357 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"
00:34:26 INFO - 1499240066358 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"
00:34:26 INFO - 1499240066370 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"
00:34:26 INFO - 1499240066372 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"
00:34:26 INFO - 1499240066373 Marionette TRACE 376 <- [1,2,null,{}]
00:34:26 INFO - 1499240066375 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
00:34:26 INFO - 1499240066377 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"338dac08-a3d2-4951-99e1-c4994785edf6","ELEMENT":"338dac08-a3d2-4951-99e1-c4994785edf6"}}]
00:34:26 INFO - 1499240066378 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"338dac08-a3d2-4951-99e1-c4994785edf6"}]
00:34:26 INFO - 1499240066619 Marionette DEBUG Canceled page load listener because no navigation has been detected
00:34:26 INFO - 1499240066619 Marionette TRACE 376 <- [1,4,null,{}]
00:34:26 INFO - 1499240066622 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}]
00:34:26 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499240066624 Marionette TRACE 376 <- [1,5,null,{"value":null}]
00:34:26 INFO - 1499240066625 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
00:34:26 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 314ms
00:34:26 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
00:34:26 INFO - 1499240066627 Marionette TRACE 376 <- [1,6,null,{}]
00:34:26 INFO - 1499240066628 Marionette DEBUG Closed connection 376
00:34:26 INFO - 1499240066629 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49801
00:34:26 INFO - 1499240066630 Marionette DEBUG Closed connection 377
00:34:26 INFO - 1499240066630 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49802
00:34:26 INFO - 1499240066631 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:34:26 INFO - 1499240066631 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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}
00:34:26 INFO - 1499240066634 Marionette DEBUG Register listener.js for window 4294967297
00:34:26 INFO - 1499240066637 Marionette TRACE 378 <- [1,1,null,{"sessionId":"88ce3326-6a11-4791-bbaf-d21f03d86258","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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}}]
00:34:26 INFO - 1499240066638 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
00:34:26 INFO - 1499240066639 Marionette TRACE 378 <- [1,2,null,{}]
00:34:26 INFO - 1499240066639 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
00:34:26 INFO - 1499240066640 Marionette TRACE 378 <- [1,3,null,{}]
00:34:26 INFO - 1499240066640 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
00:34:26 INFO - 1499240066641 Marionette TRACE 378 <- [1,4,null,{}]
00:34:26 INFO - 1499240066643 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}]
00:34:26 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499240066645 Marionette TRACE 378 <- [1,5,null,{"value":null}]
00:34:26 INFO - 1499240066646 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
00:34:26 INFO - 1499240066648 Marionette TRACE 378 <- [1,6,null,{}]
00:34:26 INFO - 1499240066649 Marionette DEBUG Closed connection 378
00:34:26 INFO - 1499240066650 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49803
00:34:26 INFO - 1499240066650 Marionette DEBUG Closed connection 379
00:34:26 INFO - 1499240066651 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49804
00:34:26 INFO - 1499240066652 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:34:26 INFO - 1499240066652 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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}
00:34:26 INFO - 1499240066654 Marionette DEBUG Register listener.js for window 4294967297
00:34:26 INFO - 1499240066657 Marionette TRACE 380 <- [1,1,null,{"sessionId":"dda0bf22-4503-48d2-ac45-3dba9625fe8d","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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}}]
00:34:26 INFO - 1499240066658 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
00:34:26 INFO - 1499240066659 Marionette TRACE 380 <- [1,2,null,{}]
00:34:26 INFO - 1499240066661 Marionette DEBUG Closed connection 380
00:34:26 INFO - 1499240066661 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49805
00:34:26 INFO - 1499240066662 Marionette DEBUG Closed connection 381
00:34:26 INFO - 1499240066663 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49806
00:34:26 INFO - 1499240066664 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
00:34:26 INFO - 1499240066664 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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}
00:34:26 INFO - 1499240066667 Marionette DEBUG Register listener.js for window 4294967297
00:34:26 INFO - 1499240066670 Marionette TRACE 382 <- [1,1,null,{"sessionId":"20498195-6398-483b-bbfb-22f6db23835c","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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}}]
00:34:26 INFO - 1499240066671 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"}]
00:34:26 INFO - 1499240066673 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"
00:34:26 INFO - 1499240066674 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"
00:34:26 INFO - 1499240066675 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"
00:34:26 INFO - 1499240066680 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"
00:34:26 INFO - 1499240066683 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"
00:34:26 INFO - 1499240066690 Marionette TRACE 382 <- [1,2,null,{}]
00:34:26 INFO - 1499240066693 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
00:34:26 INFO - 1499240066695 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"b9a6d8a0-42ab-4312-8d1c-6dc6bf163024","ELEMENT":"b9a6d8a0-42ab-4312-8d1c-6dc6bf163024"}}]
00:34:26 INFO - 1499240066696 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"b9a6d8a0-42ab-4312-8d1c-6dc6bf163024"}]
00:34:26 INFO - 1499240066937 Marionette DEBUG Canceled page load listener because no navigation has been detected
00:34:26 INFO - 1499240066938 Marionette TRACE 382 <- [1,4,null,{}]
00:34:26 INFO - 1499240066939 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}]
00:34:26 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 316ms
00:34:26 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499240066942 Marionette TRACE 382 <- [1,5,null,{"value":null}]
00:34:26 INFO - 1499240066943 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
00:34:26 INFO - 1499240066944 Marionette TRACE 382 <- [1,6,null,{}]
00:34:26 INFO - TEST-START | test_click.py TestClick.test_input_file
00:34:26 INFO - 1499240066945 Marionette DEBUG Closed connection 382
00:34:26 INFO - 1499240066947 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49807
00:34:26 INFO - 1499240066948 Marionette DEBUG Closed connection 383
00:34:26 INFO - 1499240066948 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49808
00:34:26 INFO - 1499240066949 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:34:26 INFO - 1499240066949 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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}
00:34:26 INFO - 1499240066952 Marionette DEBUG Register listener.js for window 4294967297
00:34:26 INFO - 1499240066954 Marionette TRACE 384 <- [1,1,null,{"sessionId":"83d47e79-aa92-4f6e-970f-3ca092e6bc69","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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}}]
00:34:26 INFO - 1499240066955 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
00:34:26 INFO - 1499240066956 Marionette TRACE 384 <- [1,2,null,{}]
00:34:26 INFO - 1499240066956 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
00:34:26 INFO - 1499240066957 Marionette TRACE 384 <- [1,3,null,{}]
00:34:26 INFO - 1499240066958 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
00:34:26 INFO - 1499240066958 Marionette TRACE 384 <- [1,4,null,{}]
00:34:26 INFO - 1499240066959 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}]
00:34:26 INFO - TEST-START: test_click.py TestClick.test_input_file1499240066961 Marionette TRACE 384 <- [1,5,null,{"value":null}]
00:34:26 INFO - 1499240066962 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
00:34:26 INFO - 1499240066963 Marionette TRACE 384 <- [1,6,null,{}]
00:34:26 INFO - 1499240066965 Marionette DEBUG Closed connection 384
00:34:26 INFO - 1499240066965 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49809
00:34:26 INFO - 1499240066966 Marionette DEBUG Closed connection 385
00:34:26 INFO - 1499240066966 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49810
00:34:26 INFO - 1499240066967 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:34:26 INFO - 1499240066968 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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}
00:34:27 INFO - 1499240066970 Marionette DEBUG Register listener.js for window 4294967297
00:34:27 INFO - 1499240066972 Marionette TRACE 386 <- [1,1,null,{"sessionId":"0c1a9020-75b5-4f33-8baf-abb702e79f7c","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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}}]
00:34:27 INFO - 1499240066973 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
00:34:27 INFO - 1499240066974 Marionette TRACE 386 <- [1,2,null,{}]
00:34:27 INFO - 1499240066975 Marionette DEBUG Closed connection 386
00:34:27 INFO - 1499240066976 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49811
00:34:27 INFO - 1499240066977 Marionette DEBUG Closed connection 387
00:34:27 INFO - 1499240066977 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49812
00:34:27 INFO - 1499240066978 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
00:34:27 INFO - 1499240066979 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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}
00:34:27 INFO - 1499240066981 Marionette DEBUG Register listener.js for window 4294967297
00:34:27 INFO - 1499240066983 Marionette TRACE 388 <- [1,1,null,{"sessionId":"ce9089c5-64a9-44eb-9df3-f81892c4316b","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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}}]
00:34:27 INFO - 1499240066984 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
00:34:27 INFO - 1499240066986 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"
00:34:27 INFO - 1499240066987 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"
00:34:27 INFO - 1499240066988 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"
00:34:27 INFO - 1499240066993 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
00:34:27 INFO - 1499240066996 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
00:34:27 INFO - 1499240066997 Marionette TRACE 388 <- [1,2,null,{}]
00:34:27 INFO - 1499240067000 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
00:34:27 INFO - 1499240067005 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"61afdb21-7439-43d1-9105-8430f267b95b","ELEMENT":"61afdb21-7439-43d1-9105-8430f267b95b"}}]
00:34:27 INFO - 1499240067006 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"61afdb21-7439-43d1-9105-8430f267b95b"}]
00:34:27 INFO - 1499240067031 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:393:12\nclickElement@chrome://marionette/content/listener.js:1318:5\n"},null]
00:34:27 INFO - 1499240067033 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}]
00:34:27 INFO - TEST-END: test_click.py TestClick.test_input_file1499240067035 Marionette TRACE 388 <- [1,5,null,{"value":null}]
00:34:27 INFO - 1499240067036 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
00:34:27 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 93ms
00:34:27 INFO - 1499240067038 Marionette TRACE 388 <- [1,6,null,{}]
00:34:27 INFO - TEST-START | test_click.py TestClick.test_obscured_element
00:34:27 INFO - 1499240067039 Marionette DEBUG Closed connection 388
00:34:27 INFO - 1499240067040 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49813
00:34:27 INFO - 1499240067041 Marionette DEBUG Closed connection 389
00:34:27 INFO - 1499240067042 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49814
00:34:27 INFO - 1499240067042 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:34:27 INFO - 1499240067043 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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}
00:34:27 INFO - 1499240067045 Marionette DEBUG Register listener.js for window 4294967297
00:34:27 INFO - 1499240067047 Marionette TRACE 390 <- [1,1,null,{"sessionId":"fe19c238-e867-44eb-b8ca-69b183d241bb","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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}}]
00:34:27 INFO - 1499240067048 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
00:34:27 INFO - 1499240067049 Marionette TRACE 390 <- [1,2,null,{}]
00:34:27 INFO - 1499240067050 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
00:34:27 INFO - 1499240067050 Marionette TRACE 390 <- [1,3,null,{}]
00:34:27 INFO - 1499240067051 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
00:34:27 INFO - 1499240067051 Marionette TRACE 390 <- [1,4,null,{}]
00:34:27 INFO - 1499240067052 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}]
00:34:27 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499240067055 Marionette TRACE 390 <- [1,5,null,{"value":null}]
00:34:27 INFO - 1499240067056 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
00:34:27 INFO - 1499240067057 Marionette TRACE 390 <- [1,6,null,{}]
00:34:27 INFO - 1499240067058 Marionette DEBUG Closed connection 390
00:34:27 INFO - 1499240067058 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49815
00:34:27 INFO - 1499240067059 Marionette DEBUG Closed connection 391
00:34:27 INFO - 1499240067060 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49816
00:34:27 INFO - 1499240067061 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:34:27 INFO - 1499240067061 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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}
00:34:27 INFO - 1499240067063 Marionette DEBUG Register listener.js for window 4294967297
00:34:27 INFO - 1499240067066 Marionette TRACE 392 <- [1,1,null,{"sessionId":"e9b90061-18ce-4363-92c5-206b53ace8c8","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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}}]
00:34:27 INFO - 1499240067067 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
00:34:27 INFO - 1499240067068 Marionette TRACE 392 <- [1,2,null,{}]
00:34:27 INFO - 1499240067069 Marionette DEBUG Closed connection 392
00:34:27 INFO - 1499240067070 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49817
00:34:27 INFO - 1499240067071 Marionette DEBUG Closed connection 393
00:34:27 INFO - 1499240067071 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49818
00:34:27 INFO - 1499240067072 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
00:34:27 INFO - 1499240067073 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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}
00:34:27 INFO - 1499240067075 Marionette DEBUG Register listener.js for window 4294967297
00:34:27 INFO - 1499240067078 Marionette TRACE 394 <- [1,1,null,{"sessionId":"f0ef2715-0879-4b77-a848-ff334467c3b2","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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}}]
00:34:27 INFO - 1499240067079 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"}]
00:34:27 INFO - 1499240067080 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
00:34:27 INFO - 1499240067082 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
00:34:27 INFO - 1499240067082 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
00:34:27 INFO - 1499240067088 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"
00:34:27 INFO - 1499240067090 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"
00:34:27 INFO - 1499240067093 Marionette TRACE 394 <- [1,2,null,{}]
00:34:27 INFO - 1499240067096 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
00:34:27 INFO - 1499240067098 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a6a25e7b-481b-4f95-b1c0-6f1326733c36","ELEMENT":"a6a25e7b-481b-4f95-b1c0-6f1326733c36"}}]
00:34:27 INFO - 1499240067099 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
00:34:27 INFO - 1499240067104 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"865a21ee-64a6-4cad-aabc-f4f9f8799e98","ELEMENT":"865a21ee-64a6-4cad-aabc-f4f9f8799e98"}}]
00:34:27 INFO - 1499240067105 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"a6a25e7b-481b-4f95-b1c0-6f1326733c36"}]
00:34:27 INFO - 1499240067343 Marionette DEBUG Canceled page load listener because no navigation has been detected
00:34:27 INFO - 1499240067344 Marionette TRACE 394 <- [1,5,null,{}]
00:34:27 INFO - 1499240067345 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"865a21ee-64a6-4cad-aabc-f4f9f8799e98"}]
00:34:27 INFO - 1499240067359 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:393:12\nclickElement@chrome://marionette/content/listener.js:1318:5\n"},null]
00:34:27 INFO - 1499240067361 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
00:34:27 INFO - 1499240067363 Marionette TRACE 394 <- [1,7,null,{"value":false}]
00:34:27 INFO - 1499240067364 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}]
00:34:27 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499240067366 Marionette TRACE 394 <- [1,8,null,{"value":null}]
00:34:27 INFO - 1499240067368 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
00:34:27 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 331ms
00:34:27 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
00:34:27 INFO - 1499240067369 Marionette TRACE 394 <- [1,9,null,{}]
00:34:27 INFO - 1499240067370 Marionette DEBUG Closed connection 394
00:34:27 INFO - 1499240067371 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49819
00:34:27 INFO - 1499240067372 Marionette DEBUG Closed connection 395
00:34:27 INFO - 1499240067373 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49820
00:34:27 INFO - 1499240067374 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:34:27 INFO - 1499240067374 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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}
00:34:27 INFO - 1499240067376 Marionette DEBUG Register listener.js for window 4294967297
00:34:27 INFO - 1499240067387 Marionette TRACE 396 <- [1,1,null,{"sessionId":"a0373f63-b2b8-45d2-9e21-d58b82ee6720","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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}}]
00:34:27 INFO - 1499240067388 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
00:34:27 INFO - 1499240067388 Marionette TRACE 396 <- [1,2,null,{}]
00:34:27 INFO - 1499240067389 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
00:34:27 INFO - 1499240067389 Marionette TRACE 396 <- [1,3,null,{}]
00:34:27 INFO - 1499240067390 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
00:34:27 INFO - 1499240067390 Marionette TRACE 396 <- [1,4,null,{}]
00:34:27 INFO - 1499240067392 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}]
00:34:27 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499240067394 Marionette TRACE 396 <- [1,5,null,{"value":null}]
00:34:27 INFO - 1499240067395 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
00:34:27 INFO - 1499240067396 Marionette TRACE 396 <- [1,6,null,{}]
00:34:27 INFO - 1499240067397 Marionette DEBUG Closed connection 396
00:34:27 INFO - 1499240067398 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49821
00:34:27 INFO - 1499240067399 Marionette DEBUG Closed connection 397
00:34:27 INFO - 1499240067400 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49822
00:34:27 INFO - 1499240067401 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:34:27 INFO - 1499240067401 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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}
00:34:27 INFO - 1499240067403 Marionette DEBUG Register listener.js for window 4294967297
00:34:27 INFO - 1499240067406 Marionette TRACE 398 <- [1,1,null,{"sessionId":"a2a870d8-5ff9-404a-a3f0-295c09048a64","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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}}]
00:34:27 INFO - 1499240067407 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
00:34:27 INFO - 1499240067408 Marionette TRACE 398 <- [1,2,null,{}]
00:34:27 INFO - 1499240067409 Marionette DEBUG Closed connection 398
00:34:27 INFO - 1499240067409 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49823
00:34:27 INFO - 1499240067410 Marionette DEBUG Closed connection 399
00:34:27 INFO - 1499240067410 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49824
00:34:27 INFO - 1499240067412 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
00:34:27 INFO - 1499240067412 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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}
00:34:27 INFO - 1499240067414 Marionette DEBUG Register listener.js for window 4294967297
00:34:27 INFO - 1499240067416 Marionette TRACE 400 <- [1,1,null,{"sessionId":"76809949-3896-4815-a743-ec8960d93927","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":4024,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-186.001\\AppData\\Local\\Temp\\tmpk386rn.mozrunner","moz:accessibilityChecks":false}}]
00:34:27 INFO - 1499240067418 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"}]
00:34:27 INFO - 1499240067419 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"
00:34:27 INFO - 1499240067421 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"
00:34:27 INFO - 1499240067421 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"
00:34:27 INFO - 1499240067426 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"
00:34:27 INFO - 1499240067428 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"
00:34:27 INFO - 1499240067431 Marionette TRACE 400 <- [1,2,null,{}]
00:34:27 INFO - 1499240067437 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
00:34:27 INFO - 1499240067441 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"900ca3de-53c6-420b-9718-86726b6f380b","ELEMENT":"900ca3de-53c6-420b-9718-86726b6f380b"}}]
00:34:27 INFO - 1499240067442 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"900ca3de-53c6-420b-9718-86726b6f380b"}]
00:34:27 INFO - 1499240067463 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
00:34:27 INFO - 1499240067464 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"900ca3de-53c6-420b-9718-86726b6f380b"}]
00:34:27 INFO - 1499240067478 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element