could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementNotInteractableError@chrome://marionette/content/error.js:315:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:183:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
03:48:08 INFO - 1500806888684 Marionette TRACE 353 -> [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}]
03:48:08 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1500806888691 Marionette TRACE 353 <- [1,5,null,{"value":null}]
03:48:08 INFO - 1500806888716 Marionette TRACE 353 -> [0,6,"deleteSession",{}]
03:48:08 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:08 INFO - 1500806888720 Marionette TRACE 353 <- [1,6,null,{}]
03:48:09 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 1471ms
03:48:09 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
03:48:09 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:09 INFO - 1500806889581 Marionette DEBUG Closed connection 353
03:48:09 INFO - 1500806889582 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49788
03:48:09 INFO - 1500806889637 Marionette DEBUG Closed connection 354
03:48:09 INFO - 1500806889639 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49789
03:48:09 INFO - 1500806889688 Marionette TRACE 355 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:48:09 INFO - 1500806889691 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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}
03:48:09 INFO - 1500806889711 Marionette DEBUG Register listener.js for window 12
03:48:09 INFO - 1500806889722 Marionette TRACE 355 <- [1,1,null,{"sessionId":"6d844d90-cc45-4165-9f30-66402f18bdb6","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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}}]
03:48:09 INFO - 1500806889779 Marionette TRACE 355 -> [0,2,"setTimeouts",{"script":30000}]
03:48:09 INFO - 1500806889781 Marionette TRACE 355 <- [1,2,null,{}]
03:48:09 INFO - 1500806889834 Marionette TRACE 355 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:48:09 INFO - 1500806889836 Marionette TRACE 355 <- [1,3,null,{}]
03:48:09 INFO - 1500806889838 Marionette TRACE 355 -> [0,4,"setTimeouts",{"implicit":0}]
03:48:09 INFO - 1500806889839 Marionette TRACE 355 <- [1,4,null,{}]
03:48:09 INFO - 1500806889859 Marionette TRACE 355 -> [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}]
03:48:09 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1500806889866 Marionette TRACE 355 <- [1,5,null,{"value":null}]
03:48:09 INFO - 1500806889869 Marionette TRACE 355 -> [0,6,"deleteSession",{}]
03:48:09 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:09 INFO - 1500806889873 Marionette TRACE 355 <- [1,6,null,{}]
03:48:09 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:09 INFO - 1500806889899 Marionette DEBUG Closed connection 355
03:48:09 INFO - 1500806889901 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49790
03:48:09 INFO - 1500806889906 Marionette DEBUG Closed connection 356
03:48:09 INFO - 1500806889907 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49791
03:48:09 INFO - 1500806889910 Marionette TRACE 357 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:48:09 INFO - 1500806889912 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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}
03:48:09 INFO - 1500806889935 Marionette DEBUG Register listener.js for window 12
03:48:09 INFO - 1500806889946 Marionette TRACE 357 <- [1,1,null,{"sessionId":"a9d65421-8e07-4d72-b527-e04ca3b8e671","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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}}]
03:48:09 INFO - 1500806889956 Marionette TRACE 357 -> [0,2,"deleteSession",{}]
03:48:09 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:09 INFO - 1500806889960 Marionette TRACE 357 <- [1,2,null,{}]
03:48:10 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:10 INFO - 1500806890020 Marionette DEBUG Closed connection 357
03:48:10 INFO - 1500806890023 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49792
03:48:10 INFO - 1500806890046 Marionette DEBUG Closed connection 358
03:48:10 INFO - 1500806890049 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49793
03:48:10 INFO - 1500806890054 Marionette TRACE 359 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:48:10 INFO - 1500806890066 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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}
03:48:10 INFO - 1500806890110 Marionette DEBUG Register listener.js for window 12
03:48:10 INFO - 1500806890132 Marionette TRACE 359 <- [1,1,null,{"sessionId":"ee67c43b-d996-4b98-96c2-ca6f42e1632a","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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}}]
03:48:10 INFO - 1500806890158 Marionette TRACE 359 -> [0,2,"get",{"url":"http://127.0.0.1:49337/clicks.html"}]
03:48:10 INFO - 1500806890165 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49337/hidden.html"
03:48:10 INFO - 1500806890184 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49337/hidden.html"
03:48:10 INFO - 1500806890186 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49337/hidden.html"
03:48:10 INFO - ++DOMWINDOW == 29 (0000005139E39000) [pid = 3844] [serial = 41] [outer = 0000005146E2A800]
03:48:10 INFO - 1500806890269 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49337/clicks.html"
03:48:10 INFO - 1500806890277 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49337/clicks.html"
03:48:10 INFO - 1500806890313 Marionette TRACE 359 <- [1,2,null,{}]
03:48:10 INFO - 1500806890323 Marionette TRACE 359 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
03:48:10 INFO - 1500806890336 Marionette TRACE 359 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"8a8f80d8-26cc-4c37-a1df-c81a12c57ce1","ELEMENT":"8a8f80d8-26cc-4c37-a1df-c81a12c57ce1"}}]
03:48:10 INFO - 1500806890340 Marionette TRACE 359 -> [0,4,"clickElement",{"id":"8a8f80d8-26cc-4c37-a1df-c81a12c57ce1"}]
03:48:10 INFO - 1500806890727 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49337/clicks.html"
03:48:10 INFO - [Parent 3844] 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 446
03:48:10 INFO - 1500806890748 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49337/clicks.html"
03:48:10 INFO - 1500806890750 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49337/clicks.html"
03:48:10 INFO - ++DOMWINDOW == 30 (000000513C5AB800) [pid = 3844] [serial = 42] [outer = 0000005146E2A800]
03:48:10 INFO - 1500806890834 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49337/test.html"
03:48:10 INFO - 1500806890840 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49337/test.html"
03:48:10 INFO - 1500806890862 Marionette TRACE 359 <- [1,4,null,{}]
03:48:10 INFO - 1500806890880 Marionette TRACE 359 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
03:48:10 INFO - 1500806890892 Marionette TRACE 359 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"8fcb8bb6-edfa-4f30-9241-668ed3a2b414","ELEMENT":"8fcb8bb6-edfa-4f30-9241-668ed3a2b414"}}]
03:48:10 INFO - 1500806890936 Marionette TRACE 359 -> [0,6,"getTitle",{}]
03:48:10 INFO - 1500806890939 Marionette TRACE 359 <- [1,6,null,{"value":"Marionette Test"}]
03:48:10 INFO - 1500806890944 Marionette TRACE 359 -> [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}]
03:48:10 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1500806890956 Marionette TRACE 359 <- [1,7,null,{"value":null}]
03:48:10 INFO - 1500806890959 Marionette TRACE 359 -> [0,8,"deleteSession",{}]
03:48:10 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:10 INFO - 1500806890967 Marionette TRACE 359 <- [1,8,null,{}]
03:48:10 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 1435ms
03:48:10 INFO - TEST-START | test_click.py TestClick.test_container_element
03:48:10 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:10 INFO - 1500806890975 Marionette DEBUG Closed connection 359
03:48:10 INFO - 1500806890979 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49796
03:48:11 INFO - 1500806890994 Marionette DEBUG Closed connection 360
03:48:11 INFO - 1500806890997 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49797
03:48:11 INFO - 1500806891021 Marionette TRACE 361 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:48:11 INFO - 1500806891025 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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}
03:48:11 INFO - 1500806891067 Marionette DEBUG Register listener.js for window 12
03:48:11 INFO - 1500806891084 Marionette TRACE 361 <- [1,1,null,{"sessionId":"f11e0af3-d943-4c9e-8834-0f3c5dd6ae21","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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}}]
03:48:11 INFO - 1500806891097 Marionette TRACE 361 -> [0,2,"setTimeouts",{"script":30000}]
03:48:11 INFO - 1500806891099 Marionette TRACE 361 <- [1,2,null,{}]
03:48:11 INFO - 1500806891107 Marionette TRACE 361 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:48:11 INFO - 1500806891113 Marionette TRACE 361 <- [1,3,null,{}]
03:48:11 INFO - 1500806891122 Marionette TRACE 361 -> [0,4,"setTimeouts",{"implicit":0}]
03:48:11 INFO - 1500806891124 Marionette TRACE 361 <- [1,4,null,{}]
03:48:11 INFO - 1500806891128 Marionette TRACE 361 -> [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}]
03:48:11 INFO - TEST-START: test_click.py TestClick.test_container_element1500806891139 Marionette TRACE 361 <- [1,5,null,{"value":null}]
03:48:11 INFO - 1500806891143 Marionette TRACE 361 -> [0,6,"deleteSession",{}]
03:48:11 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:11 INFO - 1500806891149 Marionette TRACE 361 <- [1,6,null,{}]
03:48:11 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:11 INFO - 1500806891175 Marionette DEBUG Closed connection 361
03:48:11 INFO - 1500806891177 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49798
03:48:11 INFO - 1500806891198 Marionette DEBUG Closed connection 362
03:48:11 INFO - 1500806891200 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49799
03:48:11 INFO - 1500806891223 Marionette TRACE 363 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:48:11 INFO - 1500806891226 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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}
03:48:11 INFO - 1500806891268 Marionette DEBUG Register listener.js for window 12
03:48:11 INFO - 1500806891285 Marionette TRACE 363 <- [1,1,null,{"sessionId":"49d8e18b-3bdc-4977-8677-b3178bb3d0ca","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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}}]
03:48:11 INFO - 1500806891294 Marionette TRACE 363 -> [0,2,"deleteSession",{}]
03:48:11 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:11 INFO - 1500806891299 Marionette TRACE 363 <- [1,2,null,{}]
03:48:11 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:11 INFO - 1500806891337 Marionette DEBUG Closed connection 363
03:48:11 INFO - 1500806891339 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49800
03:48:11 INFO - 1500806891347 Marionette DEBUG Closed connection 364
03:48:11 INFO - 1500806891349 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49801
03:48:11 INFO - 1500806891365 Marionette TRACE 365 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:48:11 INFO - 1500806891369 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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}
03:48:11 INFO - 1500806891413 Marionette DEBUG Register listener.js for window 12
03:48:11 INFO - 1500806891429 Marionette TRACE 365 <- [1,1,null,{"sessionId":"640471f6-7430-4cc1-bbc8-a12250637ec9","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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}}]
03:48:11 INFO - 1500806891442 Marionette TRACE 365 -> [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"}]
03:48:11 INFO - 1500806891448 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49337/test.html"
03:48:11 INFO - 1500806891456 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49337/test.html"
03:48:11 INFO - 1500806891457 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49337/test.html"
03:48:11 INFO - ++DOMWINDOW == 31 (0000005141A7A000) [pid = 3844] [serial = 43] [outer = 0000005146E2A800]
03:48:11 INFO - 1500806891559 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"
03:48:11 INFO - 1500806891576 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"
03:48:11 INFO - 1500806891592 Marionette TRACE 365 <- [1,2,null,{}]
03:48:11 INFO - 1500806891600 Marionette TRACE 365 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
03:48:11 INFO - 1500806891610 Marionette TRACE 365 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e4419b78-4693-47ca-b752-0129d990c812","ELEMENT":"e4419b78-4693-47ca-b752-0129d990c812"}}]
03:48:11 INFO - 1500806891612 Marionette TRACE 365 -> [0,4,"clickElement",{"id":"e4419b78-4693-47ca-b752-0129d990c812"}]
03:48:11 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
03:48:11 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
03:48:11 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
03:48:12 INFO - 1500806892203 Marionette DEBUG Canceled page load listener because no navigation has been detected
03:48:12 INFO - 1500806892205 Marionette TRACE 365 <- [1,4,null,{}]
03:48:12 INFO - 1500806892210 Marionette TRACE 365 -> [0,5,"getElementProperty",{"id":"e4419b78-4693-47ca-b752-0129d990c812","name":"selected"}]
03:48:12 INFO - 1500806892267 Marionette TRACE 365 <- [1,5,null,{"value":true}]
03:48:12 INFO - 1500806892275 Marionette TRACE 365 -> [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}]
03:48:12 INFO - TEST-END: test_click.py TestClick.test_container_element1500806892290 Marionette TRACE 365 <- [1,6,null,{"value":null}]
03:48:12 INFO - 1500806892292 Marionette TRACE 365 -> [0,7,"deleteSession",{}]
03:48:12 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:12 INFO - 1500806892298 Marionette TRACE 365 <- [1,7,null,{}]
03:48:12 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 1332ms
03:48:12 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
03:48:12 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:12 INFO - 1500806892305 Marionette DEBUG Closed connection 365
03:48:12 INFO - 1500806892307 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49802
03:48:12 INFO - 1500806892309 Marionette DEBUG Closed connection 366
03:48:12 INFO - 1500806892311 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49803
03:48:12 INFO - 1500806892314 Marionette TRACE 367 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:48:12 INFO - 1500806892320 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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}
03:48:12 INFO - 1500806892365 Marionette DEBUG Register listener.js for window 12
03:48:12 INFO - 1500806892394 Marionette TRACE 367 <- [1,1,null,{"sessionId":"7cb83f5d-f68e-46f4-8772-95a4b6c2862c","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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}}]
03:48:12 INFO - 1500806892426 Marionette TRACE 367 -> [0,2,"setTimeouts",{"script":30000}]
03:48:12 INFO - 1500806892428 Marionette TRACE 367 <- [1,2,null,{}]
03:48:12 INFO - 1500806892431 Marionette TRACE 367 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:48:12 INFO - 1500806892433 Marionette TRACE 367 <- [1,3,null,{}]
03:48:12 INFO - 1500806892473 Marionette TRACE 367 -> [0,4,"setTimeouts",{"implicit":0}]
03:48:12 INFO - 1500806892476 Marionette TRACE 367 <- [1,4,null,{}]
03:48:12 INFO - 1500806892482 Marionette TRACE 367 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":316}]
03:48:12 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1500806892492 Marionette TRACE 367 <- [1,5,null,{"value":null}]
03:48:12 INFO - 1500806892517 Marionette TRACE 367 -> [0,6,"deleteSession",{}]
03:48:12 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:12 INFO - 1500806892523 Marionette TRACE 367 <- [1,6,null,{}]
03:48:12 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:12 INFO - 1500806892552 Marionette DEBUG Closed connection 367
03:48:12 INFO - 1500806892558 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49804
03:48:12 INFO - 1500806892562 Marionette DEBUG Closed connection 368
03:48:12 INFO - 1500806892564 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49805
03:48:12 INFO - 1500806892583 Marionette TRACE 369 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:48:12 INFO - 1500806892585 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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}
03:48:12 INFO - 1500806892630 Marionette DEBUG Register listener.js for window 12
03:48:12 INFO - 1500806892646 Marionette TRACE 369 <- [1,1,null,{"sessionId":"07520ded-1078-41db-b791-a10092020ad3","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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}}]
03:48:12 INFO - 1500806892657 Marionette TRACE 369 -> [0,2,"deleteSession",{}]
03:48:12 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:12 INFO - 1500806892663 Marionette TRACE 369 <- [1,2,null,{}]
03:48:12 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:12 INFO - 1500806892706 Marionette DEBUG Closed connection 369
03:48:12 INFO - 1500806892708 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49806
03:48:12 INFO - 1500806892730 Marionette DEBUG Closed connection 370
03:48:12 INFO - 1500806892732 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49807
03:48:12 INFO - 1500806892735 Marionette TRACE 371 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:48:12 INFO - 1500806892738 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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}
03:48:12 INFO - 1500806892783 Marionette DEBUG Register listener.js for window 12
03:48:12 INFO - 1500806892796 Marionette TRACE 371 <- [1,1,null,{"sessionId":"1053233d-e64f-4778-b963-b656045765ff","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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}}]
03:48:12 INFO - 1500806892991 Marionette TRACE 371 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%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"}]
03:48:13 INFO - 1500806892998 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"
03:48:13 INFO - 1500806893009 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"
03:48:13 INFO - 1500806893010 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"
03:48:13 INFO - ++DOMWINDOW == 32 (0000005139E3B800) [pid = 3844] [serial = 44] [outer = 0000005146E2A800]
03:48:13 INFO - 1500806893070 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"
03:48:13 INFO - 1500806893083 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"
03:48:13 INFO - 1500806893106 Marionette TRACE 371 <- [1,2,null,{}]
03:48:13 INFO - 1500806893119 Marionette TRACE 371 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
03:48:13 INFO - 1500806893134 Marionette TRACE 371 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"9f564ec4-98a9-471c-98bf-cb8613f38c40","ELEMENT":"9f564ec4-98a9-471c-98bf-cb8613f38c40"}}]
03:48:13 INFO - 1500806893138 Marionette TRACE 371 -> [0,4,"clickElement",{"id":"9f564ec4-98a9-471c-98bf-cb8613f38c40"}]
03:48:13 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
03:48:13 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
03:48:13 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
03:48:13 INFO - 1500806893606 Marionette DEBUG Canceled page load listener because no navigation has been detected
03:48:13 INFO - 1500806893610 Marionette TRACE 371 <- [1,4,null,{}]
03:48:13 INFO - 1500806893615 Marionette TRACE 371 -> [0,5,"getElementProperty",{"id":"9f564ec4-98a9-471c-98bf-cb8613f38c40","name":"selected"}]
03:48:13 INFO - 1500806893648 Marionette TRACE 371 <- [1,5,null,{"value":true}]
03:48:13 INFO - 1500806893657 Marionette TRACE 371 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":328}]
03:48:13 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1500806893668 Marionette TRACE 371 <- [1,6,null,{"value":null}]
03:48:13 INFO - 1500806893711 Marionette TRACE 371 -> [0,7,"deleteSession",{}]
03:48:13 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:13 INFO - 1500806893721 Marionette TRACE 371 <- [1,7,null,{}]
03:48:13 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 1426ms
03:48:13 INFO - TEST-START | test_click.py TestClick.test_css_transforms
03:48:13 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:13 INFO - 1500806893753 Marionette DEBUG Closed connection 371
03:48:13 INFO - 1500806893755 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49808
03:48:13 INFO - 1500806893759 Marionette DEBUG Closed connection 372
03:48:13 INFO - 1500806893762 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49809
03:48:13 INFO - 1500806893765 Marionette TRACE 373 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:48:13 INFO - 1500806893775 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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}
03:48:13 INFO - 1500806893797 Marionette DEBUG Register listener.js for window 12
03:48:13 INFO - 1500806893815 Marionette TRACE 373 <- [1,1,null,{"sessionId":"f2d22682-9d6a-4e5c-bced-a5cace2f6f3c","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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}}]
03:48:13 INFO - 1500806893834 Marionette TRACE 373 -> [0,2,"setTimeouts",{"script":30000}]
03:48:13 INFO - 1500806893837 Marionette TRACE 373 <- [1,2,null,{}]
03:48:13 INFO - 1500806893841 Marionette TRACE 373 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:48:13 INFO - 1500806893844 Marionette TRACE 373 <- [1,3,null,{}]
03:48:13 INFO - 1500806893848 Marionette TRACE 373 -> [0,4,"setTimeouts",{"implicit":0}]
03:48:13 INFO - 1500806893851 Marionette TRACE 373 <- [1,4,null,{}]
03:48:13 INFO - 1500806893860 Marionette TRACE 373 -> [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}]
03:48:13 INFO - TEST-START: test_click.py TestClick.test_css_transforms1500806893873 Marionette TRACE 373 <- [1,5,null,{"value":null}]
03:48:13 INFO - 1500806893876 Marionette TRACE 373 -> [0,6,"deleteSession",{}]
03:48:13 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:13 INFO - 1500806893882 Marionette TRACE 373 <- [1,6,null,{}]
03:48:13 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:13 INFO - 1500806893892 Marionette DEBUG Closed connection 373
03:48:13 INFO - 1500806893895 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49810
03:48:13 INFO - --DOMWINDOW == 31 (00000051510B2000) [pid = 3844] [serial = 29] [outer = 0000000000000000] [url = http://127.0.0.1:49337/test_accessibility.html]
03:48:13 INFO - --DOMWINDOW == 30 (000000513C549000) [pid = 3844] [serial = 23] [outer = 0000000000000000] [url = http://127.0.0.1:49337/test_accessibility.html]
03:48:13 INFO - --DOMWINDOW == 29 (000000513DD38000) [pid = 3844] [serial = 22] [outer = 0000000000000000] [url = http://127.0.0.1:49337/test_accessibility.html]
03:48:13 INFO - --DOMWINDOW == 28 (000000513CF93000) [pid = 3844] [serial = 24] [outer = 0000000000000000] [url = http://127.0.0.1:49337/test_accessibility.html]
03:48:13 INFO - --DOMWINDOW == 27 (0000005145BF9800) [pid = 3844] [serial = 25] [outer = 0000000000000000] [url = http://127.0.0.1:49337/test_accessibility.html]
03:48:13 INFO - --DOMWINDOW == 26 (0000005146956000) [pid = 3844] [serial = 26] [outer = 0000000000000000] [url = http://127.0.0.1:49337/test_accessibility.html]
03:48:13 INFO - --DOMWINDOW == 25 (0000005147442800) [pid = 3844] [serial = 27] [outer = 0000000000000000] [url = http://127.0.0.1:49337/test_accessibility.html]
03:48:13 INFO - --DOMWINDOW == 24 (000000514F644000) [pid = 3844] [serial = 28] [outer = 0000000000000000] [url = http://127.0.0.1:49337/test_accessibility.html]
03:48:13 INFO - 1500806893927 Marionette DEBUG Closed connection 374
03:48:13 INFO - 1500806893929 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49811
03:48:13 INFO - 1500806893933 Marionette TRACE 375 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:48:13 INFO - 1500806893936 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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}
03:48:13 INFO - 1500806893959 Marionette DEBUG Register listener.js for window 12
03:48:13 INFO - 1500806893974 Marionette TRACE 375 <- [1,1,null,{"sessionId":"ff178045-738d-4542-8808-fcdbe3621087","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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}}]
03:48:13 INFO - 1500806893990 Marionette TRACE 375 -> [0,2,"deleteSession",{}]
03:48:13 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:13 INFO - 1500806893995 Marionette TRACE 375 <- [1,2,null,{}]
03:48:14 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:14 INFO - 1500806894023 Marionette DEBUG Closed connection 375
03:48:14 INFO - 1500806894025 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49812
03:48:14 INFO - 1500806894047 Marionette DEBUG Closed connection 376
03:48:14 INFO - 1500806894049 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49813
03:48:14 INFO - 1500806894053 Marionette TRACE 377 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:48:14 INFO - 1500806894057 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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}
03:48:14 INFO - 1500806894080 Marionette DEBUG Register listener.js for window 12
03:48:14 INFO - 1500806894095 Marionette TRACE 377 <- [1,1,null,{"sessionId":"07dea121-163f-4d6e-be05-fd83c29a919a","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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}}]
03:48:14 INFO - 1500806894111 Marionette TRACE 377 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%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"}]
03:48:14 INFO - 1500806894115 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"
03:48:14 INFO - 1500806894124 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"
03:48:14 INFO - 1500806894125 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"
03:48:14 INFO - ++DOMWINDOW == 25 (000000513B8BA800) [pid = 3844] [serial = 45] [outer = 0000005146E2A800]
03:48:14 INFO - 1500806894185 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"
03:48:14 INFO - 1500806894191 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"
03:48:14 INFO - 1500806894211 Marionette TRACE 377 <- [1,2,null,{}]
03:48:14 INFO - 1500806894214 Marionette TRACE 377 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
03:48:14 INFO - 1500806894225 Marionette TRACE 377 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"6d4e57d8-b816-4f96-8416-784ca5dfa89c","ELEMENT":"6d4e57d8-b816-4f96-8416-784ca5dfa89c"}}]
03:48:14 INFO - 1500806894334 Marionette TRACE 377 -> [0,4,"clickElement",{"id":"6d4e57d8-b816-4f96-8416-784ca5dfa89c"}]
03:48:15 INFO - 1500806895403 Marionette DEBUG Canceled page load listener because no navigation has been detected
03:48:15 INFO - 1500806895438 Marionette TRACE 377 <- [1,4,null,{}]
03:48:15 INFO - 1500806895486 Marionette TRACE 377 -> [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}]
03:48:15 INFO - TEST-END: test_click.py TestClick.test_css_transforms1500806895495 Marionette TRACE 377 <- [1,5,null,{"value":null}]
03:48:15 INFO - 1500806895553 Marionette TRACE 377 -> [0,6,"deleteSession",{}]
03:48:15 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:15 INFO - 1500806895558 Marionette TRACE 377 <- [1,6,null,{}]
03:48:15 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 1834ms
03:48:15 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
03:48:15 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:15 INFO - 1500806895612 Marionette DEBUG Closed connection 377
03:48:15 INFO - 1500806895614 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49814
03:48:15 INFO - 1500806895668 Marionette DEBUG Closed connection 378
03:48:15 INFO - 1500806895671 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49815
03:48:15 INFO - 1500806895724 Marionette TRACE 379 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:48:15 INFO - 1500806895727 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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}
03:48:15 INFO - 1500806895751 Marionette DEBUG Register listener.js for window 12
03:48:15 INFO - 1500806895765 Marionette TRACE 379 <- [1,1,null,{"sessionId":"6703e912-972c-42eb-b09e-deb5979bbaf5","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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}}]
03:48:15 INFO - 1500806895821 Marionette TRACE 379 -> [0,2,"setTimeouts",{"script":30000}]
03:48:15 INFO - 1500806895823 Marionette TRACE 379 <- [1,2,null,{}]
03:48:15 INFO - 1500806895845 Marionette TRACE 379 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:48:15 INFO - 1500806895847 Marionette TRACE 379 <- [1,3,null,{}]
03:48:15 INFO - 1500806895849 Marionette TRACE 379 -> [0,4,"setTimeouts",{"implicit":0}]
03:48:15 INFO - 1500806895851 Marionette TRACE 379 <- [1,4,null,{}]
03:48:15 INFO - 1500806895855 Marionette TRACE 379 -> [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}]
03:48:15 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1500806895868 Marionette TRACE 379 <- [1,5,null,{"value":null}]
03:48:15 INFO - 1500806895872 Marionette TRACE 379 -> [0,6,"deleteSession",{}]
03:48:15 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:15 INFO - 1500806895876 Marionette TRACE 379 <- [1,6,null,{}]
03:48:15 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:15 INFO - 1500806895901 Marionette DEBUG Closed connection 379
03:48:15 INFO - 1500806895902 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49816
03:48:15 INFO - 1500806895907 Marionette DEBUG Closed connection 380
03:48:15 INFO - 1500806895909 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49817
03:48:15 INFO - 1500806895911 Marionette TRACE 381 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:48:15 INFO - 1500806895916 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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}
03:48:15 INFO - 1500806895939 Marionette DEBUG Register listener.js for window 12
03:48:15 INFO - 1500806895954 Marionette TRACE 381 <- [1,1,null,{"sessionId":"d45757d5-2ae8-4a71-877a-f3e4de7747a9","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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}}]
03:48:15 INFO - 1500806895964 Marionette TRACE 381 -> [0,2,"deleteSession",{}]
03:48:15 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:15 INFO - 1500806895970 Marionette TRACE 381 <- [1,2,null,{}]
03:48:16 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:16 INFO - 1500806895994 Marionette DEBUG Closed connection 381
03:48:16 INFO - 1500806895998 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49818
03:48:16 INFO - 1500806896003 Marionette DEBUG Closed connection 382
03:48:16 INFO - 1500806896005 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49819
03:48:16 INFO - 1500806896007 Marionette TRACE 383 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:48:16 INFO - 1500806896010 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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}
03:48:16 INFO - 1500806896032 Marionette DEBUG Register listener.js for window 12
03:48:16 INFO - 1500806896046 Marionette TRACE 383 <- [1,1,null,{"sessionId":"169b981a-b1ac-4d5c-bc5a-63dfbe37a65f","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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}}]
03:48:16 INFO - 1500806896053 Marionette TRACE 383 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%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"}]
03:48:16 INFO - 1500806896057 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"
03:48:16 INFO - 1500806896064 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"
03:48:16 INFO - 1500806896065 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"
03:48:16 INFO - ++DOMWINDOW == 26 (0000005141B1C800) [pid = 3844] [serial = 46] [outer = 0000005146E2A800]
03:48:16 INFO - 1500806896120 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"
03:48:16 INFO - 1500806896130 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"
03:48:16 INFO - 1500806896140 Marionette TRACE 383 <- [1,2,null,{}]
03:48:16 INFO - 1500806896151 Marionette TRACE 383 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
03:48:16 INFO - 1500806896160 Marionette TRACE 383 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"00f09767-1f66-4f98-bf05-926fbf977b18","ELEMENT":"00f09767-1f66-4f98-bf05-926fbf977b18"}}]
03:48:16 INFO - 1500806896172 Marionette TRACE 383 -> [0,4,"clickElement",{"id":"00f09767-1f66-4f98-bf05-926fbf977b18"}]
03:48:16 INFO - 1500806896617 Marionette DEBUG Canceled page load listener because no navigation has been detected
03:48:16 INFO - 1500806896619 Marionette TRACE 383 <- [1,4,null,{}]
03:48:16 INFO - 1500806896622 Marionette TRACE 383 -> [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}]
03:48:16 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1500806896630 Marionette TRACE 383 <- [1,5,null,{"value":null}]
03:48:16 INFO - 1500806896632 Marionette TRACE 383 -> [0,6,"deleteSession",{}]
03:48:16 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:16 INFO - 1500806896637 Marionette TRACE 383 <- [1,6,null,{}]
03:48:16 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 1078ms
03:48:16 INFO - TEST-START | test_click.py TestClick.test_input_file
03:48:16 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:16 INFO - 1500806896643 Marionette DEBUG Closed connection 383
03:48:16 INFO - 1500806896644 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49820
03:48:16 INFO - 1500806896646 Marionette DEBUG Closed connection 384
03:48:16 INFO - 1500806896647 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49821
03:48:16 INFO - 1500806896672 Marionette TRACE 385 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:48:16 INFO - 1500806896675 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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}
03:48:16 INFO - 1500806896697 Marionette DEBUG Register listener.js for window 12
03:48:16 INFO - 1500806896709 Marionette TRACE 385 <- [1,1,null,{"sessionId":"65b9efe1-6f70-46af-b60a-1704478192e6","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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}}]
03:48:16 INFO - 1500806896719 Marionette TRACE 385 -> [0,2,"setTimeouts",{"script":30000}]
03:48:16 INFO - 1500806896720 Marionette TRACE 385 <- [1,2,null,{}]
03:48:16 INFO - 1500806896722 Marionette TRACE 385 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:48:16 INFO - 1500806896724 Marionette TRACE 385 <- [1,3,null,{}]
03:48:16 INFO - 1500806896726 Marionette TRACE 385 -> [0,4,"setTimeouts",{"implicit":0}]
03:48:16 INFO - 1500806896727 Marionette TRACE 385 <- [1,4,null,{}]
03:48:16 INFO - 1500806896730 Marionette TRACE 385 -> [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}]
03:48:16 INFO - TEST-START: test_click.py TestClick.test_input_file1500806896742 Marionette TRACE 385 <- [1,5,null,{"value":null}]
03:48:16 INFO - 1500806896744 Marionette TRACE 385 -> [0,6,"deleteSession",{}]
03:48:16 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:16 INFO - 1500806896748 Marionette TRACE 385 <- [1,6,null,{}]
03:48:16 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:16 INFO - 1500806896774 Marionette DEBUG Closed connection 385
03:48:16 INFO - 1500806896776 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49822
03:48:16 INFO - 1500806896777 Marionette DEBUG Closed connection 386
03:48:16 INFO - 1500806896780 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49823
03:48:16 INFO - 1500806896782 Marionette TRACE 387 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:48:16 INFO - 1500806896785 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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}
03:48:16 INFO - 1500806896807 Marionette DEBUG Register listener.js for window 12
03:48:16 INFO - 1500806896819 Marionette TRACE 387 <- [1,1,null,{"sessionId":"b76ab88d-d42e-4019-be4d-7ec2b7e5da10","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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}}]
03:48:16 INFO - 1500806896832 Marionette TRACE 387 -> [0,2,"deleteSession",{}]
03:48:16 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:16 INFO - 1500806896836 Marionette TRACE 387 <- [1,2,null,{}]
03:48:16 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:16 INFO - 1500806896842 Marionette DEBUG Closed connection 387
03:48:16 INFO - 1500806896843 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49824
03:48:16 INFO - 1500806896845 Marionette DEBUG Closed connection 388
03:48:16 INFO - 1500806896846 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49825
03:48:16 INFO - 1500806896849 Marionette TRACE 389 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:48:16 INFO - 1500806896852 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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}
03:48:16 INFO - 1500806896875 Marionette DEBUG Register listener.js for window 12
03:48:16 INFO - 1500806896886 Marionette TRACE 389 <- [1,1,null,{"sessionId":"396f51e1-55b2-4d20-98b0-4060ea092fd0","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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}}]
03:48:16 INFO - 1500806896893 Marionette TRACE 389 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
03:48:16 INFO - 1500806896897 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"
03:48:16 INFO - 1500806896906 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"
03:48:16 INFO - 1500806896908 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"
03:48:16 INFO - ++DOMWINDOW == 27 (000000514267F800) [pid = 3844] [serial = 47] [outer = 0000005146E2A800]
03:48:16 INFO - 1500806896969 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
03:48:16 INFO - 1500806896974 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
03:48:16 INFO - 1500806896992 Marionette TRACE 389 <- [1,2,null,{}]
03:48:16 INFO - 1500806896995 Marionette TRACE 389 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
03:48:17 INFO - 1500806897005 Marionette TRACE 389 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"8ab07f51-7871-4238-933f-4c3b8e073bde","ELEMENT":"8ab07f51-7871-4238-933f-4c3b8e073bde"}}]
03:48:17 INFO - 1500806897007 Marionette TRACE 389 -> [0,4,"clickElement",{"id":"8ab07f51-7871-4238-933f-4c3b8e073bde"}]
03:48:17 INFO - 1500806897210 Marionette TRACE 389 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
03:48:17 INFO - 1500806897216 Marionette TRACE 389 -> [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}]
03:48:17 INFO - TEST-END: test_click.py TestClick.test_input_file1500806897224 Marionette TRACE 389 <- [1,5,null,{"value":null}]
03:48:17 INFO - 1500806897226 Marionette TRACE 389 -> [0,6,"deleteSession",{}]
03:48:17 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:17 INFO - 1500806897231 Marionette TRACE 389 <- [1,6,null,{}]
03:48:17 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 594ms
03:48:17 INFO - TEST-START | test_click.py TestClick.test_obscured_element
03:48:17 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:17 INFO - 1500806897256 Marionette DEBUG Closed connection 389
03:48:17 INFO - 1500806897258 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49826
03:48:17 INFO - 1500806897262 Marionette DEBUG Closed connection 390
03:48:17 INFO - 1500806897263 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49827
03:48:17 INFO - 1500806897882 Marionette TRACE 391 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:48:17 INFO - 1500806897884 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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}
03:48:17 INFO - 1500806897909 Marionette DEBUG Register listener.js for window 12
03:48:17 INFO - 1500806897922 Marionette TRACE 391 <- [1,1,null,{"sessionId":"b90cdba8-1532-44ff-ae13-33a61ebe9061","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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}}]
03:48:17 INFO - 1500806897965 Marionette TRACE 391 -> [0,2,"setTimeouts",{"script":30000}]
03:48:17 INFO - 1500806897967 Marionette TRACE 391 <- [1,2,null,{}]
03:48:18 INFO - 1500806898005 Marionette TRACE 391 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:48:18 INFO - 1500806898008 Marionette TRACE 391 <- [1,3,null,{}]
03:48:18 INFO - 1500806898033 Marionette TRACE 391 -> [0,4,"setTimeouts",{"implicit":0}]
03:48:18 INFO - 1500806898034 Marionette TRACE 391 <- [1,4,null,{}]
03:48:18 INFO - 1500806898044 Marionette TRACE 391 -> [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}]
03:48:18 INFO - TEST-START: test_click.py TestClick.test_obscured_element1500806898051 Marionette TRACE 391 <- [1,5,null,{"value":null}]
03:48:18 INFO - 1500806898055 Marionette TRACE 391 -> [0,6,"deleteSession",{}]
03:48:18 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:18 INFO - 1500806898059 Marionette TRACE 391 <- [1,6,null,{}]
03:48:18 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:18 INFO - 1500806898082 Marionette DEBUG Closed connection 391
03:48:18 INFO - 1500806898083 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49828
03:48:18 INFO - 1500806898088 Marionette DEBUG Closed connection 392
03:48:18 INFO - 1500806898089 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49829
03:48:18 INFO - 1500806898092 Marionette TRACE 393 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:48:18 INFO - 1500806898095 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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}
03:48:18 INFO - 1500806898122 Marionette DEBUG Register listener.js for window 12
03:48:18 INFO - 1500806898145 Marionette TRACE 393 <- [1,1,null,{"sessionId":"b69dfc14-91eb-4f46-bac7-839ee58cd986","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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}}]
03:48:18 INFO - 1500806898158 Marionette TRACE 393 -> [0,2,"deleteSession",{}]
03:48:18 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:18 INFO - 1500806898163 Marionette TRACE 393 <- [1,2,null,{}]
03:48:18 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:18 INFO - 1500806898169 Marionette DEBUG Closed connection 393
03:48:18 INFO - 1500806898170 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49830
03:48:18 INFO - 1500806898172 Marionette DEBUG Closed connection 394
03:48:18 INFO - 1500806898173 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49831
03:48:18 INFO - 1500806898175 Marionette TRACE 395 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:48:18 INFO - 1500806898178 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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}
03:48:18 INFO - 1500806898200 Marionette DEBUG Register listener.js for window 12
03:48:18 INFO - 1500806898212 Marionette TRACE 395 <- [1,1,null,{"sessionId":"d29c9253-a27c-4b23-b2f2-b5eb7499e722","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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}}]
03:48:18 INFO - 1500806898241 Marionette TRACE 395 -> [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"}]
03:48:18 INFO - 1500806898245 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
03:48:18 INFO - 1500806898252 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
03:48:18 INFO - 1500806898252 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
03:48:18 INFO - ++DOMWINDOW == 28 (00000051419D8000) [pid = 3844] [serial = 48] [outer = 0000005146E2A800]
03:48:18 INFO - 1500806898310 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"
03:48:18 INFO - 1500806898316 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"
03:48:18 INFO - 1500806898323 Marionette TRACE 395 <- [1,2,null,{}]
03:48:18 INFO - 1500806898334 Marionette TRACE 395 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
03:48:18 INFO - 1500806898342 Marionette TRACE 395 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"8c4bdd09-433b-4e35-af20-5983a859f3ad","ELEMENT":"8c4bdd09-433b-4e35-af20-5983a859f3ad"}}]
03:48:18 INFO - 1500806898350 Marionette TRACE 395 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
03:48:18 INFO - 1500806898357 Marionette TRACE 395 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"548c9c32-3fcf-414f-85c3-b36adbff513c","ELEMENT":"548c9c32-3fcf-414f-85c3-b36adbff513c"}}]
03:48:18 INFO - 1500806898359 Marionette TRACE 395 -> [0,5,"clickElement",{"id":"8c4bdd09-433b-4e35-af20-5983a859f3ad"}]
03:48:18 INFO - 1500806898785 Marionette DEBUG Canceled page load listener because no navigation has been detected
03:48:18 INFO - 1500806898788 Marionette TRACE 395 <- [1,5,null,{}]
03:48:18 INFO - 1500806898842 Marionette TRACE 395 -> [0,6,"clickElement",{"id":"548c9c32-3fcf-414f-85c3-b36adbff513c"}]
03:48:19 INFO - 1500806899123 Marionette TRACE 395 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
03:48:19 INFO - 1500806899155 Marionette TRACE 395 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
03:48:19 INFO - 1500806899170 Marionette TRACE 395 <- [1,7,null,{"value":false}]
03:48:19 INFO - 1500806899220 Marionette TRACE 395 -> [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}]
03:48:19 INFO - TEST-END: test_click.py TestClick.test_obscured_element1500806899235 Marionette TRACE 395 <- [1,8,null,{"value":null}]
03:48:19 INFO - 1500806899242 Marionette TRACE 395 -> [0,9,"deleteSession",{}]
03:48:19 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:19 INFO - 1500806899250 Marionette TRACE 395 <- [1,9,null,{}]
03:48:19 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 2043ms
03:48:19 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
03:48:19 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:19 INFO - 1500806899286 Marionette DEBUG Closed connection 395
03:48:19 INFO - 1500806899290 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49832
03:48:19 INFO - 1500806899302 Marionette DEBUG Closed connection 396
03:48:19 INFO - 1500806899305 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49833
03:48:19 INFO - 1500806899331 Marionette TRACE 397 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:48:19 INFO - 1500806899341 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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}
03:48:19 INFO - 1500806899388 Marionette DEBUG Register listener.js for window 12
03:48:19 INFO - 1500806899410 Marionette TRACE 397 <- [1,1,null,{"sessionId":"14537766-e9be-4b6b-aa3f-2d3d127a621f","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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}}]
03:48:19 INFO - 1500806899428 Marionette TRACE 397 -> [0,2,"setTimeouts",{"script":30000}]
03:48:19 INFO - 1500806899431 Marionette TRACE 397 <- [1,2,null,{}]
03:48:19 INFO - 1500806899446 Marionette TRACE 397 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:48:19 INFO - 1500806899448 Marionette TRACE 397 <- [1,3,null,{}]
03:48:19 INFO - 1500806899452 Marionette TRACE 397 -> [0,4,"setTimeouts",{"implicit":0}]
03:48:19 INFO - 1500806899455 Marionette TRACE 397 <- [1,4,null,{}]
03:48:19 INFO - 1500806899460 Marionette TRACE 397 -> [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}]
03:48:19 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1500806899473 Marionette TRACE 397 <- [1,5,null,{"value":null}]
03:48:19 INFO - 1500806899647 Marionette TRACE 397 -> [0,6,"deleteSession",{}]
03:48:19 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:19 INFO - 1500806899657 Marionette TRACE 397 <- [1,6,null,{}]
03:48:19 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:19 INFO - 1500806899686 Marionette DEBUG Closed connection 397
03:48:19 INFO - 1500806899689 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49834
03:48:19 INFO - 1500806899741 Marionette DEBUG Closed connection 398
03:48:19 INFO - 1500806899744 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49835
03:48:19 INFO - 1500806899754 Marionette TRACE 399 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:48:19 INFO - 1500806899763 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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}
03:48:19 INFO - 1500806899789 Marionette DEBUG Register listener.js for window 12
03:48:19 INFO - 1500806899809 Marionette TRACE 399 <- [1,1,null,{"sessionId":"4edf9848-8c8b-447a-b534-2171df44dd89","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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}}]
03:48:19 INFO - 1500806899827 Marionette TRACE 399 -> [0,2,"deleteSession",{}]
03:48:19 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:19 INFO - 1500806899835 Marionette TRACE 399 <- [1,2,null,{}]
03:48:19 INFO - [Parent 3844] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:48:19 INFO - 1500806899877 Marionette DEBUG Closed connection 399
03:48:19 INFO - 1500806899881 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49836
03:48:19 INFO - 1500806899906 Marionette DEBUG Closed connection 400
03:48:19 INFO - 1500806899908 Marionette DEBUG Accepted connection 401 from 127.0.0.1:49837
03:48:19 INFO - 1500806899914 Marionette TRACE 401 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:48:19 INFO - 1500806899920 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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}
03:48:19 INFO - 1500806899945 Marionette DEBUG Register listener.js for window 12
03:48:19 INFO - 1500806899962 Marionette TRACE 401 <- [1,1,null,{"sessionId":"6c3b69bf-0088-42b5-ade0-5cd17f3da3da","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":3844,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-217.001\\AppData\\Local\\Temp\\tmpm6ivld.mozrunner","moz:accessibilityChecks":false}}]
03:48:19 INFO - 1500806899973 Marionette TRACE 401 -> [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"}]
03:48:19 INFO - 1500806899981 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"
03:48:19 INFO - 1500806899991 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"
03:48:19 INFO - 1500806899993 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"
03:48:19 INFO - ++DOMWINDOW == 29 (000000513B3D6800) [pid = 3844] [serial = 49] [outer = 0000005146E2A800]
03:48:20 INFO - 1500806900064 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"
03:48:20 INFO - 1500806900071 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"
03:48:20 INFO - 1500806900088 Marionette TRACE 401 <- [1,2,null,{}]
03:48:20 INFO - 1500806900099 Marionette TRACE 401 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
03:48:20 INFO - 1500806900111 Marionette TRACE 401 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"ca334031-d078-4fd3-9242-eab50530bc19","ELEMENT":"ca334031-d078-4fd3-9242-eab50530bc19"}}]
03:48:20 INFO - 1500806900114 Marionette TRACE 401 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"ca334031-d078-4fd3-9242-eab50530bc19"}]
03:48:20 INFO - 1500806900257 Marionette TRACE 401 <- [1,4,null,{"value":"none"}]
03:48:20 INFO - 1500806900272 Marionette TRACE 401 -> [0,5,"clickElement",{"id":"ca334031-d078-4fd3-9242-eab50530bc19"}]
03:48:20 INFO - 1500806900427 Marionette TRACE 401 <- [1,5,{"error":"element click intercepted","message":"Element