could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementNotInteractableError@chrome://marionette/content/error.js:315:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:183:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:393:12\nclickElement@chrome://marionette/content/listener.js:1330:5\n"},null]
09:53:03 INFO - 1498841583749 Marionette TRACE 360 -> [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}]
09:53:03 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1498841583756 Marionette TRACE 360 <- [1,5,null,{"value":null}]
09:53:03 INFO - 1498841583758 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
09:53:03 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:03 INFO - 1498841583762 Marionette TRACE 360 <- [1,6,null,{}]
09:53:03 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 652ms
09:53:03 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
09:53:03 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:03 INFO - 1498841583768 Marionette DEBUG Closed connection 360
09:53:03 INFO - 1498841583769 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49741
09:53:03 INFO - 1498841583771 Marionette DEBUG Closed connection 361
09:53:03 INFO - 1498841583772 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49742
09:53:03 INFO - 1498841583774 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:03 INFO - 1498841583777 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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}
09:53:03 INFO - 1498841583799 Marionette DEBUG Register listener.js for window 7
09:53:03 INFO - 1498841583810 Marionette TRACE 362 <- [1,1,null,{"sessionId":"c1e08f67-645c-45fa-96a0-23cf9f811d1e","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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}}]
09:53:03 INFO - 1498841583837 Marionette TRACE 362 -> [0,2,"setTimeouts",{"script":30000}]
09:53:03 INFO - 1498841583839 Marionette TRACE 362 <- [1,2,null,{}]
09:53:03 INFO - 1498841583842 Marionette TRACE 362 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:53:03 INFO - 1498841583843 Marionette TRACE 362 <- [1,3,null,{}]
09:53:03 INFO - 1498841583845 Marionette TRACE 362 -> [0,4,"setTimeouts",{"implicit":0}]
09:53:03 INFO - 1498841583847 Marionette TRACE 362 <- [1,4,null,{}]
09:53:03 INFO - 1498841583850 Marionette TRACE 362 -> [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}]
09:53:03 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1498841583861 Marionette TRACE 362 <- [1,5,null,{"value":null}]
09:53:03 INFO - 1498841583863 Marionette TRACE 362 -> [0,6,"deleteSession",{}]
09:53:03 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:03 INFO - 1498841583868 Marionette TRACE 362 <- [1,6,null,{}]
09:53:03 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:03 INFO - 1498841583893 Marionette DEBUG Closed connection 362
09:53:03 INFO - 1498841583894 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49743
09:53:03 INFO - 1498841583898 Marionette DEBUG Closed connection 363
09:53:03 INFO - 1498841583900 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49744
09:53:03 INFO - 1498841583902 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:03 INFO - 1498841583904 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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}
09:53:03 INFO - 1498841583928 Marionette DEBUG Register listener.js for window 7
09:53:03 INFO - 1498841583950 Marionette TRACE 364 <- [1,1,null,{"sessionId":"a33ad31e-0c67-4f5d-8a4e-0d8a145b9d97","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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}}]
09:53:03 INFO - 1498841583958 Marionette TRACE 364 -> [0,2,"deleteSession",{}]
09:53:03 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:03 INFO - 1498841583962 Marionette TRACE 364 <- [1,2,null,{}]
09:53:03 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:03 INFO - 1498841583985 Marionette DEBUG Closed connection 364
09:53:03 INFO - 1498841583986 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49745
09:53:03 INFO - 1498841583993 Marionette DEBUG Closed connection 365
09:53:03 INFO - 1498841583994 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49746
09:53:03 INFO - 1498841583997 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:53:04 INFO - 1498841583999 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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}
09:53:04 INFO - 1498841584022 Marionette DEBUG Register listener.js for window 7
09:53:04 INFO - 1498841584034 Marionette TRACE 366 <- [1,1,null,{"sessionId":"965509f5-36d3-4eba-94f2-4526c998cb9b","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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}}]
09:53:04 INFO - 1498841584679 Marionette TRACE 366 -> [0,2,"get",{"url":"http://127.0.0.1:49342/clicks.html"}]
09:53:04 INFO - 1498841584685 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49342/hidden.html"
09:53:04 INFO - 1498841584700 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49342/hidden.html"
09:53:04 INFO - 1498841584701 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49342/hidden.html"
09:53:04 INFO - ++DOMWINDOW == 23 (00000080E3B29800) [pid = 2268] [serial = 39] [outer = 00000080DB085000]
09:53:04 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:04 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:04 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:04 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:04 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:04 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:04 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:04 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:04 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:04 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:04 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:04 INFO - 1498841584815 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49342/clicks.html"
09:53:04 INFO - 1498841584822 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49342/clicks.html"
09:53:04 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:04 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:04 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:04 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:04 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:04 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:04 INFO - 1498841584839 Marionette TRACE 366 <- [1,2,null,{}]
09:53:04 INFO - 1498841584917 Marionette TRACE 366 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
09:53:04 INFO - 1498841584929 Marionette TRACE 366 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"2f83c27a-96cd-49c0-bcb1-3072352bf39a","ELEMENT":"2f83c27a-96cd-49c0-bcb1-3072352bf39a"}}]
09:53:04 INFO - 1498841584933 Marionette TRACE 366 -> [0,4,"clickElement",{"id":"2f83c27a-96cd-49c0-bcb1-3072352bf39a"}]
09:53:05 INFO - 1498841585346 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49342/clicks.html"
09:53:05 INFO - [2268] WARNING: Cannot switch to prerendered document in the parent process: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/xpfe/appshell/nsContentTreeOwner.cpp, line 445
09:53:05 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:05 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:05 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:05 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:05 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:05 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:05 INFO - 1498841585367 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49342/clicks.html"
09:53:05 INFO - 1498841585369 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49342/clicks.html"
09:53:05 INFO - ++DOMWINDOW == 24 (00000080D2121000) [pid = 2268] [serial = 40] [outer = 00000080DB085000]
09:53:05 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:05 INFO - 1498841585452 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49342/test.html"
09:53:05 INFO - 1498841585460 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49342/test.html"
09:53:05 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:05 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:05 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:05 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:05 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:05 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:05 INFO - 1498841585484 Marionette TRACE 366 <- [1,4,null,{}]
09:53:05 INFO - 1498841585503 Marionette TRACE 366 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
09:53:05 INFO - 1498841585517 Marionette TRACE 366 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"c83d6577-aafb-43a9-9b02-76b080a14a8e","ELEMENT":"c83d6577-aafb-43a9-9b02-76b080a14a8e"}}]
09:53:05 INFO - 1498841585522 Marionette TRACE 366 -> [0,6,"getTitle",{}]
09:53:05 INFO - 1498841585531 Marionette TRACE 366 <- [1,6,null,{"value":"Marionette Test"}]
09:53:05 INFO - 1498841585567 Marionette TRACE 366 -> [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}]
09:53:05 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1498841585579 Marionette TRACE 366 <- [1,7,null,{"value":null}]
09:53:05 INFO - 1498841585584 Marionette TRACE 366 -> [0,8,"deleteSession",{}]
09:53:05 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:05 INFO - 1498841585595 Marionette TRACE 366 <- [1,8,null,{}]
09:53:05 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 1833ms
09:53:05 INFO - TEST-START | test_click.py TestClick.test_container_element
09:53:05 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:05 INFO - 1498841585615 Marionette DEBUG Closed connection 366
09:53:05 INFO - 1498841585618 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49749
09:53:05 INFO - 1498841585621 Marionette DEBUG Closed connection 367
09:53:05 INFO - 1498841585623 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49750
09:53:05 INFO - 1498841585648 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:05 INFO - 1498841585658 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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}
09:53:05 INFO - 1498841585706 Marionette DEBUG Register listener.js for window 7
09:53:05 INFO - 1498841585747 Marionette TRACE 368 <- [1,1,null,{"sessionId":"e9e1375e-4889-4787-84c6-e8ba5751d4a4","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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}}]
09:53:05 INFO - 1498841585769 Marionette TRACE 368 -> [0,2,"setTimeouts",{"script":30000}]
09:53:05 INFO - 1498841585774 Marionette TRACE 368 <- [1,2,null,{}]
09:53:05 INFO - 1498841585778 Marionette TRACE 368 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:53:05 INFO - 1498841585781 Marionette TRACE 368 <- [1,3,null,{}]
09:53:05 INFO - 1498841585785 Marionette TRACE 368 -> [0,4,"setTimeouts",{"implicit":0}]
09:53:05 INFO - 1498841585788 Marionette TRACE 368 <- [1,4,null,{}]
09:53:05 INFO - 1498841585844 Marionette TRACE 368 -> [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}]
09:53:05 INFO - TEST-START: test_click.py TestClick.test_container_element1498841585860 Marionette TRACE 368 <- [1,5,null,{"value":null}]
09:53:05 INFO - 1498841585864 Marionette TRACE 368 -> [0,6,"deleteSession",{}]
09:53:05 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:05 INFO - 1498841585870 Marionette TRACE 368 <- [1,6,null,{}]
09:53:05 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:05 INFO - 1498841585906 Marionette DEBUG Closed connection 368
09:53:05 INFO - 1498841585910 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49751
09:53:05 INFO - 1498841585932 Marionette DEBUG Closed connection 369
09:53:05 INFO - 1498841585935 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49752
09:53:05 INFO - 1498841585938 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:05 INFO - 1498841585942 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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}
09:53:05 INFO - 1498841585989 Marionette DEBUG Register listener.js for window 7
09:53:06 INFO - 1498841586008 Marionette TRACE 370 <- [1,1,null,{"sessionId":"c0caf615-309a-4f1d-abfc-8c8a5e1bbb51","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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}}]
09:53:06 INFO - 1498841586021 Marionette TRACE 370 -> [0,2,"deleteSession",{}]
09:53:06 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:06 INFO - 1498841586028 Marionette TRACE 370 <- [1,2,null,{}]
09:53:06 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:06 INFO - 1498841586055 Marionette DEBUG Closed connection 370
09:53:06 INFO - 1498841586058 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49753
09:53:06 INFO - 1498841586060 Marionette DEBUG Closed connection 371
09:53:06 INFO - 1498841586063 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49754
09:53:06 INFO - 1498841586066 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:53:06 INFO - 1498841586070 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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}
09:53:06 INFO - 1498841586117 Marionette DEBUG Register listener.js for window 7
09:53:06 INFO - 1498841586135 Marionette TRACE 372 <- [1,1,null,{"sessionId":"42bcceba-cf49-493f-9a79-3c7b080a824d","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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}}]
09:53:06 INFO - 1498841586145 Marionette TRACE 372 -> [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"}]
09:53:06 INFO - 1498841586150 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49342/test.html"
09:53:06 INFO - 1498841586160 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49342/test.html"
09:53:06 INFO - 1498841586161 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49342/test.html"
09:53:06 INFO - ++DOMWINDOW == 25 (00000080E2940800) [pid = 2268] [serial = 41] [outer = 00000080DB085000]
09:53:06 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:06 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:06 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:06 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:06 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:06 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:06 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:06 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:06 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:06 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:06 INFO - 1498841586234 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"
09:53:06 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:06 INFO - 1498841586251 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"
09:53:06 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:06 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:06 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:06 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:06 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:06 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:06 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:06 INFO - 1498841586273 Marionette TRACE 372 <- [1,2,null,{}]
09:53:06 INFO - 1498841586281 Marionette TRACE 372 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
09:53:06 INFO - 1498841586292 Marionette TRACE 372 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"54bf09ea-8787-4eee-a8d6-a3ff5481c6c9","ELEMENT":"54bf09ea-8787-4eee-a8d6-a3ff5481c6c9"}}]
09:53:06 INFO - 1498841586294 Marionette TRACE 372 -> [0,4,"clickElement",{"id":"54bf09ea-8787-4eee-a8d6-a3ff5481c6c9"}]
09:53:06 INFO - [2268] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1908
09:53:06 INFO - [2268] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1816
09:53:06 INFO - [2268] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1622
09:53:06 INFO - 1498841586910 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:53:06 INFO - 1498841586913 Marionette TRACE 372 <- [1,4,null,{}]
09:53:06 INFO - 1498841586916 Marionette TRACE 372 -> [0,5,"getElementProperty",{"id":"54bf09ea-8787-4eee-a8d6-a3ff5481c6c9","name":"selected"}]
09:53:06 INFO - 1498841586976 Marionette TRACE 372 <- [1,5,null,{"value":true}]
09:53:06 INFO - 1498841586978 Marionette TRACE 372 -> [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}]
09:53:06 INFO - TEST-END: test_click.py TestClick.test_container_element1498841586992 Marionette TRACE 372 <- [1,6,null,{"value":null}]
09:53:06 INFO - 1498841586995 Marionette TRACE 372 -> [0,7,"deleteSession",{}]
09:53:06 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:07 INFO - 1498841587000 Marionette TRACE 372 <- [1,7,null,{}]
09:53:07 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 1403ms
09:53:07 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
09:53:07 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:07 INFO - 1498841587007 Marionette DEBUG Closed connection 372
09:53:07 INFO - 1498841587009 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49755
09:53:07 INFO - 1498841587027 Marionette DEBUG Closed connection 373
09:53:07 INFO - 1498841587030 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49756
09:53:07 INFO - 1498841587063 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:07 INFO - 1498841587066 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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}
09:53:07 INFO - 1498841587114 Marionette DEBUG Register listener.js for window 7
09:53:07 INFO - 1498841587132 Marionette TRACE 374 <- [1,1,null,{"sessionId":"a3d35e48-9095-45a8-946f-9115f6d9d9c2","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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}}]
09:53:07 INFO - 1498841587150 Marionette TRACE 374 -> [0,2,"setTimeouts",{"script":30000}]
09:53:07 INFO - 1498841587152 Marionette TRACE 374 <- [1,2,null,{}]
09:53:07 INFO - 1498841587155 Marionette TRACE 374 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:53:07 INFO - 1498841587156 Marionette TRACE 374 <- [1,3,null,{}]
09:53:07 INFO - 1498841587185 Marionette TRACE 374 -> [0,4,"setTimeouts",{"implicit":0}]
09:53:07 INFO - 1498841587187 Marionette TRACE 374 <- [1,4,null,{}]
09:53:07 INFO - 1498841587191 Marionette TRACE 374 -> [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}]
09:53:07 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1498841587201 Marionette TRACE 374 <- [1,5,null,{"value":null}]
09:53:07 INFO - 1498841587252 Marionette TRACE 374 -> [0,6,"deleteSession",{}]
09:53:07 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:07 INFO - 1498841587257 Marionette TRACE 374 <- [1,6,null,{}]
09:53:07 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:07 INFO - 1498841587283 Marionette DEBUG Closed connection 374
09:53:07 INFO - 1498841587285 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49757
09:53:07 INFO - 1498841587290 Marionette DEBUG Closed connection 375
09:53:07 INFO - 1498841587292 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49758
09:53:07 INFO - 1498841587325 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:07 INFO - 1498841587328 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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}
09:53:07 INFO - 1498841587375 Marionette DEBUG Register listener.js for window 7
09:53:07 INFO - 1498841587394 Marionette TRACE 376 <- [1,1,null,{"sessionId":"ae418f10-b788-476f-8bc1-2c874975f9a5","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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}}]
09:53:07 INFO - 1498841587402 Marionette TRACE 376 -> [0,2,"deleteSession",{}]
09:53:07 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:07 INFO - 1498841587407 Marionette TRACE 376 <- [1,2,null,{}]
09:53:07 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:07 INFO - 1498841587574 Marionette DEBUG Closed connection 376
09:53:07 INFO - 1498841587577 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49759
09:53:07 INFO - 1498841587600 Marionette DEBUG Closed connection 377
09:53:07 INFO - 1498841587603 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49760
09:53:07 INFO - 1498841587608 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:53:07 INFO - 1498841587619 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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}
09:53:07 INFO - 1498841587645 Marionette DEBUG Register listener.js for window 7
09:53:07 INFO - 1498841587667 Marionette TRACE 378 <- [1,1,null,{"sessionId":"735ec282-a959-4f51-8bb4-54028c9c159b","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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}}]
09:53:07 INFO - 1498841587706 Marionette TRACE 378 -> [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"}]
09:53:07 INFO - 1498841587713 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"
09:53:07 INFO - 1498841587723 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"
09:53:07 INFO - 1498841587725 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"
09:53:07 INFO - ++DOMWINDOW == 26 (00000080D71BF000) [pid = 2268] [serial = 42] [outer = 00000080DB085000]
09:53:07 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:07 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:07 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:07 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:07 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:07 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:07 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:07 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:07 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:07 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:07 INFO - 1498841587777 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"
09:53:07 INFO - 1498841587788 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"
09:53:07 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:07 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:07 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:07 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:07 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:07 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:07 INFO - 1498841587810 Marionette TRACE 378 <- [1,2,null,{}]
09:53:07 INFO - 1498841587815 Marionette TRACE 378 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
09:53:07 INFO - 1498841587828 Marionette TRACE 378 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"38189b31-600f-44be-8c2c-824d9a57adb5","ELEMENT":"38189b31-600f-44be-8c2c-824d9a57adb5"}}]
09:53:07 INFO - 1498841587832 Marionette TRACE 378 -> [0,4,"clickElement",{"id":"38189b31-600f-44be-8c2c-824d9a57adb5"}]
09:53:08 INFO - [2268] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1908
09:53:08 INFO - [2268] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1816
09:53:08 INFO - [2268] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1622
09:53:08 INFO - 1498841588303 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:53:08 INFO - 1498841588306 Marionette TRACE 378 <- [1,4,null,{}]
09:53:08 INFO - 1498841588312 Marionette TRACE 378 -> [0,5,"getElementProperty",{"id":"38189b31-600f-44be-8c2c-824d9a57adb5","name":"selected"}]
09:53:08 INFO - 1498841588345 Marionette TRACE 378 <- [1,5,null,{"value":true}]
09:53:08 INFO - 1498841588355 Marionette TRACE 378 -> [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}]
09:53:08 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1498841588367 Marionette TRACE 378 <- [1,6,null,{"value":null}]
09:53:08 INFO - 1498841588371 Marionette TRACE 378 -> [0,7,"deleteSession",{}]
09:53:08 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:08 INFO - 1498841588377 Marionette TRACE 378 <- [1,7,null,{}]
09:53:08 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 1377ms
09:53:08 INFO - TEST-START | test_click.py TestClick.test_css_transforms
09:53:08 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:08 INFO - 1498841588403 Marionette DEBUG Closed connection 378
09:53:08 INFO - 1498841588406 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49761
09:53:08 INFO - 1498841588409 Marionette DEBUG Closed connection 379
09:53:08 INFO - 1498841588412 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49762
09:53:08 INFO - 1498841588419 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:08 INFO - 1498841588422 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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}
09:53:08 INFO - 1498841588447 Marionette DEBUG Register listener.js for window 7
09:53:08 INFO - 1498841588468 Marionette TRACE 380 <- [1,1,null,{"sessionId":"8d089e09-678d-44af-a4fb-ede059a5fc61","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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}}]
09:53:08 INFO - 1498841588478 Marionette TRACE 380 -> [0,2,"setTimeouts",{"script":30000}]
09:53:08 INFO - 1498841588481 Marionette TRACE 380 <- [1,2,null,{}]
09:53:08 INFO - 1498841588488 Marionette TRACE 380 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:53:08 INFO - 1498841588490 Marionette TRACE 380 <- [1,3,null,{}]
09:53:08 INFO - --DOMWINDOW == 25 (00000080DB6F9800) [pid = 2268] [serial = 30] [outer = 0000000000000000] [url = http://127.0.0.1:49342/test_accessibility.html]
09:53:08 INFO - --DOMWINDOW == 24 (00000080D7630000) [pid = 2268] [serial = 29] [outer = 0000000000000000] [url = http://127.0.0.1:49342/test_accessibility.html]
09:53:08 INFO - --DOMWINDOW == 23 (00000080E2DE4800) [pid = 2268] [serial = 28] [outer = 0000000000000000] [url = http://127.0.0.1:49342/test_accessibility.html]
09:53:08 INFO - --DOMWINDOW == 22 (00000080E1E22800) [pid = 2268] [serial = 31] [outer = 0000000000000000] [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%20position%3A%20absolute%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%20/%2A%20move%20centre%20point%20off%20viewport%20%2A/%0A%20%20%20%20%20%20%20%20%20%20%20%20%20left%3A%20-105px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20top%3A%20-105px%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]
09:53:08 INFO - 1498841588503 Marionette TRACE 380 -> [0,4,"setTimeouts",{"implicit":0}]
09:53:08 INFO - 1498841588508 Marionette TRACE 380 <- [1,4,null,{}]
09:53:08 INFO - 1498841588511 Marionette TRACE 380 -> [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}]
09:53:08 INFO - TEST-START: test_click.py TestClick.test_css_transforms1498841588521 Marionette TRACE 380 <- [1,5,null,{"value":null}]
09:53:08 INFO - 1498841588523 Marionette TRACE 380 -> [0,6,"deleteSession",{}]
09:53:08 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:08 INFO - 1498841588529 Marionette TRACE 380 <- [1,6,null,{}]
09:53:08 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:08 INFO - 1498841588556 Marionette DEBUG Closed connection 380
09:53:08 INFO - 1498841588558 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49763
09:53:08 INFO - 1498841588560 Marionette DEBUG Closed connection 381
09:53:08 INFO - 1498841588562 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49764
09:53:08 INFO - 1498841588565 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:08 INFO - 1498841588568 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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}
09:53:08 INFO - 1498841588593 Marionette DEBUG Register listener.js for window 7
09:53:08 INFO - 1498841588608 Marionette TRACE 382 <- [1,1,null,{"sessionId":"6172a4a8-fb8b-462a-9b21-3fd8dae0a5df","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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}}]
09:53:08 INFO - 1498841588611 Marionette TRACE 382 -> [0,2,"deleteSession",{}]
09:53:08 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:08 INFO - 1498841588615 Marionette TRACE 382 <- [1,2,null,{}]
09:53:08 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:08 INFO - 1498841588622 Marionette DEBUG Closed connection 382
09:53:08 INFO - 1498841588624 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49765
09:53:08 INFO - 1498841588626 Marionette DEBUG Closed connection 383
09:53:08 INFO - 1498841588628 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49766
09:53:08 INFO - 1498841588630 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:53:08 INFO - 1498841588634 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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}
09:53:08 INFO - 1498841588658 Marionette DEBUG Register listener.js for window 7
09:53:08 INFO - 1498841588674 Marionette TRACE 384 <- [1,1,null,{"sessionId":"f76082a2-11fe-466f-940a-336002e6bac0","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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}}]
09:53:08 INFO - 1498841588676 Marionette TRACE 384 -> [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"}]
09:53:08 INFO - 1498841588683 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"
09:53:08 INFO - 1498841588691 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"
09:53:08 INFO - 1498841588692 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"
09:53:08 INFO - ++DOMWINDOW == 23 (00000080DA944800) [pid = 2268] [serial = 43] [outer = 00000080DB085000]
09:53:08 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:08 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:08 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:08 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:08 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:08 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:08 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:08 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:08 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:08 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:08 INFO - 1498841588776 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"
09:53:08 INFO - 1498841588783 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"
09:53:08 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:08 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:08 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:08 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:08 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:08 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:08 INFO - 1498841588803 Marionette TRACE 384 <- [1,2,null,{}]
09:53:08 INFO - 1498841588807 Marionette TRACE 384 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
09:53:08 INFO - 1498841588815 Marionette TRACE 384 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"0c5c3890-4f3f-4e15-8733-47fa97df2323","ELEMENT":"0c5c3890-4f3f-4e15-8733-47fa97df2323"}}]
09:53:08 INFO - 1498841588817 Marionette TRACE 384 -> [0,4,"clickElement",{"id":"0c5c3890-4f3f-4e15-8733-47fa97df2323"}]
09:53:09 INFO - 1498841589255 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:53:09 INFO - 1498841589256 Marionette TRACE 384 <- [1,4,null,{}]
09:53:09 INFO - 1498841589259 Marionette TRACE 384 -> [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}]
09:53:09 INFO - TEST-END: test_click.py TestClick.test_css_transforms1498841589268 Marionette TRACE 384 <- [1,5,null,{"value":null}]
09:53:09 INFO - 1498841589269 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
09:53:09 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:09 INFO - 1498841589275 Marionette TRACE 384 <- [1,6,null,{}]
09:53:09 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 897ms
09:53:09 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
09:53:09 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:09 INFO - 1498841589282 Marionette DEBUG Closed connection 384
09:53:09 INFO - 1498841589284 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49767
09:53:09 INFO - 1498841589285 Marionette DEBUG Closed connection 385
09:53:09 INFO - 1498841589287 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49768
09:53:09 INFO - 1498841589290 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:09 INFO - 1498841589293 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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}
09:53:09 INFO - 1498841589318 Marionette DEBUG Register listener.js for window 7
09:53:09 INFO - 1498841589340 Marionette TRACE 386 <- [1,1,null,{"sessionId":"17d1fda2-8ec4-423e-9976-36f9f344c1b1","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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}}]
09:53:09 INFO - 1498841589343 Marionette TRACE 386 -> [0,2,"setTimeouts",{"script":30000}]
09:53:09 INFO - 1498841589345 Marionette TRACE 386 <- [1,2,null,{}]
09:53:09 INFO - 1498841589347 Marionette TRACE 386 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:53:09 INFO - 1498841589349 Marionette TRACE 386 <- [1,3,null,{}]
09:53:09 INFO - 1498841589351 Marionette TRACE 386 -> [0,4,"setTimeouts",{"implicit":0}]
09:53:09 INFO - 1498841589352 Marionette TRACE 386 <- [1,4,null,{}]
09:53:09 INFO - 1498841589355 Marionette TRACE 386 -> [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}]
09:53:09 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1498841589370 Marionette TRACE 386 <- [1,5,null,{"value":null}]
09:53:09 INFO - 1498841589372 Marionette TRACE 386 -> [0,6,"deleteSession",{}]
09:53:09 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:09 INFO - 1498841589376 Marionette TRACE 386 <- [1,6,null,{}]
09:53:09 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:09 INFO - 1498841589385 Marionette DEBUG Closed connection 386
09:53:09 INFO - 1498841589390 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49769
09:53:09 INFO - 1498841589393 Marionette DEBUG Closed connection 387
09:53:09 INFO - 1498841589394 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49770
09:53:09 INFO - 1498841589397 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:09 INFO - 1498841589401 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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}
09:53:09 INFO - 1498841589426 Marionette DEBUG Register listener.js for window 7
09:53:09 INFO - 1498841589441 Marionette TRACE 388 <- [1,1,null,{"sessionId":"57bfe81a-3358-4650-8820-3c2039ecabf4","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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}}]
09:53:09 INFO - 1498841589444 Marionette TRACE 388 -> [0,2,"deleteSession",{}]
09:53:09 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:09 INFO - 1498841589448 Marionette TRACE 388 <- [1,2,null,{}]
09:53:09 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:09 INFO - 1498841589455 Marionette DEBUG Closed connection 388
09:53:09 INFO - 1498841589456 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49771
09:53:09 INFO - 1498841589458 Marionette DEBUG Closed connection 389
09:53:09 INFO - 1498841589459 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49772
09:53:09 INFO - 1498841589462 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:53:09 INFO - 1498841589464 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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}
09:53:09 INFO - 1498841589489 Marionette DEBUG Register listener.js for window 7
09:53:09 INFO - 1498841589503 Marionette TRACE 390 <- [1,1,null,{"sessionId":"6f587058-963d-48f9-9955-a2ec099c4fd8","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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}}]
09:53:09 INFO - 1498841589506 Marionette TRACE 390 -> [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"}]
09:53:09 INFO - 1498841589510 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"
09:53:09 INFO - 1498841589517 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"
09:53:09 INFO - 1498841589518 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"
09:53:09 INFO - ++DOMWINDOW == 24 (00000080E25B2800) [pid = 2268] [serial = 44] [outer = 00000080DB085000]
09:53:09 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:09 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:09 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:09 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:09 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:09 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:09 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:09 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:09 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:09 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:09 INFO - 1498841589576 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"
09:53:09 INFO - 1498841589581 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"
09:53:09 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:09 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:09 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:09 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:09 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:09 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:09 INFO - 1498841589599 Marionette TRACE 390 <- [1,2,null,{}]
09:53:09 INFO - 1498841589602 Marionette TRACE 390 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
09:53:09 INFO - 1498841589610 Marionette TRACE 390 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"65b7c279-9c43-46e8-be63-df9def6d7e41","ELEMENT":"65b7c279-9c43-46e8-be63-df9def6d7e41"}}]
09:53:09 INFO - 1498841589612 Marionette TRACE 390 -> [0,4,"clickElement",{"id":"65b7c279-9c43-46e8-be63-df9def6d7e41"}]
09:53:10 INFO - 1498841590051 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:53:10 INFO - 1498841590052 Marionette TRACE 390 <- [1,4,null,{}]
09:53:10 INFO - 1498841590055 Marionette TRACE 390 -> [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}]
09:53:10 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1498841590063 Marionette TRACE 390 <- [1,5,null,{"value":null}]
09:53:10 INFO - 1498841590065 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
09:53:10 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:10 INFO - 1498841590069 Marionette TRACE 390 <- [1,6,null,{}]
09:53:10 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 793ms
09:53:10 INFO - TEST-START | test_click.py TestClick.test_input_file
09:53:10 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:10 INFO - 1498841590075 Marionette DEBUG Closed connection 390
09:53:10 INFO - 1498841590077 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49773
09:53:10 INFO - 1498841590079 Marionette DEBUG Closed connection 391
09:53:10 INFO - 1498841590080 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49774
09:53:10 INFO - 1498841590082 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:10 INFO - 1498841590085 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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}
09:53:10 INFO - 1498841590109 Marionette DEBUG Register listener.js for window 7
09:53:10 INFO - 1498841590121 Marionette TRACE 392 <- [1,1,null,{"sessionId":"d56e42d5-3851-41f6-8c18-e1761a889749","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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}}]
09:53:10 INFO - 1498841590124 Marionette TRACE 392 -> [0,2,"setTimeouts",{"script":30000}]
09:53:10 INFO - 1498841590126 Marionette TRACE 392 <- [1,2,null,{}]
09:53:10 INFO - 1498841590127 Marionette TRACE 392 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:53:10 INFO - 1498841590129 Marionette TRACE 392 <- [1,3,null,{}]
09:53:10 INFO - 1498841590131 Marionette TRACE 392 -> [0,4,"setTimeouts",{"implicit":0}]
09:53:10 INFO - 1498841590133 Marionette TRACE 392 <- [1,4,null,{}]
09:53:10 INFO - 1498841590136 Marionette TRACE 392 -> [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}]
09:53:10 INFO - TEST-START: test_click.py TestClick.test_input_file1498841590145 Marionette TRACE 392 <- [1,5,null,{"value":null}]
09:53:10 INFO - 1498841590147 Marionette TRACE 392 -> [0,6,"deleteSession",{}]
09:53:10 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:10 INFO - 1498841590151 Marionette TRACE 392 <- [1,6,null,{}]
09:53:10 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:10 INFO - 1498841590159 Marionette DEBUG Closed connection 392
09:53:10 INFO - 1498841590161 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49775
09:53:10 INFO - 1498841590162 Marionette DEBUG Closed connection 393
09:53:10 INFO - 1498841590165 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49776
09:53:10 INFO - 1498841590168 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:10 INFO - 1498841590170 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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}
09:53:10 INFO - 1498841590195 Marionette DEBUG Register listener.js for window 7
09:53:10 INFO - 1498841590208 Marionette TRACE 394 <- [1,1,null,{"sessionId":"4d002c47-a2c6-4dbc-96ae-5cf17e2dfd7b","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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}}]
09:53:10 INFO - 1498841590211 Marionette TRACE 394 -> [0,2,"deleteSession",{}]
09:53:10 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:10 INFO - 1498841590215 Marionette TRACE 394 <- [1,2,null,{}]
09:53:10 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:10 INFO - 1498841590221 Marionette DEBUG Closed connection 394
09:53:10 INFO - 1498841590222 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49777
09:53:10 INFO - 1498841590224 Marionette DEBUG Closed connection 395
09:53:10 INFO - 1498841590225 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49778
09:53:10 INFO - 1498841590227 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:53:10 INFO - 1498841590230 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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}
09:53:10 INFO - 1498841590255 Marionette DEBUG Register listener.js for window 7
09:53:10 INFO - 1498841590268 Marionette TRACE 396 <- [1,1,null,{"sessionId":"00d1fa15-3ac1-4cbc-bec0-e9472e2796b7","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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}}]
09:53:10 INFO - 1498841590271 Marionette TRACE 396 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
09:53:10 INFO - 1498841590275 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"
09:53:10 INFO - 1498841590286 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"
09:53:10 INFO - 1498841590288 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"
09:53:10 INFO - ++DOMWINDOW == 25 (00000080E3983000) [pid = 2268] [serial = 45] [outer = 00000080DB085000]
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:10 INFO - 1498841590345 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:53:10 INFO - 1498841590351 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:10 INFO - 1498841590369 Marionette TRACE 396 <- [1,2,null,{}]
09:53:10 INFO - 1498841590373 Marionette TRACE 396 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
09:53:10 INFO - 1498841590381 Marionette TRACE 396 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"fe283014-a0af-4ffb-9a92-63581be36c8d","ELEMENT":"fe283014-a0af-4ffb-9a92-63581be36c8d"}}]
09:53:10 INFO - 1498841590383 Marionette TRACE 396 -> [0,4,"clickElement",{"id":"fe283014-a0af-4ffb-9a92-63581be36c8d"}]
09:53:10 INFO - 1498841590544 Marionette TRACE 396 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:393:12\nclickElement@chrome://marionette/content/listener.js:1330:5\n"},null]
09:53:10 INFO - 1498841590547 Marionette TRACE 396 -> [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}]
09:53:10 INFO - TEST-END: test_click.py TestClick.test_input_file1498841590555 Marionette TRACE 396 <- [1,5,null,{"value":null}]
09:53:10 INFO - 1498841590557 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
09:53:10 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:10 INFO - 1498841590561 Marionette TRACE 396 <- [1,6,null,{}]
09:53:10 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 492ms
09:53:10 INFO - TEST-START | test_click.py TestClick.test_obscured_element
09:53:10 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:10 INFO - 1498841590568 Marionette DEBUG Closed connection 396
09:53:10 INFO - 1498841590569 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49779
09:53:10 INFO - 1498841590571 Marionette DEBUG Closed connection 397
09:53:10 INFO - 1498841590572 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49780
09:53:10 INFO - 1498841590574 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:10 INFO - 1498841590577 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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}
09:53:10 INFO - 1498841590606 Marionette DEBUG Register listener.js for window 7
09:53:10 INFO - 1498841590620 Marionette TRACE 398 <- [1,1,null,{"sessionId":"e9900d57-73e5-4e21-95c1-3e13908c6bdf","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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}}]
09:53:10 INFO - 1498841590623 Marionette TRACE 398 -> [0,2,"setTimeouts",{"script":30000}]
09:53:10 INFO - 1498841590625 Marionette TRACE 398 <- [1,2,null,{}]
09:53:10 INFO - 1498841590627 Marionette TRACE 398 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:53:10 INFO - 1498841590628 Marionette TRACE 398 <- [1,3,null,{}]
09:53:10 INFO - 1498841590630 Marionette TRACE 398 -> [0,4,"setTimeouts",{"implicit":0}]
09:53:10 INFO - 1498841590632 Marionette TRACE 398 <- [1,4,null,{}]
09:53:10 INFO - 1498841590635 Marionette TRACE 398 -> [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}]
09:53:10 INFO - TEST-START: test_click.py TestClick.test_obscured_element1498841590643 Marionette TRACE 398 <- [1,5,null,{"value":null}]
09:53:10 INFO - 1498841590644 Marionette TRACE 398 -> [0,6,"deleteSession",{}]
09:53:10 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:10 INFO - 1498841590649 Marionette TRACE 398 <- [1,6,null,{}]
09:53:10 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:10 INFO - 1498841590655 Marionette DEBUG Closed connection 398
09:53:10 INFO - 1498841590657 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49781
09:53:10 INFO - 1498841590658 Marionette DEBUG Closed connection 399
09:53:10 INFO - 1498841590660 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49782
09:53:10 INFO - 1498841590662 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:10 INFO - 1498841590664 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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}
09:53:10 INFO - 1498841590689 Marionette DEBUG Register listener.js for window 7
09:53:10 INFO - 1498841590702 Marionette TRACE 400 <- [1,1,null,{"sessionId":"01bcdb4f-b083-4403-887c-f02c8e8cb10c","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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}}]
09:53:10 INFO - 1498841590705 Marionette TRACE 400 -> [0,2,"deleteSession",{}]
09:53:10 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:10 INFO - 1498841590709 Marionette TRACE 400 <- [1,2,null,{}]
09:53:10 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:10 INFO - 1498841590715 Marionette DEBUG Closed connection 400
09:53:10 INFO - 1498841590717 Marionette DEBUG Accepted connection 401 from 127.0.0.1:49783
09:53:10 INFO - 1498841590718 Marionette DEBUG Closed connection 401
09:53:10 INFO - 1498841590720 Marionette DEBUG Accepted connection 402 from 127.0.0.1:49784
09:53:10 INFO - 1498841590722 Marionette TRACE 402 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:53:10 INFO - 1498841590725 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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}
09:53:10 INFO - 1498841590750 Marionette DEBUG Register listener.js for window 7
09:53:10 INFO - 1498841590762 Marionette TRACE 402 <- [1,1,null,{"sessionId":"c7a4d461-8ef1-486a-a825-1e80dd9e022d","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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}}]
09:53:10 INFO - 1498841590764 Marionette TRACE 402 -> [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"}]
09:53:10 INFO - 1498841590768 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:53:10 INFO - 1498841590775 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:53:10 INFO - 1498841590776 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:53:10 INFO - ++DOMWINDOW == 26 (00000080E3D65000) [pid = 2268] [serial = 46] [outer = 00000080DB085000]
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:10 INFO - 1498841590830 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"
09:53:10 INFO - 1498841590837 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"
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:10 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:10 INFO - 1498841590851 Marionette TRACE 402 <- [1,2,null,{}]
09:53:10 INFO - 1498841590855 Marionette TRACE 402 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
09:53:10 INFO - 1498841590861 Marionette TRACE 402 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"2f954d05-a60a-4327-a938-fe172328b883","ELEMENT":"2f954d05-a60a-4327-a938-fe172328b883"}}]
09:53:10 INFO - 1498841590863 Marionette TRACE 402 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
09:53:10 INFO - 1498841590871 Marionette TRACE 402 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"ea9d43e0-1cb4-4b24-9e78-60ba29219727","ELEMENT":"ea9d43e0-1cb4-4b24-9e78-60ba29219727"}}]
09:53:10 INFO - 1498841590873 Marionette TRACE 402 -> [0,5,"clickElement",{"id":"2f954d05-a60a-4327-a938-fe172328b883"}]
09:53:11 INFO - 1498841591477 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:53:11 INFO - 1498841591481 Marionette TRACE 402 <- [1,5,null,{}]
09:53:11 INFO - 1498841591483 Marionette TRACE 402 -> [0,6,"clickElement",{"id":"ea9d43e0-1cb4-4b24-9e78-60ba29219727"}]
09:53:11 INFO - 1498841591617 Marionette TRACE 402 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:393:12\nclickElement@chrome://marionette/content/listener.js:1330:5\n"},null]
09:53:11 INFO - 1498841591648 Marionette TRACE 402 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
09:53:11 INFO - 1498841591656 Marionette TRACE 402 <- [1,7,null,{"value":false}]
09:53:11 INFO - 1498841591666 Marionette TRACE 402 -> [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}]
09:53:11 INFO - TEST-END: test_click.py TestClick.test_obscured_element1498841591673 Marionette TRACE 402 <- [1,8,null,{"value":null}]
09:53:11 INFO - 1498841591675 Marionette TRACE 402 -> [0,9,"deleteSession",{}]
09:53:11 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:11 INFO - 1498841591679 Marionette TRACE 402 <- [1,9,null,{}]
09:53:11 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 1118ms
09:53:11 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
09:53:11 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:11 INFO - 1498841591685 Marionette DEBUG Closed connection 402
09:53:11 INFO - 1498841591687 Marionette DEBUG Accepted connection 403 from 127.0.0.1:49785
09:53:11 INFO - 1498841591688 Marionette DEBUG Closed connection 403
09:53:11 INFO - 1498841591690 Marionette DEBUG Accepted connection 404 from 127.0.0.1:49786
09:53:11 INFO - 1498841591692 Marionette TRACE 404 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:11 INFO - 1498841591694 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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}
09:53:11 INFO - 1498841591720 Marionette DEBUG Register listener.js for window 7
09:53:11 INFO - 1498841591732 Marionette TRACE 404 <- [1,1,null,{"sessionId":"645671ea-85e4-4809-b763-cf0fa4790225","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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}}]
09:53:11 INFO - 1498841591761 Marionette TRACE 404 -> [0,2,"setTimeouts",{"script":30000}]
09:53:11 INFO - 1498841591763 Marionette TRACE 404 <- [1,2,null,{}]
09:53:11 INFO - 1498841591765 Marionette TRACE 404 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:53:11 INFO - 1498841591766 Marionette TRACE 404 <- [1,3,null,{}]
09:53:11 INFO - 1498841591768 Marionette TRACE 404 -> [0,4,"setTimeouts",{"implicit":0}]
09:53:11 INFO - 1498841591770 Marionette TRACE 404 <- [1,4,null,{}]
09:53:11 INFO - 1498841591772 Marionette TRACE 404 -> [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}]
09:53:11 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1498841591783 Marionette TRACE 404 <- [1,5,null,{"value":null}]
09:53:11 INFO - 1498841591785 Marionette TRACE 404 -> [0,6,"deleteSession",{}]
09:53:11 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:11 INFO - 1498841591789 Marionette TRACE 404 <- [1,6,null,{}]
09:53:11 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:11 INFO - 1498841591795 Marionette DEBUG Closed connection 404
09:53:11 INFO - 1498841591797 Marionette DEBUG Accepted connection 405 from 127.0.0.1:49787
09:53:11 INFO - 1498841591799 Marionette DEBUG Closed connection 405
09:53:11 INFO - 1498841591800 Marionette DEBUG Accepted connection 406 from 127.0.0.1:49788
09:53:11 INFO - 1498841591802 Marionette TRACE 406 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:11 INFO - 1498841591804 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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}
09:53:11 INFO - 1498841591829 Marionette DEBUG Register listener.js for window 7
09:53:11 INFO - 1498841591841 Marionette TRACE 406 <- [1,1,null,{"sessionId":"55c3bfc6-47fe-43d2-96eb-d0174ca36b2b","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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}}]
09:53:11 INFO - 1498841591844 Marionette TRACE 406 -> [0,2,"deleteSession",{}]
09:53:11 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:11 INFO - 1498841591848 Marionette TRACE 406 <- [1,2,null,{}]
09:53:11 INFO - [2268] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:53:11 INFO - 1498841591854 Marionette DEBUG Closed connection 406
09:53:11 INFO - 1498841591855 Marionette DEBUG Accepted connection 407 from 127.0.0.1:49789
09:53:11 INFO - 1498841591857 Marionette DEBUG Closed connection 407
09:53:11 INFO - 1498841591858 Marionette DEBUG Accepted connection 408 from 127.0.0.1:49790
09:53:11 INFO - 1498841591861 Marionette TRACE 408 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:53:11 INFO - 1498841591863 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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}
09:53:11 INFO - 1498841591888 Marionette DEBUG Register listener.js for window 7
09:53:11 INFO - 1498841591908 Marionette TRACE 408 <- [1,1,null,{"sessionId":"653f668f-5514-49d7-8dc8-b69b40bebe42","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":2268,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-288.000\\AppData\\Local\\Temp\\tmphdfdik.mozrunner","moz:accessibilityChecks":false}}]
09:53:11 INFO - 1498841591912 Marionette TRACE 408 -> [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"}]
09:53:11 INFO - 1498841591916 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"
09:53:11 INFO - 1498841591928 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"
09:53:11 INFO - 1498841591929 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"
09:53:11 INFO - ++DOMWINDOW == 27 (00000080E4B7E800) [pid = 2268] [serial = 47] [outer = 00000080DB085000]
09:53:11 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:11 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:11 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:11 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:11 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:11 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:11 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:11 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:11 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:11 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:12 INFO - 1498841591996 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"
09:53:12 INFO - 1498841592003 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"
09:53:12 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:12 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:12 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:12 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:12 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:12 INFO - [2268] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:12 INFO - 1498841592018 Marionette TRACE 408 <- [1,2,null,{}]
09:53:12 INFO - 1498841592075 Marionette TRACE 408 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
09:53:12 INFO - 1498841592081 Marionette TRACE 408 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"885401bf-aef5-4919-a534-33734eea680c","ELEMENT":"885401bf-aef5-4919-a534-33734eea680c"}}]
09:53:12 INFO - 1498841592192 Marionette TRACE 408 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"885401bf-aef5-4919-a534-33734eea680c"}]
09:53:12 INFO - 1498841592312 Marionette TRACE 408 <- [1,4,null,{"value":"none"}]
09:53:12 INFO - 1498841592315 Marionette TRACE 408 -> [0,5,"clickElement",{"id":"885401bf-aef5-4919-a534-33734eea680c"}]
09:53:12 INFO - 1498841592458 Marionette TRACE 408 <- [1,5,{"error":"element click intercepted","message":"Element