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:42 INFO - 1499014422439 Marionette TRACE 354 -> [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:42 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499014422449 Marionette TRACE 354 <- [1,5,null,{"value":null}]
09:53:42 INFO - 1499014422451 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
09:53:42 INFO - [2700] 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:42 INFO - 1499014422455 Marionette TRACE 354 <- [1,6,null,{}]
09:53:42 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 943ms
09:53:42 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
09:53:42 INFO - [2700] 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:42 INFO - 1499014422462 Marionette DEBUG Closed connection 354
09:53:42 INFO - 1499014422464 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49954
09:53:42 INFO - 1499014422466 Marionette DEBUG Closed connection 355
09:53:42 INFO - 1499014422467 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49955
09:53:42 INFO - 1499014422470 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:42 INFO - 1499014422473 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}
09:53:42 INFO - 1499014422518 Marionette DEBUG Register listener.js for window 12
09:53:42 INFO - 1499014422532 Marionette TRACE 356 <- [1,1,null,{"sessionId":"b072bc1c-3920-4b68-954c-131e73c67860","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}}]
09:53:42 INFO - 1499014422535 Marionette TRACE 356 -> [0,2,"setTimeouts",{"script":30000}]
09:53:42 INFO - 1499014422537 Marionette TRACE 356 <- [1,2,null,{}]
09:53:42 INFO - 1499014422539 Marionette TRACE 356 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:53:42 INFO - 1499014422541 Marionette TRACE 356 <- [1,3,null,{}]
09:53:42 INFO - 1499014422579 Marionette TRACE 356 -> [0,4,"setTimeouts",{"implicit":0}]
09:53:42 INFO - 1499014422581 Marionette TRACE 356 <- [1,4,null,{}]
09:53:42 INFO - 1499014422633 Marionette TRACE 356 -> [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:42 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499014422645 Marionette TRACE 356 <- [1,5,null,{"value":null}]
09:53:42 INFO - 1499014422649 Marionette TRACE 356 -> [0,6,"deleteSession",{}]
09:53:42 INFO - [2700] 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:42 INFO - 1499014422654 Marionette TRACE 356 <- [1,6,null,{}]
09:53:42 INFO - [2700] 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:42 INFO - 1499014422661 Marionette DEBUG Closed connection 356
09:53:42 INFO - 1499014422663 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49956
09:53:42 INFO - 1499014422665 Marionette DEBUG Closed connection 357
09:53:42 INFO - 1499014422667 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49957
09:53:42 INFO - 1499014422669 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:42 INFO - 1499014422672 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}
09:53:42 INFO - 1499014422716 Marionette DEBUG Register listener.js for window 12
09:53:42 INFO - 1499014422730 Marionette TRACE 358 <- [1,1,null,{"sessionId":"858973e4-ccbf-4715-8ce8-36640aa2c5af","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}}]
09:53:42 INFO - 1499014422767 Marionette TRACE 358 -> [0,2,"deleteSession",{}]
09:53:42 INFO - [2700] 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:42 INFO - 1499014422772 Marionette TRACE 358 <- [1,2,null,{}]
09:53:42 INFO - [2700] 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:42 INFO - 1499014422797 Marionette DEBUG Closed connection 358
09:53:42 INFO - 1499014422798 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49958
09:53:42 INFO - 1499014422804 Marionette DEBUG Closed connection 359
09:53:42 INFO - 1499014422806 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49959
09:53:42 INFO - 1499014422808 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:53:42 INFO - 1499014422812 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}
09:53:42 INFO - 1499014422856 Marionette DEBUG Register listener.js for window 12
09:53:42 INFO - 1499014422870 Marionette TRACE 360 <- [1,1,null,{"sessionId":"19a3cc36-1c20-472a-9a02-c7dcbe7f17f2","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}}]
09:53:42 INFO - 1499014422873 Marionette TRACE 360 -> [0,2,"get",{"url":"http://127.0.0.1:49503/clicks.html"}]
09:53:42 INFO - 1499014422878 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49503/hidden.html"
09:53:42 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:42 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:42 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:42 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:42 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:42 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:42 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:42 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:42 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:42 INFO - 1499014422898 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49503/hidden.html"
09:53:42 INFO - 1499014422899 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49503/hidden.html"
09:53:42 INFO - ++DOMWINDOW == 28 (00000043FE9E0800) [pid = 2700] [serial = 44] [outer = 00000043F578B000]
09:53:42 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:42 INFO - 1499014422992 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49503/clicks.html"
09:53:43 INFO - 1499014422998 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49503/clicks.html"
09:53:43 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:43 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:43 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:43 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:43 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:43 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:43 INFO - 1499014423021 Marionette TRACE 360 <- [1,2,null,{}]
09:53:43 INFO - 1499014423038 Marionette TRACE 360 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
09:53:43 INFO - 1499014423048 Marionette TRACE 360 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"7a4d9f12-32bd-441e-b75f-b4a862ba9b16","ELEMENT":"7a4d9f12-32bd-441e-b75f-b4a862ba9b16"}}]
09:53:43 INFO - 1499014423060 Marionette TRACE 360 -> [0,4,"clickElement",{"id":"7a4d9f12-32bd-441e-b75f-b4a862ba9b16"}]
09:53:43 INFO - 1499014423406 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49503/clicks.html"
09:53:43 INFO - [2700] 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:43 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:43 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:43 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:43 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:43 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:43 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:43 INFO - 1499014423425 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49503/clicks.html"
09:53:43 INFO - 1499014423426 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49503/clicks.html"
09:53:43 INFO - ++DOMWINDOW == 29 (00000043E98D2000) [pid = 2700] [serial = 45] [outer = 00000043F578B000]
09:53:43 INFO - 1499014423489 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49503/test.html"
09:53:43 INFO - 1499014423496 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49503/test.html"
09:53:43 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:43 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:43 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:43 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:43 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:43 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:43 INFO - 1499014423514 Marionette TRACE 360 <- [1,4,null,{}]
09:53:43 INFO - 1499014423590 Marionette TRACE 360 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
09:53:43 INFO - 1499014423600 Marionette TRACE 360 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"866b9814-1422-4bb2-b098-9556c8ade931","ELEMENT":"866b9814-1422-4bb2-b098-9556c8ade931"}}]
09:53:43 INFO - 1499014423602 Marionette TRACE 360 -> [0,6,"getTitle",{}]
09:53:43 INFO - 1499014423607 Marionette TRACE 360 <- [1,6,null,{"value":"Marionette Test"}]
09:53:43 INFO - 1499014423613 Marionette TRACE 360 -> [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:43 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499014423623 Marionette TRACE 360 <- [1,7,null,{"value":null}]
09:53:43 INFO - 1499014423639 Marionette TRACE 360 -> [0,8,"deleteSession",{}]
09:53:43 INFO - [2700] 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:43 INFO - 1499014423644 Marionette TRACE 360 <- [1,8,null,{}]
09:53:43 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 1188ms
09:53:43 INFO - TEST-START | test_click.py TestClick.test_container_element
09:53:43 INFO - [2700] 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:43 INFO - 1499014423670 Marionette DEBUG Closed connection 360
09:53:43 INFO - 1499014423672 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49962
09:53:43 INFO - 1499014423676 Marionette DEBUG Closed connection 361
09:53:43 INFO - 1499014423678 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49963
09:53:43 INFO - 1499014423830 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:43 INFO - 1499014423845 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}
09:53:43 INFO - 1499014423872 Marionette DEBUG Register listener.js for window 12
09:53:43 INFO - 1499014423894 Marionette TRACE 362 <- [1,1,null,{"sessionId":"eda0e0a7-6605-4bfb-856d-b2b5a340eb43","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}}]
09:53:43 INFO - 1499014423903 Marionette TRACE 362 -> [0,2,"setTimeouts",{"script":30000}]
09:53:43 INFO - 1499014423907 Marionette TRACE 362 <- [1,2,null,{}]
09:53:43 INFO - 1499014423963 Marionette TRACE 362 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:53:43 INFO - 1499014423966 Marionette TRACE 362 <- [1,3,null,{}]
09:53:43 INFO - 1499014423972 Marionette TRACE 362 -> [0,4,"setTimeouts",{"implicit":0}]
09:53:43 INFO - 1499014423976 Marionette TRACE 362 <- [1,4,null,{}]
09:53:44 INFO - 1499014424000 Marionette TRACE 362 -> [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:44 INFO - TEST-START: test_click.py TestClick.test_container_element1499014424013 Marionette TRACE 362 <- [1,5,null,{"value":null}]
09:53:44 INFO - 1499014424021 Marionette TRACE 362 -> [0,6,"deleteSession",{}]
09:53:44 INFO - [2700] 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:44 INFO - 1499014424029 Marionette TRACE 362 <- [1,6,null,{}]
09:53:44 INFO - [2700] 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:44 INFO - 1499014424040 Marionette DEBUG Closed connection 362
09:53:44 INFO - 1499014424043 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49964
09:53:44 INFO - 1499014424045 Marionette DEBUG Closed connection 363
09:53:44 INFO - 1499014424047 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49965
09:53:44 INFO - 1499014424070 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:44 INFO - 1499014424075 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}
09:53:44 INFO - 1499014424098 Marionette DEBUG Register listener.js for window 12
09:53:44 INFO - 1499014424120 Marionette TRACE 364 <- [1,1,null,{"sessionId":"3a1b655a-7665-408c-a3ac-0c3a0c044957","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}}]
09:53:44 INFO - 1499014424124 Marionette TRACE 364 -> [0,2,"deleteSession",{}]
09:53:44 INFO - [2700] 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:44 INFO - 1499014424129 Marionette TRACE 364 <- [1,2,null,{}]
09:53:44 INFO - [2700] 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:44 INFO - 1499014424157 Marionette DEBUG Closed connection 364
09:53:44 INFO - 1499014424159 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49966
09:53:44 INFO - 1499014424163 Marionette DEBUG Closed connection 365
09:53:44 INFO - 1499014424165 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49967
09:53:44 INFO - 1499014424168 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:53:44 INFO - 1499014424171 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}
09:53:44 INFO - 1499014424194 Marionette DEBUG Register listener.js for window 12
09:53:44 INFO - 1499014424215 Marionette TRACE 366 <- [1,1,null,{"sessionId":"4e117fd5-946b-41f2-bcb2-39a7ef74feeb","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}}]
09:53:44 INFO - 1499014424225 Marionette TRACE 366 -> [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:44 INFO - 1499014424230 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49503/test.html"
09:53:44 INFO - 1499014424239 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49503/test.html"
09:53:44 INFO - 1499014424240 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49503/test.html"
09:53:44 INFO - ++DOMWINDOW == 30 (00000043E8FDF000) [pid = 2700] [serial = 46] [outer = 00000043F578B000]
09:53:44 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:44 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:44 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:44 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:44 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:44 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:44 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:44 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:44 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:44 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:44 INFO - 1499014424294 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:44 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:44 INFO - 1499014424313 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:44 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:44 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:44 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:44 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:44 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:44 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:44 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:44 INFO - 1499014424333 Marionette TRACE 366 <- [1,2,null,{}]
09:53:44 INFO - 1499014424343 Marionette TRACE 366 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
09:53:44 INFO - 1499014424356 Marionette TRACE 366 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"46c6c9ef-0e3b-4cd4-ba27-7d9d1235c920","ELEMENT":"46c6c9ef-0e3b-4cd4-ba27-7d9d1235c920"}}]
09:53:44 INFO - 1499014424358 Marionette TRACE 366 -> [0,4,"clickElement",{"id":"46c6c9ef-0e3b-4cd4-ba27-7d9d1235c920"}]
09:53:44 INFO - [2700] 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:44 INFO - [2700] 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:44 INFO - [2700] 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:44 INFO - --DOMWINDOW == 29 (00000043E9EC6800) [pid = 2700] [serial = 29] [outer = 0000000000000000] [url = http://127.0.0.1:49503/test_accessibility.html]
09:53:44 INFO - --DOMWINDOW == 28 (00000043F5E13800) [pid = 2700] [serial = 31] [outer = 0000000000000000] [url = http://127.0.0.1:49503/test_accessibility.html]
09:53:44 INFO - --DOMWINDOW == 27 (00000043F9121800) [pid = 2700] [serial = 32] [outer = 0000000000000000] [url = http://127.0.0.1:49503/test_accessibility.html]
09:53:44 INFO - --DOMWINDOW == 26 (00000043FA097800) [pid = 2700] [serial = 33] [outer = 0000000000000000] [url = http://127.0.0.1:49503/test_accessibility.html]
09:53:44 INFO - --DOMWINDOW == 25 (00000043FBE37800) [pid = 2700] [serial = 34] [outer = 0000000000000000] [url = http://127.0.0.1:49503/test_accessibility.html]
09:53:44 INFO - --DOMWINDOW == 24 (00000043F9CD1800) [pid = 2700] [serial = 28] [outer = 0000000000000000] [url = http://127.0.0.1:49503/test_accessibility.html]
09:53:44 INFO - --DOMWINDOW == 23 (00000043F1E38000) [pid = 2700] [serial = 30] [outer = 0000000000000000] [url = http://127.0.0.1:49503/test_accessibility.html]
09:53:45 INFO - 1499014425484 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:53:45 INFO - 1499014425489 Marionette TRACE 366 <- [1,4,null,{}]
09:53:45 INFO - 1499014425528 Marionette TRACE 366 -> [0,5,"getElementProperty",{"id":"46c6c9ef-0e3b-4cd4-ba27-7d9d1235c920","name":"selected"}]
09:53:45 INFO - 1499014425553 Marionette TRACE 366 <- [1,5,null,{"value":true}]
09:53:45 INFO - 1499014425557 Marionette TRACE 366 -> [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:45 INFO - TEST-END: test_click.py TestClick.test_container_element1499014425566 Marionette TRACE 366 <- [1,6,null,{"value":null}]
09:53:45 INFO - 1499014425568 Marionette TRACE 366 -> [0,7,"deleteSession",{}]
09:53:45 INFO - [2700] 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:45 INFO - 1499014425573 Marionette TRACE 366 <- [1,7,null,{}]
09:53:45 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 1928ms
09:53:45 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
09:53:45 INFO - [2700] 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:45 INFO - 1499014425580 Marionette DEBUG Closed connection 366
09:53:45 INFO - 1499014425582 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49968
09:53:45 INFO - 1499014425584 Marionette DEBUG Closed connection 367
09:53:45 INFO - 1499014425586 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49969
09:53:45 INFO - 1499014425588 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:45 INFO - 1499014425591 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}
09:53:45 INFO - 1499014425615 Marionette DEBUG Register listener.js for window 12
09:53:45 INFO - 1499014425673 Marionette TRACE 368 <- [1,1,null,{"sessionId":"9153f534-b699-41ee-82af-db896807dfad","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}}]
09:53:45 INFO - 1499014425725 Marionette TRACE 368 -> [0,2,"setTimeouts",{"script":30000}]
09:53:45 INFO - 1499014425727 Marionette TRACE 368 <- [1,2,null,{}]
09:53:45 INFO - 1499014425767 Marionette TRACE 368 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:53:45 INFO - 1499014425769 Marionette TRACE 368 <- [1,3,null,{}]
09:53:45 INFO - 1499014425781 Marionette TRACE 368 -> [0,4,"setTimeouts",{"implicit":0}]
09:53:45 INFO - 1499014425784 Marionette TRACE 368 <- [1,4,null,{}]
09:53:45 INFO - 1499014425787 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_outside_view')","sandbox":"simpletest","line":316}]
09:53:45 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499014425797 Marionette TRACE 368 <- [1,5,null,{"value":null}]
09:53:45 INFO - 1499014425800 Marionette TRACE 368 -> [0,6,"deleteSession",{}]
09:53:45 INFO - [2700] 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:45 INFO - 1499014425805 Marionette TRACE 368 <- [1,6,null,{}]
09:53:45 INFO - [2700] 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:45 INFO - 1499014425828 Marionette DEBUG Closed connection 368
09:53:45 INFO - 1499014425830 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49970
09:53:45 INFO - 1499014425834 Marionette DEBUG Closed connection 369
09:53:45 INFO - 1499014425836 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49971
09:53:45 INFO - 1499014425839 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:45 INFO - 1499014425841 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}
09:53:45 INFO - 1499014425864 Marionette DEBUG Register listener.js for window 12
09:53:45 INFO - 1499014425880 Marionette TRACE 370 <- [1,1,null,{"sessionId":"5fe67330-b3d1-4688-9f35-bea291ee9cce","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}}]
09:53:45 INFO - 1499014425887 Marionette TRACE 370 -> [0,2,"deleteSession",{}]
09:53:45 INFO - [2700] 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:45 INFO - 1499014425892 Marionette TRACE 370 <- [1,2,null,{}]
09:53:45 INFO - [2700] 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:45 INFO - 1499014425914 Marionette DEBUG Closed connection 370
09:53:45 INFO - 1499014425916 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49972
09:53:45 INFO - 1499014425920 Marionette DEBUG Closed connection 371
09:53:45 INFO - 1499014425922 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49973
09:53:45 INFO - 1499014425925 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:53:45 INFO - 1499014425929 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}
09:53:45 INFO - 1499014425953 Marionette DEBUG Register listener.js for window 12
09:53:45 INFO - 1499014425968 Marionette TRACE 372 <- [1,1,null,{"sessionId":"944f4357-7222-45ac-ab0f-323fb17aa790","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}}]
09:53:45 INFO - 1499014425975 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%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:45 INFO - 1499014425979 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:45 INFO - 1499014425988 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:45 INFO - 1499014425989 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:45 INFO - ++DOMWINDOW == 24 (00000043EF97E000) [pid = 2700] [serial = 47] [outer = 00000043F578B000]
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:46 INFO - 1499014426043 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:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:46 INFO - 1499014426057 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:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:46 INFO - 1499014426077 Marionette TRACE 372 <- [1,2,null,{}]
09:53:46 INFO - 1499014426084 Marionette TRACE 372 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
09:53:46 INFO - 1499014426092 Marionette TRACE 372 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"726b5893-5080-407b-ae60-0bda6a9c1065","ELEMENT":"726b5893-5080-407b-ae60-0bda6a9c1065"}}]
09:53:46 INFO - 1499014426095 Marionette TRACE 372 -> [0,4,"clickElement",{"id":"726b5893-5080-407b-ae60-0bda6a9c1065"}]
09:53:46 INFO - [2700] 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:46 INFO - [2700] 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:46 INFO - [2700] 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:46 INFO - 1499014426544 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:53:46 INFO - 1499014426546 Marionette TRACE 372 <- [1,4,null,{}]
09:53:46 INFO - 1499014426548 Marionette TRACE 372 -> [0,5,"getElementProperty",{"id":"726b5893-5080-407b-ae60-0bda6a9c1065","name":"selected"}]
09:53:46 INFO - 1499014426576 Marionette TRACE 372 <- [1,5,null,{"value":true}]
09:53:46 INFO - 1499014426578 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_outside_view')","sandbox":"simpletest","line":328}]
09:53:46 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499014426586 Marionette TRACE 372 <- [1,6,null,{"value":null}]
09:53:46 INFO - 1499014426588 Marionette TRACE 372 -> [0,7,"deleteSession",{}]
09:53:46 INFO - [2700] 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:46 INFO - 1499014426593 Marionette TRACE 372 <- [1,7,null,{}]
09:53:46 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 1020ms
09:53:46 INFO - TEST-START | test_click.py TestClick.test_css_transforms
09:53:46 INFO - [2700] 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:46 INFO - 1499014426601 Marionette DEBUG Closed connection 372
09:53:46 INFO - 1499014426606 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49974
09:53:46 INFO - 1499014426608 Marionette DEBUG Closed connection 373
09:53:46 INFO - 1499014426609 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49975
09:53:46 INFO - 1499014426612 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:46 INFO - 1499014426614 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}
09:53:46 INFO - 1499014426637 Marionette DEBUG Register listener.js for window 12
09:53:46 INFO - 1499014426649 Marionette TRACE 374 <- [1,1,null,{"sessionId":"d1453b38-30ce-4625-8d41-abd42434c65f","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}}]
09:53:46 INFO - 1499014426685 Marionette TRACE 374 -> [0,2,"setTimeouts",{"script":30000}]
09:53:46 INFO - 1499014426687 Marionette TRACE 374 <- [1,2,null,{}]
09:53:46 INFO - 1499014426688 Marionette TRACE 374 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:53:46 INFO - 1499014426690 Marionette TRACE 374 <- [1,3,null,{}]
09:53:46 INFO - 1499014426692 Marionette TRACE 374 -> [0,4,"setTimeouts",{"implicit":0}]
09:53:46 INFO - 1499014426693 Marionette TRACE 374 <- [1,4,null,{}]
09:53:46 INFO - 1499014426696 Marionette TRACE 374 -> [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:46 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499014426704 Marionette TRACE 374 <- [1,5,null,{"value":null}]
09:53:46 INFO - 1499014426706 Marionette TRACE 374 -> [0,6,"deleteSession",{}]
09:53:46 INFO - [2700] 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:46 INFO - 1499014426710 Marionette TRACE 374 <- [1,6,null,{}]
09:53:46 INFO - [2700] 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:46 INFO - 1499014426716 Marionette DEBUG Closed connection 374
09:53:46 INFO - 1499014426717 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49976
09:53:46 INFO - 1499014426740 Marionette DEBUG Closed connection 375
09:53:46 INFO - 1499014426741 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49977
09:53:46 INFO - 1499014426744 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:46 INFO - 1499014426746 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}
09:53:46 INFO - 1499014426769 Marionette DEBUG Register listener.js for window 12
09:53:46 INFO - 1499014426781 Marionette TRACE 376 <- [1,1,null,{"sessionId":"689be1ee-0d69-4217-830e-cdc72e813bf9","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}}]
09:53:46 INFO - 1499014426784 Marionette TRACE 376 -> [0,2,"deleteSession",{}]
09:53:46 INFO - [2700] 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:46 INFO - 1499014426788 Marionette TRACE 376 <- [1,2,null,{}]
09:53:46 INFO - [2700] 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:46 INFO - 1499014426794 Marionette DEBUG Closed connection 376
09:53:46 INFO - 1499014426795 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49978
09:53:46 INFO - 1499014426797 Marionette DEBUG Closed connection 377
09:53:46 INFO - 1499014426798 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49979
09:53:46 INFO - 1499014426800 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:53:46 INFO - 1499014426803 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}
09:53:46 INFO - 1499014426828 Marionette DEBUG Register listener.js for window 12
09:53:46 INFO - 1499014426840 Marionette TRACE 378 <- [1,1,null,{"sessionId":"d4384455-3ff0-4a41-b272-bd9abba52a69","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}}]
09:53:46 INFO - 1499014426843 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%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:46 INFO - 1499014426846 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:46 INFO - 1499014426853 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:46 INFO - 1499014426854 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:46 INFO - ++DOMWINDOW == 25 (00000043F4EC0000) [pid = 2700] [serial = 48] [outer = 00000043F578B000]
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:46 INFO - 1499014426905 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:46 INFO - 1499014426913 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:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:46 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:46 INFO - 1499014426930 Marionette TRACE 378 <- [1,2,null,{}]
09:53:46 INFO - 1499014426933 Marionette TRACE 378 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
09:53:46 INFO - 1499014426973 Marionette TRACE 378 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"c6e1023f-a502-49b0-96fe-2e414b433b3b","ELEMENT":"c6e1023f-a502-49b0-96fe-2e414b433b3b"}}]
09:53:46 INFO - 1499014426975 Marionette TRACE 378 -> [0,4,"clickElement",{"id":"c6e1023f-a502-49b0-96fe-2e414b433b3b"}]
09:53:47 INFO - 1499014427396 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:53:47 INFO - 1499014427398 Marionette TRACE 378 <- [1,4,null,{}]
09:53:47 INFO - 1499014427401 Marionette TRACE 378 -> [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:47 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499014427410 Marionette TRACE 378 <- [1,5,null,{"value":null}]
09:53:47 INFO - 1499014427416 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
09:53:47 INFO - [2700] 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:47 INFO - 1499014427421 Marionette TRACE 378 <- [1,6,null,{}]
09:53:47 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 828ms
09:53:47 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
09:53:47 INFO - [2700] 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:47 INFO - 1499014427444 Marionette DEBUG Closed connection 378
09:53:47 INFO - 1499014427445 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49980
09:53:48 INFO - 1499014428113 Marionette DEBUG Closed connection 379
09:53:48 INFO - 1499014428115 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49981
09:53:48 INFO - 1499014428120 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:48 INFO - 1499014428122 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}
09:53:48 INFO - 1499014428145 Marionette DEBUG Register listener.js for window 12
09:53:48 INFO - 1499014428157 Marionette TRACE 380 <- [1,1,null,{"sessionId":"11e1704c-273c-43ed-a47f-ac0b1d24ce70","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}}]
09:53:48 INFO - 1499014428160 Marionette TRACE 380 -> [0,2,"setTimeouts",{"script":30000}]
09:53:48 INFO - 1499014428162 Marionette TRACE 380 <- [1,2,null,{}]
09:53:48 INFO - 1499014428164 Marionette TRACE 380 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:53:48 INFO - 1499014428166 Marionette TRACE 380 <- [1,3,null,{}]
09:53:48 INFO - 1499014428168 Marionette TRACE 380 -> [0,4,"setTimeouts",{"implicit":0}]
09:53:48 INFO - 1499014428169 Marionette TRACE 380 <- [1,4,null,{}]
09:53:48 INFO - 1499014428172 Marionette TRACE 380 -> [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:48 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499014428179 Marionette TRACE 380 <- [1,5,null,{"value":null}]
09:53:48 INFO - 1499014428181 Marionette TRACE 380 -> [0,6,"deleteSession",{}]
09:53:48 INFO - [2700] 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:48 INFO - 1499014428185 Marionette TRACE 380 <- [1,6,null,{}]
09:53:48 INFO - [2700] 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:48 INFO - 1499014428223 Marionette DEBUG Closed connection 380
09:53:48 INFO - 1499014428225 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49982
09:53:48 INFO - 1499014428228 Marionette DEBUG Closed connection 381
09:53:48 INFO - 1499014428230 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49983
09:53:48 INFO - 1499014428233 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:48 INFO - 1499014428236 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}
09:53:48 INFO - 1499014428264 Marionette DEBUG Register listener.js for window 12
09:53:48 INFO - 1499014428278 Marionette TRACE 382 <- [1,1,null,{"sessionId":"e1bb63c9-134e-4323-9f86-4937d887443b","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}}]
09:53:48 INFO - 1499014428284 Marionette TRACE 382 -> [0,2,"deleteSession",{}]
09:53:48 INFO - [2700] 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:48 INFO - 1499014428288 Marionette TRACE 382 <- [1,2,null,{}]
09:53:48 INFO - [2700] 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:48 INFO - 1499014428311 Marionette DEBUG Closed connection 382
09:53:48 INFO - 1499014428312 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49984
09:53:48 INFO - 1499014428329 Marionette DEBUG Closed connection 383
09:53:48 INFO - 1499014428330 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49985
09:53:48 INFO - 1499014428333 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:53:48 INFO - 1499014428336 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}
09:53:48 INFO - 1499014428361 Marionette DEBUG Register listener.js for window 12
09:53:48 INFO - 1499014428375 Marionette TRACE 384 <- [1,1,null,{"sessionId":"12475bf4-c0d1-440e-b237-2238355bd7cf","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}}]
09:53:48 INFO - 1499014428382 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%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:48 INFO - 1499014428386 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:48 INFO - 1499014428396 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:48 INFO - 1499014428397 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:48 INFO - ++DOMWINDOW == 26 (00000043F6B92800) [pid = 2700] [serial = 49] [outer = 00000043F578B000]
09:53:48 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:48 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:48 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:48 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:48 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:48 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:48 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:48 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:48 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:48 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:48 INFO - 1499014428452 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:48 INFO - 1499014428458 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:48 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:48 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:48 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:48 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:48 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:48 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:48 INFO - 1499014428476 Marionette TRACE 384 <- [1,2,null,{}]
09:53:48 INFO - 1499014428484 Marionette TRACE 384 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
09:53:48 INFO - 1499014428492 Marionette TRACE 384 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"2cd1258a-950b-443c-a965-764cd3f8f4c4","ELEMENT":"2cd1258a-950b-443c-a965-764cd3f8f4c4"}}]
09:53:48 INFO - 1499014428494 Marionette TRACE 384 -> [0,4,"clickElement",{"id":"2cd1258a-950b-443c-a965-764cd3f8f4c4"}]
09:53:48 INFO - 1499014428937 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:53:48 INFO - 1499014428941 Marionette TRACE 384 <- [1,4,null,{}]
09:53:48 INFO - 1499014428946 Marionette TRACE 384 -> [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:48 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499014428961 Marionette TRACE 384 <- [1,5,null,{"value":null}]
09:53:48 INFO - 1499014428966 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
09:53:48 INFO - [2700] 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:48 INFO - 1499014428976 Marionette TRACE 384 <- [1,6,null,{}]
09:53:48 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 1557ms
09:53:48 INFO - TEST-START | test_click.py TestClick.test_input_file
09:53:49 INFO - [2700] 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:49 INFO - 1499014429021 Marionette DEBUG Closed connection 384
09:53:49 INFO - 1499014429023 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49986
09:53:49 INFO - 1499014429045 Marionette DEBUG Closed connection 385
09:53:49 INFO - 1499014429048 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49987
09:53:49 INFO - 1499014429056 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:49 INFO - 1499014429066 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}
09:53:49 INFO - 1499014429115 Marionette DEBUG Register listener.js for window 12
09:53:49 INFO - 1499014429139 Marionette TRACE 386 <- [1,1,null,{"sessionId":"1bb3f510-aa80-470b-9727-b4a7818eb761","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}}]
09:53:49 INFO - 1499014429149 Marionette TRACE 386 -> [0,2,"setTimeouts",{"script":30000}]
09:53:49 INFO - 1499014429154 Marionette TRACE 386 <- [1,2,null,{}]
09:53:49 INFO - 1499014429169 Marionette TRACE 386 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:53:49 INFO - 1499014429172 Marionette TRACE 386 <- [1,3,null,{}]
09:53:49 INFO - 1499014429175 Marionette TRACE 386 -> [0,4,"setTimeouts",{"implicit":0}]
09:53:49 INFO - 1499014429178 Marionette TRACE 386 <- [1,4,null,{}]
09:53:49 INFO - 1499014429181 Marionette TRACE 386 -> [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:49 INFO - TEST-START: test_click.py TestClick.test_input_file1499014429195 Marionette TRACE 386 <- [1,5,null,{"value":null}]
09:53:49 INFO - 1499014429198 Marionette TRACE 386 -> [0,6,"deleteSession",{}]
09:53:49 INFO - [2700] 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:49 INFO - 1499014429204 Marionette TRACE 386 <- [1,6,null,{}]
09:53:49 INFO - [2700] 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:49 INFO - 1499014429213 Marionette DEBUG Closed connection 386
09:53:49 INFO - 1499014429217 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49988
09:53:49 INFO - 1499014429241 Marionette DEBUG Closed connection 387
09:53:49 INFO - 1499014429243 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49989
09:53:49 INFO - 1499014429247 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:49 INFO - 1499014429251 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}
09:53:49 INFO - 1499014429300 Marionette DEBUG Register listener.js for window 12
09:53:49 INFO - 1499014429331 Marionette TRACE 388 <- [1,1,null,{"sessionId":"aa1bb334-5e3e-4854-bb15-77a17ddadfd2","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}}]
09:53:49 INFO - 1499014429338 Marionette TRACE 388 -> [0,2,"deleteSession",{}]
09:53:49 INFO - [2700] 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:49 INFO - 1499014429346 Marionette TRACE 388 <- [1,2,null,{}]
09:53:49 INFO - [2700] 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:49 INFO - 1499014429370 Marionette DEBUG Closed connection 388
09:53:49 INFO - 1499014429372 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49990
09:53:49 INFO - 1499014429391 Marionette DEBUG Closed connection 389
09:53:49 INFO - 1499014429393 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49991
09:53:49 INFO - 1499014429429 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:53:49 INFO - 1499014429439 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}
09:53:49 INFO - 1499014429487 Marionette DEBUG Register listener.js for window 12
09:53:49 INFO - 1499014429504 Marionette TRACE 390 <- [1,1,null,{"sessionId":"daed52f6-0046-40ad-b70d-2b8d75b1e03a","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}}]
09:53:49 INFO - 1499014429514 Marionette TRACE 390 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
09:53:49 INFO - 1499014429520 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:49 INFO - 1499014429541 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:49 INFO - 1499014429544 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:49 INFO - ++DOMWINDOW == 27 (00000043EF22C000) [pid = 2700] [serial = 50] [outer = 00000043F578B000]
09:53:49 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:49 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:49 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:49 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:49 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:49 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:49 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:49 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:49 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:49 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:49 INFO - 1499014429612 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:53:49 INFO - 1499014429620 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:53:49 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:49 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:49 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:49 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:49 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:49 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:49 INFO - 1499014429640 Marionette TRACE 390 <- [1,2,null,{}]
09:53:49 INFO - 1499014429645 Marionette TRACE 390 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
09:53:49 INFO - 1499014429657 Marionette TRACE 390 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"373ad784-fd62-4aa1-aec0-6cbd4d55eb40","ELEMENT":"373ad784-fd62-4aa1-aec0-6cbd4d55eb40"}}]
09:53:49 INFO - 1499014429659 Marionette TRACE 390 -> [0,4,"clickElement",{"id":"373ad784-fd62-4aa1-aec0-6cbd4d55eb40"}]
09:53:49 INFO - 1499014429889 Marionette TRACE 390 <- [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:49 INFO - 1499014429909 Marionette TRACE 390 -> [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:49 INFO - TEST-END: test_click.py TestClick.test_input_file1499014429919 Marionette TRACE 390 <- [1,5,null,{"value":null}]
09:53:49 INFO - 1499014429921 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
09:53:49 INFO - [2700] 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:49 INFO - 1499014429927 Marionette TRACE 390 <- [1,6,null,{}]
09:53:49 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 949ms
09:53:49 INFO - TEST-START | test_click.py TestClick.test_obscured_element
09:53:49 INFO - [2700] 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:49 INFO - 1499014429952 Marionette DEBUG Closed connection 390
09:53:49 INFO - 1499014429954 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49992
09:53:50 INFO - 1499014430006 Marionette DEBUG Closed connection 391
09:53:50 INFO - 1499014430008 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49993
09:53:50 INFO - 1499014430014 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:50 INFO - 1499014430017 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}
09:53:50 INFO - 1499014430066 Marionette DEBUG Register listener.js for window 12
09:53:50 INFO - 1499014430083 Marionette TRACE 392 <- [1,1,null,{"sessionId":"b9326fe0-696f-40c5-b962-c6f600e6a91a","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}}]
09:53:50 INFO - 1499014430089 Marionette TRACE 392 -> [0,2,"setTimeouts",{"script":30000}]
09:53:50 INFO - 1499014430092 Marionette TRACE 392 <- [1,2,null,{}]
09:53:50 INFO - 1499014430143 Marionette TRACE 392 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:53:50 INFO - 1499014430145 Marionette TRACE 392 <- [1,3,null,{}]
09:53:50 INFO - 1499014430148 Marionette TRACE 392 -> [0,4,"setTimeouts",{"implicit":0}]
09:53:50 INFO - 1499014430151 Marionette TRACE 392 <- [1,4,null,{}]
09:53:50 INFO - 1499014430155 Marionette TRACE 392 -> [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:50 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499014430167 Marionette TRACE 392 <- [1,5,null,{"value":null}]
09:53:50 INFO - 1499014430200 Marionette TRACE 392 -> [0,6,"deleteSession",{}]
09:53:50 INFO - [2700] 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:50 INFO - 1499014430205 Marionette TRACE 392 <- [1,6,null,{}]
09:53:50 INFO - [2700] 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:50 INFO - 1499014430231 Marionette DEBUG Closed connection 392
09:53:50 INFO - 1499014430233 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49994
09:53:50 INFO - 1499014430237 Marionette DEBUG Closed connection 393
09:53:50 INFO - 1499014430239 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49995
09:53:50 INFO - 1499014430427 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:50 INFO - 1499014430439 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}
09:53:50 INFO - 1499014430468 Marionette DEBUG Register listener.js for window 12
09:53:50 INFO - 1499014430493 Marionette TRACE 394 <- [1,1,null,{"sessionId":"87e6d96e-5959-408a-82ae-7082f11bd235","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}}]
09:53:50 INFO - 1499014430502 Marionette TRACE 394 -> [0,2,"deleteSession",{}]
09:53:50 INFO - [2700] 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:50 INFO - 1499014430508 Marionette TRACE 394 <- [1,2,null,{}]
09:53:50 INFO - [2700] 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:50 INFO - 1499014430517 Marionette DEBUG Closed connection 394
09:53:50 INFO - 1499014430520 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49996
09:53:50 INFO - 1499014430522 Marionette DEBUG Closed connection 395
09:53:50 INFO - 1499014430525 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49997
09:53:50 INFO - 1499014430553 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:53:50 INFO - 1499014430559 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}
09:53:50 INFO - 1499014430587 Marionette DEBUG Register listener.js for window 12
09:53:50 INFO - 1499014430621 Marionette TRACE 396 <- [1,1,null,{"sessionId":"1c3f12b4-cdc7-42d0-9915-6488b6f8d024","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}}]
09:53:50 INFO - 1499014430652 Marionette TRACE 396 -> [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:50 INFO - 1499014430659 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:53:50 INFO - 1499014430669 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:53:50 INFO - 1499014430670 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:53:50 INFO - ++DOMWINDOW == 28 (00000043EAEBE000) [pid = 2700] [serial = 51] [outer = 00000043F578B000]
09:53:50 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:50 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:50 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:50 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:50 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:50 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:50 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:50 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:50 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:50 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:50 INFO - 1499014430734 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:50 INFO - 1499014430742 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:50 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:50 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:50 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:50 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:50 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:50 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:50 INFO - 1499014430762 Marionette TRACE 396 <- [1,2,null,{}]
09:53:50 INFO - 1499014430778 Marionette TRACE 396 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
09:53:50 INFO - 1499014430789 Marionette TRACE 396 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"fcc0e1ed-9d87-41f5-a30b-14b2f14964f5","ELEMENT":"fcc0e1ed-9d87-41f5-a30b-14b2f14964f5"}}]
09:53:50 INFO - 1499014430792 Marionette TRACE 396 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
09:53:50 INFO - 1499014430801 Marionette TRACE 396 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"f2880911-c4f6-48ec-bf86-5001aa584e1d","ELEMENT":"f2880911-c4f6-48ec-bf86-5001aa584e1d"}}]
09:53:50 INFO - 1499014430804 Marionette TRACE 396 -> [0,5,"clickElement",{"id":"fcc0e1ed-9d87-41f5-a30b-14b2f14964f5"}]
09:53:51 INFO - 1499014431237 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:53:51 INFO - 1499014431239 Marionette TRACE 396 <- [1,5,null,{}]
09:53:51 INFO - 1499014431245 Marionette TRACE 396 -> [0,6,"clickElement",{"id":"f2880911-c4f6-48ec-bf86-5001aa584e1d"}]
09:53:51 INFO - 1499014431366 Marionette TRACE 396 <- [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:51 INFO - 1499014431395 Marionette TRACE 396 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
09:53:51 INFO - 1499014431406 Marionette TRACE 396 <- [1,7,null,{"value":false}]
09:53:51 INFO - 1499014431411 Marionette TRACE 396 -> [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:51 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499014431419 Marionette TRACE 396 <- [1,8,null,{"value":null}]
09:53:51 INFO - 1499014431426 Marionette TRACE 396 -> [0,9,"deleteSession",{}]
09:53:51 INFO - [2700] 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:51 INFO - 1499014431435 Marionette TRACE 396 <- [1,9,null,{}]
09:53:51 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 1507ms
09:53:51 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
09:53:51 INFO - [2700] 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:51 INFO - 1499014431442 Marionette DEBUG Closed connection 396
09:53:51 INFO - 1499014431444 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49998
09:53:51 INFO - 1499014431446 Marionette DEBUG Closed connection 397
09:53:51 INFO - 1499014431448 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49999
09:53:51 INFO - 1499014431451 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:51 INFO - 1499014431454 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}
09:53:51 INFO - 1499014431480 Marionette DEBUG Register listener.js for window 12
09:53:51 INFO - 1499014431495 Marionette TRACE 398 <- [1,1,null,{"sessionId":"79db5be5-c691-4ffe-9337-bc92e658af25","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}}]
09:53:51 INFO - 1499014431504 Marionette TRACE 398 -> [0,2,"setTimeouts",{"script":30000}]
09:53:51 INFO - 1499014431506 Marionette TRACE 398 <- [1,2,null,{}]
09:53:51 INFO - --DOMWINDOW == 27 (00000043EABB5000) [pid = 2700] [serial = 36] [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:51 INFO - --DOMWINDOW == 26 (00000043F5568800) [pid = 2700] [serial = 37] [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%20horizontally%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%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:51 INFO - --DOMWINDOW == 25 (00000043F9128800) [pid = 2700] [serial = 38] [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%20vertically%20%2A/%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:51 INFO - --DOMWINDOW == 24 (00000043F99D5800) [pid = 2700] [serial = 39] [outer = 0000000000000000] [url = data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%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.clicks%20%3D%200%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.clicks%2B%2B%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:51 INFO - --DOMWINDOW == 23 (00000043FDA08000) [pid = 2700] [serial = 35] [outer = 0000000000000000] [url = http://127.0.0.1:49503/test_accessibility.html]
09:53:51 INFO - 1499014431538 Marionette TRACE 398 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:53:51 INFO - 1499014431540 Marionette TRACE 398 <- [1,3,null,{}]
09:53:51 INFO - 1499014431550 Marionette TRACE 398 -> [0,4,"setTimeouts",{"implicit":0}]
09:53:51 INFO - 1499014431551 Marionette TRACE 398 <- [1,4,null,{}]
09:53:51 INFO - 1499014431554 Marionette TRACE 398 -> [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:51 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499014431565 Marionette TRACE 398 <- [1,5,null,{"value":null}]
09:53:51 INFO - 1499014431568 Marionette TRACE 398 -> [0,6,"deleteSession",{}]
09:53:51 INFO - [2700] 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:51 INFO - 1499014431573 Marionette TRACE 398 <- [1,6,null,{}]
09:53:51 INFO - [2700] 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:51 INFO - 1499014431598 Marionette DEBUG Closed connection 398
09:53:51 INFO - 1499014431600 Marionette DEBUG Accepted connection 399 from 127.0.0.1:50000
09:53:51 INFO - 1499014431722 Marionette DEBUG Closed connection 399
09:53:51 INFO - 1499014431724 Marionette DEBUG Accepted connection 400 from 127.0.0.1:50001
09:53:51 INFO - 1499014431746 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:53:51 INFO - 1499014431749 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}
09:53:51 INFO - 1499014431774 Marionette DEBUG Register listener.js for window 12
09:53:51 INFO - 1499014431789 Marionette TRACE 400 <- [1,1,null,{"sessionId":"229af8e0-6199-42e4-ae09-5320693dd61d","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}}]
09:53:51 INFO - 1499014431798 Marionette TRACE 400 -> [0,2,"deleteSession",{}]
09:53:51 INFO - [2700] 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:51 INFO - 1499014431803 Marionette TRACE 400 <- [1,2,null,{}]
09:53:51 INFO - [2700] 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:51 INFO - 1499014431810 Marionette DEBUG Closed connection 400
09:53:51 INFO - 1499014431813 Marionette DEBUG Accepted connection 401 from 127.0.0.1:50002
09:53:51 INFO - 1499014431833 Marionette DEBUG Closed connection 401
09:53:51 INFO - 1499014431835 Marionette DEBUG Accepted connection 402 from 127.0.0.1:50003
09:53:51 INFO - 1499014431839 Marionette TRACE 402 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:53:51 INFO - 1499014431842 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}
09:53:51 INFO - 1499014431866 Marionette DEBUG Register listener.js for window 12
09:53:51 INFO - 1499014431883 Marionette TRACE 402 <- [1,1,null,{"sessionId":"dd49ddc8-bcee-4756-9920-16554bc2b6ff","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-042.001\\AppData\\Local\\Temp\\tmpedcpq5.mozrunner","moz:accessibilityChecks":false}}]
09:53:51 INFO - 1499014431890 Marionette TRACE 402 -> [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:51 INFO - 1499014431895 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:51 INFO - 1499014431904 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:51 INFO - 1499014431905 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:51 INFO - ++DOMWINDOW == 24 (00000043F577D000) [pid = 2700] [serial = 52] [outer = 00000043F578B000]
09:53:51 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:51 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:51 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:51 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:51 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:51 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:51 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:51 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:51 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:51 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:51 INFO - 1499014431969 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:51 INFO - 1499014431974 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:51 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:51 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:51 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:51 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
09:53:51 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:51 INFO - [2700] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
09:53:52 INFO - 1499014431993 Marionette TRACE 402 <- [1,2,null,{}]
09:53:52 INFO - 1499014432002 Marionette TRACE 402 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
09:53:52 INFO - 1499014432011 Marionette TRACE 402 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"384bfec1-26d0-499b-a468-22f7d22718ea","ELEMENT":"384bfec1-26d0-499b-a468-22f7d22718ea"}}]
09:53:52 INFO - 1499014432013 Marionette TRACE 402 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"384bfec1-26d0-499b-a468-22f7d22718ea"}]
09:53:52 INFO - 1499014432135 Marionette TRACE 402 <- [1,4,null,{"value":"none"}]
09:53:52 INFO - 1499014432145 Marionette TRACE 402 -> [0,5,"clickElement",{"id":"384bfec1-26d0-499b-a468-22f7d22718ea"}]
09:53:52 INFO - 1499014432296 Marionette TRACE 402 <- [1,5,{"error":"element click intercepted","message":"Element