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]
15:58:49 INFO - 1498863529696 Marionette TRACE 358 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises')","sandbox":"simpletest","line":328}]
15:58:49 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1498863529708 Marionette TRACE 358 <- [1,5,null,{"value":null}]
15:58:49 INFO - 1498863529711 Marionette TRACE 358 -> [0,6,"deleteSession",{}]
15:58:49 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:49 INFO - 1498863529715 Marionette TRACE 358 <- [1,6,null,{}]
15:58:49 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 810ms
15:58:49 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
15:58:49 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:49 INFO - 1498863529722 Marionette DEBUG Closed connection 358
15:58:49 INFO - 1498863529725 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49691
15:58:49 INFO - 1498863529727 Marionette DEBUG Closed connection 359
15:58:49 INFO - 1498863529728 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49692
15:58:49 INFO - 1498863529731 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:58:49 INFO - 1498863529734 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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}
15:58:49 INFO - 1498863529759 Marionette DEBUG Register listener.js for window 7
15:58:49 INFO - 1498863529775 Marionette TRACE 360 <- [1,1,null,{"sessionId":"33c2057d-18b2-41c5-97e6-e29f23ffc975","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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}}]
15:58:49 INFO - 1498863529786 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
15:58:49 INFO - 1498863529788 Marionette TRACE 360 <- [1,2,null,{}]
15:58:49 INFO - --DOMWINDOW == 28 (000000A153E1E800) [pid = 4980] [serial = 22] [outer = 0000000000000000] [url = http://127.0.0.1:49292/test_accessibility.html]
15:58:49 INFO - --DOMWINDOW == 27 (000000A157C65800) [pid = 4980] [serial = 21] [outer = 0000000000000000] [url = http://127.0.0.1:49292/test_accessibility.html]
15:58:49 INFO - --DOMWINDOW == 26 (000000A157B5D000) [pid = 4980] [serial = 23] [outer = 0000000000000000] [url = http://127.0.0.1:49292/test_accessibility.html]
15:58:49 INFO - --DOMWINDOW == 25 (000000A157C6B800) [pid = 4980] [serial = 24] [outer = 0000000000000000] [url = http://127.0.0.1:49292/test_accessibility.html]
15:58:49 INFO - 1498863529822 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:58:49 INFO - 1498863529824 Marionette TRACE 360 <- [1,3,null,{}]
15:58:49 INFO - 1498863529826 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
15:58:49 INFO - 1498863529828 Marionette TRACE 360 <- [1,4,null,{}]
15:58:49 INFO - 1498863529831 Marionette TRACE 360 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":316}]
15:58:49 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1498863529840 Marionette TRACE 360 <- [1,5,null,{"value":null}]
15:58:49 INFO - 1498863529842 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
15:58:49 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:49 INFO - 1498863529846 Marionette TRACE 360 <- [1,6,null,{}]
15:58:49 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:49 INFO - 1498863529853 Marionette DEBUG Closed connection 360
15:58:49 INFO - 1498863529855 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49693
15:58:49 INFO - 1498863529856 Marionette DEBUG Closed connection 361
15:58:49 INFO - 1498863529858 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49694
15:58:49 INFO - 1498863529861 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:58:49 INFO - 1498863529865 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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}
15:58:49 INFO - 1498863529889 Marionette DEBUG Register listener.js for window 7
15:58:49 INFO - 1498863529904 Marionette TRACE 362 <- [1,1,null,{"sessionId":"b0344d5b-7b2b-46c8-938b-b21c5b836b4f","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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}}]
15:58:49 INFO - 1498863529907 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
15:58:49 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:49 INFO - 1498863529912 Marionette TRACE 362 <- [1,2,null,{}]
15:58:49 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:49 INFO - 1498863529920 Marionette DEBUG Closed connection 362
15:58:49 INFO - 1498863529925 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49695
15:58:49 INFO - 1498863529927 Marionette DEBUG Closed connection 363
15:58:49 INFO - 1498863529929 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49696
15:58:49 INFO - 1498863529931 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:58:49 INFO - 1498863529934 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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}
15:58:49 INFO - 1498863529957 Marionette DEBUG Register listener.js for window 7
15:58:49 INFO - 1498863529977 Marionette TRACE 364 <- [1,1,null,{"sessionId":"98c2bdba-2200-421b-9e87-593d259c8768","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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}}]
15:58:50 INFO - 1498863530026 Marionette TRACE 364 -> [0,2,"get",{"url":"http://127.0.0.1:49292/clicks.html"}]
15:58:50 INFO - 1498863530030 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49292/hidden.html"
15:58:50 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:50 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:50 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:50 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:50 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:50 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:50 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:50 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:50 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:50 INFO - 1498863530051 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49292/hidden.html"
15:58:50 INFO - 1498863530051 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49292/hidden.html"
15:58:50 INFO - ++DOMWINDOW == 26 (000000A157C5B800) [pid = 4980] [serial = 39] [outer = 000000A15817D800]
15:58:50 INFO - 1498863530114 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49292/clicks.html"
15:58:50 INFO - 1498863530120 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49292/clicks.html"
15:58:50 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:50 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:50 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:50 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:50 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:50 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:50 INFO - 1498863530143 Marionette TRACE 364 <- [1,2,null,{}]
15:58:50 INFO - 1498863530146 Marionette TRACE 364 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
15:58:50 INFO - 1498863530157 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"7dbda594-fbec-4cfc-bc9c-eb53cf85e576","ELEMENT":"7dbda594-fbec-4cfc-bc9c-eb53cf85e576"}}]
15:58:50 INFO - 1498863530160 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"7dbda594-fbec-4cfc-bc9c-eb53cf85e576"}]
15:58:50 INFO - 1498863530403 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49292/clicks.html"
15:58:50 INFO - [4980] 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
15:58:50 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:50 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:50 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:50 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:50 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:50 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:50 INFO - 1498863530531 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49292/clicks.html"
15:58:50 INFO - 1498863530532 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49292/clicks.html"
15:58:50 INFO - ++DOMWINDOW == 27 (000000A15EF0B000) [pid = 4980] [serial = 40] [outer = 000000A15817D800]
15:58:50 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:50 INFO - 1498863530594 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49292/test.html"
15:58:50 INFO - 1498863530600 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49292/test.html"
15:58:50 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:50 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:50 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:50 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:50 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:50 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:50 INFO - 1498863530616 Marionette TRACE 364 <- [1,4,null,{}]
15:58:50 INFO - 1498863530653 Marionette TRACE 364 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
15:58:50 INFO - 1498863530661 Marionette TRACE 364 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"f6ae5d5f-0760-4a65-9642-4dc3a86f01a9","ELEMENT":"f6ae5d5f-0760-4a65-9642-4dc3a86f01a9"}}]
15:58:50 INFO - 1498863530663 Marionette TRACE 364 -> [0,6,"getTitle",{}]
15:58:50 INFO - 1498863530668 Marionette TRACE 364 <- [1,6,null,{"value":"Marionette Test"}]
15:58:50 INFO - 1498863530670 Marionette TRACE 364 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":328}]
15:58:50 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1498863530678 Marionette TRACE 364 <- [1,7,null,{"value":null}]
15:58:50 INFO - 1498863530680 Marionette TRACE 364 -> [0,8,"deleteSession",{}]
15:58:50 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:50 INFO - 1498863530685 Marionette TRACE 364 <- [1,8,null,{}]
15:58:50 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 969ms
15:58:50 INFO - TEST-START | test_click.py TestClick.test_container_element
15:58:50 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:50 INFO - 1498863530692 Marionette DEBUG Closed connection 364
15:58:50 INFO - 1498863530693 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49699
15:58:50 INFO - 1498863530695 Marionette DEBUG Closed connection 365
15:58:50 INFO - 1498863530696 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49700
15:58:50 INFO - 1498863530699 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:58:50 INFO - 1498863530701 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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}
15:58:50 INFO - 1498863530726 Marionette DEBUG Register listener.js for window 7
15:58:50 INFO - 1498863530739 Marionette TRACE 366 <- [1,1,null,{"sessionId":"2c55bf17-1c7d-4985-96a5-c95f18a14d8b","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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}}]
15:58:50 INFO - 1498863530743 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
15:58:50 INFO - 1498863530745 Marionette TRACE 366 <- [1,2,null,{}]
15:58:50 INFO - 1498863530748 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:58:50 INFO - 1498863530750 Marionette TRACE 366 <- [1,3,null,{}]
15:58:50 INFO - 1498863530752 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
15:58:50 INFO - 1498863530754 Marionette TRACE 366 <- [1,4,null,{}]
15:58:50 INFO - 1498863530785 Marionette TRACE 366 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":316}]
15:58:50 INFO - TEST-START: test_click.py TestClick.test_container_element1498863530794 Marionette TRACE 366 <- [1,5,null,{"value":null}]
15:58:50 INFO - 1498863530801 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
15:58:50 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:50 INFO - 1498863530805 Marionette TRACE 366 <- [1,6,null,{}]
15:58:50 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:50 INFO - 1498863530829 Marionette DEBUG Closed connection 366
15:58:50 INFO - 1498863530830 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49701
15:58:51 INFO - 1498863531669 Marionette DEBUG Closed connection 367
15:58:51 INFO - 1498863531670 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49702
15:58:51 INFO - 1498863531689 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:58:51 INFO - 1498863531691 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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}
15:58:51 INFO - 1498863531714 Marionette DEBUG Register listener.js for window 7
15:58:51 INFO - 1498863531726 Marionette TRACE 368 <- [1,1,null,{"sessionId":"495e993e-b929-4de9-88db-ad01544645d7","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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}}]
15:58:51 INFO - 1498863531729 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
15:58:51 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:51 INFO - 1498863531734 Marionette TRACE 368 <- [1,2,null,{}]
15:58:51 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:51 INFO - 1498863531786 Marionette DEBUG Closed connection 368
15:58:51 INFO - 1498863531788 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49703
15:58:51 INFO - 1498863531842 Marionette DEBUG Closed connection 369
15:58:51 INFO - 1498863531844 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49704
15:58:51 INFO - 1498863531899 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:58:51 INFO - 1498863531901 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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}
15:58:51 INFO - 1498863531925 Marionette DEBUG Register listener.js for window 7
15:58:51 INFO - 1498863531938 Marionette TRACE 370 <- [1,1,null,{"sessionId":"a655be08-a6ea-40a3-992f-0002cc81f009","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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}}]
15:58:51 INFO - 1498863531991 Marionette TRACE 370 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
15:58:51 INFO - 1498863531995 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49292/test.html"
15:58:52 INFO - 1498863532005 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49292/test.html"
15:58:52 INFO - 1498863532006 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49292/test.html"
15:58:52 INFO - ++DOMWINDOW == 28 (000000A16134F000) [pid = 4980] [serial = 41] [outer = 000000A15817D800]
15:58:52 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:52 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:52 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:52 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:52 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:52 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:52 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:52 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:52 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:52 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:52 INFO - 1498863532115 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"
15:58:52 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:52 INFO - 1498863532134 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"
15:58:52 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:52 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:52 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:52 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:52 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:52 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:52 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:52 INFO - 1498863532149 Marionette TRACE 370 <- [1,2,null,{}]
15:58:52 INFO - 1498863532198 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
15:58:52 INFO - 1498863532205 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"78a4de81-5f53-4ba8-80c7-3d590bb5ba3d","ELEMENT":"78a4de81-5f53-4ba8-80c7-3d590bb5ba3d"}}]
15:58:52 INFO - 1498863532226 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"78a4de81-5f53-4ba8-80c7-3d590bb5ba3d"}]
15:58:52 INFO - [4980] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1908
15:58:52 INFO - [4980] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1816
15:58:52 INFO - [4980] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1622
15:58:52 INFO - 1498863532668 Marionette DEBUG Canceled page load listener because no navigation has been detected
15:58:52 INFO - 1498863532670 Marionette TRACE 370 <- [1,4,null,{}]
15:58:52 INFO - 1498863532672 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"78a4de81-5f53-4ba8-80c7-3d590bb5ba3d","name":"selected"}]
15:58:52 INFO - 1498863532701 Marionette TRACE 370 <- [1,5,null,{"value":true}]
15:58:52 INFO - 1498863532704 Marionette TRACE 370 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":328}]
15:58:52 INFO - TEST-END: test_click.py TestClick.test_container_element1498863532712 Marionette TRACE 370 <- [1,6,null,{"value":null}]
15:58:52 INFO - 1498863532714 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
15:58:52 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:52 INFO - 1498863532718 Marionette TRACE 370 <- [1,7,null,{}]
15:58:52 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 2033ms
15:58:52 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
15:58:52 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:52 INFO - 1498863532725 Marionette DEBUG Closed connection 370
15:58:52 INFO - 1498863532726 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49705
15:58:52 INFO - 1498863532728 Marionette DEBUG Closed connection 371
15:58:52 INFO - 1498863532729 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49706
15:58:52 INFO - 1498863532731 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:58:52 INFO - 1498863532735 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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}
15:58:52 INFO - 1498863532762 Marionette DEBUG Register listener.js for window 7
15:58:52 INFO - 1498863532776 Marionette TRACE 372 <- [1,1,null,{"sessionId":"5d7527bb-47c9-4b69-9a13-833946bc9029","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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}}]
15:58:52 INFO - 1498863532779 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
15:58:52 INFO - 1498863532781 Marionette TRACE 372 <- [1,2,null,{}]
15:58:52 INFO - 1498863532783 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:58:52 INFO - 1498863532785 Marionette TRACE 372 <- [1,3,null,{}]
15:58:52 INFO - 1498863532787 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
15:58:52 INFO - 1498863532788 Marionette TRACE 372 <- [1,4,null,{}]
15:58:52 INFO - 1498863532791 Marionette TRACE 372 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":316}]
15:58:52 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1498863532799 Marionette TRACE 372 <- [1,5,null,{"value":null}]
15:58:52 INFO - 1498863532801 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
15:58:52 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:52 INFO - 1498863532806 Marionette TRACE 372 <- [1,6,null,{}]
15:58:52 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:52 INFO - 1498863532812 Marionette DEBUG Closed connection 372
15:58:52 INFO - 1498863532813 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49707
15:58:52 INFO - 1498863532815 Marionette DEBUG Closed connection 373
15:58:52 INFO - 1498863532816 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49708
15:58:52 INFO - 1498863532818 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:58:52 INFO - 1498863532820 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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}
15:58:52 INFO - 1498863532844 Marionette DEBUG Register listener.js for window 7
15:58:52 INFO - 1498863532855 Marionette TRACE 374 <- [1,1,null,{"sessionId":"31611706-cc27-4d0f-a536-0d7148c58967","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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}}]
15:58:52 INFO - 1498863532859 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
15:58:52 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:52 INFO - 1498863532863 Marionette TRACE 374 <- [1,2,null,{}]
15:58:52 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:52 INFO - 1498863532869 Marionette DEBUG Closed connection 374
15:58:52 INFO - 1498863532870 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49709
15:58:52 INFO - 1498863532872 Marionette DEBUG Closed connection 375
15:58:52 INFO - 1498863532873 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49710
15:58:52 INFO - 1498863532876 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:58:52 INFO - 1498863532878 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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}
15:58:52 INFO - 1498863532901 Marionette DEBUG Register listener.js for window 7
15:58:52 INFO - 1498863532912 Marionette TRACE 376 <- [1,1,null,{"sessionId":"efdf105d-9435-4180-a98b-229f6fd5a396","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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}}]
15:58:52 INFO - 1498863532915 Marionette TRACE 376 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
15:58:52 INFO - 1498863532919 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"
15:58:52 INFO - 1498863532925 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"
15:58:52 INFO - 1498863532926 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"
15:58:52 INFO - ++DOMWINDOW == 29 (000000A15FEC8000) [pid = 4980] [serial = 42] [outer = 000000A15817D800]
15:58:52 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:52 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:52 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:52 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:52 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:52 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:52 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:52 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:52 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:52 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:53 INFO - 1498863533068 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"
15:58:53 INFO - 1498863533072 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"
15:58:53 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:53 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:53 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:53 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:53 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:53 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:53 INFO - 1498863533092 Marionette TRACE 376 <- [1,2,null,{}]
15:58:53 INFO - 1498863533095 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
15:58:53 INFO - 1498863533103 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"ddf4fc4f-82cd-4501-bec4-5441a0cb221a","ELEMENT":"ddf4fc4f-82cd-4501-bec4-5441a0cb221a"}}]
15:58:53 INFO - 1498863533105 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"ddf4fc4f-82cd-4501-bec4-5441a0cb221a"}]
15:58:53 INFO - [4980] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1908
15:58:53 INFO - [4980] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1816
15:58:53 INFO - [4980] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1622
15:58:53 INFO - 1498863533543 Marionette DEBUG Canceled page load listener because no navigation has been detected
15:58:53 INFO - 1498863533545 Marionette TRACE 376 <- [1,4,null,{}]
15:58:53 INFO - 1498863533547 Marionette TRACE 376 -> [0,5,"getElementProperty",{"id":"ddf4fc4f-82cd-4501-bec4-5441a0cb221a","name":"selected"}]
15:58:53 INFO - 1498863533576 Marionette TRACE 376 <- [1,5,null,{"value":true}]
15:58:53 INFO - 1498863533580 Marionette TRACE 376 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":328}]
15:58:53 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1498863533587 Marionette TRACE 376 <- [1,6,null,{"value":null}]
15:58:53 INFO - 1498863533589 Marionette TRACE 376 -> [0,7,"deleteSession",{}]
15:58:53 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:53 INFO - 1498863533593 Marionette TRACE 376 <- [1,7,null,{}]
15:58:53 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 875ms
15:58:53 INFO - TEST-START | test_click.py TestClick.test_css_transforms
15:58:53 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:53 INFO - 1498863533600 Marionette DEBUG Closed connection 376
15:58:53 INFO - 1498863533601 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49711
15:58:53 INFO - 1498863533603 Marionette DEBUG Closed connection 377
15:58:53 INFO - 1498863533604 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49712
15:58:53 INFO - 1498863533607 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:58:53 INFO - 1498863533609 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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}
15:58:53 INFO - 1498863533634 Marionette DEBUG Register listener.js for window 7
15:58:53 INFO - 1498863533646 Marionette TRACE 378 <- [1,1,null,{"sessionId":"25240224-f9d5-4509-a953-79df8143b9c2","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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}}]
15:58:53 INFO - 1498863533651 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
15:58:53 INFO - 1498863533652 Marionette TRACE 378 <- [1,2,null,{}]
15:58:53 INFO - 1498863533688 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:58:53 INFO - 1498863533689 Marionette TRACE 378 <- [1,3,null,{}]
15:58:53 INFO - 1498863533691 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
15:58:53 INFO - 1498863533693 Marionette TRACE 378 <- [1,4,null,{}]
15:58:53 INFO - 1498863533695 Marionette TRACE 378 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":316}]
15:58:53 INFO - TEST-START: test_click.py TestClick.test_css_transforms1498863533703 Marionette TRACE 378 <- [1,5,null,{"value":null}]
15:58:53 INFO - 1498863533705 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
15:58:53 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:53 INFO - 1498863533709 Marionette TRACE 378 <- [1,6,null,{}]
15:58:53 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:53 INFO - 1498863533715 Marionette DEBUG Closed connection 378
15:58:53 INFO - 1498863533717 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49713
15:58:53 INFO - 1498863533718 Marionette DEBUG Closed connection 379
15:58:53 INFO - 1498863533720 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49714
15:58:53 INFO - 1498863533722 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:58:53 INFO - 1498863533724 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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}
15:58:53 INFO - 1498863533747 Marionette DEBUG Register listener.js for window 7
15:58:53 INFO - 1498863533759 Marionette TRACE 380 <- [1,1,null,{"sessionId":"5098bd7f-172f-4ce6-96a4-38b7d4bd228d","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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}}]
15:58:53 INFO - 1498863533762 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
15:58:53 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:53 INFO - 1498863533766 Marionette TRACE 380 <- [1,2,null,{}]
15:58:53 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:53 INFO - 1498863533772 Marionette DEBUG Closed connection 380
15:58:53 INFO - 1498863533773 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49715
15:58:53 INFO - 1498863533775 Marionette DEBUG Closed connection 381
15:58:53 INFO - 1498863533776 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49716
15:58:53 INFO - 1498863533778 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:58:53 INFO - 1498863533781 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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}
15:58:53 INFO - 1498863533804 Marionette DEBUG Register listener.js for window 7
15:58:53 INFO - 1498863533826 Marionette TRACE 382 <- [1,1,null,{"sessionId":"944c063c-b33d-48e5-9d32-2d65bebf9e92","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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}}]
15:58:53 INFO - 1498863533829 Marionette TRACE 382 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"}]
15:58:53 INFO - 1498863533833 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"
15:58:53 INFO - 1498863533840 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"
15:58:53 INFO - 1498863533840 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"
15:58:53 INFO - ++DOMWINDOW == 30 (000000A16021C000) [pid = 4980] [serial = 43] [outer = 000000A15817D800]
15:58:53 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:53 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:53 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:53 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:53 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:53 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:53 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:53 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:53 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:53 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:53 INFO - 1498863533893 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"
15:58:53 INFO - 1498863533899 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"
15:58:53 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:53 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:53 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:53 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:53 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:53 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:53 INFO - 1498863533916 Marionette TRACE 382 <- [1,2,null,{}]
15:58:53 INFO - 1498863533919 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
15:58:53 INFO - 1498863533926 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"4053901f-094d-4a18-9c60-5a2390864992","ELEMENT":"4053901f-094d-4a18-9c60-5a2390864992"}}]
15:58:53 INFO - 1498863533928 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"4053901f-094d-4a18-9c60-5a2390864992"}]
15:58:54 INFO - 1498863534445 Marionette DEBUG Canceled page load listener because no navigation has been detected
15:58:54 INFO - 1498863534447 Marionette TRACE 382 <- [1,4,null,{}]
15:58:54 INFO - 1498863534450 Marionette TRACE 382 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":328}]
15:58:54 INFO - TEST-END: test_click.py TestClick.test_css_transforms1498863534461 Marionette TRACE 382 <- [1,5,null,{"value":null}]
15:58:54 INFO - 1498863534463 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
15:58:54 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:54 INFO - 1498863534467 Marionette TRACE 382 <- [1,6,null,{}]
15:58:54 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 872ms
15:58:54 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
15:58:54 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:54 INFO - 1498863534473 Marionette DEBUG Closed connection 382
15:58:54 INFO - 1498863534474 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49717
15:58:54 INFO - 1498863534476 Marionette DEBUG Closed connection 383
15:58:54 INFO - 1498863534477 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49718
15:58:54 INFO - 1498863534480 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:58:54 INFO - 1498863534482 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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}
15:58:54 INFO - 1498863534506 Marionette DEBUG Register listener.js for window 7
15:58:54 INFO - 1498863534518 Marionette TRACE 384 <- [1,1,null,{"sessionId":"13202015-52b9-4de4-8d83-32c599963fb2","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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}}]
15:58:54 INFO - 1498863534551 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
15:58:54 INFO - 1498863534552 Marionette TRACE 384 <- [1,2,null,{}]
15:58:54 INFO - 1498863534554 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:58:54 INFO - 1498863534556 Marionette TRACE 384 <- [1,3,null,{}]
15:58:55 INFO - 1498863535252 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
15:58:55 INFO - 1498863535254 Marionette TRACE 384 <- [1,4,null,{}]
15:58:55 INFO - 1498863535292 Marionette TRACE 384 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":316}]
15:58:55 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1498863535299 Marionette TRACE 384 <- [1,5,null,{"value":null}]
15:58:55 INFO - 1498863535301 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
15:58:55 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:55 INFO - 1498863535306 Marionette TRACE 384 <- [1,6,null,{}]
15:58:55 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:55 INFO - 1498863535312 Marionette DEBUG Closed connection 384
15:58:55 INFO - 1498863535313 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49719
15:58:55 INFO - 1498863535315 Marionette DEBUG Closed connection 385
15:58:55 INFO - 1498863535316 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49720
15:58:55 INFO - 1498863535318 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:58:55 INFO - 1498863535323 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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}
15:58:55 INFO - 1498863535348 Marionette DEBUG Register listener.js for window 7
15:58:55 INFO - 1498863535403 Marionette TRACE 386 <- [1,1,null,{"sessionId":"d910e78a-c2b1-4af3-95ec-61ac51a4bb40","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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}}]
15:58:55 INFO - 1498863535560 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
15:58:55 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:55 INFO - 1498863535568 Marionette TRACE 386 <- [1,2,null,{}]
15:58:55 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:55 INFO - 1498863535596 Marionette DEBUG Closed connection 386
15:58:55 INFO - 1498863535600 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49721
15:58:55 INFO - 1498863535653 Marionette DEBUG Closed connection 387
15:58:55 INFO - 1498863535656 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49722
15:58:55 INFO - 1498863535661 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:58:55 INFO - 1498863535672 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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}
15:58:55 INFO - 1498863535723 Marionette DEBUG Register listener.js for window 7
15:58:55 INFO - 1498863535746 Marionette TRACE 388 <- [1,1,null,{"sessionId":"e76c0ef9-5e68-44de-a610-a474f3987c02","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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}}]
15:58:55 INFO - 1498863535759 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
15:58:55 INFO - 1498863535767 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"
15:58:55 INFO - 1498863535779 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"
15:58:55 INFO - 1498863535780 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"
15:58:55 INFO - ++DOMWINDOW == 31 (000000A157A48000) [pid = 4980] [serial = 44] [outer = 000000A15817D800]
15:58:55 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:55 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:55 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:55 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:55 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:55 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:55 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:55 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:55 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:55 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:55 INFO - 1498863535860 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"
15:58:55 INFO - 1498863535868 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"
15:58:55 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:55 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:55 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:55 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:55 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:55 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:55 INFO - 1498863535892 Marionette TRACE 388 <- [1,2,null,{}]
15:58:55 INFO - 1498863535897 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
15:58:55 INFO - 1498863535912 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"33d65c4e-0a6c-495e-b670-2f80feff023c","ELEMENT":"33d65c4e-0a6c-495e-b670-2f80feff023c"}}]
15:58:55 INFO - 1498863535915 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"33d65c4e-0a6c-495e-b670-2f80feff023c"}]
15:58:56 INFO - 1498863536547 Marionette DEBUG Canceled page load listener because no navigation has been detected
15:58:56 INFO - 1498863536551 Marionette TRACE 388 <- [1,4,null,{}]
15:58:56 INFO - 1498863536555 Marionette TRACE 388 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":328}]
15:58:56 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1498863536570 Marionette TRACE 388 <- [1,5,null,{"value":null}]
15:58:56 INFO - 1498863536581 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
15:58:56 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:56 INFO - 1498863536588 Marionette TRACE 388 <- [1,6,null,{}]
15:58:56 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 2122ms
15:58:56 INFO - TEST-START | test_click.py TestClick.test_input_file
15:58:56 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:56 INFO - 1498863536618 Marionette DEBUG Closed connection 388
15:58:56 INFO - 1498863536622 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49723
15:58:56 INFO - 1498863536625 Marionette DEBUG Closed connection 389
15:58:56 INFO - 1498863536628 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49724
15:58:56 INFO - 1498863536632 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:58:56 INFO - 1498863536635 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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}
15:58:56 INFO - 1498863536687 Marionette DEBUG Register listener.js for window 7
15:58:56 INFO - 1498863536721 Marionette TRACE 390 <- [1,1,null,{"sessionId":"2230bb8b-990d-45c2-9608-660e9fb96d8f","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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}}]
15:58:56 INFO - 1498863536731 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
15:58:56 INFO - 1498863536734 Marionette TRACE 390 <- [1,2,null,{}]
15:58:56 INFO - 1498863536737 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:58:56 INFO - 1498863536740 Marionette TRACE 390 <- [1,3,null,{}]
15:58:56 INFO - 1498863536804 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
15:58:56 INFO - 1498863536810 Marionette TRACE 390 <- [1,4,null,{}]
15:58:56 INFO - 1498863536817 Marionette TRACE 390 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":316}]
15:58:56 INFO - TEST-START: test_click.py TestClick.test_input_file1498863536829 Marionette TRACE 390 <- [1,5,null,{"value":null}]
15:58:56 INFO - 1498863536877 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
15:58:56 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:56 INFO - 1498863536884 Marionette TRACE 390 <- [1,6,null,{}]
15:58:56 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:56 INFO - 1498863536911 Marionette DEBUG Closed connection 390
15:58:56 INFO - 1498863536914 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49725
15:58:56 INFO - 1498863536919 Marionette DEBUG Closed connection 391
15:58:56 INFO - 1498863536922 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49726
15:58:56 INFO - 1498863536950 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:58:56 INFO - 1498863536954 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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}
15:58:57 INFO - 1498863537005 Marionette DEBUG Register listener.js for window 7
15:58:57 INFO - 1498863537022 Marionette TRACE 392 <- [1,1,null,{"sessionId":"3d0fc6ff-923e-4a68-840f-d225c76d7328","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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}}]
15:58:57 INFO - 1498863537029 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
15:58:57 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:57 INFO - 1498863537035 Marionette TRACE 392 <- [1,2,null,{}]
15:58:57 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:57 INFO - 1498863537233 Marionette DEBUG Closed connection 392
15:58:57 INFO - 1498863537236 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49727
15:58:57 INFO - 1498863537240 Marionette DEBUG Closed connection 393
15:58:57 INFO - 1498863537243 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49728
15:58:57 INFO - 1498863537267 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:58:57 INFO - 1498863537278 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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}
15:58:57 INFO - 1498863537306 Marionette DEBUG Register listener.js for window 7
15:58:57 INFO - 1498863537327 Marionette TRACE 394 <- [1,1,null,{"sessionId":"0c0c05be-dca3-4bc0-a358-99c2c25eb639","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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}}]
15:58:57 INFO - 1498863537345 Marionette TRACE 394 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
15:58:57 INFO - 1498863537351 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"
15:58:57 INFO - 1498863537362 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"
15:58:57 INFO - 1498863537366 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"
15:58:57 INFO - ++DOMWINDOW == 32 (000000A156605000) [pid = 4980] [serial = 45] [outer = 000000A15817D800]
15:58:57 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:57 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:57 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:57 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:57 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:57 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:57 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:57 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:57 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:57 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:57 INFO - 1498863537426 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
15:58:57 INFO - 1498863537433 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
15:58:57 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:57 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:57 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:57 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:57 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:57 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:57 INFO - 1498863537453 Marionette TRACE 394 <- [1,2,null,{}]
15:58:57 INFO - 1498863537469 Marionette TRACE 394 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
15:58:57 INFO - 1498863537481 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"d78d3d50-802c-41c0-a371-24a5b862b4b5","ELEMENT":"d78d3d50-802c-41c0-a371-24a5b862b4b5"}}]
15:58:57 INFO - 1498863537485 Marionette TRACE 394 -> [0,4,"clickElement",{"id":"d78d3d50-802c-41c0-a371-24a5b862b4b5"}]
15:58:57 INFO - 1498863537665 Marionette TRACE 394 <- [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]
15:58:57 INFO - 1498863537684 Marionette TRACE 394 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":328}]
15:58:57 INFO - TEST-END: test_click.py TestClick.test_input_file1498863537694 Marionette TRACE 394 <- [1,5,null,{"value":null}]
15:58:57 INFO - 1498863537698 Marionette TRACE 394 -> [0,6,"deleteSession",{}]
15:58:57 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:57 INFO - 1498863537705 Marionette TRACE 394 <- [1,6,null,{}]
15:58:57 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 1115ms
15:58:57 INFO - TEST-START | test_click.py TestClick.test_obscured_element
15:58:57 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:57 INFO - 1498863537765 Marionette DEBUG Closed connection 394
15:58:57 INFO - 1498863537768 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49729
15:58:57 INFO - 1498863537794 Marionette DEBUG Closed connection 395
15:58:57 INFO - 1498863537796 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49730
15:58:57 INFO - 1498863537801 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:58:57 INFO - 1498863537804 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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}
15:58:57 INFO - 1498863537832 Marionette DEBUG Register listener.js for window 7
15:58:57 INFO - 1498863537852 Marionette TRACE 396 <- [1,1,null,{"sessionId":"8bd73122-e625-4c8c-b875-4213ae947e8c","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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}}]
15:58:57 INFO - 1498863537857 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
15:58:57 INFO - 1498863537859 Marionette TRACE 396 <- [1,2,null,{}]
15:58:57 INFO - 1498863537864 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:58:57 INFO - 1498863537867 Marionette TRACE 396 <- [1,3,null,{}]
15:58:57 INFO - 1498863537875 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
15:58:57 INFO - 1498863537877 Marionette TRACE 396 <- [1,4,null,{}]
15:58:57 INFO - 1498863537891 Marionette TRACE 396 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":316}]
15:58:57 INFO - TEST-START: test_click.py TestClick.test_obscured_element1498863537904 Marionette TRACE 396 <- [1,5,null,{"value":null}]
15:58:57 INFO - --DOMWINDOW == 31 (000000A160497800) [pid = 4980] [serial = 30] [outer = 0000000000000000] [url = http://127.0.0.1:49292/test_accessibility.html]
15:58:57 INFO - --DOMWINDOW == 30 (000000A157B45800) [pid = 4980] [serial = 29] [outer = 0000000000000000] [url = http://127.0.0.1:49292/test_accessibility.html]
15:58:57 INFO - --DOMWINDOW == 29 (000000A1531D5800) [pid = 4980] [serial = 28] [outer = 0000000000000000] [url = http://127.0.0.1:49292/test_accessibility.html]
15:58:57 INFO - --DOMWINDOW == 28 (000000A1580C1800) [pid = 4980] [serial = 27] [outer = 0000000000000000] [url = http://127.0.0.1:49292/test_accessibility.html]
15:58:57 INFO - --DOMWINDOW == 27 (000000A15C756800) [pid = 4980] [serial = 26] [outer = 0000000000000000] [url = http://127.0.0.1:49292/test_accessibility.html]
15:58:57 INFO - --DOMWINDOW == 26 (000000A161BA7800) [pid = 4980] [serial = 33] [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]
15:58:57 INFO - --DOMWINDOW == 25 (000000A161967800) [pid = 4980] [serial = 32] [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]
15:58:57 INFO - --DOMWINDOW == 24 (000000A1609AF800) [pid = 4980] [serial = 31] [outer = 0000000000000000] [url = data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20position%3A%20absolute%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20/%2A%20move%20centre%20point%20off%20viewport%20%2A/%0A%20%20%20%20%20%20%20%20%20%20%20%20%20left%3A%20-105px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20top%3A%20-105px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E]
15:58:57 INFO - --DOMWINDOW == 23 (000000A158189800) [pid = 4980] [serial = 25] [outer = 0000000000000000] [url = http://127.0.0.1:49292/test_accessibility.html]
15:58:57 INFO - 1498863537913 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
15:58:57 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:57 INFO - 1498863537920 Marionette TRACE 396 <- [1,6,null,{}]
15:58:57 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:57 INFO - 1498863537946 Marionette DEBUG Closed connection 396
15:58:57 INFO - 1498863537948 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49731
15:58:57 INFO - 1498863537950 Marionette DEBUG Closed connection 397
15:58:57 INFO - 1498863537952 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49732
15:58:57 INFO - 1498863537954 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:58:57 INFO - 1498863537958 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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}
15:58:57 INFO - 1498863537983 Marionette DEBUG Register listener.js for window 7
15:58:58 INFO - 1498863537998 Marionette TRACE 398 <- [1,1,null,{"sessionId":"1f195df5-6777-4e41-b4d8-8851cb778c64","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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}}]
15:58:58 INFO - 1498863538004 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
15:58:58 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:58 INFO - 1498863538009 Marionette TRACE 398 <- [1,2,null,{}]
15:58:58 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:58 INFO - 1498863538015 Marionette DEBUG Closed connection 398
15:58:58 INFO - 1498863538017 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49733
15:58:58 INFO - 1498863538019 Marionette DEBUG Closed connection 399
15:58:58 INFO - 1498863538022 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49734
15:58:58 INFO - 1498863538024 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:58:58 INFO - 1498863538027 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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}
15:58:58 INFO - 1498863538053 Marionette DEBUG Register listener.js for window 7
15:58:58 INFO - 1498863538069 Marionette TRACE 400 <- [1,1,null,{"sessionId":"73b45edf-049f-47b1-b363-bf17849d0ce9","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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}}]
15:58:58 INFO - 1498863538071 Marionette TRACE 400 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"}]
15:58:58 INFO - 1498863538076 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
15:58:58 INFO - 1498863538085 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
15:58:58 INFO - 1498863538086 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
15:58:58 INFO - ++DOMWINDOW == 24 (000000A154153800) [pid = 4980] [serial = 46] [outer = 000000A15817D800]
15:58:58 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:58 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:58 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:58 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:58 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:58 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:58 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:58 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:58 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:58 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:58 INFO - 1498863538153 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"
15:58:58 INFO - 1498863538159 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"
15:58:58 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:58 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:58 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:58 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:58 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:58 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:58 INFO - 1498863538177 Marionette TRACE 400 <- [1,2,null,{}]
15:58:58 INFO - 1498863538179 Marionette TRACE 400 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
15:58:58 INFO - 1498863538190 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"0a7ddf23-a8ec-4423-83ff-d3e1512c0a47","ELEMENT":"0a7ddf23-a8ec-4423-83ff-d3e1512c0a47"}}]
15:58:58 INFO - 1498863538192 Marionette TRACE 400 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
15:58:58 INFO - 1498863538200 Marionette TRACE 400 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"c91bcc5f-ce8e-4d02-a59b-bb4104ebb488","ELEMENT":"c91bcc5f-ce8e-4d02-a59b-bb4104ebb488"}}]
15:58:58 INFO - 1498863538202 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"0a7ddf23-a8ec-4423-83ff-d3e1512c0a47"}]
15:58:58 INFO - 1498863538661 Marionette DEBUG Canceled page load listener because no navigation has been detected
15:58:58 INFO - 1498863538662 Marionette TRACE 400 <- [1,5,null,{}]
15:58:58 INFO - 1498863538665 Marionette TRACE 400 -> [0,6,"clickElement",{"id":"c91bcc5f-ce8e-4d02-a59b-bb4104ebb488"}]
15:58:58 INFO - 1498863538805 Marionette TRACE 400 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js: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]
15:58:58 INFO - 1498863538809 Marionette TRACE 400 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
15:58:58 INFO - 1498863538824 Marionette TRACE 400 <- [1,7,null,{"value":false}]
15:58:58 INFO - 1498863538827 Marionette TRACE 400 -> [0,8,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":328}]
15:58:58 INFO - TEST-END: test_click.py TestClick.test_obscured_element1498863538835 Marionette TRACE 400 <- [1,8,null,{"value":null}]
15:58:58 INFO - 1498863538837 Marionette TRACE 400 -> [0,9,"deleteSession",{}]
15:58:58 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:58 INFO - 1498863538842 Marionette TRACE 400 <- [1,9,null,{}]
15:58:58 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 1136ms
15:58:58 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
15:58:58 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:58 INFO - 1498863538848 Marionette DEBUG Closed connection 400
15:58:58 INFO - 1498863538850 Marionette DEBUG Accepted connection 401 from 127.0.0.1:49735
15:58:58 INFO - 1498863538852 Marionette DEBUG Closed connection 401
15:58:58 INFO - 1498863538854 Marionette DEBUG Accepted connection 402 from 127.0.0.1:49736
15:58:58 INFO - 1498863538856 Marionette TRACE 402 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:58:58 INFO - 1498863538858 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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}
15:58:58 INFO - 1498863538884 Marionette DEBUG Register listener.js for window 7
15:58:58 INFO - 1498863538900 Marionette TRACE 402 <- [1,1,null,{"sessionId":"210b9219-c78c-4712-8071-07f3f2433603","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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}}]
15:58:58 INFO - 1498863538903 Marionette TRACE 402 -> [0,2,"setTimeouts",{"script":30000}]
15:58:58 INFO - 1498863538905 Marionette TRACE 402 <- [1,2,null,{}]
15:58:58 INFO - 1498863538907 Marionette TRACE 402 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:58:58 INFO - 1498863538909 Marionette TRACE 402 <- [1,3,null,{}]
15:58:58 INFO - 1498863538911 Marionette TRACE 402 -> [0,4,"setTimeouts",{"implicit":0}]
15:58:58 INFO - 1498863538913 Marionette TRACE 402 <- [1,4,null,{}]
15:58:58 INFO - 1498863538915 Marionette TRACE 402 -> [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}]
15:58:58 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1498863538924 Marionette TRACE 402 <- [1,5,null,{"value":null}]
15:58:58 INFO - 1498863538926 Marionette TRACE 402 -> [0,6,"deleteSession",{}]
15:58:58 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:58 INFO - 1498863538930 Marionette TRACE 402 <- [1,6,null,{}]
15:58:58 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:58 INFO - 1498863538939 Marionette DEBUG Closed connection 402
15:58:58 INFO - 1498863538944 Marionette DEBUG Accepted connection 403 from 127.0.0.1:49737
15:58:58 INFO - 1498863538946 Marionette DEBUG Closed connection 403
15:58:58 INFO - 1498863538948 Marionette DEBUG Accepted connection 404 from 127.0.0.1:49738
15:58:58 INFO - 1498863538950 Marionette TRACE 404 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:58:58 INFO - 1498863538955 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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}
15:58:58 INFO - 1498863538981 Marionette DEBUG Register listener.js for window 7
15:58:59 INFO - 1498863538995 Marionette TRACE 404 <- [1,1,null,{"sessionId":"119bbe47-f429-49e1-8527-7274353d28fe","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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}}]
15:58:59 INFO - 1498863538998 Marionette TRACE 404 -> [0,2,"deleteSession",{}]
15:58:59 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:59 INFO - 1498863539003 Marionette TRACE 404 <- [1,2,null,{}]
15:58:59 INFO - [4980] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:58:59 INFO - 1498863539009 Marionette DEBUG Closed connection 404
15:58:59 INFO - 1498863539010 Marionette DEBUG Accepted connection 405 from 127.0.0.1:49739
15:58:59 INFO - 1498863539012 Marionette DEBUG Closed connection 405
15:58:59 INFO - 1498863539013 Marionette DEBUG Accepted connection 406 from 127.0.0.1:49740
15:58:59 INFO - 1498863539015 Marionette TRACE 406 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:58:59 INFO - 1498863539018 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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}
15:58:59 INFO - 1498863539043 Marionette DEBUG Register listener.js for window 7
15:58:59 INFO - 1498863539055 Marionette TRACE 406 <- [1,1,null,{"sessionId":"462222e4-b0f4-4f03-9a1c-a6ca42267da9","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":4980,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local\\Temp\\tmpkoubcw.mozrunner","moz:accessibilityChecks":false}}]
15:58:59 INFO - 1498863539058 Marionette TRACE 406 -> [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"}]
15:58:59 INFO - 1498863539062 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"
15:58:59 INFO - 1498863539069 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"
15:58:59 INFO - 1498863539070 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"
15:58:59 INFO - ++DOMWINDOW == 25 (000000A16057C000) [pid = 4980] [serial = 47] [outer = 000000A15817D800]
15:58:59 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:59 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:59 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:59 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:59 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:59 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:59 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:59 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:59 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:59 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:59 INFO - 1498863539128 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"
15:58:59 INFO - 1498863539135 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"
15:58:59 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:59 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:59 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:59 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/VectorImage.cpp, line 1032
15:58:59 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:59 INFO - [4980] WARNING: 'obs', file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/image/RasterImage.cpp, line 1402
15:58:59 INFO - 1498863539151 Marionette TRACE 406 <- [1,2,null,{}]
15:58:59 INFO - 1498863539155 Marionette TRACE 406 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
15:58:59 INFO - 1498863539162 Marionette TRACE 406 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e4d7d756-18fc-4218-b6d5-3edbfc94c33e","ELEMENT":"e4d7d756-18fc-4218-b6d5-3edbfc94c33e"}}]
15:58:59 INFO - 1498863539164 Marionette TRACE 406 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"e4d7d756-18fc-4218-b6d5-3edbfc94c33e"}]
15:58:59 INFO - 1498863539301 Marionette TRACE 406 <- [1,4,null,{"value":"none"}]
15:58:59 INFO - 1498863539303 Marionette TRACE 406 -> [0,5,"clickElement",{"id":"e4d7d756-18fc-4218-b6d5-3edbfc94c33e"}]
15:58:59 INFO - 1498863539452 Marionette TRACE 406 <- [1,5,{"error":"element click intercepted","message":"Element