could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:222:5\nElementNotInteractableError@chrome://marionette/content/error.js:311:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:176: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:357:12\nclickElement@chrome://marionette/content/listener.js:1226:5\n"},null]
14:39:22 INFO - 1498772362979 Marionette TRACE 358 -> [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}]
14:39:23 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1498772362987 Marionette TRACE 358 <- [1,5,null,{"value":null}]
14:39:23 INFO - 1498772362989 Marionette TRACE 358 -> [0,6,"deleteSession",{}]
14:39:23 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:23 INFO - 1498772362993 Marionette TRACE 358 <- [1,6,null,{}]
14:39:23 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 641ms
14:39:23 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
14:39:23 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:23 INFO - 1498772362999 Marionette DEBUG Closed connection 358
14:39:23 INFO - 1498772363000 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49733
14:39:23 INFO - 1498772363002 Marionette DEBUG Closed connection 359
14:39:23 INFO - 1498772363003 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49734
14:39:23 INFO - 1498772363005 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:39:23 INFO - 1498772363007 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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}
14:39:23 INFO - 1498772363029 Marionette DEBUG Register listener.js for window 7
14:39:23 INFO - 1498772363040 Marionette TRACE 360 <- [1,1,null,{"sessionId":"2b9f225d-c09f-4dca-ba89-57460dce811c","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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}}]
14:39:23 INFO - 1498772363043 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
14:39:23 INFO - 1498772363044 Marionette TRACE 360 <- [1,2,null,{}]
14:39:23 INFO - 1498772363046 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
14:39:23 INFO - 1498772363048 Marionette TRACE 360 <- [1,3,null,{}]
14:39:23 INFO - 1498772363050 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
14:39:23 INFO - 1498772363051 Marionette TRACE 360 <- [1,4,null,{}]
14:39:23 INFO - 1498772363054 Marionette TRACE 360 -> [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}]
14:39:23 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1498772363060 Marionette TRACE 360 <- [1,5,null,{"value":null}]
14:39:23 INFO - 1498772363062 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
14:39:23 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:23 INFO - 1498772363066 Marionette TRACE 360 <- [1,6,null,{}]
14:39:23 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:23 INFO - 1498772363072 Marionette DEBUG Closed connection 360
14:39:23 INFO - 1498772363074 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49735
14:39:23 INFO - 1498772363075 Marionette DEBUG Closed connection 361
14:39:23 INFO - 1498772363077 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49736
14:39:23 INFO - 1498772363079 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:39:23 INFO - 1498772363081 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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}
14:39:23 INFO - 1498772363102 Marionette DEBUG Register listener.js for window 7
14:39:23 INFO - 1498772363113 Marionette TRACE 362 <- [1,1,null,{"sessionId":"d6d19b43-8fbc-4322-853d-c6817f4e882e","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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}}]
14:39:23 INFO - 1498772363116 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
14:39:23 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:23 INFO - 1498772363120 Marionette TRACE 362 <- [1,2,null,{}]
14:39:23 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:23 INFO - 1498772363125 Marionette DEBUG Closed connection 362
14:39:23 INFO - 1498772363127 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49737
14:39:23 INFO - 1498772363128 Marionette DEBUG Closed connection 363
14:39:23 INFO - 1498772363129 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49738
14:39:23 INFO - 1498772363131 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
14:39:23 INFO - 1498772363134 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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}
14:39:23 INFO - 1498772363155 Marionette DEBUG Register listener.js for window 7
14:39:23 INFO - 1498772363167 Marionette TRACE 364 <- [1,1,null,{"sessionId":"cb384e6e-bbc1-4133-acbc-0cba35dfd02f","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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}}]
14:39:23 INFO - 1498772363169 Marionette TRACE 364 -> [0,2,"get",{"url":"http://127.0.0.1:49337/clicks.html"}]
14:39:23 INFO - 1498772363173 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49337/hidden.html"
14:39:23 INFO - 1498772363184 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49337/hidden.html"
14:39:23 INFO - 1498772363185 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49337/hidden.html"
14:39:23 INFO - ++DOMWINDOW == 30 (000000A13FDCF800) [pid = 1124] [serial = 39] [outer = 000000A13FE94800]
14:39:23 INFO - 1498772363244 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49337/clicks.html"
14:39:23 INFO - 1498772363248 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49337/clicks.html"
14:39:23 INFO - 1498772363344 Marionette TRACE 364 <- [1,2,null,{}]
14:39:23 INFO - 1498772363352 Marionette TRACE 364 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
14:39:23 INFO - 1498772363365 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"13bc5146-f922-4062-b9d9-7c819a26584b","ELEMENT":"13bc5146-f922-4062-b9d9-7c819a26584b"}}]
14:39:23 INFO - 1498772363371 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"13bc5146-f922-4062-b9d9-7c819a26584b"}]
14:39:23 INFO - 1498772363594 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49337/clicks.html"
14:39:23 INFO - [1124] WARNING: Cannot switch to prerendered document in the parent process: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/xpfe/appshell/nsContentTreeOwner.cpp, line 445
14:39:23 INFO - 1498772363610 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49337/clicks.html"
14:39:23 INFO - 1498772363611 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49337/clicks.html"
14:39:23 INFO - ++DOMWINDOW == 31 (000000A140430000) [pid = 1124] [serial = 40] [outer = 000000A13FE94800]
14:39:23 INFO - 1498772363704 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49337/test.html"
14:39:23 INFO - 1498772363708 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49337/test.html"
14:39:23 INFO - 1498772363724 Marionette TRACE 364 <- [1,4,null,{}]
14:39:23 INFO - 1498772363729 Marionette TRACE 364 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
14:39:23 INFO - 1498772363741 Marionette TRACE 364 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"f69616e1-f6cb-44c7-821d-d8eb86d7266c","ELEMENT":"f69616e1-f6cb-44c7-821d-d8eb86d7266c"}}]
14:39:24 INFO - 1498772364624 Marionette TRACE 364 -> [0,6,"getTitle",{}]
14:39:24 INFO - 1498772364639 Marionette TRACE 364 <- [1,6,null,{"value":"Marionette Test"}]
14:39:24 INFO - 1498772364646 Marionette TRACE 364 -> [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}]
14:39:24 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1498772364655 Marionette TRACE 364 <- [1,7,null,{"value":null}]
14:39:24 INFO - 1498772364658 Marionette TRACE 364 -> [0,8,"deleteSession",{}]
14:39:24 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:24 INFO - 1498772364662 Marionette TRACE 364 <- [1,8,null,{}]
14:39:24 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 1668ms
14:39:24 INFO - TEST-START | test_click.py TestClick.test_container_element
14:39:24 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:24 INFO - 1498772364719 Marionette DEBUG Closed connection 364
14:39:24 INFO - 1498772364720 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49741
14:39:24 INFO - 1498772364775 Marionette DEBUG Closed connection 365
14:39:24 INFO - 1498772364777 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49742
14:39:24 INFO - 1498772364830 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:39:24 INFO - 1498772364832 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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}
14:39:24 INFO - 1498772364854 Marionette DEBUG Register listener.js for window 7
14:39:24 INFO - 1498772364866 Marionette TRACE 366 <- [1,1,null,{"sessionId":"dd1446c3-537c-4019-b01a-6f27a8e4286e","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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}}]
14:39:24 INFO - 1498772364919 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
14:39:24 INFO - 1498772364920 Marionette TRACE 366 <- [1,2,null,{}]
14:39:24 INFO - 1498772364973 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
14:39:24 INFO - 1498772364975 Marionette TRACE 366 <- [1,3,null,{}]
14:39:25 INFO - 1498772365004 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
14:39:25 INFO - 1498772365005 Marionette TRACE 366 <- [1,4,null,{}]
14:39:25 INFO - 1498772365008 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')","sandbox":"simpletest","line":316}]
14:39:25 INFO - TEST-START: test_click.py TestClick.test_container_element1498772365016 Marionette TRACE 366 <- [1,5,null,{"value":null}]
14:39:25 INFO - 1498772365018 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
14:39:25 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:25 INFO - 1498772365022 Marionette TRACE 366 <- [1,6,null,{}]
14:39:25 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:25 INFO - 1498772365028 Marionette DEBUG Closed connection 366
14:39:25 INFO - 1498772365030 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49743
14:39:25 INFO - 1498772365032 Marionette DEBUG Closed connection 367
14:39:25 INFO - 1498772365033 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49744
14:39:25 INFO - 1498772365035 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:39:25 INFO - 1498772365037 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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}
14:39:25 INFO - 1498772365060 Marionette DEBUG Register listener.js for window 7
14:39:25 INFO - 1498772365111 Marionette TRACE 368 <- [1,1,null,{"sessionId":"ee14b159-7a94-42d7-9fb1-107a8b68b152","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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}}]
14:39:25 INFO - 1498772365114 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
14:39:25 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:25 INFO - 1498772365118 Marionette TRACE 368 <- [1,2,null,{}]
14:39:25 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:25 INFO - 1498772365143 Marionette DEBUG Closed connection 368
14:39:25 INFO - 1498772365144 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49745
14:39:25 INFO - 1498772365153 Marionette DEBUG Closed connection 369
14:39:25 INFO - 1498772365155 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49746
14:39:25 INFO - 1498772365158 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
14:39:25 INFO - 1498772365160 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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}
14:39:25 INFO - 1498772365182 Marionette DEBUG Register listener.js for window 7
14:39:25 INFO - 1498772365194 Marionette TRACE 370 <- [1,1,null,{"sessionId":"3a5bfd25-e942-402f-a3fb-0de9368aa3f3","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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}}]
14:39:25 INFO - 1498772365197 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%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"}]
14:39:25 INFO - 1498772365200 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49337/test.html"
14:39:25 INFO - 1498772365210 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49337/test.html"
14:39:25 INFO - 1498772365211 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49337/test.html"
14:39:25 INFO - ++DOMWINDOW == 32 (000000A140436000) [pid = 1124] [serial = 41] [outer = 000000A13FE94800]
14:39:25 INFO - 1498772365295 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"
14:39:25 INFO - 1498772365317 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"
14:39:25 INFO - 1498772365335 Marionette TRACE 370 <- [1,2,null,{}]
14:39:25 INFO - 1498772365338 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
14:39:25 INFO - 1498772365346 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"b9bff76a-2b12-47e6-b27e-4c3947d61d2e","ELEMENT":"b9bff76a-2b12-47e6-b27e-4c3947d61d2e"}}]
14:39:25 INFO - 1498772365348 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"b9bff76a-2b12-47e6-b27e-4c3947d61d2e"}]
14:39:25 INFO - [1124] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1908
14:39:25 INFO - [1124] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1816
14:39:25 INFO - [1124] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1622
14:39:25 INFO - 1498772365821 Marionette DEBUG Canceled page load listener because no navigation has been detected
14:39:25 INFO - 1498772365825 Marionette TRACE 370 <- [1,4,null,{}]
14:39:25 INFO - 1498772365830 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"b9bff76a-2b12-47e6-b27e-4c3947d61d2e","name":"selected"}]
14:39:25 INFO - 1498772365895 Marionette TRACE 370 <- [1,5,null,{"value":true}]
14:39:25 INFO - 1498772365905 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')","sandbox":"simpletest","line":328}]
14:39:25 INFO - TEST-END: test_click.py TestClick.test_container_element1498772365920 Marionette TRACE 370 <- [1,6,null,{"value":null}]
14:39:25 INFO - 1498772365941 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
14:39:25 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:25 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 1288ms
14:39:25 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
14:39:25 INFO - 1498772365950 Marionette TRACE 370 <- [1,7,null,{}]
14:39:25 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:25 INFO - 1498772365959 Marionette DEBUG Closed connection 370
14:39:25 INFO - 1498772365962 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49747
14:39:25 INFO - 1498772365966 Marionette DEBUG Closed connection 371
14:39:25 INFO - 1498772365970 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49748
14:39:26 INFO - 1498772366000 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:39:26 INFO - 1498772366010 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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}
14:39:26 INFO - 1498772366057 Marionette DEBUG Register listener.js for window 7
14:39:26 INFO - 1498772366092 Marionette TRACE 372 <- [1,1,null,{"sessionId":"3aa7921d-bc5d-4e40-a693-373dd7bff49c","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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}}]
14:39:26 INFO - 1498772366097 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
14:39:26 INFO - 1498772366104 Marionette TRACE 372 <- [1,2,null,{}]
14:39:26 INFO - 1498772366107 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
14:39:26 INFO - 1498772366110 Marionette TRACE 372 <- [1,3,null,{}]
14:39:26 INFO - 1498772366112 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
14:39:26 INFO - 1498772366115 Marionette TRACE 372 <- [1,4,null,{}]
14:39:26 INFO - 1498772366119 Marionette TRACE 372 -> [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}]
14:39:26 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1498772366132 Marionette TRACE 372 <- [1,5,null,{"value":null}]
14:39:26 INFO - 1498772366136 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
14:39:26 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:26 INFO - 1498772366143 Marionette TRACE 372 <- [1,6,null,{}]
14:39:26 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:26 INFO - 1498772366174 Marionette DEBUG Closed connection 372
14:39:26 INFO - 1498772366178 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49749
14:39:26 INFO - 1498772366183 Marionette DEBUG Closed connection 373
14:39:26 INFO - 1498772366185 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49750
14:39:26 INFO - 1498772366189 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:39:26 INFO - 1498772366193 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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}
14:39:26 INFO - 1498772366242 Marionette DEBUG Register listener.js for window 7
14:39:26 INFO - 1498772366296 Marionette TRACE 374 <- [1,1,null,{"sessionId":"94cfc44e-9778-44c6-a3da-fe04c2fafef3","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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}}]
14:39:26 INFO - 1498772366313 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
14:39:26 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:26 INFO - 1498772366323 Marionette TRACE 374 <- [1,2,null,{}]
14:39:26 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:26 INFO - 1498772366349 Marionette DEBUG Closed connection 374
14:39:26 INFO - 1498772366352 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49751
14:39:26 INFO - 1498772366404 Marionette DEBUG Closed connection 375
14:39:26 INFO - 1498772366407 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49752
14:39:26 INFO - 1498772366413 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
14:39:26 INFO - 1498772366417 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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}
14:39:26 INFO - 1498772366467 Marionette DEBUG Register listener.js for window 7
14:39:26 INFO - 1498772366485 Marionette TRACE 376 <- [1,1,null,{"sessionId":"3ce03b8a-47b0-4343-a218-52e73a16a17b","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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}}]
14:39:26 INFO - 1498772366493 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%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"}]
14:39:26 INFO - 1498772366498 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"
14:39:26 INFO - 1498772366511 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"
14:39:26 INFO - 1498772366512 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"
14:39:26 INFO - ++DOMWINDOW == 33 (000000A13F713800) [pid = 1124] [serial = 42] [outer = 000000A13FE94800]
14:39:26 INFO - 1498772366585 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"
14:39:26 INFO - 1498772366593 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"
14:39:26 INFO - 1498772366628 Marionette TRACE 376 <- [1,2,null,{}]
14:39:26 INFO - 1498772366633 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
14:39:26 INFO - 1498772366643 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"6b098c1f-7088-4e54-b5a7-fe5161eb0163","ELEMENT":"6b098c1f-7088-4e54-b5a7-fe5161eb0163"}}]
14:39:26 INFO - 1498772366646 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"6b098c1f-7088-4e54-b5a7-fe5161eb0163"}]
14:39:27 INFO - [1124] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1908
14:39:27 INFO - [1124] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1816
14:39:27 INFO - [1124] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1622
14:39:27 INFO - 1498772367297 Marionette DEBUG Canceled page load listener because no navigation has been detected
14:39:27 INFO - 1498772367300 Marionette TRACE 376 <- [1,4,null,{}]
14:39:27 INFO - 1498772367303 Marionette TRACE 376 -> [0,5,"getElementProperty",{"id":"6b098c1f-7088-4e54-b5a7-fe5161eb0163","name":"selected"}]
14:39:27 INFO - 1498772367366 Marionette TRACE 376 <- [1,5,null,{"value":true}]
14:39:27 INFO - 1498772367388 Marionette TRACE 376 -> [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}]
14:39:27 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1498772367403 Marionette TRACE 376 <- [1,6,null,{"value":null}]
14:39:27 INFO - 1498772367406 Marionette TRACE 376 -> [0,7,"deleteSession",{}]
14:39:27 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:27 INFO - 1498772367411 Marionette TRACE 376 <- [1,7,null,{}]
14:39:27 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 1460ms
14:39:27 INFO - TEST-START | test_click.py TestClick.test_css_transforms
14:39:27 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:27 INFO - 1498772367444 Marionette DEBUG Closed connection 376
14:39:27 INFO - 1498772367447 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49753
14:39:27 INFO - 1498772367450 Marionette DEBUG Closed connection 377
14:39:27 INFO - 1498772367454 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49754
14:39:27 INFO - 1498772367460 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:39:27 INFO - 1498772367463 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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}
14:39:27 INFO - 1498772367511 Marionette DEBUG Register listener.js for window 7
14:39:27 INFO - 1498772367565 Marionette TRACE 378 <- [1,1,null,{"sessionId":"135240cf-e300-464b-9d3d-b80a0b354b6d","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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}}]
14:39:27 INFO - 1498772367575 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
14:39:27 INFO - 1498772367577 Marionette TRACE 378 <- [1,2,null,{}]
14:39:27 INFO - 1498772367580 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
14:39:27 INFO - 1498772367583 Marionette TRACE 378 <- [1,3,null,{}]
14:39:27 INFO - 1498772367635 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
14:39:27 INFO - 1498772367637 Marionette TRACE 378 <- [1,4,null,{}]
14:39:27 INFO - 1498772367643 Marionette TRACE 378 -> [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}]
14:39:27 INFO - TEST-START: test_click.py TestClick.test_css_transforms1498772367652 Marionette TRACE 378 <- [1,5,null,{"value":null}]
14:39:27 INFO - 1498772367654 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
14:39:27 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:27 INFO - 1498772367660 Marionette TRACE 378 <- [1,6,null,{}]
14:39:27 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:27 INFO - 1498772367686 Marionette DEBUG Closed connection 378
14:39:27 INFO - 1498772367688 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49755
14:39:27 INFO - 1498772367691 Marionette DEBUG Closed connection 379
14:39:27 INFO - 1498772367693 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49756
14:39:27 INFO - 1498772367696 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:39:27 INFO - 1498772367699 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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}
14:39:27 INFO - 1498772367748 Marionette DEBUG Register listener.js for window 7
14:39:27 INFO - 1498772367780 Marionette TRACE 380 <- [1,1,null,{"sessionId":"9d05027b-b614-4d2f-882b-9bc3635387d8","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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}}]
14:39:27 INFO - 1498772367791 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
14:39:27 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:27 INFO - 1498772367798 Marionette TRACE 380 <- [1,2,null,{}]
14:39:27 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:27 INFO - 1498772367826 Marionette DEBUG Closed connection 380
14:39:27 INFO - 1498772367832 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49757
14:39:27 INFO - 1498772367850 Marionette DEBUG Closed connection 381
14:39:27 INFO - 1498772367852 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49758
14:39:27 INFO - 1498772367858 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
14:39:27 INFO - 1498772367864 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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}
14:39:27 INFO - 1498772367915 Marionette DEBUG Register listener.js for window 7
14:39:27 INFO - 1498772367932 Marionette TRACE 382 <- [1,1,null,{"sessionId":"59dfdf17-d1e7-4b61-a346-6d456492df76","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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}}]
14:39:27 INFO - 1498772367939 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%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"}]
14:39:27 INFO - 1498772367945 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"
14:39:27 INFO - 1498772367955 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"
14:39:27 INFO - 1498772367956 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"
14:39:27 INFO - ++DOMWINDOW == 34 (000000A1475C2800) [pid = 1124] [serial = 43] [outer = 000000A13FE94800]
14:39:28 INFO - 1498772368023 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"
14:39:28 INFO - 1498772368033 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"
14:39:28 INFO - 1498772368281 Marionette TRACE 382 <- [1,2,null,{}]
14:39:28 INFO - 1498772368288 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
14:39:28 INFO - 1498772368301 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"53a6bb0d-078c-44b2-9529-2403ab2b5a6b","ELEMENT":"53a6bb0d-078c-44b2-9529-2403ab2b5a6b"}}]
14:39:28 INFO - 1498772368305 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"53a6bb0d-078c-44b2-9529-2403ab2b5a6b"}]
14:39:28 INFO - 1498772368777 Marionette DEBUG Canceled page load listener because no navigation has been detected
14:39:28 INFO - 1498772368781 Marionette TRACE 382 <- [1,4,null,{}]
14:39:28 INFO - 1498772368786 Marionette TRACE 382 -> [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}]
14:39:28 INFO - TEST-END: test_click.py TestClick.test_css_transforms1498772368800 Marionette TRACE 382 <- [1,5,null,{"value":null}]
14:39:28 INFO - 1498772368804 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
14:39:28 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:28 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 1403ms
14:39:28 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
14:39:28 INFO - 1498772368814 Marionette TRACE 382 <- [1,6,null,{}]
14:39:28 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:28 INFO - 1498772368825 Marionette DEBUG Closed connection 382
14:39:28 INFO - 1498772368830 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49759
14:39:28 INFO - 1498772368869 Marionette DEBUG Closed connection 383
14:39:28 INFO - 1498772368872 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49760
14:39:28 INFO - 1498772368877 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:39:28 INFO - 1498772368887 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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}
14:39:28 INFO - 1498772368915 Marionette DEBUG Register listener.js for window 7
14:39:28 INFO - 1498772368938 Marionette TRACE 384 <- [1,1,null,{"sessionId":"cd7fe8e1-9f91-4ff3-8b8b-5374eb510353","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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}}]
14:39:28 INFO - 1498772368970 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
14:39:28 INFO - 1498772368974 Marionette TRACE 384 <- [1,2,null,{}]
14:39:28 INFO - 1498772368984 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
14:39:28 INFO - 1498772368986 Marionette TRACE 384 <- [1,3,null,{}]
14:39:29 INFO - 1498772369048 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
14:39:29 INFO - 1498772369050 Marionette TRACE 384 <- [1,4,null,{}]
14:39:29 INFO - 1498772369057 Marionette TRACE 384 -> [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}]
14:39:29 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1498772369068 Marionette TRACE 384 <- [1,5,null,{"value":null}]
14:39:29 INFO - 1498772369072 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
14:39:29 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:29 INFO - 1498772369079 Marionette TRACE 384 <- [1,6,null,{}]
14:39:29 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:29 INFO - 1498772369087 Marionette DEBUG Closed connection 384
14:39:29 INFO - 1498772369091 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49761
14:39:29 INFO - 1498772369096 Marionette DEBUG Closed connection 385
14:39:29 INFO - 1498772369098 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49762
14:39:29 INFO - 1498772369106 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:39:29 INFO - 1498772369112 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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}
14:39:29 INFO - 1498772369137 Marionette DEBUG Register listener.js for window 7
14:39:29 INFO - 1498772369155 Marionette TRACE 386 <- [1,1,null,{"sessionId":"bc4f2f1e-1d93-478a-ab80-7227de0c0040","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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}}]
14:39:29 INFO - 1498772369159 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
14:39:29 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:29 INFO - 1498772369165 Marionette TRACE 386 <- [1,2,null,{}]
14:39:29 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:29 INFO - 1498772369175 Marionette DEBUG Closed connection 386
14:39:29 INFO - 1498772369177 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49763
14:39:29 INFO - 1498772369181 Marionette DEBUG Closed connection 387
14:39:29 INFO - 1498772369184 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49764
14:39:29 INFO - 1498772369187 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
14:39:29 INFO - 1498772369190 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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}
14:39:29 INFO - 1498772369216 Marionette DEBUG Register listener.js for window 7
14:39:29 INFO - 1498772369232 Marionette TRACE 388 <- [1,1,null,{"sessionId":"bc478eec-0c9a-472c-8775-41b9247cde4d","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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}}]
14:39:29 INFO - 1498772369286 Marionette TRACE 388 -> [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"}]
14:39:29 INFO - 1498772369296 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"
14:39:29 INFO - 1498772369306 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"
14:39:29 INFO - 1498772369307 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"
14:39:29 INFO - ++DOMWINDOW == 35 (000000A137373000) [pid = 1124] [serial = 44] [outer = 000000A13FE94800]
14:39:29 INFO - 1498772369369 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"
14:39:29 INFO - 1498772369376 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"
14:39:29 INFO - 1498772369396 Marionette TRACE 388 <- [1,2,null,{}]
14:39:29 INFO - --DOMWINDOW == 34 (000000A1478AD800) [pid = 1124] [serial = 28] [outer = 0000000000000000] [url = http://127.0.0.1:49337/test_accessibility.html]
14:39:29 INFO - --DOMWINDOW == 33 (000000A1475BD000) [pid = 1124] [serial = 27] [outer = 0000000000000000] [url = http://127.0.0.1:49337/test_accessibility.html]
14:39:29 INFO - --DOMWINDOW == 32 (000000A143D78000) [pid = 1124] [serial = 26] [outer = 0000000000000000] [url = http://127.0.0.1:49337/test_accessibility.html]
14:39:29 INFO - --DOMWINDOW == 31 (000000A13FE86800) [pid = 1124] [serial = 25] [outer = 0000000000000000] [url = http://127.0.0.1:49337/test_accessibility.html]
14:39:29 INFO - --DOMWINDOW == 30 (000000A13FB06000) [pid = 1124] [serial = 24] [outer = 0000000000000000] [url = http://127.0.0.1:49337/test_accessibility.html]
14:39:29 INFO - --DOMWINDOW == 29 (000000A13F70E800) [pid = 1124] [serial = 23] [outer = 0000000000000000] [url = http://127.0.0.1:49337/test_accessibility.html]
14:39:29 INFO - --DOMWINDOW == 28 (000000A136B87000) [pid = 1124] [serial = 22] [outer = 0000000000000000] [url = http://127.0.0.1:49337/test_accessibility.html]
14:39:29 INFO - --DOMWINDOW == 27 (000000A13F71D800) [pid = 1124] [serial = 21] [outer = 0000000000000000] [url = http://127.0.0.1:49337/test_accessibility.html]
14:39:29 INFO - 1498772369411 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
14:39:29 INFO - 1498772369419 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"3c6e4f2a-8b62-4a44-a21c-6ae0d2166487","ELEMENT":"3c6e4f2a-8b62-4a44-a21c-6ae0d2166487"}}]
14:39:29 INFO - 1498772369421 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"3c6e4f2a-8b62-4a44-a21c-6ae0d2166487"}]
14:39:29 INFO - 1498772369876 Marionette DEBUG Canceled page load listener because no navigation has been detected
14:39:29 INFO - 1498772369878 Marionette TRACE 388 <- [1,4,null,{}]
14:39:29 INFO - 1498772369881 Marionette TRACE 388 -> [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}]
14:39:29 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1498772369892 Marionette TRACE 388 <- [1,5,null,{"value":null}]
14:39:30 INFO - 1498772370732 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
14:39:30 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:30 INFO - 1498772370736 Marionette TRACE 388 <- [1,6,null,{}]
14:39:30 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 1927ms
14:39:30 INFO - TEST-START | test_click.py TestClick.test_input_file
14:39:30 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:30 INFO - 1498772370792 Marionette DEBUG Closed connection 388
14:39:30 INFO - 1498772370793 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49765
14:39:30 INFO - 1498772370848 Marionette DEBUG Closed connection 389
14:39:30 INFO - 1498772370850 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49766
14:39:30 INFO - 1498772370906 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:39:30 INFO - 1498772370908 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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}
14:39:30 INFO - 1498772370933 Marionette DEBUG Register listener.js for window 7
14:39:30 INFO - 1498772370948 Marionette TRACE 390 <- [1,1,null,{"sessionId":"99e46049-a48e-4a1d-ad12-843a51c1067c","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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}}]
14:39:30 INFO - 1498772370951 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
14:39:30 INFO - 1498772370953 Marionette TRACE 390 <- [1,2,null,{}]
14:39:30 INFO - 1498772370955 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
14:39:30 INFO - 1498772370957 Marionette TRACE 390 <- [1,3,null,{}]
14:39:30 INFO - 1498772370959 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
14:39:30 INFO - 1498772370961 Marionette TRACE 390 <- [1,4,null,{}]
14:39:30 INFO - 1498772370964 Marionette TRACE 390 -> [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}]
14:39:31 INFO - TEST-START: test_click.py TestClick.test_input_file1498772371024 Marionette TRACE 390 <- [1,5,null,{"value":null}]
14:39:31 INFO - 1498772371076 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
14:39:31 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:31 INFO - 1498772371081 Marionette TRACE 390 <- [1,6,null,{}]
14:39:31 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:31 INFO - 1498772371137 Marionette DEBUG Closed connection 390
14:39:31 INFO - 1498772371139 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49767
14:39:31 INFO - 1498772371193 Marionette DEBUG Closed connection 391
14:39:31 INFO - 1498772371195 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49768
14:39:31 INFO - 1498772371231 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:39:31 INFO - 1498772371234 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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}
14:39:31 INFO - 1498772371257 Marionette DEBUG Register listener.js for window 7
14:39:31 INFO - 1498772371274 Marionette TRACE 392 <- [1,1,null,{"sessionId":"07cbb97b-daee-4980-b402-49c3e356273a","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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}}]
14:39:31 INFO - 1498772371277 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
14:39:31 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:31 INFO - 1498772371282 Marionette TRACE 392 <- [1,2,null,{}]
14:39:31 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:31 INFO - 1498772371291 Marionette DEBUG Closed connection 392
14:39:31 INFO - 1498772371295 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49769
14:39:31 INFO - 1498772371342 Marionette DEBUG Closed connection 393
14:39:31 INFO - 1498772371344 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49770
14:39:31 INFO - 1498772371346 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
14:39:31 INFO - 1498772371351 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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}
14:39:31 INFO - 1498772371375 Marionette DEBUG Register listener.js for window 7
14:39:31 INFO - 1498772371389 Marionette TRACE 394 <- [1,1,null,{"sessionId":"bc8f9fdc-391b-4f5f-b72a-d2b61f644207","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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}}]
14:39:31 INFO - 1498772371397 Marionette TRACE 394 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
14:39:31 INFO - 1498772371401 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"
14:39:31 INFO - 1498772371410 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"
14:39:31 INFO - 1498772371411 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"
14:39:31 INFO - ++DOMWINDOW == 28 (000000A13F71D000) [pid = 1124] [serial = 45] [outer = 000000A13FE94800]
14:39:31 INFO - 1498772371468 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
14:39:31 INFO - 1498772371484 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
14:39:31 INFO - 1498772371494 Marionette TRACE 394 <- [1,2,null,{}]
14:39:31 INFO - 1498772371504 Marionette TRACE 394 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
14:39:31 INFO - 1498772371538 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"c1964e4b-4cf8-4acd-b17d-338e1b0b3782","ELEMENT":"c1964e4b-4cf8-4acd-b17d-338e1b0b3782"}}]
14:39:31 INFO - 1498772371540 Marionette TRACE 394 -> [0,4,"clickElement",{"id":"c1964e4b-4cf8-4acd-b17d-338e1b0b3782"}]
14:39:31 INFO - 1498772371723 Marionette TRACE 394 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:222:5\nInvalidArgumentError@chrome://marionette/content/error.js:325:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:158: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:357:12\nclickElement@chrome://marionette/content/listener.js:1226:5\n"},null]
14:39:31 INFO - 1498772371727 Marionette TRACE 394 -> [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}]
14:39:31 INFO - TEST-END: test_click.py TestClick.test_input_file1498772371735 Marionette TRACE 394 <- [1,5,null,{"value":null}]
14:39:31 INFO - 1498772371737 Marionette TRACE 394 -> [0,6,"deleteSession",{}]
14:39:31 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:31 INFO - 1498772371741 Marionette TRACE 394 <- [1,6,null,{}]
14:39:31 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 997ms
14:39:31 INFO - TEST-START | test_click.py TestClick.test_obscured_element
14:39:31 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:31 INFO - 1498772371747 Marionette DEBUG Closed connection 394
14:39:31 INFO - 1498772371749 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49771
14:39:31 INFO - 1498772371750 Marionette DEBUG Closed connection 395
14:39:31 INFO - 1498772371751 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49772
14:39:31 INFO - 1498772371775 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:39:31 INFO - 1498772371778 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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}
14:39:31 INFO - 1498772371801 Marionette DEBUG Register listener.js for window 7
14:39:31 INFO - 1498772371814 Marionette TRACE 396 <- [1,1,null,{"sessionId":"cb96406a-72a9-4707-b7b1-7a80acfcd109","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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}}]
14:39:31 INFO - 1498772371820 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
14:39:31 INFO - 1498772371822 Marionette TRACE 396 <- [1,2,null,{}]
14:39:31 INFO - 1498772371824 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
14:39:31 INFO - 1498772371826 Marionette TRACE 396 <- [1,3,null,{}]
14:39:31 INFO - 1498772371828 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
14:39:31 INFO - 1498772371830 Marionette TRACE 396 <- [1,4,null,{}]
14:39:31 INFO - 1498772371832 Marionette TRACE 396 -> [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}]
14:39:31 INFO - TEST-START: test_click.py TestClick.test_obscured_element1498772371841 Marionette TRACE 396 <- [1,5,null,{"value":null}]
14:39:31 INFO - 1498772371843 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
14:39:31 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:31 INFO - 1498772371847 Marionette TRACE 396 <- [1,6,null,{}]
14:39:31 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:31 INFO - 1498772371872 Marionette DEBUG Closed connection 396
14:39:31 INFO - 1498772371874 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49773
14:39:31 INFO - 1498772371878 Marionette DEBUG Closed connection 397
14:39:31 INFO - 1498772371879 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49774
14:39:31 INFO - 1498772371881 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:39:31 INFO - 1498772371884 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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}
14:39:31 INFO - 1498772371908 Marionette DEBUG Register listener.js for window 7
14:39:31 INFO - 1498772371920 Marionette TRACE 398 <- [1,1,null,{"sessionId":"9e34d291-cc24-4c3c-bf55-07f30f7910f4","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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}}]
14:39:31 INFO - 1498772371927 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
14:39:31 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:31 INFO - 1498772371931 Marionette TRACE 398 <- [1,2,null,{}]
14:39:31 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:31 INFO - 1498772371954 Marionette DEBUG Closed connection 398
14:39:31 INFO - 1498772371956 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49775
14:39:31 INFO - 1498772371976 Marionette DEBUG Closed connection 399
14:39:31 INFO - 1498772371977 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49776
14:39:31 INFO - 1498772371981 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
14:39:31 INFO - 1498772371984 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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}
14:39:32 INFO - 1498772372009 Marionette DEBUG Register listener.js for window 7
14:39:32 INFO - 1498772372024 Marionette TRACE 400 <- [1,1,null,{"sessionId":"c5ef430b-9a83-4954-80db-547211e247dc","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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}}]
14:39:32 INFO - 1498772372031 Marionette TRACE 400 -> [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"}]
14:39:32 INFO - 1498772372035 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
14:39:32 INFO - 1498772372050 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
14:39:32 INFO - 1498772372051 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
14:39:32 INFO - ++DOMWINDOW == 29 (000000A13F8DE800) [pid = 1124] [serial = 46] [outer = 000000A13FE94800]
14:39:32 INFO - 1498772372113 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"
14:39:32 INFO - 1498772372120 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"
14:39:32 INFO - 1498772372128 Marionette TRACE 400 <- [1,2,null,{}]
14:39:32 INFO - 1498772372138 Marionette TRACE 400 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
14:39:32 INFO - 1498772372146 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"8c4cf473-0c88-48ba-afc4-d197aca6d22d","ELEMENT":"8c4cf473-0c88-48ba-afc4-d197aca6d22d"}}]
14:39:32 INFO - 1498772372153 Marionette TRACE 400 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
14:39:32 INFO - 1498772372161 Marionette TRACE 400 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"8c8dd529-9968-44f9-9ed7-b999ddcfd445","ELEMENT":"8c8dd529-9968-44f9-9ed7-b999ddcfd445"}}]
14:39:32 INFO - 1498772372163 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"8c4cf473-0c88-48ba-afc4-d197aca6d22d"}]
14:39:32 INFO - 1498772372621 Marionette DEBUG Canceled page load listener because no navigation has been detected
14:39:32 INFO - 1498772372622 Marionette TRACE 400 <- [1,5,null,{}]
14:39:32 INFO - 1498772372624 Marionette TRACE 400 -> [0,6,"clickElement",{"id":"8c8dd529-9968-44f9-9ed7-b999ddcfd445"}]
14:39:32 INFO - 1498772372761 Marionette TRACE 400 <- [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:222:5\nElementClickInterceptedError@chrome://marionette/content/error.js:304:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:185: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:357:12\nclickElement@chrome://marionette/content/listener.js:1226:5\n"},null]
14:39:32 INFO - 1498772372791 Marionette TRACE 400 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
14:39:32 INFO - 1498772372800 Marionette TRACE 400 <- [1,7,null,{"value":false}]
14:39:32 INFO - 1498772372807 Marionette TRACE 400 -> [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}]
14:39:32 INFO - TEST-END: test_click.py TestClick.test_obscured_element1498772372815 Marionette TRACE 400 <- [1,8,null,{"value":null}]
14:39:32 INFO - 1498772372817 Marionette TRACE 400 -> [0,9,"deleteSession",{}]
14:39:32 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:32 INFO - 1498772372822 Marionette TRACE 400 <- [1,9,null,{}]
14:39:32 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 1081ms
14:39:32 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
14:39:33 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:33 INFO - 1498772373484 Marionette DEBUG Closed connection 400
14:39:33 INFO - 1498772373486 Marionette DEBUG Accepted connection 401 from 127.0.0.1:49777
14:39:33 INFO - 1498772373488 Marionette DEBUG Accepted connection 402 from 127.0.0.1:49778
14:39:33 INFO - 1498772373490 Marionette DEBUG Closed connection 401
14:39:33 INFO - 1498772373541 Marionette DEBUG Closed connection 402
14:39:33 INFO - 1498772373543 Marionette DEBUG Accepted connection 403 from 127.0.0.1:49779
14:39:33 INFO - 1498772373576 Marionette TRACE 403 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:39:33 INFO - 1498772373579 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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}
14:39:33 INFO - 1498772373603 Marionette DEBUG Register listener.js for window 7
14:39:33 INFO - 1498772373615 Marionette TRACE 403 <- [1,1,null,{"sessionId":"f0897c95-cb03-4727-a363-61c2a34b6a9d","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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}}]
14:39:33 INFO - 1498772373626 Marionette TRACE 403 -> [0,2,"setTimeouts",{"script":30000}]
14:39:33 INFO - 1498772373628 Marionette TRACE 403 <- [1,2,null,{}]
14:39:33 INFO - 1498772373630 Marionette TRACE 403 -> [0,3,"setTimeouts",{"pageLoad":300000}]
14:39:33 INFO - 1498772373632 Marionette TRACE 403 <- [1,3,null,{}]
14:39:33 INFO - 1498772373634 Marionette TRACE 403 -> [0,4,"setTimeouts",{"implicit":0}]
14:39:33 INFO - 1498772373636 Marionette TRACE 403 <- [1,4,null,{}]
14:39:33 INFO - 1498772373638 Marionette TRACE 403 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_pointer_events_none')","sandbox":"simpletest","line":316}]
14:39:33 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1498772373646 Marionette TRACE 403 <- [1,5,null,{"value":null}]
14:39:33 INFO - 1498772373651 Marionette TRACE 403 -> [0,6,"deleteSession",{}]
14:39:33 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:33 INFO - 1498772373655 Marionette TRACE 403 <- [1,6,null,{}]
14:39:33 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:33 INFO - 1498772373679 Marionette DEBUG Closed connection 403
14:39:33 INFO - 1498772373681 Marionette DEBUG Accepted connection 404 from 127.0.0.1:49780
14:39:33 INFO - 1498772373685 Marionette DEBUG Closed connection 404
14:39:33 INFO - 1498772373687 Marionette DEBUG Accepted connection 405 from 127.0.0.1:49781
14:39:33 INFO - 1498772373689 Marionette TRACE 405 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:39:33 INFO - 1498772373693 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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}
14:39:33 INFO - 1498772373727 Marionette DEBUG Register listener.js for window 7
14:39:33 INFO - 1498772373743 Marionette TRACE 405 <- [1,1,null,{"sessionId":"0aaba50c-0bc3-40ca-abb0-cde8057365ea","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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}}]
14:39:33 INFO - 1498772373750 Marionette TRACE 405 -> [0,2,"deleteSession",{}]
14:39:33 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:33 INFO - 1498772373754 Marionette TRACE 405 <- [1,2,null,{}]
14:39:33 INFO - [1124] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:39:33 INFO - 1498772373778 Marionette DEBUG Closed connection 405
14:39:33 INFO - 1498772373779 Marionette DEBUG Accepted connection 406 from 127.0.0.1:49782
14:39:33 INFO - 1498772373784 Marionette DEBUG Closed connection 406
14:39:33 INFO - 1498772373785 Marionette DEBUG Accepted connection 407 from 127.0.0.1:49783
14:39:33 INFO - 1498772373788 Marionette TRACE 407 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
14:39:33 INFO - 1498772373790 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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}
14:39:33 INFO - 1498772373815 Marionette DEBUG Register listener.js for window 7
14:39:33 INFO - 1498772373828 Marionette TRACE 407 <- [1,1,null,{"sessionId":"cc749bee-bdce-4691-986a-8c9d02b1cf0a","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":1124,"moz:profile":"c:\\users\\cltbld~1.t-w\\appdata\\local\\temp\\tmpka2jli.mozrunner","moz:accessibilityChecks":false}}]
14:39:33 INFO - 1498772373835 Marionette TRACE 407 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"}]
14:39:33 INFO - 1498772373839 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"
14:39:33 INFO - 1498772373850 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"
14:39:33 INFO - 1498772373850 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"
14:39:33 INFO - ++DOMWINDOW == 30 (000000A142F95800) [pid = 1124] [serial = 47] [outer = 000000A13FE94800]
14:39:33 INFO - 1498772373912 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"
14:39:33 INFO - 1498772373918 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"
14:39:33 INFO - 1498772373926 Marionette TRACE 407 <- [1,2,null,{}]
14:39:33 INFO - 1498772373936 Marionette TRACE 407 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
14:39:33 INFO - 1498772373944 Marionette TRACE 407 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"2a863123-1525-4c5e-a717-a09098fa3ef2","ELEMENT":"2a863123-1525-4c5e-a717-a09098fa3ef2"}}]
14:39:33 INFO - 1498772373951 Marionette TRACE 407 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"2a863123-1525-4c5e-a717-a09098fa3ef2"}]
14:39:34 INFO - 1498772374103 Marionette TRACE 407 <- [1,4,null,{"value":"none"}]
14:39:34 INFO - 1498772374107 Marionette TRACE 407 -> [0,5,"clickElement",{"id":"2a863123-1525-4c5e-a717-a09098fa3ef2"}]
14:39:34 INFO - 1498772374421 Marionette TRACE 407 <- [1,5,{"error":"element click intercepted","message":"Element