could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementNotInteractableError@chrome://marionette/content/error.js:315:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:183:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:392:12\nclickElement@chrome://marionette/content/listener.js:1312:5\n"},null]
19:04:31 INFO - 1499479471788 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}]
19:04:31 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499479471791 Marionette TRACE 352 <- [1,5,null,{"value":null}]
19:04:31 INFO - 1499479471792 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
19:04:31 INFO - 1499479471793 Marionette TRACE 352 <- [1,6,null,{}]
19:04:31 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 148ms
19:04:31 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
19:04:31 INFO - 1499479471795 Marionette DEBUG Closed connection 352
19:04:31 INFO - 1499479471798 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49747
19:04:31 INFO - 1499479471799 Marionette DEBUG Closed connection 353
19:04:31 INFO - 1499479471800 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49748
19:04:31 INFO - 1499479471801 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:04:31 INFO - 1499479471801 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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}
19:04:31 INFO - 1499479471804 Marionette DEBUG Register listener.js for window 12
19:04:31 INFO - 1499479471806 Marionette TRACE 354 <- [1,1,null,{"sessionId":"7aa932d6-3630-4f4a-b523-2b5716083c2d","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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}}]
19:04:31 INFO - 1499479471809 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
19:04:31 INFO - 1499479471809 Marionette TRACE 354 <- [1,2,null,{}]
19:04:31 INFO - 1499479471810 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
19:04:31 INFO - 1499479471810 Marionette TRACE 354 <- [1,3,null,{}]
19:04:31 INFO - 1499479471811 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
19:04:31 INFO - 1499479471811 Marionette TRACE 354 <- [1,4,null,{}]
19:04:31 INFO - 1499479471813 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}]
19:04:31 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499479471815 Marionette TRACE 354 <- [1,5,null,{"value":null}]
19:04:31 INFO - 1499479471816 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
19:04:31 INFO - 1499479471817 Marionette TRACE 354 <- [1,6,null,{}]
19:04:31 INFO - 1499479471819 Marionette DEBUG Closed connection 354
19:04:31 INFO - 1499479471819 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49749
19:04:31 INFO - 1499479471820 Marionette DEBUG Closed connection 355
19:04:31 INFO - 1499479471821 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49750
19:04:31 INFO - 1499479471821 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:04:31 INFO - 1499479471822 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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}
19:04:31 INFO - 1499479471824 Marionette DEBUG Register listener.js for window 12
19:04:31 INFO - 1499479471826 Marionette TRACE 356 <- [1,1,null,{"sessionId":"d48a0d89-fd9f-401d-abec-020d1f9db591","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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}}]
19:04:31 INFO - 1499479471828 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
19:04:31 INFO - 1499479471829 Marionette TRACE 356 <- [1,2,null,{}]
19:04:31 INFO - 1499479471831 Marionette DEBUG Closed connection 356
19:04:31 INFO - 1499479471831 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49751
19:04:31 INFO - 1499479471832 Marionette DEBUG Closed connection 357
19:04:31 INFO - 1499479471832 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49752
19:04:31 INFO - 1499479471833 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
19:04:31 INFO - 1499479471834 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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}
19:04:31 INFO - 1499479471836 Marionette DEBUG Register listener.js for window 12
19:04:31 INFO - 1499479471839 Marionette TRACE 358 <- [1,1,null,{"sessionId":"50c39db3-47cf-4c3c-a095-4c8a3a3cece1","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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}}]
19:04:31 INFO - 1499479471841 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49323/clicks.html"}]
19:04:31 INFO - 1499479471842 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49323/hidden.html"
19:04:31 INFO - 1499479471851 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49323/hidden.html"
19:04:31 INFO - 1499479471851 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49323/hidden.html"
19:04:31 INFO - 1499479471870 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49323/clicks.html"
19:04:31 INFO - 1499479471871 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49323/clicks.html"
19:04:31 INFO - 1499479471874 Marionette TRACE 358 <- [1,2,null,{}]
19:04:31 INFO - 1499479471875 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
19:04:31 INFO - 1499479471877 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"ed2811ca-e711-4313-ad05-ada868db33f7","ELEMENT":"ed2811ca-e711-4313-ad05-ada868db33f7"}}]
19:04:31 INFO - 1499479471878 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"ed2811ca-e711-4313-ad05-ada868db33f7"}]
19:04:31 INFO - 1499479471920 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49323/clicks.html"
19:04:31 INFO - 1499479471924 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49323/clicks.html"
19:04:31 INFO - 1499479471924 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49323/clicks.html"
19:04:31 INFO - 1499479471951 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49323/test.html"
19:04:31 INFO - 1499479471952 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49323/test.html"
19:04:31 INFO - 1499479471954 Marionette TRACE 358 <- [1,4,null,{}]
19:04:31 INFO - 1499479471955 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
19:04:31 INFO - 1499479471957 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"50f558cf-2c14-4afd-a706-b1005d808c9e","ELEMENT":"50f558cf-2c14-4afd-a706-b1005d808c9e"}}]
19:04:31 INFO - 1499479471958 Marionette TRACE 358 -> [0,6,"getTitle",{}]
19:04:31 INFO - 1499479471958 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
19:04:31 INFO - 1499479471959 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}]
19:04:31 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499479471961 Marionette TRACE 358 <- [1,7,null,{"value":null}]
19:04:31 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 175ms
19:04:31 INFO - TEST-START | test_click.py TestClick.test_container_element
19:04:31 INFO - 1499479471967 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
19:04:31 INFO - 1499479471969 Marionette TRACE 358 <- [1,8,null,{}]
19:04:31 INFO - 1499479471970 Marionette DEBUG Closed connection 358
19:04:31 INFO - 1499479471971 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49755
19:04:31 INFO - 1499479471972 Marionette DEBUG Closed connection 359
19:04:31 INFO - 1499479471973 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49756
19:04:31 INFO - 1499479471973 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:04:31 INFO - 1499479471974 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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}
19:04:31 INFO - 1499479471976 Marionette DEBUG Register listener.js for window 12
19:04:31 INFO - 1499479471979 Marionette TRACE 360 <- [1,1,null,{"sessionId":"b2587973-d5b2-4389-9f7f-ab41d9990091","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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}}]
19:04:31 INFO - 1499479471982 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
19:04:31 INFO - 1499479471983 Marionette TRACE 360 <- [1,2,null,{}]
19:04:31 INFO - 1499479471984 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
19:04:31 INFO - 1499479471984 Marionette TRACE 360 <- [1,3,null,{}]
19:04:31 INFO - 1499479471985 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
19:04:31 INFO - 1499479471985 Marionette TRACE 360 <- [1,4,null,{}]
19:04:31 INFO - 1499479471986 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}]
19:04:31 INFO - TEST-START: test_click.py TestClick.test_container_element1499479471988 Marionette TRACE 360 <- [1,5,null,{"value":null}]
19:04:31 INFO - 1499479471989 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
19:04:31 INFO - 1499479471990 Marionette TRACE 360 <- [1,6,null,{}]
19:04:31 INFO - 1499479471992 Marionette DEBUG Closed connection 360
19:04:31 INFO - 1499479471992 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49757
19:04:31 INFO - 1499479471993 Marionette DEBUG Closed connection 361
19:04:31 INFO - 1499479471994 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49758
19:04:31 INFO - 1499479471995 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:04:31 INFO - 1499479471995 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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}
19:04:31 INFO - 1499479471998 Marionette DEBUG Register listener.js for window 12
19:04:32 INFO - 1499479472001 Marionette TRACE 362 <- [1,1,null,{"sessionId":"c0f9e978-7d04-47ac-bfb6-0077b4584d3b","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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}}]
19:04:32 INFO - 1499479472003 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
19:04:32 INFO - 1499479472004 Marionette TRACE 362 <- [1,2,null,{}]
19:04:32 INFO - 1499479472006 Marionette DEBUG Closed connection 362
19:04:32 INFO - 1499479472006 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49759
19:04:32 INFO - 1499479472007 Marionette DEBUG Closed connection 363
19:04:32 INFO - 1499479472007 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49760
19:04:32 INFO - 1499479472008 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
19:04:32 INFO - 1499479472009 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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}
19:04:32 INFO - 1499479472011 Marionette DEBUG Register listener.js for window 12
19:04:32 INFO - 1499479472015 Marionette TRACE 364 <- [1,1,null,{"sessionId":"4df32ea1-8fc4-49fa-95f7-728251ba4596","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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}}]
19:04:32 INFO - 1499479472016 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"}]
19:04:32 INFO - 1499479472017 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49323/test.html"
19:04:32 INFO - 1499479472019 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49323/test.html"
19:04:32 INFO - 1499479472019 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49323/test.html"
19:04:32 INFO - 1499479472038 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"
19:04:32 INFO - 1499479472041 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"
19:04:32 INFO - 1499479472043 Marionette TRACE 364 <- [1,2,null,{}]
19:04:32 INFO - 1499479472045 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
19:04:32 INFO - 1499479472052 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"57cb5548-68ba-493b-8e68-b44fb275d4dd","ELEMENT":"57cb5548-68ba-493b-8e68-b44fb275d4dd"}}]
19:04:32 INFO - 1499479472053 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"57cb5548-68ba-493b-8e68-b44fb275d4dd"}]
19:04:32 INFO - 1499479472289 Marionette DEBUG Canceled page load listener because no navigation has been detected
19:04:32 INFO - 1499479472290 Marionette TRACE 364 <- [1,4,null,{}]
19:04:32 INFO - 1499479472291 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"57cb5548-68ba-493b-8e68-b44fb275d4dd","name":"selected"}]
19:04:32 INFO - 1499479472294 Marionette TRACE 364 <- [1,5,null,{"value":true}]
19:04:32 INFO - 1499479472296 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}]
19:04:32 INFO - TEST-END: test_click.py TestClick.test_container_element1499479472298 Marionette TRACE 364 <- [1,6,null,{"value":null}]
19:04:32 INFO - 1499479472299 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
19:04:32 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 331ms
19:04:32 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
19:04:32 INFO - 1499479472300 Marionette TRACE 364 <- [1,7,null,{}]
19:04:32 INFO - 1499479472301 Marionette DEBUG Closed connection 364
19:04:32 INFO - 1499479472302 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49761
19:04:32 INFO - 1499479472303 Marionette DEBUG Closed connection 365
19:04:32 INFO - 1499479472303 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49762
19:04:32 INFO - 1499479472304 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:04:32 INFO - 1499479472305 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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}
19:04:32 INFO - 1499479472307 Marionette DEBUG Register listener.js for window 12
19:04:32 INFO - 1499479472309 Marionette TRACE 366 <- [1,1,null,{"sessionId":"72a821bd-8d3c-4819-a8f9-a01d91db7d90","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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}}]
19:04:32 INFO - 1499479472311 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
19:04:32 INFO - 1499479472311 Marionette TRACE 366 <- [1,2,null,{}]
19:04:32 INFO - 1499479472312 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
19:04:32 INFO - 1499479472312 Marionette TRACE 366 <- [1,3,null,{}]
19:04:32 INFO - 1499479472313 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
19:04:32 INFO - 1499479472313 Marionette TRACE 366 <- [1,4,null,{}]
19:04:32 INFO - 1499479472315 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}]
19:04:32 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499479472317 Marionette TRACE 366 <- [1,5,null,{"value":null}]
19:04:32 INFO - 1499479472318 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
19:04:32 INFO - 1499479472319 Marionette TRACE 366 <- [1,6,null,{}]
19:04:32 INFO - 1499479472320 Marionette DEBUG Closed connection 366
19:04:32 INFO - 1499479472321 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49763
19:04:32 INFO - 1499479472321 Marionette DEBUG Closed connection 367
19:04:32 INFO - 1499479472322 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49764
19:04:32 INFO - 1499479472323 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:04:32 INFO - 1499479472323 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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}
19:04:32 INFO - 1499479472325 Marionette DEBUG Register listener.js for window 12
19:04:32 INFO - 1499479472327 Marionette TRACE 368 <- [1,1,null,{"sessionId":"8f39bfb8-22fb-4639-8481-e083ccc8eaa6","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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}}]
19:04:32 INFO - 1499479472329 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
19:04:32 INFO - 1499479472330 Marionette TRACE 368 <- [1,2,null,{}]
19:04:32 INFO - 1499479472331 Marionette DEBUG Closed connection 368
19:04:32 INFO - 1499479472332 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49765
19:04:32 INFO - 1499479472333 Marionette DEBUG Closed connection 369
19:04:32 INFO - 1499479472333 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49766
19:04:32 INFO - 1499479472335 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
19:04:32 INFO - 1499479472335 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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}
19:04:32 INFO - 1499479472337 Marionette DEBUG Register listener.js for window 12
19:04:32 INFO - 1499479472339 Marionette TRACE 370 <- [1,1,null,{"sessionId":"893eff1f-68b2-414c-94ba-cce397152568","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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}}]
19:04:32 INFO - 1499479472341 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"}]
19:04:32 INFO - 1499479472342 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"
19:04:32 INFO - 1499479472343 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"
19:04:32 INFO - 1499479472344 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"
19:04:32 INFO - 1499479472359 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"
19:04:32 INFO - 1499479472362 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"
19:04:32 INFO - 1499479472371 Marionette TRACE 370 <- [1,2,null,{}]
19:04:32 INFO - 1499479472372 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
19:04:32 INFO - 1499479472374 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"625f92bf-f85d-45a6-8bc7-b5038af61007","ELEMENT":"625f92bf-f85d-45a6-8bc7-b5038af61007"}}]
19:04:32 INFO - 1499479472375 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"625f92bf-f85d-45a6-8bc7-b5038af61007"}]
19:04:32 INFO - 1499479472620 Marionette DEBUG Canceled page load listener because no navigation has been detected
19:04:32 INFO - 1499479472620 Marionette TRACE 370 <- [1,4,null,{}]
19:04:32 INFO - 1499479472622 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"625f92bf-f85d-45a6-8bc7-b5038af61007","name":"selected"}]
19:04:32 INFO - 1499479472625 Marionette TRACE 370 <- [1,5,null,{"value":true}]
19:04:32 INFO - 1499479472627 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}]
19:04:32 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499479472628 Marionette TRACE 370 <- [1,6,null,{"value":null}]
19:04:32 INFO - 1499479472629 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
19:04:32 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 331ms
19:04:32 INFO - TEST-START | test_click.py TestClick.test_css_transforms
19:04:32 INFO - 1499479472630 Marionette TRACE 370 <- [1,7,null,{}]
19:04:32 INFO - 1499479472632 Marionette DEBUG Closed connection 370
19:04:32 INFO - 1499479472633 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49767
19:04:32 INFO - 1499479472633 Marionette DEBUG Closed connection 371
19:04:32 INFO - 1499479472634 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49768
19:04:32 INFO - 1499479472635 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:04:32 INFO - 1499479472635 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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}
19:04:32 INFO - 1499479472637 Marionette DEBUG Register listener.js for window 12
19:04:32 INFO - 1499479472640 Marionette TRACE 372 <- [1,1,null,{"sessionId":"f5afa71a-03a1-4b85-81a9-27f1d84f1346","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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}}]
19:04:32 INFO - 1499479472641 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
19:04:32 INFO - 1499479472642 Marionette TRACE 372 <- [1,2,null,{}]
19:04:32 INFO - 1499479472642 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
19:04:32 INFO - 1499479472643 Marionette TRACE 372 <- [1,3,null,{}]
19:04:32 INFO - 1499479472644 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
19:04:32 INFO - 1499479472644 Marionette TRACE 372 <- [1,4,null,{}]
19:04:32 INFO - 1499479472646 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}]
19:04:32 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499479472648 Marionette TRACE 372 <- [1,5,null,{"value":null}]
19:04:32 INFO - 1499479472649 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
19:04:32 INFO - 1499479472650 Marionette TRACE 372 <- [1,6,null,{}]
19:04:32 INFO - 1499479472651 Marionette DEBUG Closed connection 372
19:04:32 INFO - 1499479472652 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49769
19:04:32 INFO - 1499479472652 Marionette DEBUG Closed connection 373
19:04:32 INFO - 1499479472653 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49770
19:04:32 INFO - 1499479472654 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:04:32 INFO - 1499479472654 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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}
19:04:32 INFO - 1499479472656 Marionette DEBUG Register listener.js for window 12
19:04:32 INFO - 1499479472658 Marionette TRACE 374 <- [1,1,null,{"sessionId":"a7310aa3-3a46-45d1-8ee5-4efb859974b6","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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}}]
19:04:32 INFO - 1499479472662 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
19:04:32 INFO - 1499479472663 Marionette TRACE 374 <- [1,2,null,{}]
19:04:32 INFO - 1499479472664 Marionette DEBUG Closed connection 374
19:04:32 INFO - 1499479472665 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49771
19:04:32 INFO - 1499479472666 Marionette DEBUG Closed connection 375
19:04:32 INFO - 1499479472666 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49772
19:04:32 INFO - 1499479472667 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
19:04:32 INFO - 1499479472668 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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}
19:04:32 INFO - 1499479472669 Marionette DEBUG Register listener.js for window 12
19:04:32 INFO - 1499479472672 Marionette TRACE 376 <- [1,1,null,{"sessionId":"ab5eeda8-2478-4739-a567-11fcf5bb2947","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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}}]
19:04:32 INFO - 1499479472673 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"}]
19:04:32 INFO - 1499479472674 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"
19:04:32 INFO - 1499479472676 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"
19:04:32 INFO - 1499479472676 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"
19:04:32 INFO - 1499479472692 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"
19:04:32 INFO - 1499479472695 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"
19:04:32 INFO - 1499479472702 Marionette TRACE 376 <- [1,2,null,{}]
19:04:32 INFO - 1499479472704 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
19:04:32 INFO - 1499479472706 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"df10d990-78e0-40a3-a49f-129fd0c33acb","ELEMENT":"df10d990-78e0-40a3-a49f-129fd0c33acb"}}]
19:04:32 INFO - 1499479472707 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"df10d990-78e0-40a3-a49f-129fd0c33acb"}]
19:04:32 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 316ms
19:04:32 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
19:04:32 INFO - 1499479472940 Marionette DEBUG Canceled page load listener because no navigation has been detected
19:04:32 INFO - 1499479472941 Marionette TRACE 376 <- [1,4,null,{}]
19:04:32 INFO - 1499479472942 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}]
19:04:32 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499479472944 Marionette TRACE 376 <- [1,5,null,{"value":null}]
19:04:32 INFO - 1499479472945 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
19:04:32 INFO - 1499479472946 Marionette TRACE 376 <- [1,6,null,{}]
19:04:32 INFO - 1499479472948 Marionette DEBUG Closed connection 376
19:04:32 INFO - 1499479472949 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49773
19:04:32 INFO - 1499479472950 Marionette DEBUG Closed connection 377
19:04:32 INFO - 1499479472950 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49774
19:04:32 INFO - 1499479472951 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:04:32 INFO - 1499479472952 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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}
19:04:32 INFO - 1499479472953 Marionette DEBUG Register listener.js for window 12
19:04:32 INFO - 1499479472962 Marionette TRACE 378 <- [1,1,null,{"sessionId":"24469841-4a9a-481f-b399-16ffdc92d385","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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}}]
19:04:32 INFO - 1499479472964 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
19:04:32 INFO - 1499479472964 Marionette TRACE 378 <- [1,2,null,{}]
19:04:32 INFO - 1499479472965 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
19:04:32 INFO - 1499479472966 Marionette TRACE 378 <- [1,3,null,{}]
19:04:32 INFO - 1499479472967 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
19:04:32 INFO - 1499479472967 Marionette TRACE 378 <- [1,4,null,{}]
19:04:32 INFO - 1499479472969 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}]
19:04:32 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499479472971 Marionette TRACE 378 <- [1,5,null,{"value":null}]
19:04:32 INFO - 1499479472971 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
19:04:32 INFO - 1499479472972 Marionette TRACE 378 <- [1,6,null,{}]
19:04:32 INFO - 1499479472974 Marionette DEBUG Closed connection 378
19:04:32 INFO - 1499479472974 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49775
19:04:32 INFO - 1499479472975 Marionette DEBUG Closed connection 379
19:04:32 INFO - 1499479472976 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49776
19:04:32 INFO - 1499479472977 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:04:32 INFO - 1499479472977 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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}
19:04:32 INFO - 1499479472979 Marionette DEBUG Register listener.js for window 12
19:04:32 INFO - 1499479472981 Marionette TRACE 380 <- [1,1,null,{"sessionId":"9683d584-41e4-4563-9a4a-9e525a3c28fd","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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}}]
19:04:32 INFO - 1499479472983 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
19:04:33 INFO - 1499479472984 Marionette TRACE 380 <- [1,2,null,{}]
19:04:33 INFO - 1499479472986 Marionette DEBUG Closed connection 380
19:04:33 INFO - 1499479472986 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49777
19:04:33 INFO - 1499479472987 Marionette DEBUG Closed connection 381
19:04:33 INFO - 1499479472988 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49778
19:04:33 INFO - 1499479472989 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
19:04:33 INFO - 1499479472989 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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}
19:04:33 INFO - 1499479472991 Marionette DEBUG Register listener.js for window 12
19:04:33 INFO - 1499479472993 Marionette TRACE 382 <- [1,1,null,{"sessionId":"9b5950dc-8da7-440e-afed-21d9002493c0","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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}}]
19:04:33 INFO - 1499479472995 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"}]
19:04:33 INFO - 1499479472996 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"
19:04:33 INFO - 1499479472997 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"
19:04:33 INFO - 1499479472997 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"
19:04:33 INFO - 1499479473007 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"
19:04:33 INFO - 1499479473010 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"
19:04:33 INFO - 1499479473013 Marionette TRACE 382 <- [1,2,null,{}]
19:04:33 INFO - 1499479473022 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
19:04:33 INFO - 1499479473024 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e40b4acf-580f-4947-9c81-d7dcdd0c1a96","ELEMENT":"e40b4acf-580f-4947-9c81-d7dcdd0c1a96"}}]
19:04:33 INFO - 1499479473025 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"e40b4acf-580f-4947-9c81-d7dcdd0c1a96"}]
19:04:33 INFO - 1499479473262 Marionette DEBUG Canceled page load listener because no navigation has been detected
19:04:33 INFO - 1499479473263 Marionette TRACE 382 <- [1,4,null,{}]
19:04:33 INFO - 1499479473264 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}]
19:04:33 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499479473266 Marionette TRACE 382 <- [1,5,null,{"value":null}]
19:04:33 INFO - 1499479473267 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
19:04:33 INFO - 1499479473268 Marionette TRACE 382 <- [1,6,null,{}]
19:04:33 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 322ms
19:04:33 INFO - TEST-START | test_click.py TestClick.test_input_file
19:04:33 INFO - 1499479473270 Marionette DEBUG Closed connection 382
19:04:33 INFO - 1499479473271 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49779
19:04:33 INFO - 1499479473272 Marionette DEBUG Closed connection 383
19:04:33 INFO - 1499479473273 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49780
19:04:33 INFO - 1499479473274 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:04:33 INFO - 1499479473274 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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}
19:04:33 INFO - 1499479473276 Marionette DEBUG Register listener.js for window 12
19:04:33 INFO - 1499479473278 Marionette TRACE 384 <- [1,1,null,{"sessionId":"d48a1a2c-baed-4bf7-a507-df9595f924ac","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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}}]
19:04:33 INFO - 1499479473281 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
19:04:33 INFO - 1499479473282 Marionette TRACE 384 <- [1,2,null,{}]
19:04:33 INFO - 1499479473283 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
19:04:33 INFO - 1499479473284 Marionette TRACE 384 <- [1,3,null,{}]
19:04:33 INFO - 1499479473285 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
19:04:33 INFO - 1499479473285 Marionette TRACE 384 <- [1,4,null,{}]
19:04:33 INFO - 1499479473287 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}]
19:04:33 INFO - TEST-START: test_click.py TestClick.test_input_file1499479473289 Marionette TRACE 384 <- [1,5,null,{"value":null}]
19:04:33 INFO - 1499479473289 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
19:04:33 INFO - 1499479473290 Marionette TRACE 384 <- [1,6,null,{}]
19:04:33 INFO - 1499479473292 Marionette DEBUG Closed connection 384
19:04:33 INFO - 1499479473293 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49781
19:04:33 INFO - 1499479473293 Marionette DEBUG Closed connection 385
19:04:33 INFO - 1499479473294 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49782
19:04:33 INFO - 1499479473295 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:04:33 INFO - 1499479473295 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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}
19:04:33 INFO - 1499479473297 Marionette DEBUG Register listener.js for window 12
19:04:33 INFO - 1499479473299 Marionette TRACE 386 <- [1,1,null,{"sessionId":"c0a48930-4d3b-48f6-9300-1de03a352e69","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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}}]
19:04:33 INFO - 1499479473301 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
19:04:33 INFO - 1499479473302 Marionette TRACE 386 <- [1,2,null,{}]
19:04:33 INFO - 1499479473304 Marionette DEBUG Closed connection 386
19:04:33 INFO - 1499479473304 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49783
19:04:33 INFO - 1499479473305 Marionette DEBUG Closed connection 387
19:04:33 INFO - 1499479473305 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49784
19:04:33 INFO - 1499479473306 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
19:04:33 INFO - 1499479473307 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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}
19:04:33 INFO - 1499479473308 Marionette DEBUG Register listener.js for window 12
19:04:33 INFO - 1499479473310 Marionette TRACE 388 <- [1,1,null,{"sessionId":"a33cc42f-bddc-4573-8e8b-493d0472b8f4","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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}}]
19:04:33 INFO - 1499479473312 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
19:04:33 INFO - 1499479473313 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"
19:04:33 INFO - 1499479473315 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"
19:04:33 INFO - 1499479473315 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"
19:04:33 INFO - 1499479473324 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
19:04:33 INFO - 1499479473327 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
19:04:33 INFO - 1499479473329 Marionette TRACE 388 <- [1,2,null,{}]
19:04:33 INFO - 1499479473337 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
19:04:33 INFO - 1499479473339 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"46d41585-bd14-4e42-a73a-283374487685","ELEMENT":"46d41585-bd14-4e42-a73a-283374487685"}}]
19:04:33 INFO - 1499479473340 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"46d41585-bd14-4e42-a73a-283374487685"}]
19:04:33 INFO - 1499479473371 Marionette TRACE 388 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:392:12\nclickElement@chrome://marionette/content/listener.js:1312:5\n"},null]
19:04:33 INFO - 1499479473373 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}]
19:04:33 INFO - TEST-END: test_click.py TestClick.test_input_file1499479473375 Marionette TRACE 388 <- [1,5,null,{"value":null}]
19:04:33 INFO - 1499479473376 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
19:04:33 INFO - 1499479473377 Marionette TRACE 388 <- [1,6,null,{}]
19:04:33 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 108ms
19:04:33 INFO - TEST-START | test_click.py TestClick.test_obscured_element
19:04:33 INFO - 1499479473379 Marionette DEBUG Closed connection 388
19:04:33 INFO - 1499479473381 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49785
19:04:33 INFO - 1499479473381 Marionette DEBUG Closed connection 389
19:04:33 INFO - 1499479473382 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49786
19:04:33 INFO - 1499479473383 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:04:33 INFO - 1499479473383 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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}
19:04:33 INFO - 1499479473385 Marionette DEBUG Register listener.js for window 12
19:04:33 INFO - 1499479473388 Marionette TRACE 390 <- [1,1,null,{"sessionId":"df9a7281-ec1e-4c59-9534-55c6438addb0","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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}}]
19:04:33 INFO - 1499479473389 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
19:04:33 INFO - 1499479473390 Marionette TRACE 390 <- [1,2,null,{}]
19:04:33 INFO - 1499479473391 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
19:04:33 INFO - 1499479473391 Marionette TRACE 390 <- [1,3,null,{}]
19:04:33 INFO - 1499479473392 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
19:04:33 INFO - 1499479473392 Marionette TRACE 390 <- [1,4,null,{}]
19:04:33 INFO - 1499479473393 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}]
19:04:33 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499479473396 Marionette TRACE 390 <- [1,5,null,{"value":null}]
19:04:33 INFO - 1499479473397 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
19:04:33 INFO - 1499479473397 Marionette TRACE 390 <- [1,6,null,{}]
19:04:33 INFO - 1499479473399 Marionette DEBUG Closed connection 390
19:04:33 INFO - 1499479473399 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49787
19:04:33 INFO - 1499479473400 Marionette DEBUG Closed connection 391
19:04:33 INFO - 1499479473401 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49788
19:04:33 INFO - 1499479473402 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:04:33 INFO - 1499479473403 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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}
19:04:33 INFO - 1499479473405 Marionette DEBUG Register listener.js for window 12
19:04:33 INFO - 1499479473407 Marionette TRACE 392 <- [1,1,null,{"sessionId":"df355957-4dcd-4729-a5ee-5aef7e6ecc05","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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}}]
19:04:33 INFO - 1499479473409 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
19:04:33 INFO - 1499479473410 Marionette TRACE 392 <- [1,2,null,{}]
19:04:33 INFO - 1499479473411 Marionette DEBUG Closed connection 392
19:04:33 INFO - 1499479473412 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49789
19:04:33 INFO - 1499479473412 Marionette DEBUG Closed connection 393
19:04:33 INFO - 1499479473413 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49790
19:04:33 INFO - 1499479473414 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
19:04:33 INFO - 1499479473414 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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}
19:04:33 INFO - 1499479473416 Marionette DEBUG Register listener.js for window 12
19:04:33 INFO - 1499479473418 Marionette TRACE 394 <- [1,1,null,{"sessionId":"84c72072-3d48-4400-9898-22621bf84c76","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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}}]
19:04:33 INFO - 1499479473420 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"}]
19:04:33 INFO - 1499479473421 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
19:04:33 INFO - 1499479473423 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
19:04:33 INFO - 1499479473423 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
19:04:33 INFO - 1499479473440 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"
19:04:33 INFO - 1499479473442 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"
19:04:33 INFO - 1499479473444 Marionette TRACE 394 <- [1,2,null,{}]
19:04:33 INFO - 1499479473450 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
19:04:33 INFO - 1499479473452 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"6dc00d8e-fd6d-495b-9caf-3a3e1133411c","ELEMENT":"6dc00d8e-fd6d-495b-9caf-3a3e1133411c"}}]
19:04:33 INFO - 1499479473453 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
19:04:33 INFO - 1499479473454 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"ba5347fd-b80e-40a1-884a-c83f48ea5d02","ELEMENT":"ba5347fd-b80e-40a1-884a-c83f48ea5d02"}}]
19:04:33 INFO - 1499479473456 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"6dc00d8e-fd6d-495b-9caf-3a3e1133411c"}]
19:04:33 INFO - 1499479473688 Marionette DEBUG Canceled page load listener because no navigation has been detected
19:04:33 INFO - 1499479473689 Marionette TRACE 394 <- [1,5,null,{}]
19:04:33 INFO - 1499479473690 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"ba5347fd-b80e-40a1-884a-c83f48ea5d02"}]
19:04:33 INFO - 1499479473703 Marionette TRACE 394 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:392:12\nclickElement@chrome://marionette/content/listener.js:1312:5\n"},null]
19:04:33 INFO - 1499479473704 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
19:04:33 INFO - 1499479473706 Marionette TRACE 394 <- [1,7,null,{"value":false}]
19:04:33 INFO - 1499479473708 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}]
19:04:33 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499479473710 Marionette TRACE 394 <- [1,8,null,{"value":null}]
19:04:33 INFO - 1499479473711 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
19:04:33 INFO - 1499479473712 Marionette TRACE 394 <- [1,9,null,{}]
19:04:33 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 334ms
19:04:33 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
19:04:33 INFO - 1499479473714 Marionette DEBUG Closed connection 394
19:04:33 INFO - 1499479473716 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49791
19:04:33 INFO - 1499479473716 Marionette DEBUG Closed connection 395
19:04:33 INFO - 1499479473717 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49792
19:04:33 INFO - 1499479473718 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:04:33 INFO - 1499479473718 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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}
19:04:33 INFO - 1499479473720 Marionette DEBUG Register listener.js for window 12
19:04:33 INFO - 1499479473722 Marionette TRACE 396 <- [1,1,null,{"sessionId":"8f339cea-cb73-44fa-b0d0-d2de6df76208","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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}}]
19:04:33 INFO - 1499479473724 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
19:04:33 INFO - 1499479473724 Marionette TRACE 396 <- [1,2,null,{}]
19:04:33 INFO - 1499479473725 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
19:04:33 INFO - 1499479473726 Marionette TRACE 396 <- [1,3,null,{}]
19:04:33 INFO - 1499479473726 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
19:04:33 INFO - 1499479473727 Marionette TRACE 396 <- [1,4,null,{}]
19:04:33 INFO - 1499479473728 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}]
19:04:33 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499479473730 Marionette TRACE 396 <- [1,5,null,{"value":null}]
19:04:33 INFO - 1499479473731 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
19:04:33 INFO - 1499479473732 Marionette TRACE 396 <- [1,6,null,{}]
19:04:33 INFO - 1499479473734 Marionette DEBUG Closed connection 396
19:04:33 INFO - 1499479473734 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49793
19:04:33 INFO - 1499479473735 Marionette DEBUG Closed connection 397
19:04:33 INFO - 1499479473735 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49794
19:04:33 INFO - 1499479473736 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:04:33 INFO - 1499479473736 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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}
19:04:33 INFO - 1499479473738 Marionette DEBUG Register listener.js for window 12
19:04:33 INFO - 1499479473748 Marionette TRACE 398 <- [1,1,null,{"sessionId":"7f59d0e0-61cb-49db-ab9c-0eefb67a403c","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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}}]
19:04:33 INFO - 1499479473749 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
19:04:33 INFO - 1499479473750 Marionette TRACE 398 <- [1,2,null,{}]
19:04:33 INFO - 1499479473752 Marionette DEBUG Closed connection 398
19:04:33 INFO - 1499479473752 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49795
19:04:33 INFO - 1499479473753 Marionette DEBUG Closed connection 399
19:04:33 INFO - 1499479473754 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49796
19:04:33 INFO - 1499479473754 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
19:04:33 INFO - 1499479473755 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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}
19:04:33 INFO - 1499479473757 Marionette DEBUG Register listener.js for window 12
19:04:33 INFO - 1499479473759 Marionette TRACE 400 <- [1,1,null,{"sessionId":"4336ea1d-982b-403a-a725-0ed0f64e6b95","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":2840,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-227.001\\AppData\\Local\\Temp\\tmpbr0bwc.mozrunner","moz:accessibilityChecks":false}}]
19:04:33 INFO - 1499479473761 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"}]
19:04:33 INFO - 1499479473762 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"
19:04:33 INFO - 1499479473764 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"
19:04:33 INFO - 1499479473764 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"
19:04:33 INFO - 1499479473775 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"
19:04:33 INFO - 1499479473778 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"
19:04:33 INFO - 1499479473780 Marionette TRACE 400 <- [1,2,null,{}]
19:04:33 INFO - 1499479473787 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
19:04:33 INFO - 1499479473789 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"0802302e-8498-45e5-aebf-d40776787d9e","ELEMENT":"0802302e-8498-45e5-aebf-d40776787d9e"}}]
19:04:33 INFO - 1499479473790 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"0802302e-8498-45e5-aebf-d40776787d9e"}]
19:04:33 INFO - 1499479473811 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
19:04:33 INFO - 1499479473813 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"0802302e-8498-45e5-aebf-d40776787d9e"}]
19:04:33 INFO - 1499479473825 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element