[0,2672,"setScriptTimeout",{"ms":35000}]
00:39:16 INFO - PROCESS | 1768 | 1462347556343 Marionette TRACE conn2 <- [1,2672,null,{}]
00:39:16 INFO - PROCESS | 1768 | 1462347556345 Marionette TRACE conn2 -> [0,2673,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"executormarionette.py","script":"if (window.wrappedJSObject.win) {window.wrappedJSObject.win.close()}","sandbox":"default","line":398}]
00:39:16 INFO - PROCESS | 1768 | 1462347556469 Marionette TRACE conn2 <- [1,2673,null,{"value":null}]
00:39:16 INFO - PROCESS | 1768 | 1462347556756 Marionette TRACE conn2 -> [0,2674,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":false,"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distributed with this\n * file, You can obtain one at http://mozilla.org/MPL/2.0/. */\n\nwindow.wrappedJSObject.timeout_multiplier = 3;\nwindow.wrappedJSObject.explicit_timeout = 0;\n\nwindow.wrappedJSObject.addEventListener(\"message\", function listener(event) {\n if (event.data.type != \"complete\") {\n return;\n }\n window.wrappedJSObject.removeEventListener(\"message\", listener);\n clearTimeout(timer);\n var tests = event.data.tests;\n var status = event.data.status;\n\n var subtest_results = tests.map(function(x) {\n return [x.name, x.status, x.message, x.stack]\n });\n\n marionetteScriptFinished([\"/cssom-view/scrollingElement.html\",\n status.status,\n status.message,\n status.stack,\n subtest_results]);\n}, false);\n\nwindow.wrappedJSObject.win = window.open(\"http://web-platform.test:8000/cssom-view/scrollingElement.html\", \"2ced755f-84b6-4663-9dfa-fcbe7c8049e0\");\n\nvar timer = null;\nif (30000) {\n timer = setTimeout(function() {\n log(\"Timeout fired\");\n window.wrappedJSObject.win.timeout();\n }, 30000);\n}\n","newSandbox":false,"line":412,"args":[],"filename":"executormarionette.py"}]
00:39:16 INFO - PROCESS | 1768 | ++DOCSHELL 0x11b23a000 == 50 [pid = 1768] [id = 741]
00:39:16 INFO - PROCESS | 1768 | ++DOMWINDOW == 150 (0x114c85800) [pid = 1768] [serial = 2171] [outer = 0x0]
00:39:16 INFO - PROCESS | 1768 | ++DOMWINDOW == 151 (0x1150ea400) [pid = 1768] [serial = 2172] [outer = 0x114c85800]
00:39:16 INFO - PROCESS | 1768 | 1462347556821 Marionette DEBUG loaded listener.js
00:39:16 INFO - PROCESS | 1768 | ++DOMWINDOW == 152 (0x11ad0bc00) [pid = 1768] [serial = 2173] [outer = 0x114c85800]
00:39:17 INFO - PROCESS | 1768 | ++DOCSHELL 0x114f43800 == 51 [pid = 1768] [id = 742]
00:39:17 INFO - PROCESS | 1768 | ++DOMWINDOW == 153 (0x11a99e000) [pid = 1768] [serial = 2174] [outer = 0x0]
00:39:17 INFO - PROCESS | 1768 | ++DOCSHELL 0x115718800 == 52 [pid = 1768] [id = 743]
00:39:17 INFO - PROCESS | 1768 | ++DOMWINDOW == 154 (0x11b19dc00) [pid = 1768] [serial = 2175] [outer = 0x0]
00:39:17 INFO - PROCESS | 1768 | ++DOMWINDOW == 155 (0x115741800) [pid = 1768] [serial = 2176] [outer = 0x11a99e000]
00:39:17 INFO - PROCESS | 1768 | ++DOMWINDOW == 156 (0x11c010c00) [pid = 1768] [serial = 2177] [outer = 0x11b19dc00]
00:39:17 INFO - PROCESS | 1768 | ++DOMWINDOW == 157 (0x1136eec00) [pid = 1768] [serial = 2178] [outer = 0x11b19dc00]
00:39:17 INFO - PROCESS | 1768 | --DOCSHELL 0x131107800 == 51 [pid = 1768] [id = 727]
00:39:17 INFO - PROCESS | 1768 | --DOCSHELL 0x1302ca000 == 50 [pid = 1768] [id = 726]
00:39:17 INFO - PROCESS | 1768 | --DOCSHELL 0x12fcd4000 == 49 [pid = 1768] [id = 725]
00:39:17 INFO - PROCESS | 1768 | --DOCSHELL 0x12f82d000 == 48 [pid = 1768] [id = 724]
00:39:17 INFO - PROCESS | 1768 | --DOCSHELL 0x12edae800 == 47 [pid = 1768] [id = 723]
00:39:17 INFO - PROCESS | 1768 | --DOCSHELL 0x12e58c000 == 46 [pid = 1768] [id = 722]
00:39:17 INFO - PROCESS | 1768 | --DOMWINDOW == 156 (0x12a322400) [pid = 1768] [serial = 2101] [outer = 0x0] [url = about:blank]
00:39:17 INFO - PROCESS | 1768 | --DOMWINDOW == 155 (0x12650fc00) [pid = 1768] [serial = 2082] [outer = 0x0] [url = about:blank]
00:39:17 INFO - PROCESS | 1768 | --DOMWINDOW == 154 (0x126529800) [pid = 1768] [serial = 2083] [outer = 0x0] [url = about:blank]
00:39:17 INFO - PROCESS | 1768 | --DOMWINDOW == 153 (0x1235d2400) [pid = 1768] [serial = 2078] [outer = 0x0] [url = about:blank]
00:39:17 INFO - PROCESS | 1768 | --DOMWINDOW == 152 (0x12603d400) [pid = 1768] [serial = 2079] [outer = 0x0] [url = about:blank]
00:39:17 INFO - PROCESS | 1768 | --DOMWINDOW == 151 (0x11c37c400) [pid = 1768] [serial = 2076] [outer = 0x0] [url = https://web-platform.test:8443/testharness_runner.html]
00:39:17 INFO - PROCESS | 1768 | --DOMWINDOW == 150 (0x12603c800) [pid = 1768] [serial = 2080] [outer = 0x0] [url = http://web-platform.test:8000/testharness_runner.html]
00:39:17 INFO - PROCESS | 1768 | --DOCSHELL 0x1266c3000 == 45 [pid = 1768] [id = 721]
00:39:17 INFO - PROCESS | 1768 | --DOCSHELL 0x11890f000 == 44 [pid = 1768] [id = 720]
00:39:17 INFO - PROCESS | 1768 | --DOCSHELL 0x130b3d800 == 43 [pid = 1768] [id = 719]
00:39:17 INFO - PROCESS | 1768 | --DOCSHELL 0x12fcc5800 == 42 [pid = 1768] [id = 718]
00:39:17 INFO - PROCESS | 1768 | --DOCSHELL 0x1266c6800 == 41 [pid = 1768] [id = 717]
00:39:17 INFO - PROCESS | 1768 | --DOCSHELL 0x11b16b800 == 40 [pid = 1768] [id = 716]
00:39:17 INFO - PROCESS | 1768 | --DOMWINDOW == 149 (0x126a26800) [pid = 1768] [serial = 2086] [outer = 0x0] [url = about:blank]
00:39:17 INFO - PROCESS | 1768 | --DOMWINDOW == 148 (0x115103800) [pid = 1768] [serial = 2065] [outer = 0x0] [url = about:blank]
00:39:17 INFO - PROCESS | 1768 | --DOMWINDOW == 147 (0x115ae3400) [pid = 1768] [serial = 2066] [outer = 0x0] [url = about:blank]
00:39:17 INFO - PROCESS | 1768 | --DOMWINDOW == 146 (0x118b4bc00) [pid = 1768] [serial = 2068] [outer = 0x0] [url = http://web-platform.test:8000/content-security-policy/svg/scripted.svg]
00:39:17 INFO - PROCESS | 1768 | --DOMWINDOW == 145 (0x11510cc00) [pid = 1768] [serial = 2057] [outer = 0x0] [url = about:blank]
00:39:17 INFO - PROCESS | 1768 | --DOMWINDOW == 144 (0x118d77c00) [pid = 1768] [serial = 2060] [outer = 0x0] [url = data:image/svg+xml;charset=utf-8;base64,PD94bWwgdmVyc2lvbj0iMS4wIiBzdGFuZGFsb25lPSJubyI/Pg0KPCFET0NUWVBFIHN2ZyBQVUJMSUMgIi0vL1czQy8vRFREIFNWRyAxLjEvL0VOIg0KICAiaHR0cDovL3d3dy53My5vcmcvR3JhcGhpY3MvU1ZHLzEuMS9EVEQvc3ZnMTEuZHRkIj4NCjxzdmcgd2lkdGg9IjZjbSIgaGVpZ2h0PSI1Y20iIHZpZXdCb3g9IjAgMCA2MDAgNTAwIg0KICAgICB4bWxucz0iaHR0cDovL3d3dy53My5vcmcvMjAwMC9zdmciIHZlcnNpb249IjEuMSI+DQogIDxkZXNjPkV4YW1wbGUgc2NyaXB0MDEgLSByZWRpcmVjdDwvZGVzYz4NCg0KICA8c2NyaXB0IGlkPSJwb3N0bWVzc2FnZXNjcmlwdCIgdHlwZT0iYXBwbGljYXRpb24vZWNtYXNjcmlwdCI+IDwhW0NEQVRBWw0KICAgIGxvY2F0aW9uID0gIi9jb250ZW50LXNlY3VyaXR5LXBvbGljeS9ibGluay1jb250cmliL3Jlc291cmNlcy9wb3N0bWVzc2FnZS1mYWlsLmh0bWwiOw0KICBdXT4gPC9zY3JpcHQ+DQoNCiAgPGNpcmNsZSBjeD0iMzAwIiBjeT0iMjI1IiByPSIxMDAiIGZpbGw9Imxhd25ncmVlbiIvPg0KDQogIDx0ZXh0IHg9IjMwMCIgeT0iMjUwIg0KICAgICAgICBmb250LWZhbWlseT0iVmVyZGFuYSINCiAgICAgICAgZm9udC1zaXplPSI1MCINCiAgICAgICAgdGV4dC1hbmNob3I9Im1pZGRsZSI+DQogICAgICBQQVNTDQogICAgPC90ZXh0Pg0KPC9zdmc+]
00:39:17 INFO - PROCESS | 1768 | --DOMWINDOW == 143 (0x126037800) [pid = 1768] [serial = 2055] [outer = 0x0] [url = about:blank]
00:39:17 INFO - PROCESS | 1768 | --DOMWINDOW == 142 (0x119032000) [pid = 1768] [serial = 2062] [outer = 0x0] [url = about:blank]
00:39:17 INFO - PROCESS | 1768 | --DOMWINDOW == 141 (0x11b0e5000) [pid = 1768] [serial = 2075] [outer = 0x0] [url = http://web-platform.test:8000/content-security-policy/svg/scripted.svg]
00:39:17 INFO - PROCESS | 1768 | --DOMWINDOW == 140 (0x11bb3e400) [pid = 1768] [serial = 2074] [outer = 0x0] [url = http://web-platform.test:8000/content-security-policy/svg/scripted.svg]
00:39:17 INFO - PROCESS | 1768 | --DOMWINDOW == 139 (0x118d13c00) [pid = 1768] [serial = 2070] [outer = 0x0] [url = about:blank]
00:39:17 INFO - PROCESS | 1768 | --DOMWINDOW == 138 (0x1278d0800) [pid = 1768] [serial = 2090] [outer = 0x0] [url = about:blank]
00:39:17 INFO - PROCESS | 1768 | --DOMWINDOW == 137 (0x129735c00) [pid = 1768] [serial = 2094] [outer = 0x0] [url = about:blank]
00:39:17 INFO - PROCESS | 1768 | --DOMWINDOW == 136 (0x12a15dc00) [pid = 1768] [serial = 2097] [outer = 0x0] [url = about:blank]
00:39:17 INFO - PROCESS | 1768 | --DOMWINDOW == 135 (0x129b64800) [pid = 1768] [serial = 2095] [outer = 0x0] [url = about:blank]
00:39:17 INFO - PROCESS | 1768 | 1462347557470 Marionette TRACE conn2 <- [1,2674,null,{"value":["/cssom-view/scrollingElement.html",0,null,null,[["Tests for scrollingElement",0,null,null]]]}]
00:39:17 INFO - TEST-PASS | /cssom-view/scrollingElement.html | Tests for scrollingElement
00:39:17 INFO - TEST-OK | /cssom-view/scrollingElement.html | took 1174ms
00:39:17 INFO - PROCESS | 1768 | 1462347557517 Marionette TRACE conn2 -> [0,2675,"getWindowHandle",null]
00:39:17 INFO - PROCESS | 1768 | 1462347557518 Marionette TRACE conn2 <- [1,2675,null,{"value":"7"}]
00:39:17 INFO - TEST-START | /dom/collections/HTMLCollection-as-proto-length-get-throws.html
00:39:17 INFO - PROCESS | 1768 | 1462347557521 Marionette TRACE conn2 -> [0,2676,"setScriptTimeout",{"ms":35000}]
00:39:17 INFO - PROCESS | 1768 | 1462347557523 Marionette TRACE conn2 <- [1,2676,null,{}]
00:39:17 INFO - PROCESS | 1768 | 1462347557527 Marionette TRACE conn2 -> [0,2677,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"executormarionette.py","script":"if (window.wrappedJSObject.win) {window.wrappedJSObject.win.close()}","sandbox":"default","line":398}]
00:39:17 INFO - PROCESS | 1768 | 1462347557634 Marionette TRACE conn2 <- [1,2677,null,{"value":null}]
00:39:17 INFO - PROCESS | 1768 | 1462347557710 Marionette TRACE conn2 -> [0,2678,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":false,"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distributed with this\n * file, You can obtain one at http://mozilla.org/MPL/2.0/. */\n\nwindow.wrappedJSObject.timeout_multiplier = 3;\nwindow.wrappedJSObject.explicit_timeout = 0;\n\nwindow.wrappedJSObject.addEventListener(\"message\", function listener(event) {\n if (event.data.type != \"complete\") {\n return;\n }\n window.wrappedJSObject.removeEventListener(\"message\", listener);\n clearTimeout(timer);\n var tests = event.data.tests;\n var status = event.data.status;\n\n var subtest_results = tests.map(function(x) {\n return [x.name, x.status, x.message, x.stack]\n });\n\n marionetteScriptFinished([\"/dom/collections/HTMLCollection-as-proto-length-get-throws.html\",\n status.status,\n status.message,\n status.stack,\n subtest_results]);\n}, false);\n\nwindow.wrappedJSObject.win = window.open(\"http://web-platform.test:8000/dom/collections/HTMLCollection-as-proto-length-get-throws.html\", \"2ced755f-84b6-4663-9dfa-fcbe7c8049e0\");\n\nvar timer = null;\nif (30000) {\n timer = setTimeout(function() {\n log(\"Timeout fired\");\n window.wrappedJSObject.win.timeout();\n }, 30000);\n}\n","newSandbox":false,"line":412,"args":[],"filename":"executormarionette.py"}]
00:39:17 INFO - PROCESS | 1768 | ++DOCSHELL 0x11bd56000 == 41 [pid = 1768] [id = 744]
00:39:17 INFO - PROCESS | 1768 | ++DOMWINDOW == 136 (0x11948cc00) [pid = 1768] [serial = 2179] [outer = 0x0]
00:39:17 INFO - PROCESS | 1768 | ++DOMWINDOW == 137 (0x11ab8f400) [pid = 1768] [serial = 2180] [outer = 0x11948cc00]
00:39:17 INFO - PROCESS | 1768 | 1462347557738 Marionette DEBUG loaded listener.js
00:39:17 INFO - PROCESS | 1768 | ++DOMWINDOW == 138 (0x11bb3dc00) [pid = 1768] [serial = 2181] [outer = 0x11948cc00]
00:39:18 INFO - PROCESS | 1768 | 1462347558021 Marionette TRACE conn2 <- [1,2678,null,{"value":["/dom/collections/HTMLCollection-as-proto-length-get-throws.html",0,null,null,[["HTMLcollection as a prototype should not allow getting .length on the base object",0,null,null]]]}]
00:39:18 INFO - TEST-PASS | /dom/collections/HTMLCollection-as-proto-length-get-throws.html | HTMLcollection as a prototype should not allow getting .length on the base object
00:39:18 INFO - TEST-OK | /dom/collections/HTMLCollection-as-proto-length-get-throws.html | took 522ms
00:39:18 INFO - PROCESS | 1768 | 1462347558049 Marionette TRACE conn2 -> [0,2679,"getWindowHandle",null]
00:39:18 INFO - PROCESS | 1768 | 1462347558051 Marionette TRACE conn2 <- [1,2679,null,{"value":"7"}]
00:39:18 INFO - TEST-START | /dom/collections/HTMLCollection-empty-name.html
00:39:18 INFO - PROCESS | 1768 | 1462347558055 Marionette TRACE conn2 -> [0,2680,"setScriptTimeout",{"ms":35000}]
00:39:18 INFO - PROCESS | 1768 | 1462347558056 Marionette TRACE conn2 <- [1,2680,null,{}]
00:39:18 INFO - PROCESS | 1768 | 1462347558066 Marionette TRACE conn2 -> [0,2681,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"executormarionette.py","script":"if (window.wrappedJSObject.win) {window.wrappedJSObject.win.close()}","sandbox":"default","line":398}]
00:39:18 INFO - PROCESS | 1768 | 1462347558149 Marionette TRACE conn2 <- [1,2681,null,{"value":null}]
00:39:18 INFO - PROCESS | 1768 | 1462347558155 Marionette TRACE conn2 -> [0,2682,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":false,"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distributed with this\n * file, You can obtain one at http://mozilla.org/MPL/2.0/. */\n\nwindow.wrappedJSObject.timeout_multiplier = 3;\nwindow.wrappedJSObject.explicit_timeout = 0;\n\nwindow.wrappedJSObject.addEventListener(\"message\", function listener(event) {\n if (event.data.type != \"complete\") {\n return;\n }\n window.wrappedJSObject.removeEventListener(\"message\", listener);\n clearTimeout(timer);\n var tests = event.data.tests;\n var status = event.data.status;\n\n var subtest_results = tests.map(function(x) {\n return [x.name, x.status, x.message, x.stack]\n });\n\n marionetteScriptFinished([\"/dom/collections/HTMLCollection-empty-name.html\",\n status.status,\n status.message,\n status.stack,\n subtest_results]);\n}, false);\n\nwindow.wrappedJSObject.win = window.open(\"http://web-platform.test:8000/dom/collections/HTMLCollection-empty-name.html\", \"2ced755f-84b6-4663-9dfa-fcbe7c8049e0\");\n\nvar timer = null;\nif (30000) {\n timer = setTimeout(function() {\n log(\"Timeout fired\");\n window.wrappedJSObject.win.timeout();\n }, 30000);\n}\n","newSandbox":false,"line":412,"args":[],"filename":"executormarionette.py"}]
00:39:18 INFO - PROCESS | 1768 | ++DOCSHELL 0x12bf14000 == 42 [pid = 1768] [id = 745]
00:39:18 INFO - PROCESS | 1768 | ++DOMWINDOW == 139 (0x11c11b400) [pid = 1768] [serial = 2182] [outer = 0x0]
00:39:18 INFO - PROCESS | 1768 | ++DOMWINDOW == 140 (0x1235dd400) [pid = 1768] [serial = 2183] [outer = 0x11c11b400]
00:39:18 INFO - PROCESS | 1768 | 1462347558184 Marionette DEBUG loaded listener.js
00:39:18 INFO - PROCESS | 1768 | ++DOMWINDOW == 141 (0x126435c00) [pid = 1768] [serial = 2184] [outer = 0x11c11b400]
00:39:18 INFO - PROCESS | 1768 | 1462347558500 Marionette TRACE conn2 <- [1,2682,null,{"value":["/dom/collections/HTMLCollection-empty-name.html",0,null,null,[["Empty string as a name for Document.getElementsByTagName",0,null,null],["Empty string as a name for Element.getElementsByTagName",0,null,null],["Empty string as a name for Document.getElementsByTagNameNS",0,null,null],["Empty string as a name for Element.getElementsByTagNameNS",0,null,null],["Empty string as a name for Document.getElementsByClassName",0,null,null],["Empty string as a name for Element.getElementsByClassName",0,null,null],["Empty string as a name for Element.children",0,null,null]]]}]
00:39:18 INFO - TEST-PASS | /dom/collections/HTMLCollection-empty-name.html | Empty string as a name for Document.getElementsByTagName
00:39:18 INFO - TEST-PASS | /dom/collections/HTMLCollection-empty-name.html | Empty string as a name for Element.getElementsByTagName
00:39:18 INFO - TEST-PASS | /dom/collections/HTMLCollection-empty-name.html | Empty string as a name for Document.getElementsByTagNameNS
00:39:18 INFO - TEST-PASS | /dom/collections/HTMLCollection-empty-name.html | Empty string as a name for Element.getElementsByTagNameNS
00:39:18 INFO - TEST-PASS | /dom/collections/HTMLCollection-empty-name.html | Empty string as a name for Document.getElementsByClassName
00:39:18 INFO - TEST-PASS | /dom/collections/HTMLCollection-empty-name.html | Empty string as a name for Element.getElementsByClassName
00:39:18 INFO - TEST-PASS | /dom/collections/HTMLCollection-empty-name.html | Empty string as a name for Element.children
00:39:18 INFO - TEST-OK | /dom/collections/HTMLCollection-empty-name.html | took 474ms
00:39:18 INFO - TEST-START | /dom/collections/HTMLCollection-supported-property-indices.html
00:39:18 INFO - PROCESS | 1768 | 1462347558532 Marionette TRACE conn2 -> [0,2683,"getWindowHandle",null]
00:39:18 INFO - PROCESS | 1768 | 1462347558534 Marionette TRACE conn2 <- [1,2683,null,{"value":"7"}]
00:39:18 INFO - PROCESS | 1768 | 1462347558537 Marionette TRACE conn2 -> [0,2684,"setScriptTimeout",{"ms":35000}]
00:39:18 INFO - PROCESS | 1768 | 1462347558542 Marionette TRACE conn2 <- [1,2684,null,{}]
00:39:18 INFO - PROCESS | 1768 | 1462347558549 Marionette TRACE conn2 -> [0,2685,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"executormarionette.py","script":"if (window.wrappedJSObject.win) {window.wrappedJSObject.win.close()}","sandbox":"default","line":398}]
00:39:18 INFO - PROCESS | 1768 | 1462347558639 Marionette TRACE conn2 <- [1,2685,null,{"value":null}]
00:39:18 INFO - PROCESS | 1768 | 1462347558650 Marionette TRACE conn2 -> [0,2686,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":false,"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distributed with this\n * file, You can obtain one at http://mozilla.org/MPL/2.0/. */\n\nwindow.wrappedJSObject.timeout_multiplier = 3;\nwindow.wrappedJSObject.explicit_timeout = 0;\n\nwindow.wrappedJSObject.addEventListener(\"message\", function listener(event) {\n if (event.data.type != \"complete\") {\n return;\n }\n window.wrappedJSObject.removeEventListener(\"message\", listener);\n clearTimeout(timer);\n var tests = event.data.tests;\n var status = event.data.status;\n\n var subtest_results = tests.map(function(x) {\n return [x.name, x.status, x.message, x.stack]\n });\n\n marionetteScriptFinished([\"/dom/collections/HTMLCollection-supported-property-indices.html\",\n status.status,\n status.message,\n status.stack,\n subtest_results]);\n}, false);\n\nwindow.wrappedJSObject.win = window.open(\"http://web-platform.test:8000/dom/collections/HTMLCollection-supported-property-indices.html\", \"2ced755f-84b6-4663-9dfa-fcbe7c8049e0\");\n\nvar timer = null;\nif (30000) {\n timer = setTimeout(function() {\n log(\"Timeout fired\");\n window.wrappedJSObject.win.timeout();\n }, 30000);\n}\n","newSandbox":false,"line":412,"args":[],"filename":"executormarionette.py"}]
00:39:18 INFO - PROCESS | 1768 | ++DOCSHELL 0x12ed1f800 == 43 [pid = 1768] [id = 746]
00:39:18 INFO - PROCESS | 1768 | ++DOMWINDOW == 142 (0x12650f000) [pid = 1768] [serial = 2185] [outer = 0x0]
00:39:18 INFO - PROCESS | 1768 | ++DOMWINDOW == 143 (0x126890000) [pid = 1768] [serial = 2186] [outer = 0x12650f000]
00:39:18 INFO - PROCESS | 1768 | 1462347558691 Marionette DEBUG loaded listener.js
00:39:18 INFO - PROCESS | 1768 | ++DOMWINDOW == 144 (0x129735c00) [pid = 1768] [serial = 2187] [outer = 0x12650f000]
00:39:19 INFO - PROCESS | 1768 | 1462347559131 Marionette TRACE conn2 <- [1,2686,null,{"value":["/dom/collections/HTMLCollection-supported-property-indices.html",0,null,null,[["Handling of property names that look like negative integers",0,null,null],["Handling of property names that look like small nonnegative integers",0,null,null],["Handling of property names that look like integers around 2^31",0,null,null],["Handling of property names that look like integers around 2^32",0,null,null]]]}]
00:39:19 INFO - TEST-PASS | /dom/collections/HTMLCollection-supported-property-indices.html | Handling of property names that look like negative integers
00:39:19 INFO - TEST-PASS | /dom/collections/HTMLCollection-supported-property-indices.html | Handling of property names that look like small nonnegative integers
00:39:19 INFO - TEST-PASS | /dom/collections/HTMLCollection-supported-property-indices.html | Handling of property names that look like integers around 2^31
00:39:19 INFO - TEST-PASS | /dom/collections/HTMLCollection-supported-property-indices.html | Handling of property names that look like integers around 2^32
00:39:19 INFO - TEST-OK | /dom/collections/HTMLCollection-supported-property-indices.html | took 625ms
00:39:19 INFO - PROCESS | 1768 | 1462347559174 Marionette TRACE conn2 -> [0,2687,"getWindowHandle",null]
00:39:19 INFO - PROCESS | 1768 | 1462347559176 Marionette TRACE conn2 <- [1,2687,null,{"value":"7"}]
00:39:19 INFO - TEST-START | /dom/collections/HTMLCollection-supported-property-names.html
00:39:19 INFO - PROCESS | 1768 | 1462347559179 Marionette TRACE conn2 -> [0,2688,"setScriptTimeout",{"ms":35000}]
00:39:19 INFO - PROCESS | 1768 | 1462347559180 Marionette TRACE conn2 <- [1,2688,null,{}]
00:39:19 INFO - PROCESS | 1768 | 1462347559182 Marionette TRACE conn2 -> [0,2689,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"executormarionette.py","script":"if (window.wrappedJSObject.win) {window.wrappedJSObject.win.close()}","sandbox":"default","line":398}]
00:39:19 INFO - PROCESS | 1768 | 1462347559257 Marionette TRACE conn2 <- [1,2689,null,{"value":null}]
00:39:19 INFO - PROCESS | 1768 | 1462347559264 Marionette TRACE conn2 -> [0,2690,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":false,"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distributed with this\n * file, You can obtain one at http://mozilla.org/MPL/2.0/. */\n\nwindow.wrappedJSObject.timeout_multiplier = 3;\nwindow.wrappedJSObject.explicit_timeout = 0;\n\nwindow.wrappedJSObject.addEventListener(\"message\", function listener(event) {\n if (event.data.type != \"complete\") {\n return;\n }\n window.wrappedJSObject.removeEventListener(\"message\", listener);\n clearTimeout(timer);\n var tests = event.data.tests;\n var status = event.data.status;\n\n var subtest_results = tests.map(function(x) {\n return [x.name, x.status, x.message, x.stack]\n });\n\n marionetteScriptFinished([\"/dom/collections/HTMLCollection-supported-property-names.html\",\n status.status,\n status.message,\n status.stack,\n subtest_results]);\n}, false);\n\nwindow.wrappedJSObject.win = window.open(\"http://web-platform.test:8000/dom/collections/HTMLCollection-supported-property-names.html\", \"2ced755f-84b6-4663-9dfa-fcbe7c8049e0\");\n\nvar timer = null;\nif (30000) {\n timer = setTimeout(function() {\n log(\"Timeout fired\");\n window.wrappedJSObject.win.timeout();\n }, 30000);\n}\n","newSandbox":false,"line":412,"args":[],"filename":"executormarionette.py"}]
00:39:19 INFO - PROCESS | 1768 | ++DOCSHELL 0x11a049000 == 44 [pid = 1768] [id = 747]
00:39:19 INFO - PROCESS | 1768 | ++DOMWINDOW == 145 (0x129e68000) [pid = 1768] [serial = 2188] [outer = 0x0]
00:39:19 INFO - PROCESS | 1768 | ++DOMWINDOW == 146 (0x12b374800) [pid = 1768] [serial = 2189] [outer = 0x129e68000]
00:39:19 INFO - PROCESS | 1768 | 1462347559290 Marionette DEBUG loaded listener.js
00:39:19 INFO - PROCESS | 1768 | ++DOMWINDOW == 147 (0x12ba0cc00) [pid = 1768] [serial = 2190] [outer = 0x129e68000]
00:39:19 INFO - PROCESS | 1768 | 1462347559617 Marionette TRACE conn2 <- [1,2690,null,{"value":["/dom/collections/HTMLCollection-supported-property-names.html",0,null,null,[["Object.getOwnPropertyNames on HTMLCollection",0,null,null],["Object.getOwnPropertyNames on HTMLCollection with non-HTML namespace",0,null,null],["Object.getOwnPropertyNames on HTMLCollection with expando object",0,null,null]]]}]
00:39:19 INFO - TEST-PASS | /dom/collections/HTMLCollection-supported-property-names.html | Object.getOwnPropertyNames on HTMLCollection
00:39:19 INFO - TEST-PASS | /dom/collections/HTMLCollection-supported-property-names.html | Object.getOwnPropertyNames on HTMLCollection with non-HTML namespace
00:39:19 INFO - TEST-PASS | /dom/collections/HTMLCollection-supported-property-names.html | Object.getOwnPropertyNames on HTMLCollection with expando object
00:39:19 INFO - TEST-OK | /dom/collections/HTMLCollection-supported-property-names.html | took 468ms
00:39:19 INFO - PROCESS | 1768 | 1462347559655 Marionette TRACE conn2 -> [0,2691,"getWindowHandle",null]
00:39:19 INFO - PROCESS | 1768 | 1462347559656 Marionette TRACE conn2 <- [1,2691,null,{"value":"7"}]
00:39:19 INFO - TEST-START | /dom/collections/domstringmap-supported-property-names.html
00:39:19 INFO - PROCESS | 1768 | 1462347559658 Marionette TRACE conn2 -> [0,2692,"setScriptTimeout",{"ms":35000}]
00:39:19 INFO - PROCESS | 1768 | 1462347559660 Marionette TRACE conn2 <- [1,2692,null,{}]
00:39:19 INFO - PROCESS | 1768 | 1462347559662 Marionette TRACE conn2 -> [0,2693,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"executormarionette.py","script":"if (window.wrappedJSObject.win) {window.wrappedJSObject.win.close()}","sandbox":"default","line":398}]
00:39:19 INFO - PROCESS | 1768 | 1462347559762 Marionette TRACE conn2 <- [1,2693,null,{"value":null}]
00:39:19 INFO - PROCESS | 1768 | 1462347559766 Marionette TRACE conn2 -> [0,2694,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":false,"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distributed with this\n * file, You can obtain one at http://mozilla.org/MPL/2.0/. */\n\nwindow.wrappedJSObject.timeout_multiplier = 3;\nwindow.wrappedJSObject.explicit_timeout = 0;\n\nwindow.wrappedJSObject.addEventListener(\"message\", function listener(event) {\n if (event.data.type != \"complete\") {\n return;\n }\n window.wrappedJSObject.removeEventListener(\"message\", listener);\n clearTimeout(timer);\n var tests = event.data.tests;\n var status = event.data.status;\n\n var subtest_results = tests.map(function(x) {\n return [x.name, x.status, x.message, x.stack]\n });\n\n marionetteScriptFinished([\"/dom/collections/domstringmap-supported-property-names.html\",\n status.status,\n status.message,\n status.stack,\n subtest_results]);\n}, false);\n\nwindow.wrappedJSObject.win = window.open(\"http://web-platform.test:8000/dom/collections/domstringmap-supported-property-names.html\", \"2ced755f-84b6-4663-9dfa-fcbe7c8049e0\");\n\nvar timer = null;\nif (30000) {\n timer = setTimeout(function() {\n log(\"Timeout fired\");\n window.wrappedJSObject.win.timeout();\n }, 30000);\n}\n","newSandbox":false,"line":412,"args":[],"filename":"executormarionette.py"}]
00:39:19 INFO - PROCESS | 1768 | ++DOCSHELL 0x13096f000 == 45 [pid = 1768] [id = 748]
00:39:19 INFO - PROCESS | 1768 | ++DOMWINDOW == 148 (0x12ba80000) [pid = 1768] [serial = 2191] [outer = 0x0]
00:39:19 INFO - PROCESS | 1768 | ++DOMWINDOW == 149 (0x12bbd1000) [pid = 1768] [serial = 2192] [outer = 0x12ba80000]
00:39:19 INFO - PROCESS | 1768 | 1462347559830 Marionette DEBUG loaded listener.js
00:39:19 INFO - PROCESS | 1768 | ++DOMWINDOW == 150 (0x12bf29400) [pid = 1768] [serial = 2193] [outer = 0x12ba80000]
00:39:20 INFO - PROCESS | 1768 | 1462347560187 Marionette TRACE conn2 <- [1,2694,null,{"value":["/dom/collections/domstringmap-supported-property-names.html",0,null,null,[["Object.getOwnPropertyNames on DOMStringMap, empty data attribute",0,null,null],["Object.getOwnPropertyNames on DOMStringMap, data attribute trailing hyphen",0,null,null],["Object.getOwnPropertyNames on DOMStringMap, multiple data attributes",0,null,null],["Object.getOwnPropertyNames on DOMStringMap, attribute set on dataset in JS",0,null,null],["Object.getOwnPropertyNames on DOMStringMap, attribute set on element in JS",0,null,null]]]}]
00:39:20 INFO - TEST-PASS | /dom/collections/domstringmap-supported-property-names.html | Object.getOwnPropertyNames on DOMStringMap, empty data attribute
00:39:20 INFO - TEST-PASS | /dom/collections/domstringmap-supported-property-names.html | Object.getOwnPropertyNames on DOMStringMap, data attribute trailing hyphen
00:39:20 INFO - TEST-PASS | /dom/collections/domstringmap-supported-property-names.html | Object.getOwnPropertyNames on DOMStringMap, multiple data attributes
00:39:20 INFO - TEST-PASS | /dom/collections/domstringmap-supported-property-names.html | Object.getOwnPropertyNames on DOMStringMap, attribute set on dataset in JS
00:39:20 INFO - TEST-PASS | /dom/collections/domstringmap-supported-property-names.html | Object.getOwnPropertyNames on DOMStringMap, attribute set on element in JS
00:39:20 INFO - TEST-OK | /dom/collections/domstringmap-supported-property-names.html | took 570ms
00:39:20 INFO - PROCESS | 1768 | 1462347560234 Marionette TRACE conn2 -> [0,2695,"getWindowHandle",null]
00:39:20 INFO - PROCESS | 1768 | 1462347560236 Marionette TRACE conn2 <- [1,2695,null,{"value":"7"}]
00:39:20 INFO - TEST-START | /dom/collections/namednodemap-supported-property-names.html
00:39:20 INFO - PROCESS | 1768 | 1462347560240 Marionette TRACE conn2 -> [0,2696,"setScriptTimeout",{"ms":35000}]
00:39:20 INFO - PROCESS | 1768 | 1462347560241 Marionette TRACE conn2 <- [1,2696,null,{}]
00:39:20 INFO - PROCESS | 1768 | 1462347560245 Marionette TRACE conn2 -> [0,2697,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"executormarionette.py","script":"if (window.wrappedJSObject.win) {window.wrappedJSObject.win.close()}","sandbox":"default","line":398}]
00:39:20 INFO - PROCESS | 1768 | 1462347560409 Marionette TRACE conn2 <- [1,2697,null,{"value":null}]
00:39:20 INFO - PROCESS | 1768 | 1462347560432 Marionette TRACE conn2 -> [0,2698,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":false,"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distributed with this\n * file, You can obtain one at http://mozilla.org/MPL/2.0/. */\n\nwindow.wrappedJSObject.timeout_multiplier = 3;\nwindow.wrappedJSObject.explicit_timeout = 0;\n\nwindow.wrappedJSObject.addEventListener(\"message\", function listener(event) {\n if (event.data.type != \"complete\") {\n return;\n }\n window.wrappedJSObject.removeEventListener(\"message\", listener);\n clearTimeout(timer);\n var tests = event.data.tests;\n var status = event.data.status;\n\n var subtest_results = tests.map(function(x) {\n return [x.name, x.status, x.message, x.stack]\n });\n\n marionetteScriptFinished([\"/dom/collections/namednodemap-supported-property-names.html\",\n status.status,\n status.message,\n status.stack,\n subtest_results]);\n}, false);\n\nwindow.wrappedJSObject.win = window.open(\"http://web-platform.test:8000/dom/collections/namednodemap-supported-property-names.html\", \"2ced755f-84b6-4663-9dfa-fcbe7c8049e0\");\n\nvar timer = null;\nif (30000) {\n timer = setTimeout(function() {\n log(\"Timeout fired\");\n window.wrappedJSObject.win.timeout();\n }, 30000);\n}\n","newSandbox":false,"line":412,"args":[],"filename":"executormarionette.py"}]
00:39:20 INFO - PROCESS | 1768 | ++DOCSHELL 0x13a213000 == 46 [pid = 1768] [id = 749]
00:39:20 INFO - PROCESS | 1768 | ++DOMWINDOW == 151 (0x12bf2d800) [pid = 1768] [serial = 2194] [outer = 0x0]
00:39:20 INFO - PROCESS | 1768 | ++DOMWINDOW == 152 (0x12c16dc00) [pid = 1768] [serial = 2195] [outer = 0x12bf2d800]
00:39:20 INFO - PROCESS | 1768 | 1462347560473 Marionette DEBUG loaded listener.js
00:39:20 INFO - PROCESS | 1768 | ++DOMWINDOW == 153 (0x12c25cc00) [pid = 1768] [serial = 2196] [outer = 0x12bf2d800]
00:39:20 INFO - PROCESS | 1768 | 1462347560817 Marionette TRACE conn2 <- [1,2698,null,{"value":["/dom/collections/namednodemap-supported-property-names.html",0,null,null,[["Object.getOwnPropertyNames on NamedNodeMap",0,null,null],["Object.getOwnPropertyNames on NamedNodeMap of input",1,"assert_array_equals: property 5, expected \"type\" but got \"value\"","@http://web-platform.test:8000/dom/collections/namednodemap-supported-property-names.html:19:5\nTest.prototype.step@http://web-platform.test:8000/resources/testharness.js:1382:20\ntest@http://web-platform.test:8000/resources/testharness.js:496:9\n@http://web-platform.test:8000/dom/collections/namednodemap-supported-property-names.html:17:1\n"],["Object.getOwnPropertyNames on NamedNodeMap after attribute removal",1,"assert_array_equals: property 4, expected \"type\" but got \"value\"","@http://web-platform.test:8000/dom/collections/namednodemap-supported-property-names.html:26:5\nTest.prototype.step@http://web-platform.test:8000/resources/testharness.js:1382:20\ntest@http://web-platform.test:8000/resources/testharness.js:496:9\n@http://web-platform.test:8000/dom/collections/namednodemap-supported-property-names.html:23:1\n"]]]}]
00:39:20 INFO - TEST-PASS | /dom/collections/namednodemap-supported-property-names.html | Object.getOwnPropertyNames on NamedNodeMap
00:39:20 INFO - TEST-FAIL | /dom/collections/namednodemap-supported-property-names.html | Object.getOwnPropertyNames on NamedNodeMap of input - assert_array_equals: property 5, expected "type" but got "value"
00:39:20 INFO - @http://web-platform.test:8000/dom/collections/namednodemap-supported-property-names.html:19:5
00:39:20 INFO - Test.prototype.step@http://web-platform.test:8000/resources/testharness.js:1382:20
00:39:20 INFO - test@http://web-platform.test:8000/resources/testharness.js:496:9
00:39:20 INFO - @http://web-platform.test:8000/dom/collections/namednodemap-supported-property-names.html:17:1
00:39:20 INFO - TEST-FAIL | /dom/collections/namednodemap-supported-property-names.html | Object.getOwnPropertyNames on NamedNodeMap after attribute removal - assert_array_equals: property 4, expected "type" but got "value"
00:39:20 INFO - @http://web-platform.test:8000/dom/collections/namednodemap-supported-property-names.html:26:5
00:39:20 INFO - Test.prototype.step@http://web-platform.test:8000/resources/testharness.js:1382:20
00:39:20 INFO - test@http://web-platform.test:8000/resources/testharness.js:496:9
00:39:20 INFO - @http://web-platform.test:8000/dom/collections/namednodemap-supported-property-names.html:23:1
00:39:20 INFO - TEST-OK | /dom/collections/namednodemap-supported-property-names.html | took 621ms
00:39:20 INFO - PROCESS | 1768 | 1462347560862 Marionette TRACE conn2 -> [0,2699,"getWindowHandle",null]
00:39:20 INFO - PROCESS | 1768 | 1462347560863 Marionette TRACE conn2 <- [1,2699,null,{"value":"7"}]
00:39:20 INFO - TEST-START | /dom/events/Event-constants.html
00:39:20 INFO - PROCESS | 1768 | 1462347560865 Marionette TRACE conn2 -> [0,2700,"setScriptTimeout",{"ms":35000}]
00:39:20 INFO - PROCESS | 1768 | 1462347560866 Marionette TRACE conn2 <- [1,2700,null,{}]
00:39:20 INFO - PROCESS | 1768 | 1462347560869 Marionette TRACE conn2 -> [0,2701,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"executormarionette.py","script":"if (window.wrappedJSObject.win) {window.wrappedJSObject.win.close()}","sandbox":"default","line":398}]
00:39:20 INFO - PROCESS | 1768 | 1462347560966 Marionette TRACE conn2 <- [1,2701,null,{"value":null}]
00:39:20 INFO - PROCESS | 1768 | 1462347560979 Marionette TRACE conn2 -> [0,2702,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":false,"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distributed with this\n * file, You can obtain one at http://mozilla.org/MPL/2.0/. */\n\nwindow.wrappedJSObject.timeout_multiplier = 3;\nwindow.wrappedJSObject.explicit_timeout = 0;\n\nwindow.wrappedJSObject.addEventListener(\"message\", function listener(event) {\n if (event.data.type != \"complete\") {\n return;\n }\n window.wrappedJSObject.removeEventListener(\"message\", listener);\n clearTimeout(timer);\n var tests = event.data.tests;\n var status = event.data.status;\n\n var subtest_results = tests.map(function(x) {\n return [x.name, x.status, x.message, x.stack]\n });\n\n marionetteScriptFinished([\"/dom/events/Event-constants.html\",\n status.status,\n status.message,\n status.stack,\n subtest_results]);\n}, false);\n\nwindow.wrappedJSObject.win = window.open(\"http://web-platform.test:8000/dom/events/Event-constants.html\", \"2ced755f-84b6-4663-9dfa-fcbe7c8049e0\");\n\nvar timer = null;\nif (30000) {\n timer = setTimeout(function() {\n log(\"Timeout fired\");\n window.wrappedJSObject.win.timeout();\n }, 30000);\n}\n","newSandbox":false,"line":412,"args":[],"filename":"executormarionette.py"}]
00:39:20 INFO - PROCESS | 1768 | ++DOCSHELL 0x13a807000 == 47 [pid = 1768] [id = 750]
00:39:20 INFO - PROCESS | 1768 | ++DOMWINDOW == 154 (0x12c212400) [pid = 1768] [serial = 2197] [outer = 0x0]
00:39:21 INFO - PROCESS | 1768 | ++DOMWINDOW == 155 (0x12c84b800) [pid = 1768] [serial = 2198] [outer = 0x12c212400]
00:39:21 INFO - PROCESS | 1768 | 1462347561003 Marionette DEBUG loaded listener.js
00:39:21 INFO - PROCESS | 1768 | ++DOMWINDOW == 156 (0x12c8de000) [pid = 1768] [serial = 2199] [outer = 0x12c212400]
00:39:21 INFO - PROCESS | 1768 | 1462347561307 Marionette TRACE conn2 <- [1,2702,null,{"value":["/dom/events/Event-constants.html",0,null,null,[["Constants for eventPhase on Event interface object.",0,null,null],["Constants for eventPhase on Event prototype object.",0,null,null],["Constants for eventPhase on Event object.",0,null,null],["Constants for eventPhase on CustomEvent object.",0,null,null]]]}]
00:39:21 INFO - TEST-PASS | /dom/events/Event-constants.html | Constants for eventPhase on Event interface object.
00:39:21 INFO - TEST-PASS | /dom/events/Event-constants.html | Constants for eventPhase on Event prototype object.
00:39:21 INFO - TEST-PASS | /dom/events/Event-constants.html | Constants for eventPhase on Event object.
00:39:21 INFO - TEST-PASS | /dom/events/Event-constants.html | Constants for eventPhase on CustomEvent object.
00:39:21 INFO - TEST-OK | /dom/events/Event-constants.html | took 469ms
00:39:21 INFO - PROCESS | 1768 | 1462347561335 Marionette TRACE conn2 -> [0,2703,"getWindowHandle",null]
00:39:21 INFO - PROCESS | 1768 | 1462347561336 Marionette TRACE conn2 <- [1,2703,null,{"value":"7"}]
00:39:21 INFO - TEST-START | /dom/events/Event-constructors.html
00:39:21 INFO - PROCESS | 1768 | 1462347561339 Marionette TRACE conn2 -> [0,2704,"setScriptTimeout",{"ms":35000}]
00:39:21 INFO - PROCESS | 1768 | 1462347561340 Marionette TRACE conn2 <- [1,2704,null,{}]
00:39:21 INFO - PROCESS | 1768 | 1462347561345 Marionette TRACE conn2 -> [0,2705,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"executormarionette.py","script":"if (window.wrappedJSObject.win) {window.wrappedJSObject.win.close()}","sandbox":"default","line":398}]
00:39:21 INFO - PROCESS | 1768 | 1462347561440 Marionette TRACE conn2 <- [1,2705,null,{"value":null}]
00:39:21 INFO - PROCESS | 1768 | 1462347561454 Marionette TRACE conn2 -> [0,2706,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":false,"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distributed with this\n * file, You can obtain one at http://mozilla.org/MPL/2.0/. */\n\nwindow.wrappedJSObject.timeout_multiplier = 3;\nwindow.wrappedJSObject.explicit_timeout = 0;\n\nwindow.wrappedJSObject.addEventListener(\"message\", function listener(event) {\n if (event.data.type != \"complete\") {\n return;\n }\n window.wrappedJSObject.removeEventListener(\"message\", listener);\n clearTimeout(timer);\n var tests = event.data.tests;\n var status = event.data.status;\n\n var subtest_results = tests.map(function(x) {\n return [x.name, x.status, x.message, x.stack]\n });\n\n marionetteScriptFinished([\"/dom/events/Event-constructors.html\",\n status.status,\n status.message,\n status.stack,\n subtest_results]);\n}, false);\n\nwindow.wrappedJSObject.win = window.open(\"http://web-platform.test:8000/dom/events/Event-constructors.html\", \"2ced755f-84b6-4663-9dfa-fcbe7c8049e0\");\n\nvar timer = null;\nif (30000) {\n timer = setTimeout(function() {\n log(\"Timeout fired\");\n window.wrappedJSObject.win.timeout();\n }, 30000);\n}\n","newSandbox":false,"line":412,"args":[],"filename":"executormarionette.py"}]
00:39:21 INFO - PROCESS | 1768 | ++DOCSHELL 0x12b387000 == 48 [pid = 1768] [id = 751]
00:39:21 INFO - PROCESS | 1768 | ++DOMWINDOW == 157 (0x12c8e0400) [pid = 1768] [serial = 2200] [outer = 0x0]
00:39:21 INFO - PROCESS | 1768 | ++DOMWINDOW == 158 (0x12cc37800) [pid = 1768] [serial = 2201] [outer = 0x12c8e0400]
00:39:21 INFO - PROCESS | 1768 | 1462347561480 Marionette DEBUG loaded listener.js
00:39:21 INFO - PROCESS | 1768 | ++DOMWINDOW == 159 (0x12cc98c00) [pid = 1768] [serial = 2202] [outer = 0x12c8e0400]
00:39:21 INFO - PROCESS | 1768 | --DOMWINDOW == 158 (0x12a31e400) [pid = 1768] [serial = 2100] [outer = 0x0] [url = http://web-platform.test:8000/cors/allow-headers.htm]
00:39:21 INFO - PROCESS | 1768 | --DOMWINDOW == 157 (0x12c20e800) [pid = 1768] [serial = 2135] [outer = 0x0] [url = http://web-platform.test:8000/cors/response-headers.htm]
00:39:21 INFO - PROCESS | 1768 | --DOMWINDOW == 156 (0x11c122c00) [pid = 1768] [serial = 2121] [outer = 0x0] [url = http://web-platform.test:8000/cors/redirect-preflight.htm]
00:39:21 INFO - PROCESS | 1768 | --DOMWINDOW == 155 (0x127ae2000) [pid = 1768] [serial = 2124] [outer = 0x0] [url = http://web-platform.test:8000/cors/redirect-userinfo.htm]
00:39:21 INFO - PROCESS | 1768 | --DOMWINDOW == 154 (0x127ae3400) [pid = 1768] [serial = 2127] [outer = 0x0] [url = http://web-platform.test:8000/cors/remote-origin.htm]
00:39:21 INFO - PROCESS | 1768 | --DOMWINDOW == 153 (0x1150b2400) [pid = 1768] [serial = 2115] [outer = 0x0] [url = http://web-platform.test:8000/cors/preflight-cache.htm]
00:39:21 INFO - PROCESS | 1768 | --DOMWINDOW == 152 (0x12a31cc00) [pid = 1768] [serial = 2130] [outer = 0x0] [url = http://www1.web-platform.test:8000/cors/resources/remote-xhrer.html]
00:39:21 INFO - PROCESS | 1768 | --DOMWINDOW == 151 (0x12bf2d400) [pid = 1768] [serial = 2132] [outer = 0x0] [url = http://web-platform.test:8000/cors/request-headers.htm]
00:39:21 INFO - PROCESS | 1768 | --DOMWINDOW == 150 (0x11b191000) [pid = 1768] [serial = 2118] [outer = 0x0] [url = http://web-platform.test:8000/cors/redirect-preflight-2.htm]
00:39:21 INFO - PROCESS | 1768 | 1462347561894 Marionette TRACE conn2 <- [1,2706,null,{"value":["/dom/events/Event-constructors.html",0,null,null,[["Event constructors",0,null,null],["Event constructors 1",0,null,null],["Event constructors 2",0,null,null],["Event constructors 3",0,null,null],["Event constructors 4",1,"Constructor Event requires 'new'","@http://web-platform.test:8000/dom/events/Event-constructors.html:45:12\nTest.prototype.step@http://web-platform.test:8000/resources/testharness.js:1382:20\ntest@http://web-platform.test:8000/resources/testharness.js:496:9\n@http://web-platform.test:8000/dom/events/Event-constructors.html:44:1\n"],["Event constructors 5",0,null,null],["Event constructors 6",0,null,null],["Event constructors 7",0,null,null],["Event constructors 8",0,null,null],["Event constructors 9",0,null,null],["Event constructors 10",0,null,null],["Event constructors 11",0,null,null],["Event constructors 12",0,null,null]]]}]
00:39:21 INFO - TEST-PASS | /dom/events/Event-constructors.html | Event constructors
00:39:21 INFO - TEST-PASS | /dom/events/Event-constructors.html | Event constructors 1
00:39:21 INFO - TEST-PASS | /dom/events/Event-constructors.html | Event constructors 2
00:39:21 INFO - TEST-PASS | /dom/events/Event-constructors.html | Event constructors 3
00:39:21 INFO - TEST-FAIL | /dom/events/Event-constructors.html | Event constructors 4 - Constructor Event requires 'new'
00:39:21 INFO - @http://web-platform.test:8000/dom/events/Event-constructors.html:45:12
00:39:21 INFO - Test.prototype.step@http://web-platform.test:8000/resources/testharness.js:1382:20
00:39:21 INFO - test@http://web-platform.test:8000/resources/testharness.js:496:9
00:39:21 INFO - @http://web-platform.test:8000/dom/events/Event-constructors.html:44:1
00:39:21 INFO - TEST-PASS | /dom/events/Event-constructors.html | Event constructors 5
00:39:21 INFO - TEST-PASS | /dom/events/Event-constructors.html | Event constructors 6
00:39:21 INFO - TEST-PASS | /dom/events/Event-constructors.html | Event constructors 7
00:39:21 INFO - TEST-PASS | /dom/events/Event-constructors.html | Event constructors 8
00:39:21 INFO - TEST-PASS | /dom/events/Event-constructors.html | Event constructors 9
00:39:21 INFO - TEST-PASS | /dom/events/Event-constructors.html | Event constructors 10
00:39:21 INFO - TEST-PASS | /dom/events/Event-constructors.html | Event constructors 11
00:39:21 INFO - TEST-PASS | /dom/events/Event-constructors.html | Event constructors 12
00:39:21 INFO - TEST-OK | /dom/events/Event-constructors.html | took 573ms
00:39:21 INFO - TEST-START | /dom/events/Event-defaultPrevented.html
00:39:21 INFO - PROCESS | 1768 | 1462347561914 Marionette TRACE conn2 -> [0,2707,"getWindowHandle",null]
00:39:21 INFO - PROCESS | 1768 | 1462347561915 Marionette TRACE conn2 <- [1,2707,null,{"value":"7"}]
00:39:21 INFO - PROCESS | 1768 | 1462347561917 Marionette TRACE conn2 -> [0,2708,"setScriptTimeout",{"ms":35000}]
00:39:21 INFO - PROCESS | 1768 | 1462347561918 Marionette TRACE conn2 <- [1,2708,null,{}]
00:39:21 INFO - PROCESS | 1768 | 1462347561921 Marionette TRACE conn2 -> [0,2709,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"executormarionette.py","script":"if (window.wrappedJSObject.win) {window.wrappedJSObject.win.close()}","sandbox":"default","line":398}]
00:39:22 INFO - PROCESS | 1768 | 1462347562027 Marionette TRACE conn2 <- [1,2709,null,{"value":null}]
00:39:22 INFO - PROCESS | 1768 | 1462347562063 Marionette TRACE conn2 -> [0,2710,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":false,"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distributed with this\n * file, You can obtain one at http://mozilla.org/MPL/2.0/. */\n\nwindow.wrappedJSObject.timeout_multiplier = 3;\nwindow.wrappedJSObject.explicit_timeout = 0;\n\nwindow.wrappedJSObject.addEventListener(\"message\", function listener(event) {\n if (event.data.type != \"complete\") {\n return;\n }\n window.wrappedJSObject.removeEventListener(\"message\", listener);\n clearTimeout(timer);\n var tests = event.data.tests;\n var status = event.data.status;\n\n var subtest_results = tests.map(function(x) {\n return [x.name, x.status, x.message, x.stack]\n });\n\n marionetteScriptFinished([\"/dom/events/Event-defaultPrevented.html\",\n status.status,\n status.message,\n status.stack,\n subtest_results]);\n}, false);\n\nwindow.wrappedJSObject.win = window.open(\"http://web-platform.test:8000/dom/events/Event-defaultPrevented.html\", \"2ced755f-84b6-4663-9dfa-fcbe7c8049e0\");\n\nvar timer = null;\nif (30000) {\n timer = setTimeout(function() {\n log(\"Timeout fired\");\n window.wrappedJSObject.win.timeout();\n }, 30000);\n}\n","newSandbox":false,"line":412,"args":[],"filename":"executormarionette.py"}]
00:39:22 INFO - PROCESS | 1768 | ++DOCSHELL 0x11c921000 == 49 [pid = 1768] [id = 752]
00:39:22 INFO - PROCESS | 1768 | ++DOMWINDOW == 151 (0x11510a400) [pid = 1768] [serial = 2203] [outer = 0x0]
00:39:22 INFO - PROCESS | 1768 | ++DOMWINDOW == 152 (0x12c8e1400) [pid = 1768] [serial = 2204] [outer = 0x11510a400]
00:39:22 INFO - PROCESS | 1768 | 1462347562089 Marionette DEBUG loaded listener.js
00:39:22 INFO - PROCESS | 1768 | ++DOMWINDOW == 153 (0x12ccc2400) [pid = 1768] [serial = 2205] [outer = 0x11510a400]
00:39:22 INFO - PROCESS | 1768 | 1462347562341 Marionette TRACE conn2 <- [1,2710,null,{"value":["/dom/events/Event-defaultPrevented.html",0,null,null,[["When an event is created, defaultPrevented should be initialized to false.",0,null,null],["initEvent should work correctly (not cancelable).",0,null,null],["preventDefault() should not change defaultPrevented if cancelable is false.",0,null,null],["initEvent should work correctly (cancelable).",0,null,null],["preventDefault() should change defaultPrevented if cancelable is false.",0,null,null],["initEvent should unset defaultPrevented.",0,null,null]]]}]
00:39:22 INFO - TEST-PASS | /dom/events/Event-defaultPrevented.html | When an event is created, defaultPrevented should be initialized to false.
00:39:22 INFO - TEST-PASS | /dom/events/Event-defaultPrevented.html | initEvent should work correctly (not cancelable).
00:39:22 INFO - TEST-PASS | /dom/events/Event-defaultPrevented.html | preventDefault() should not change defaultPrevented if cancelable is false.
00:39:22 INFO - TEST-PASS | /dom/events/Event-defaultPrevented.html | initEvent should work correctly (cancelable).
00:39:22 INFO - TEST-PASS | /dom/events/Event-defaultPrevented.html | preventDefault() should change defaultPrevented if cancelable is false.
00:39:22 INFO - TEST-PASS | /dom/events/Event-defaultPrevented.html | initEvent should unset defaultPrevented.
00:39:22 INFO - TEST-OK | /dom/events/Event-defaultPrevented.html | took 469ms
00:39:22 INFO - PROCESS | 1768 | 1462347562387 Marionette TRACE conn2 -> [0,2711,"getWindowHandle",null]
00:39:22 INFO - PROCESS | 1768 | 1462347562389 Marionette TRACE conn2 <- [1,2711,null,{"value":"7"}]
00:39:22 INFO - TEST-START | /dom/events/Event-dispatch-bubbles-false.html
00:39:22 INFO - PROCESS | 1768 | 1462347562402 Marionette TRACE conn2 -> [0,2712,"setScriptTimeout",{"ms":35000}]
00:39:22 INFO - PROCESS | 1768 | 1462347562404 Marionette TRACE conn2 <- [1,2712,null,{}]
00:39:22 INFO - PROCESS | 1768 | 1462347562410 Marionette TRACE conn2 -> [0,2713,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"executormarionette.py","script":"if (window.wrappedJSObject.win) {window.wrappedJSObject.win.close()}","sandbox":"default","line":398}]
00:39:22 INFO - PROCESS | 1768 | 1462347562517 Marionette TRACE conn2 <- [1,2713,null,{"value":null}]
00:39:22 INFO - PROCESS | 1768 | 1462347562521 Marionette TRACE conn2 -> [0,2714,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":false,"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distributed with this\n * file, You can obtain one at http://mozilla.org/MPL/2.0/. */\n\nwindow.wrappedJSObject.timeout_multiplier = 3;\nwindow.wrappedJSObject.explicit_timeout = 0;\n\nwindow.wrappedJSObject.addEventListener(\"message\", function listener(event) {\n if (event.data.type != \"complete\") {\n return;\n }\n window.wrappedJSObject.removeEventListener(\"message\", listener);\n clearTimeout(timer);\n var tests = event.data.tests;\n var status = event.data.status;\n\n var subtest_results = tests.map(function(x) {\n return [x.name, x.status, x.message, x.stack]\n });\n\n marionetteScriptFinished([\"/dom/events/Event-dispatch-bubbles-false.html\",\n status.status,\n status.message,\n status.stack,\n subtest_results]);\n}, false);\n\nwindow.wrappedJSObject.win = window.open(\"http://web-platform.test:8000/dom/events/Event-dispatch-bubbles-false.html\", \"2ced755f-84b6-4663-9dfa-fcbe7c8049e0\");\n\nvar timer = null;\nif (30000) {\n timer = setTimeout(function() {\n log(\"Timeout fired\");\n window.wrappedJSObject.win.timeout();\n }, 30000);\n}\n","newSandbox":false,"line":412,"args":[],"filename":"executormarionette.py"}]
00:39:22 INFO - PROCESS | 1768 | ++DOCSHELL 0x131111000 == 50 [pid = 1768] [id = 753]
00:39:22 INFO - PROCESS | 1768 | ++DOMWINDOW == 154 (0x12a167800) [pid = 1768] [serial = 2206] [outer = 0x0]
00:39:22 INFO - PROCESS | 1768 | ++DOMWINDOW == 155 (0x12e656400) [pid = 1768] [serial = 2207] [outer = 0x12a167800]
00:39:22 INFO - PROCESS | 1768 | 1462347562552 Marionette DEBUG loaded listener.js
00:39:22 INFO - PROCESS | 1768 | ++DOMWINDOW == 156 (0x12ed41000) [pid = 1768] [serial = 2208] [outer = 0x12a167800]
00:39:22 INFO - PROCESS | 1768 | 1462347562863 Marionette TRACE conn2 <- [1,2714,null,{"value":["/dom/events/Event-dispatch-bubbles-false.html",0,null,null,[["In window.document with click event",0,null,null],["In window.document with load event",0,null,null],["In window.document.cloneNode(true)",0,null,null],["In new Document()",0,null,null],["In DOMImplementation.createHTMLDocument()",0,null,null]]]}]
00:39:22 INFO - TEST-PASS | /dom/events/Event-dispatch-bubbles-false.html | In window.document with click event
00:39:22 INFO - TEST-PASS | /dom/events/Event-dispatch-bubbles-false.html | In window.document with load event
00:39:22 INFO - TEST-PASS | /dom/events/Event-dispatch-bubbles-false.html | In window.document.cloneNode(true)
00:39:22 INFO - TEST-PASS | /dom/events/Event-dispatch-bubbles-false.html | In new Document()
00:39:22 INFO - TEST-PASS | /dom/events/Event-dispatch-bubbles-false.html | In DOMImplementation.createHTMLDocument()
00:39:22 INFO - TEST-OK | /dom/events/Event-dispatch-bubbles-false.html | took 479ms
00:39:22 INFO - TEST-START | /dom/events/Event-dispatch-handlers-changed.html
00:39:22 INFO - PROCESS | 1768 | 1462347562880 Marionette TRACE conn2 -> [0,2715,"getWindowHandle",null]
00:39:22 INFO - PROCESS | 1768 | 1462347562882 Marionette TRACE conn2 <- [1,2715,null,{"value":"7"}]
00:39:22 INFO - PROCESS | 1768 | 1462347562884 Marionette TRACE conn2 -> [0,2716,"setScriptTimeout",{"ms":35000}]
00:39:22 INFO - PROCESS | 1768 | 1462347562885 Marionette TRACE conn2 <- [1,2716,null,{}]
00:39:22 INFO - PROCESS | 1768 | 1462347562888 Marionette TRACE conn2 -> [0,2717,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"executormarionette.py","script":"if (window.wrappedJSObject.win) {window.wrappedJSObject.win.close()}","sandbox":"default","line":398}]
00:39:23 INFO - PROCESS | 1768 | 1462347563013 Marionette TRACE conn2 <- [1,2717,null,{"value":null}]
00:39:23 INFO - PROCESS | 1768 | 1462347563046 Marionette TRACE conn2 -> [0,2718,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":false,"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distributed with this\n * file, You can obtain one at http://mozilla.org/MPL/2.0/. */\n\nwindow.wrappedJSObject.timeout_multiplier = 3;\nwindow.wrappedJSObject.explicit_timeout = 0;\n\nwindow.wrappedJSObject.addEventListener(\"message\", function listener(event) {\n if (event.data.type != \"complete\") {\n return;\n }\n window.wrappedJSObject.removeEventListener(\"message\", listener);\n clearTimeout(timer);\n var tests = event.data.tests;\n var status = event.data.status;\n\n var subtest_results = tests.map(function(x) {\n return [x.name, x.status, x.message, x.stack]\n });\n\n marionetteScriptFinished([\"/dom/events/Event-dispatch-handlers-changed.html\",\n status.status,\n status.message,\n status.stack,\n subtest_results]);\n}, false);\n\nwindow.wrappedJSObject.win = window.open(\"http://web-platform.test:8000/dom/events/Event-dispatch-handlers-changed.html\", \"2ced755f-84b6-4663-9dfa-fcbe7c8049e0\");\n\nvar timer = null;\nif (30000) {\n timer = setTimeout(function() {\n log(\"Timeout fired\");\n window.wrappedJSObject.win.timeout();\n }, 30000);\n}\n","newSandbox":false,"line":412,"args":[],"filename":"executormarionette.py"}]
00:39:23 INFO - PROCESS | 1768 | ++DOCSHELL 0x12ff97800 == 51 [pid = 1768] [id = 754]
00:39:23 INFO - PROCESS | 1768 | ++DOMWINDOW == 157 (0x12e67ac00) [pid = 1768] [serial = 2209] [outer = 0x0]
00:39:23 INFO - PROCESS | 1768 | ++DOMWINDOW == 158 (0x12ef84c00) [pid = 1768] [serial = 2210] [outer = 0x12e67ac00]
00:39:23 INFO - PROCESS | 1768 | 1462347563072 Marionette DEBUG loaded listener.js
00:39:23 INFO - PROCESS | 1768 | ++DOMWINDOW == 159 (0x12efb0c00) [pid = 1768] [serial = 2211] [outer = 0x12e67ac00]
00:39:23 INFO - PROCESS | 1768 | 1462347563338 Marionette TRACE conn2 <- [1,2718,null,{"value":["/dom/events/Event-dispatch-handlers-changed.html",0,null,null,[[" Dispatch additional events inside an event listener ",0,null,null]]]}]
00:39:23 INFO - TEST-PASS | /dom/events/Event-dispatch-handlers-changed.html | Dispatch additional events inside an event listener
00:39:23 INFO - TEST-OK | /dom/events/Event-dispatch-handlers-changed.html | took 468ms
00:39:23 INFO - TEST-START | /dom/events/Event-dispatch-omitted-capture.html
00:39:23 INFO - PROCESS | 1768 | 1462347563353 Marionette TRACE conn2 -> [0,2719,"getWindowHandle",null]
00:39:23 INFO - PROCESS | 1768 | 1462347563354 Marionette TRACE conn2 <- [1,2719,null,{"value":"7"}]
00:39:23 INFO - PROCESS | 1768 | 1462347563363 Marionette TRACE conn2 -> [0,2720,"setScriptTimeout",{"ms":35000}]
00:39:23 INFO - PROCESS | 1768 | 1462347563364 Marionette TRACE conn2 <- [1,2720,null,{}]
00:39:23 INFO - PROCESS | 1768 | 1462347563367 Marionette TRACE conn2 -> [0,2721,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"executormarionette.py","script":"if (window.wrappedJSObject.win) {window.wrappedJSObject.win.close()}","sandbox":"default","line":398}]
00:39:23 INFO - PROCESS | 1768 | 1462347563453 Marionette TRACE conn2 <- [1,2721,null,{"value":null}]
00:39:23 INFO - PROCESS | 1768 | 1462347563458 Marionette TRACE conn2 -> [0,2722,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":false,"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distributed with this\n * file, You can obtain one at http://mozilla.org/MPL/2.0/. */\n\nwindow.wrappedJSObject.timeout_multiplier = 3;\nwindow.wrappedJSObject.explicit_timeout = 0;\n\nwindow.wrappedJSObject.addEventListener(\"message\", function listener(event) {\n if (event.data.type != \"complete\") {\n return;\n }\n window.wrappedJSObject.removeEventListener(\"message\", listener);\n clearTimeout(timer);\n var tests = event.data.tests;\n var status = event.data.status;\n\n var subtest_results = tests.map(function(x) {\n return [x.name, x.status, x.message, x.stack]\n });\n\n marionetteScriptFinished([\"/dom/events/Event-dispatch-omitted-capture.html\",\n status.status,\n status.message,\n status.stack,\n subtest_results]);\n}, false);\n\nwindow.wrappedJSObject.win = window.open(\"http://web-platform.test:8000/dom/events/Event-dispatch-omitted-capture.html\", \"2ced755f-84b6-4663-9dfa-fcbe7c8049e0\");\n\nvar timer = null;\nif (30000) {\n timer = setTimeout(function() {\n log(\"Timeout fired\");\n window.wrappedJSObject.win.timeout();\n }, 30000);\n}\n","newSandbox":false,"line":412,"args":[],"filename":"executormarionette.py"}]
00:39:23 INFO - PROCESS | 1768 | ++DOCSHELL 0x13a8ba800 == 52 [pid = 1768] [id = 755]
00:39:23 INFO - PROCESS | 1768 | ++DOMWINDOW == 160 (0x12efb0000) [pid = 1768] [serial = 2212] [outer = 0x0]
00:39:23 INFO - PROCESS | 1768 | ++DOMWINDOW == 161 (0x12efb6400) [pid = 1768] [serial = 2213] [outer = 0x12efb0000]
00:39:23 INFO - PROCESS | 1768 | 1462347563483 Marionette DEBUG loaded listener.js
00:39:23 INFO - PROCESS | 1768 | ++DOMWINDOW == 162 (0x12f019000) [pid = 1768] [serial = 2214] [outer = 0x12efb0000]
00:39:23 INFO - PROCESS | 1768 | 1462347563847 Marionette TRACE conn2 <- [1,2722,null,{"value":["/dom/events/Event-dispatch-omitted-capture.html",0,null,null,[["EventTarget.addEventListener with the capture argument omitted",0,null,null]]]}]
00:39:23 INFO - TEST-PASS | /dom/events/Event-dispatch-omitted-capture.html | EventTarget.addEventListener with the capture argument omitted
00:39:23 INFO - TEST-OK | /dom/events/Event-dispatch-omitted-capture.html | took 526ms
00:39:23 INFO - PROCESS | 1768 | 1462347563883 Marionette TRACE conn2 -> [0,2723,"getWindowHandle",null]
00:39:23 INFO - PROCESS | 1768 | 1462347563885 Marionette TRACE conn2 <- [1,2723,null,{"value":"7"}]
00:39:23 INFO - TEST-START | /dom/events/Event-dispatch-propagation-stopped.html
00:39:23 INFO - PROCESS | 1768 | 1462347563889 Marionette TRACE conn2 -> [0,2724,"setScriptTimeout",{"ms":35000}]
00:39:23 INFO - PROCESS | 1768 | 1462347563892 Marionette TRACE conn2 <- [1,2724,null,{}]
00:39:23 INFO - PROCESS | 1768 | 1462347563896 Marionette TRACE conn2 -> [0,2725,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"executormarionette.py","script":"if (window.wrappedJSObject.win) {window.wrappedJSObject.win.close()}","sandbox":"default","line":398}]
00:39:23 INFO - PROCESS | 1768 | 1462347563998 Marionette TRACE conn2 <- [1,2725,null,{"value":null}]
00:39:24 INFO - PROCESS | 1768 | 1462347564069 Marionette TRACE conn2 -> [0,2726,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":false,"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distributed with this\n * file, You can obtain one at http://mozilla.org/MPL/2.0/. */\n\nwindow.wrappedJSObject.timeout_multiplier = 3;\nwindow.wrappedJSObject.explicit_timeout = 0;\n\nwindow.wrappedJSObject.addEventListener(\"message\", function listener(event) {\n if (event.data.type != \"complete\") {\n return;\n }\n window.wrappedJSObject.removeEventListener(\"message\", listener);\n clearTimeout(timer);\n var tests = event.data.tests;\n var status = event.data.status;\n\n var subtest_results = tests.map(function(x) {\n return [x.name, x.status, x.message, x.stack]\n });\n\n marionetteScriptFinished([\"/dom/events/Event-dispatch-propagation-stopped.html\",\n status.status,\n status.message,\n status.stack,\n subtest_results]);\n}, false);\n\nwindow.wrappedJSObject.win = window.open(\"http://web-platform.test:8000/dom/events/Event-dispatch-propagation-stopped.html\", \"2ced755f-84b6-4663-9dfa-fcbe7c8049e0\");\n\nvar timer = null;\nif (30000) {\n timer = setTimeout(function() {\n log(\"Timeout fired\");\n window.wrappedJSObject.win.timeout();\n }, 30000);\n}\n","newSandbox":false,"line":412,"args":[],"filename":"executormarionette.py"}]
00:39:24 INFO - PROCESS | 1768 | ++DOCSHELL 0x11ccad800 == 53 [pid = 1768] [id = 756]
00:39:24 INFO - PROCESS | 1768 | ++DOMWINDOW == 163 (0x11583e800) [pid = 1768] [serial = 2215] [outer = 0x0]
00:39:24 INFO - PROCESS | 1768 | ++DOMWINDOW == 164 (0x116706000) [pid = 1768] [serial = 2216] [outer = 0x11583e800]
00:39:24 INFO - PROCESS | 1768 | 1462347564101 Marionette DEBUG loaded listener.js
00:39:24 INFO - PROCESS | 1768 | ++DOMWINDOW == 165 (0x11a0f4800) [pid = 1768] [serial = 2217] [outer = 0x11583e800]
00:39:24 INFO - PROCESS | 1768 | 1462347564465 Marionette TRACE conn2 <- [1,2726,null,{"value":["/dom/events/Event-dispatch-propagation-stopped.html",0,null,null,[[" Calling stopPropagation() prior to dispatchEvent() ",0,null,null]]]}]
00:39:24 INFO - TEST-PASS | /dom/events/Event-dispatch-propagation-stopped.html | Calling stopPropagation() prior to dispatchEvent()
00:39:24 INFO - TEST-OK | /dom/events/Event-dispatch-propagation-stopped.html | took 620ms
00:39:24 INFO - PROCESS | 1768 | 1462347564510 Marionette TRACE conn2 -> [0,2727,"getWindowHandle",null]
00:39:24 INFO - PROCESS | 1768 | 1462347564514 Marionette TRACE conn2 <- [1,2727,null,{"value":"7"}]
00:39:24 INFO - TEST-START | /dom/events/Event-dispatch-redispatch.html
00:39:24 INFO - PROCESS | 1768 | 1462347564519 Marionette TRACE conn2 -> [0,2728,"setScriptTimeout",{"ms":35000}]
00:39:24 INFO - PROCESS | 1768 | 1462347564521 Marionette TRACE conn2 <- [1,2728,null,{}]
00:39:24 INFO - PROCESS | 1768 | 1462347564523 Marionette TRACE conn2 -> [0,2729,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"executormarionette.py","script":"if (window.wrappedJSObject.win) {window.wrappedJSObject.win.close()}","sandbox":"default","line":398}]
00:39:24 INFO - PROCESS | 1768 | 1462347564629 Marionette TRACE conn2 <- [1,2729,null,{"value":null}]
00:39:24 INFO - PROCESS | 1768 | 1462347564726 Marionette TRACE conn2 -> [0,2730,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":false,"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distributed with this\n * file, You can obtain one at http://mozilla.org/MPL/2.0/. */\n\nwindow.wrappedJSObject.timeout_multiplier = 3;\nwindow.wrappedJSObject.explicit_timeout = 0;\n\nwindow.wrappedJSObject.addEventListener(\"message\", function listener(event) {\n if (event.data.type != \"complete\") {\n return;\n }\n window.wrappedJSObject.removeEventListener(\"message\", listener);\n clearTimeout(timer);\n var tests = event.data.tests;\n var status = event.data.status;\n\n var subtest_results = tests.map(function(x) {\n return [x.name, x.status, x.message, x.stack]\n });\n\n marionetteScriptFinished([\"/dom/events/Event-dispatch-redispatch.html\",\n status.status,\n status.message,\n status.stack,\n subtest_results]);\n}, false);\n\nwindow.wrappedJSObject.win = window.open(\"http://web-platform.test:8000/dom/events/Event-dispatch-redispatch.html\", \"2ced755f-84b6-4663-9dfa-fcbe7c8049e0\");\n\nvar timer = null;\nif (30000) {\n timer = setTimeout(function() {\n log(\"Timeout fired\");\n window.wrappedJSObject.win.timeout();\n }, 30000);\n}\n","newSandbox":false,"line":412,"args":[],"filename":"executormarionette.py"}]
00:39:24 INFO - PROCESS | 1768 | ++DOCSHELL 0x12d0a5000 == 54 [pid = 1768] [id = 757]
00:39:24 INFO - PROCESS | 1768 | ++DOMWINDOW == 166 (0x11c668c00) [pid = 1768] [serial = 2218] [outer = 0x0]
00:39:24 INFO - PROCESS | 1768 | ++DOMWINDOW == 167 (0x126089800) [pid = 1768] [serial = 2219] [outer = 0x11c668c00]
00:39:24 INFO - PROCESS | 1768 | 1462347564758 Marionette DEBUG loaded listener.js
00:39:24 INFO - PROCESS | 1768 | ++DOMWINDOW == 168 (0x12650f800) [pid = 1768] [serial = 2220] [outer = 0x11c668c00]
00:39:25 INFO - PROCESS | 1768 | 1462347565108 Marionette TRACE conn2 <- [1,2730,null,{"value":["/dom/events/Event-dispatch-redispatch.html",0,null,null,[["EventTarget#dispatchEvent(): redispatching a native event",0,null,null]]]}]
00:39:25 INFO - TEST-PASS | /dom/events/Event-dispatch-redispatch.html | EventTarget#dispatchEvent(): redispatching a native event
00:39:25 INFO - TEST-OK | /dom/events/Event-dispatch-redispatch.html | took 619ms
00:39:25 INFO - PROCESS | 1768 | 1462347565139 Marionette TRACE conn2 -> [0,2731,"getWindowHandle",null]
00:39:25 INFO - PROCESS | 1768 | 1462347565140 Marionette TRACE conn2 <- [1,2731,null,{"value":"7"}]
00:39:25 INFO - TEST-START | /dom/events/Event-dispatch-reenter.html
00:39:25 INFO - PROCESS | 1768 | 1462347565143 Marionette TRACE conn2 -> [0,2732,"setScriptTimeout",{"ms":35000}]
00:39:25 INFO - PROCESS | 1768 | 1462347565146 Marionette TRACE conn2 <- [1,2732,null,{}]
00:39:25 INFO - PROCESS | 1768 | 1462347565154 Marionette TRACE conn2 -> [0,2733,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"executormarionette.py","script":"if (window.wrappedJSObject.win) {window.wrappedJSObject.win.close()}","sandbox":"default","line":398}]
00:39:25 INFO - PROCESS | 1768 | 1462347565258 Marionette TRACE conn2 <- [1,2733,null,{"value":null}]
00:39:25 INFO - PROCESS | 1768 | 1462347565320 Marionette TRACE conn2 -> [0,2734,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":false,"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distributed with this\n * file, You can obtain one at http://mozilla.org/MPL/2.0/. */\n\nwindow.wrappedJSObject.timeout_multiplier = 3;\nwindow.wrappedJSObject.explicit_timeout = 0;\n\nwindow.wrappedJSObject.addEventListener(\"message\", function listener(event) {\n if (event.data.type != \"complete\") {\n return;\n }\n window.wrappedJSObject.removeEventListener(\"message\", listener);\n clearTimeout(timer);\n var tests = event.data.tests;\n var status = event.data.status;\n\n var subtest_results = tests.map(function(x) {\n return [x.name, x.status, x.message, x.stack]\n });\n\n marionetteScriptFinished([\"/dom/events/Event-dispatch-reenter.html\",\n status.status,\n status.message,\n status.stack,\n subtest_results]);\n}, false);\n\nwindow.wrappedJSObject.win = window.open(\"http://web-platform.test:8000/dom/events/Event-dispatch-reenter.html\", \"2ced755f-84b6-4663-9dfa-fcbe7c8049e0\");\n\nvar timer = null;\nif (30000) {\n timer = setTimeout(function() {\n log(\"Timeout fired\");\n window.wrappedJSObject.win.timeout();\n }, 30000);\n}\n","newSandbox":false,"line":412,"args":[],"filename":"executormarionette.py"}]
00:39:25 INFO - PROCESS | 1768 | ++DOCSHELL 0x12ff92000 == 55 [pid = 1768] [id = 758]
00:39:25 INFO - PROCESS | 1768 | ++DOMWINDOW == 169 (0x1267a9c00) [pid = 1768] [serial = 2221] [outer = 0x0]
00:39:25 INFO - PROCESS | 1768 | ++DOMWINDOW == 170 (0x127f32400) [pid = 1768] [serial = 2222] [outer = 0x1267a9c00]
00:39:25 INFO - PROCESS | 1768 | 1462347565352 Marionette DEBUG loaded listener.js
00:39:25 INFO - PROCESS | 1768 | ++DOMWINDOW == 171 (0x12b371800) [pid = 1768] [serial = 2223] [outer = 0x1267a9c00]
00:39:25 INFO - PROCESS | 1768 | 1462347565737 Marionette TRACE conn2 <- [1,2734,null,{"value":["/dom/events/Event-dispatch-reenter.html",0,null,null,[[" Dispatch additional events inside an event listener ",0,null,null]]]}]
00:39:25 INFO - TEST-PASS | /dom/events/Event-dispatch-reenter.html | Dispatch additional events inside an event listener
00:39:25 INFO - TEST-OK | /dom/events/Event-dispatch-reenter.html | took 622ms
00:39:25 INFO - PROCESS | 1768 | 1462347565765 Marionette TRACE conn2 -> [0,2735,"getWindowHandle",null]
00:39:25 INFO - TEST-START | /dom/events/Event-dispatch-target-moved.html
00:39:25 INFO - PROCESS | 1768 | 1462347565767 Marionette TRACE conn2 <- [1,2735,null,{"value":"7"}]
00:39:25 INFO - PROCESS | 1768 | 1462347565769 Marionette TRACE conn2 -> [0,2736,"setScriptTimeout",{"ms":35000}]
00:39:25 INFO - PROCESS | 1768 | 1462347565771 Marionette TRACE conn2 <- [1,2736,null,{}]
00:39:25 INFO - PROCESS | 1768 | 1462347565773 Marionette TRACE conn2 -> [0,2737,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"executormarionette.py","script":"if (window.wrappedJSObject.win) {window.wrappedJSObject.win.close()}","sandbox":"default","line":398}]
00:39:25 INFO - PROCESS | 1768 | 1462347565875 Marionette TRACE conn2 <- [1,2737,null,{"value":null}]
00:39:25 INFO - PROCESS | 1768 | 1462347565964 Marionette TRACE conn2 -> [0,2738,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":false,"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distributed with this\n * file, You can obtain one at http://mozilla.org/MPL/2.0/. */\n\nwindow.wrappedJSObject.timeout_multiplier = 3;\nwindow.wrappedJSObject.explicit_timeout = 0;\n\nwindow.wrappedJSObject.addEventListener(\"message\", function listener(event) {\n if (event.data.type != \"complete\") {\n return;\n }\n window.wrappedJSObject.removeEventListener(\"message\", listener);\n clearTimeout(timer);\n var tests = event.data.tests;\n var status = event.data.status;\n\n var subtest_results = tests.map(function(x) {\n return [x.name, x.status, x.message, x.stack]\n });\n\n marionetteScriptFinished([\"/dom/events/Event-dispatch-target-moved.html\",\n status.status,\n status.message,\n status.stack,\n subtest_results]);\n}, false);\n\nwindow.wrappedJSObject.win = window.open(\"http://web-platform.test:8000/dom/events/Event-dispatch-target-moved.html\", \"2ced755f-84b6-4663-9dfa-fcbe7c8049e0\");\n\nvar timer = null;\nif (30000) {\n timer = setTimeout(function() {\n log(\"Timeout fired\");\n window.wrappedJSObject.win.timeout();\n }, 30000);\n}\n","newSandbox":false,"line":412,"args":[],"filename":"executormarionette.py"}]
00:39:25 INFO - PROCESS | 1768 | ++DOCSHELL 0x13a8c1000 == 56 [pid = 1768] [id = 759]
00:39:25 INFO - PROCESS | 1768 | ++DOMWINDOW == 172 (0x12bf2f400) [pid = 1768] [serial = 2224] [outer = 0x0]
00:39:26 INFO - PROCESS | 1768 | ++DOMWINDOW == 173 (0x12c169400) [pid = 1768] [serial = 2225] [outer = 0x12bf2f400]
00:39:26 INFO - PROCESS | 1768 | 1462347566006 Marionette DEBUG loaded listener.js
00:39:26 INFO - PROCESS | 1768 | ++DOMWINDOW == 174 (0x12c84a400) [pid = 1768] [serial = 2226] [outer = 0x12bf2f400]
00:39:26 INFO - PROCESS | 1768 | 1462347566362 Marionette TRACE conn2 <- [1,2738,null,{"value":["/dom/events/Event-dispatch-target-moved.html",0,null,null,[["Event propagation path when an element in it is moved within the DOM",0,null,null]]]}]
00:39:26 INFO - TEST-PASS | /dom/events/Event-dispatch-target-moved.html | Event propagation path when an element in it is moved within the DOM
00:39:26 INFO - TEST-OK | /dom/events/Event-dispatch-target-moved.html | took 621ms
00:39:26 INFO - TEST-START | /dom/events/Event-dispatch-target-removed.html
00:39:26 INFO - PROCESS | 1768 | 1462347566390 Marionette TRACE conn2 -> [0,2739,"getWindowHandle",null]
00:39:26 INFO - PROCESS | 1768 | 1462347566392 Marionette TRACE conn2 <- [1,2739,null,{"value":"7"}]
00:39:26 INFO - PROCESS | 1768 | 1462347566394 Marionette TRACE conn2 -> [0,2740,"setScriptTimeout",{"ms":35000}]
00:39:26 INFO - PROCESS | 1768 | 1462347566395 Marionette TRACE conn2 <- [1,2740,null,{}]
00:39:26 INFO - PROCESS | 1768 | 1462347566398 Marionette TRACE conn2 -> [0,2741,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"executormarionette.py","script":"if (window.wrappedJSObject.win) {window.wrappedJSObject.win.close()}","sandbox":"default","line":398}]
00:39:26 INFO - PROCESS | 1768 | 1462347566496 Marionette TRACE conn2 <- [1,2741,null,{"value":null}]
00:39:26 INFO - PROCESS | 1768 | 1462347566553 Marionette TRACE conn2 -> [0,2742,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":false,"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distributed with this\n * file, You can obtain one at http://mozilla.org/MPL/2.0/. */\n\nwindow.wrappedJSObject.timeout_multiplier = 3;\nwindow.wrappedJSObject.explicit_timeout = 0;\n\nwindow.wrappedJSObject.addEventListener(\"message\", function listener(event) {\n if (event.data.type != \"complete\") {\n return;\n }\n window.wrappedJSObject.removeEventListener(\"message\", listener);\n clearTimeout(timer);\n var tests = event.data.tests;\n var status = event.data.status;\n\n var subtest_results = tests.map(function(x) {\n return [x.name, x.status, x.message, x.stack]\n });\n\n marionetteScriptFinished([\"/dom/events/Event-dispatch-target-removed.html\",\n status.status,\n status.message,\n status.stack,\n subtest_results]);\n}, false);\n\nwindow.wrappedJSObject.win = window.open(\"http://web-platform.test:8000/dom/events/Event-dispatch-target-removed.html\", \"2ced755f-84b6-4663-9dfa-fcbe7c8049e0\");\n\nvar timer = null;\nif (30000) {\n timer = setTimeout(function() {\n log(\"Timeout fired\");\n window.wrappedJSObject.win.timeout();\n }, 30000);\n}\n","newSandbox":false,"line":412,"args":[],"filename":"executormarionette.py"}]
00:39:26 INFO - PROCESS | 1768 | ++DOCSHELL 0x13a8f5000 == 57 [pid = 1768] [id = 760]
00:39:26 INFO - PROCESS | 1768 | ++DOMWINDOW == 175 (0x11c00c400) [pid = 1768] [serial = 2227] [outer = 0x0]
00:39:26 INFO - PROCESS | 1768 | ++DOMWINDOW == 176 (0x12cc3a400) [pid = 1768] [serial = 2228] [outer = 0x11c00c400]
00:39:26 INFO - PROCESS | 1768 | 1462347566582 Marionette DEBUG loaded listener.js
00:39:26 INFO - PROCESS | 1768 | ++DOMWINDOW == 177 (0x12e65e000) [pid = 1768] [serial = 2229] [outer = 0x11c00c400]
00:39:26 INFO - PROCESS | 1768 | 1462347566965 Marionette TRACE conn2 <- [1,2742,null,{"value":["/dom/events/Event-dispatch-target-removed.html",0,null,null,[["Event propagation path when an element in it is removed from the DOM",0,null,null]]]}]
00:39:27 INFO - TEST-PASS | /dom/events/Event-dispatch-target-removed.html | Event propagation path when an element in it is removed from the DOM
00:39:27 INFO - TEST-OK | /dom/events/Event-dispatch-target-removed.html | took 618ms
00:39:27 INFO - PROCESS | 1768 | 1462347567013 Marionette TRACE conn2 -> [0,2743,"getWindowHandle",null]
00:39:27 INFO - PROCESS | 1768 | 1462347567014 Marionette TRACE conn2 <- [1,2743,null,{"value":"7"}]
00:39:27 INFO - TEST-START | /dom/events/Event-initEvent.html
00:39:27 INFO - PROCESS | 1768 | 1462347567017 Marionette TRACE conn2 -> [0,2744,"setScriptTimeout",{"ms":35000}]
00:39:27 INFO - PROCESS | 1768 | 1462347567018 Marionette TRACE conn2 <- [1,2744,null,{}]
00:39:27 INFO - PROCESS | 1768 | 1462347567020 Marionette TRACE conn2 -> [0,2745,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"executormarionette.py","script":"if (window.wrappedJSObject.win) {window.wrappedJSObject.win.close()}","sandbox":"default","line":398}]
00:39:27 INFO - PROCESS | 1768 | 1462347567132 Marionette TRACE conn2 <- [1,2745,null,{"value":null}]
00:39:27 INFO - PROCESS | 1768 | 1462347567225 Marionette TRACE conn2 -> [0,2746,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":false,"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distributed with this\n * file, You can obtain one at http://mozilla.org/MPL/2.0/. */\n\nwindow.wrappedJSObject.timeout_multiplier = 3;\nwindow.wrappedJSObject.explicit_timeout = 0;\n\nwindow.wrappedJSObject.addEventListener(\"message\", function listener(event) {\n if (event.data.type != \"complete\") {\n return;\n }\n window.wrappedJSObject.removeEventListener(\"message\", listener);\n clearTimeout(timer);\n var tests = event.data.tests;\n var status = event.data.status;\n\n var subtest_results = tests.map(function(x) {\n return [x.name, x.status, x.message, x.stack]\n });\n\n marionetteScriptFinished([\"/dom/events/Event-initEvent.html\",\n status.status,\n status.message,\n status.stack,\n subtest_results]);\n}, false);\n\nwindow.wrappedJSObject.win = window.open(\"http://web-platform.test:8000/dom/events/Event-initEvent.html\", \"2ced755f-84b6-4663-9dfa-fcbe7c8049e0\");\n\nvar timer = null;\nif (30000) {\n timer = setTimeout(function() {\n log(\"Timeout fired\");\n window.wrappedJSObject.win.timeout();\n }, 30000);\n}\n","newSandbox":false,"line":412,"args":[],"filename":"executormarionette.py"}]
00:39:27 INFO - PROCESS | 1768 | ++DOCSHELL 0x141f18000 == 58 [pid = 1768] [id = 761]
00:39:27 INFO - PROCESS | 1768 | ++DOMWINDOW == 178 (0x12ed41800) [pid = 1768] [serial = 2230] [outer = 0x0]
00:39:27 INFO - PROCESS | 1768 | ++DOMWINDOW == 179 (0x12efb5800) [pid = 1768] [serial = 2231] [outer = 0x12ed41800]
00:39:27 INFO - PROCESS | 1768 | 1462347567258 Marionette DEBUG loaded listener.js
00:39:27 INFO - PROCESS | 1768 | ++DOMWINDOW == 180 (0x12f033c00) [pid = 1768] [serial = 2232] [outer = 0x12ed41800]
00:39:27 INFO - PROCESS | 1768 | [1768] WARNING: NS_ENSURE_TRUE(!mEvent->mFlags.mIsBeingDispatched) failed: file /builds/slave/fx-team-m64-d-0000000000000000/build/src/dom/events/Event.cpp, line 570
00:39:27 INFO - PROCESS | 1768 | [1768] WARNING: NS_ENSURE_TRUE(!mEvent->mFlags.mIsBeingDispatched) failed: file /builds/slave/fx-team-m64-d-0000000000000000/build/src/dom/events/Event.cpp, line 570
00:39:27 INFO - PROCESS | 1768 | 1462347567641 Marionette TRACE conn2 <- [1,2746,null,{"value":["/dom/events/Event-initEvent.html",0,null,null,[["Properties of initEvent(type, true, true)",0,null,null],["Properties of initEvent(type, true, false)",0,null,null],["Properties of initEvent(type, false, true)",0,null,null],["Properties of initEvent(type, false, false)",0,null,null],["Calling initEvent multiple times (getting type).",0,null,null],["Calling initEvent multiple times (not getting type).",0,null,null],["Calling initEvent must not have an effect during dispatching.",0,null,null],["Calling initEvent must unset the stop propagation flag.",1,"assert_unreached: Reached unreachable code","@http://web-platform.test:8000/dom/events/Event-initEvent.html:88:5\nTest.prototype.step@http://web-platform.test:8000/resources/testharness.js:1382:20\nTest.prototype.step_func/<@http://web-platform.test:8000/resources/testharness.js:1406:20\n@http://web-platform.test:8000/dom/events/Event-initEvent.html:91:17\nTest.prototype.step@http://web-platform.test:8000/resources/testharness.js:1382:20\nasync_test@http://web-platform.test:8000/resources/testharness.js:513:13\n@http://web-platform.test:8000/dom/events/Event-initEvent.html:81:1\n"],["Calling initEvent during propagation.",0,null,null]]]}]
00:39:27 INFO - TEST-PASS | /dom/events/Event-initEvent.html | Properties of initEvent(type, true, true)
00:39:27 INFO - TEST-PASS | /dom/events/Event-initEvent.html | Properties of initEvent(type, true, false)
00:39:27 INFO - TEST-PASS | /dom/events/Event-initEvent.html | Properties of initEvent(type, false, true)
00:39:27 INFO - TEST-PASS | /dom/events/Event-initEvent.html | Properties of initEvent(type, false, false)
00:39:27 INFO - TEST-PASS | /dom/events/Event-initEvent.html | Calling initEvent multiple times (getting type).
00:39:27 INFO - TEST-PASS | /dom/events/Event-initEvent.html | Calling initEvent multiple times (not getting type).
00:39:27 INFO - TEST-PASS | /dom/events/Event-initEvent.html | Calling initEvent must not have an effect during dispatching.
00:39:27 INFO - TEST-FAIL | /dom/events/Event-initEvent.html | Calling initEvent must unset the stop propagation flag. - assert_unreached: Reached unreachable code
00:39:27 INFO - @http://web-platform.test:8000/dom/events/Event-initEvent.html:88:5
00:39:27 INFO - Test.prototype.step@http://web-platform.test:8000/resources/testharness.js:1382:20
00:39:27 INFO - Test.prototype.step_func/<@http://web-platform.test:8000/resources/testharness.js:1406:20
00:39:27 INFO - @http://web-platform.test:8000/dom/events/Event-initEvent.html:91:17
00:39:27 INFO - Test.prototype.step@http://web-platform.test:8000/resources/testharness.js:1382:20
00:39:27 INFO - async_test@http://web-platform.test:8000/resources/testharness.js:513:13
00:39:27 INFO - @http://web-platform.test:8000/dom/events/Event-initEvent.html:81:1
00:39:27 INFO - TEST-PASS | /dom/events/Event-initEvent.html | Calling initEvent during propagation.
00:39:27 INFO - TEST-OK | /dom/events/Event-initEvent.html | took 669ms
00:39:27 INFO - TEST-START | /dom/events/Event-propagation.html
00:39:27 INFO - PROCESS | 1768 | 1462347567687 Marionette TRACE conn2 -> [0,2747,"getWindowHandle",null]
00:39:27 INFO - PROCESS | 1768 | 1462347567688 Marionette TRACE conn2 <- [1,2747,null,{"value":"7"}]
00:39:27 INFO - PROCESS | 1768 | 1462347567690 Marionette TRACE conn2 -> [0,2748,"setScriptTimeout",{"ms":35000}]
00:39:27 INFO - PROCESS | 1768 | 1462347567692 Marionette TRACE conn2 <- [1,2748,null,{}]
00:39:27 INFO - PROCESS | 1768 | 1462347567694 Marionette TRACE conn2 -> [0,2749,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"executormarionette.py","script":"if (window.wrappedJSObject.win) {window.wrappedJSObject.win.close()}","sandbox":"default","line":398}]
00:39:27 INFO - PROCESS | 1768 | 1462347567793 Marionette TRACE conn2 <- [1,2749,null,{"value":null}]
00:39:27 INFO - PROCESS | 1768 | 1462347567852 Marionette TRACE conn2 -> [0,2750,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":false,"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distributed with this\n * file, You can obtain one at http://mozilla.org/MPL/2.0/. */\n\nwindow.wrappedJSObject.timeout_multiplier = 3;\nwindow.wrappedJSObject.explicit_timeout = 0;\n\nwindow.wrappedJSObject.addEventListener(\"message\", function listener(event) {\n if (event.data.type != \"complete\") {\n return;\n }\n window.wrappedJSObject.removeEventListener(\"message\", listener);\n clearTimeout(timer);\n var tests = event.data.tests;\n var status = event.data.status;\n\n var subtest_results = tests.map(function(x) {\n return [x.name, x.status, x.message, x.stack]\n });\n\n marionetteScriptFinished([\"/dom/events/Event-propagation.html\",\n status.status,\n status.message,\n status.stack,\n subtest_results]);\n}, false);\n\nwindow.wrappedJSObject.win = window.open(\"http://web-platform.test:8000/dom/events/Event-propagation.html\", \"2ced755f-84b6-4663-9dfa-fcbe7c8049e0\");\n\nvar timer = null;\nif (30000) {\n timer = setTimeout(function() {\n log(\"Timeout fired\");\n window.wrappedJSObject.win.timeout();\n }, 30000);\n}\n","newSandbox":false,"line":412,"args":[],"filename":"executormarionette.py"}]
00:39:27 INFO - PROCESS | 1768 | ++DOCSHELL 0x12b39f000 == 59 [pid = 1768] [id = 762]
00:39:27 INFO - PROCESS | 1768 | ++DOMWINDOW == 181 (0x11cae8800) [pid = 1768] [serial = 2233] [outer = 0x0]
00:39:27 INFO - PROCESS | 1768 | ++DOMWINDOW == 182 (0x12c8e3000) [pid = 1768] [serial = 2234] [outer = 0x11cae8800]
00:39:27 INFO - PROCESS | 1768 | 1462347567882 Marionette DEBUG loaded listener.js
00:39:27 INFO - PROCESS | 1768 | ++DOMWINDOW == 183 (0x12f037c00) [pid = 1768] [serial = 2235] [outer = 0x11cae8800]
00:39:28 INFO - PROCESS | 1768 | 1462347568218 Marionette TRACE conn2 <- [1,2750,null,{"value":["/dom/events/Event-propagation.html",0,null,null,[["Newly-created Event",0,null,null],["After stopPropagation()",1,"assert_equals: Propagation flag expected false but got true","testPropagationFlag/<@http://web-platform.test:8000/dom/events/Event-propagation.html:19:5\nTest.prototype.step@http://web-platform.test:8000/resources/testharness.js:1382:20\ntest@http://web-platform.test:8000/resources/testharness.js:496:9\ntestPropagationFlag@http://web-platform.test:8000/dom/events/Event-propagation.html:11:3\n@http://web-platform.test:8000/dom/events/Event-propagation.html:28:1\n"],["Reinitialized after stopPropagation()",0,null,null],["After stopImmediatePropagation()",1,"assert_equals: Propagation flag expected false but got true","testPropagationFlag/<@http://web-platform.test:8000/dom/events/Event-propagation.html:19:5\nTest.prototype.step@http://web-platform.test:8000/resources/testharness.js:1382:20\ntest@http://web-platform.test:8000/resources/testharness.js:496:9\ntestPropagationFlag@http://web-platform.test:8000/dom/events/Event-propagation.html:11:3\n@http://web-platform.test:8000/dom/events/Event-propagation.html:35:1\n"],["Reinitialized after stopImmediatePropagation()",0,null,null]]]}]
00:39:28 INFO - TEST-PASS | /dom/events/Event-propagation.html | Newly-created Event
00:39:28 INFO - TEST-FAIL | /dom/events/Event-propagation.html | After stopPropagation() - assert_equals: Propagation flag expected false but got true
00:39:28 INFO - testPropagationFlag/<@http://web-platform.test:8000/dom/events/Event-propagation.html:19:5
00:39:28 INFO - Test.prototype.step@http://web-platform.test:8000/resources/testharness.js:1382:20
00:39:28 INFO - test@http://web-platform.test:8000/resources/testharness.js:496:9
00:39:28 INFO - testPropagationFlag@http://web-platform.test:8000/dom/events/Event-propagation.html:11:3
00:39:28 INFO - @http://web-platform.test:8000/dom/events/Event-propagation.html:28:1
00:39:28 INFO - TEST-PASS | /dom/events/Event-propagation.html | Reinitialized after stopPropagation()
00:39:28 INFO - TEST-FAIL | /dom/events/Event-propagation.html | After stopImmediatePropagation() - assert_equals: Propagation flag expected false but got true
00:39:28 INFO - testPropagationFlag/<@http://web-platform.test:8000/dom/events/Event-propagation.html:19:5
00:39:28 INFO - Test.prototype.step@http://web-platform.test:8000/resources/testharness.js:1382:20
00:39:28 INFO - test@http://web-platform.test:8000/resources/testharness.js:496:9
00:39:28 INFO - testPropagationFlag@http://web-platform.test:8000/dom/events/Event-propagation.html:11:3
00:39:28 INFO - @http://web-platform.test:8000/dom/events/Event-propagation.html:35:1
00:39:28 INFO - TEST-PASS | /dom/events/Event-propagation.html | Reinitialized after stopImmediatePropagation()
00:39:28 INFO - TEST-OK | /dom/events/Event-propagation.html | took 569ms
00:39:28 INFO - PROCESS | 1768 | 1462347568261 Marionette TRACE conn2 -> [0,2751,"getWindowHandle",null]
00:39:28 INFO - TEST-START | /dom/events/Event-type-empty.html
00:39:28 INFO - PROCESS | 1768 | 1462347568262 Marionette TRACE conn2 <- [1,2751,null,{"value":"7"}]
00:39:28 INFO - PROCESS | 1768 | 1462347568264 Marionette TRACE conn2 -> [0,2752,"setScriptTimeout",{"ms":35000}]
00:39:28 INFO - PROCESS | 1768 | 1462347568266 Marionette TRACE conn2 <- [1,2752,null,{}]
00:39:28 INFO - PROCESS | 1768 | 1462347568268 Marionette TRACE conn2 -> [0,2753,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"executormarionette.py","script":"if (window.wrappedJSObject.win) {window.wrappedJSObject.win.close()}","sandbox":"default","line":398}]
00:39:28 INFO - PROCESS | 1768 | 1462347568369 Marionette TRACE conn2 <- [1,2753,null,{"value":null}]
00:39:28 INFO - PROCESS | 1768 | 1462347568445 Marionette TRACE conn2 -> [0,2754,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":false,"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distributed with this\n * file, You can obtain one at http://mozilla.org/MPL/2.0/. */\n\nwindow.wrappedJSObject.timeout_multiplier = 3;\nwindow.wrappedJSObject.explicit_timeout = 0;\n\nwindow.wrappedJSObject.addEventListener(\"message\", function listener(event) {\n if (event.data.type != \"complete\") {\n return;\n }\n window.wrappedJSObject.removeEventListener(\"message\", listener);\n clearTimeout(timer);\n var tests = event.data.tests;\n var status = event.data.status;\n\n var subtest_results = tests.map(function(x) {\n return [x.name, x.status, x.message, x.stack]\n });\n\n marionetteScriptFinished([\"/dom/events/Event-type-empty.html\",\n status.status,\n status.message,\n status.stack,\n subtest_results]);\n}, false);\n\nwindow.wrappedJSObject.win = window.open(\"http://web-platform.test:8000/dom/events/Event-type-empty.html\", \"2ced755f-84b6-4663-9dfa-fcbe7c8049e0\");\n\nvar timer = null;\nif (30000) {\n timer = setTimeout(function() {\n log(\"Timeout fired\");\n window.wrappedJSObject.win.timeout();\n }, 30000);\n}\n","newSandbox":false,"line":412,"args":[],"filename":"executormarionette.py"}]
00:39:28 INFO - PROCESS | 1768 | ++DOCSHELL 0x12c829800 == 60 [pid = 1768] [id = 763]
00:39:28 INFO - PROCESS | 1768 | ++DOMWINDOW == 184 (0x11bbeac00) [pid = 1768] [serial = 2236] [outer = 0x0]
00:39:28 INFO - PROCESS | 1768 | ++DOMWINDOW == 185 (0x12b36a400) [pid = 1768] [serial = 2237] [outer = 0x11bbeac00]
00:39:28 INFO - PROCESS | 1768 | 1462347568520 Marionette DEBUG loaded listener.js
00:39:28 INFO - PROCESS | 1768 | ++DOMWINDOW == 186 (0x12bf2a000) [pid = 1768] [serial = 2238] [outer = 0x11bbeac00]
00:39:28 INFO - PROCESS | 1768 | 1462347568865 Marionette TRACE conn2 <- [1,2754,null,{"value":["/dom/events/Event-type-empty.html",0,null,null,[["initEvent",0,null,null],["Constructor",0,null,null]]]}]
00:39:28 INFO - TEST-PASS | /dom/events/Event-type-empty.html | initEvent
00:39:28 INFO - TEST-PASS | /dom/events/Event-type-empty.html | Constructor
00:39:28 INFO - TEST-OK | /dom/events/Event-type-empty.html | took 619ms
00:39:28 INFO - TEST-START | /dom/events/Event-type.html
00:39:28 INFO - PROCESS | 1768 | 1462347568883 Marionette TRACE conn2 -> [0,2755,"getWindowHandle",null]
00:39:28 INFO - PROCESS | 1768 | 1462347568885 Marionette TRACE conn2 <- [1,2755,null,{"value":"7"}]
00:39:28 INFO - PROCESS | 1768 | 1462347568887 Marionette TRACE conn2 -> [0,2756,"setScriptTimeout",{"ms":35000}]
00:39:28 INFO - PROCESS | 1768 | 1462347568888 Marionette TRACE conn2 <- [1,2756,null,{}]
00:39:28 INFO - PROCESS | 1768 | 1462347568891 Marionette TRACE conn2 -> [0,2757,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"executormarionette.py","script":"if (window.wrappedJSObject.win) {window.wrappedJSObject.win.close()}","sandbox":"default","line":398}]
00:39:29 INFO - PROCESS | 1768 | 1462347569088 Marionette TRACE conn2 <- [1,2757,null,{"value":null}]
00:39:29 INFO - PROCESS | 1768 | 1462347569215 Marionette TRACE conn2 -> [0,2758,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":false,"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distributed with this\n * file, You can obtain one at http://mozilla.org/MPL/2.0/. */\n\nwindow.wrappedJSObject.timeout_multiplier = 3;\nwindow.wrappedJSObject.explicit_timeout = 0;\n\nwindow.wrappedJSObject.addEventListener(\"message\", function listener(event) {\n if (event.data.type != \"complete\") {\n return;\n }\n window.wrappedJSObject.removeEventListener(\"message\", listener);\n clearTimeout(timer);\n var tests = event.data.tests;\n var status = event.data.status;\n\n var subtest_results = tests.map(function(x) {\n return [x.name, x.status, x.message, x.stack]\n });\n\n marionetteScriptFinished([\"/dom/events/Event-type.html\",\n status.status,\n status.message,\n status.stack,\n subtest_results]);\n}, false);\n\nwindow.wrappedJSObject.win = window.open(\"http://web-platform.test:8000/dom/events/Event-type.html\", \"2ced755f-84b6-4663-9dfa-fcbe7c8049e0\");\n\nvar timer = null;\nif (30000) {\n timer = setTimeout(function() {\n log(\"Timeout fired\");\n window.wrappedJSObject.win.timeout();\n }, 30000);\n}\n","newSandbox":false,"line":412,"args":[],"filename":"executormarionette.py"}]
00:39:29 INFO - PROCESS | 1768 | ++DOCSHELL 0x129b95000 == 61 [pid = 1768] [id = 764]
00:39:29 INFO - PROCESS | 1768 | ++DOMWINDOW == 187 (0x1150b7400) [pid = 1768] [serial = 2239] [outer = 0x0]
00:39:29 INFO - PROCESS | 1768 | ++DOMWINDOW == 188 (0x1150ef400) [pid = 1768] [serial = 2240] [outer = 0x1150b7400]
00:39:29 INFO - PROCESS | 1768 | 1462347569247 Marionette DEBUG loaded listener.js
00:39:29 INFO - PROCESS | 1768 | ++DOMWINDOW == 189 (0x116710c00) [pid = 1768] [serial = 2241] [outer = 0x1150b7400]
00:39:29 INFO - PROCESS | 1768 | 1462347569627 Marionette TRACE conn2 <- [1,2758,null,{"value":["/dom/events/Event-type.html",0,null,null,[["Event.type should initially be the empty string",0,null,null],["Event.type should be initialized by initEvent",0,null,null],["Event.type should be initialized by the constructor",0,null,null]]]}]
00:39:29 INFO - TEST-PASS | /dom/events/Event-type.html | Event.type should initially be the empty string
00:39:29 INFO - TEST-PASS | /dom/events/Event-type.html | Event.type should be initialized by initEvent
00:39:29 INFO - TEST-PASS | /dom/events/Event-type.html | Event.type should be initialized by the constructor
00:39:29 INFO - TEST-OK | /dom/events/Event-type.html | took 770ms
00:39:29 INFO - TEST-START | /dom/events/EventTarget-addEventListener.html
00:39:29 INFO - PROCESS | 1768 | 1462347569680 Marionette TRACE conn2 -> [0,2759,"getWindowHandle",null]
00:39:29 INFO - PROCESS | 1768 | 1462347569683 Marionette TRACE conn2 <- [1,2759,null,{"value":"7"}]
00:39:29 INFO - PROCESS | 1768 | 1462347569686 Marionette TRACE conn2 -> [0,2760,"setScriptTimeout",{"ms":35000}]
00:39:29 INFO - PROCESS | 1768 | 1462347569687 Marionette TRACE conn2 <- [1,2760,null,{}]
00:39:29 INFO - PROCESS | 1768 | 1462347569703 Marionette TRACE conn2 -> [0,2761,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"executormarionette.py","script":"if (window.wrappedJSObject.win) {window.wrappedJSObject.win.close()}","sandbox":"default","line":398}]
00:39:29 INFO - PROCESS | 1768 | 1462347569840 Marionette TRACE conn2 <- [1,2761,null,{"value":null}]
00:39:29 INFO - PROCESS | 1768 | --DOCSHELL 0x12ff97800 == 60 [pid = 1768] [id = 754]
00:39:29 INFO - PROCESS | 1768 | --DOCSHELL 0x131111000 == 59 [pid = 1768] [id = 753]
00:39:29 INFO - PROCESS | 1768 | --DOCSHELL 0x11c921000 == 58 [pid = 1768] [id = 752]
00:39:29 INFO - PROCESS | 1768 | --DOCSHELL 0x12b387000 == 57 [pid = 1768] [id = 751]
00:39:29 INFO - PROCESS | 1768 | --DOCSHELL 0x13a807000 == 56 [pid = 1768] [id = 750]
00:39:29 INFO - PROCESS | 1768 | --DOCSHELL 0x13a213000 == 55 [pid = 1768] [id = 749]
00:39:29 INFO - PROCESS | 1768 | --DOMWINDOW == 188 (0x12c8da800) [pid = 1768] [serial = 2139] [outer = 0x0] [url = about:blank]
00:39:29 INFO - PROCESS | 1768 | --DOCSHELL 0x13096f000 == 54 [pid = 1768] [id = 748]
00:39:29 INFO - PROCESS | 1768 | --DOCSHELL 0x11a049000 == 53 [pid = 1768] [id = 747]
00:39:29 INFO - PROCESS | 1768 | --DOCSHELL 0x12ed1f800 == 52 [pid = 1768] [id = 746]
00:39:29 INFO - PROCESS | 1768 | --DOCSHELL 0x12bf14000 == 51 [pid = 1768] [id = 745]
00:39:29 INFO - PROCESS | 1768 | --DOCSHELL 0x11bd56000 == 50 [pid = 1768] [id = 744]
00:39:29 INFO - PROCESS | 1768 | --DOCSHELL 0x115718800 == 49 [pid = 1768] [id = 743]
00:39:29 INFO - PROCESS | 1768 | --DOCSHELL 0x114f43800 == 48 [pid = 1768] [id = 742]
00:39:29 INFO - PROCESS | 1768 | --DOCSHELL 0x11b23a000 == 47 [pid = 1768] [id = 741]
00:39:29 INFO - PROCESS | 1768 | --DOCSHELL 0x119b0f000 == 46 [pid = 1768] [id = 740]
00:39:29 INFO - PROCESS | 1768 | --DOCSHELL 0x11cca6800 == 45 [pid = 1768] [id = 739]
00:39:29 INFO - PROCESS | 1768 | --DOCSHELL 0x11cca4800 == 44 [pid = 1768] [id = 738]
00:39:29 INFO - PROCESS | 1768 | --DOCSHELL 0x11cca3000 == 43 [pid = 1768] [id = 737]
00:39:29 INFO - PROCESS | 1768 | --DOCSHELL 0x130bf8000 == 42 [pid = 1768] [id = 736]
00:39:29 INFO - PROCESS | 1768 | --DOCSHELL 0x1421f5800 == 41 [pid = 1768] [id = 735]
00:39:29 INFO - PROCESS | 1768 | --DOCSHELL 0x1421ec000 == 40 [pid = 1768] [id = 734]
00:39:29 INFO - PROCESS | 1768 | --DOCSHELL 0x127fe6800 == 39 [pid = 1768] [id = 733]
00:39:29 INFO - PROCESS | 1768 | --DOCSHELL 0x1421df800 == 38 [pid = 1768] [id = 732]
00:39:29 INFO - PROCESS | 1768 | --DOCSHELL 0x11c68a800 == 37 [pid = 1768] [id = 729]
00:39:29 INFO - PROCESS | 1768 | --DOCSHELL 0x13a229000 == 36 [pid = 1768] [id = 728]
00:39:29 INFO - PROCESS | 1768 | 1462347569883 Marionette TRACE conn2 -> [0,2762,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":false,"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distributed with this\n * file, You can obtain one at http://mozilla.org/MPL/2.0/. */\n\nwindow.wrappedJSObject.timeout_multiplier = 3;\nwindow.wrappedJSObject.explicit_timeout = 0;\n\nwindow.wrappedJSObject.addEventListener(\"message\", function listener(event) {\n if (event.data.type != \"complete\") {\n return;\n }\n window.wrappedJSObject.removeEventListener(\"message\", listener);\n clearTimeout(timer);\n var tests = event.data.tests;\n var status = event.data.status;\n\n var subtest_results = tests.map(function(x) {\n return [x.name, x.status, x.message, x.stack]\n });\n\n marionetteScriptFinished([\"/dom/events/EventTarget-addEventListener.html\",\n status.status,\n status.message,\n status.stack,\n subtest_results]);\n}, false);\n\nwindow.wrappedJSObject.win = window.open(\"http://web-platform.test:8000/dom/events/EventTarget-addEventListener.html\", \"2ced755f-84b6-4663-9dfa-fcbe7c8049e0\");\n\nvar timer = null;\nif (30000) {\n timer = setTimeout(function() {\n log(\"Timeout fired\");\n window.wrappedJSObject.win.timeout();\n }, 30000);\n}\n","newSandbox":false,"line":412,"args":[],"filename":"executormarionette.py"}]
00:39:29 INFO - PROCESS | 1768 | ++DOCSHELL 0x1190d1000 == 37 [pid = 1768] [id = 765]
00:39:29 INFO - PROCESS | 1768 | ++DOMWINDOW == 189 (0x1150e4800) [pid = 1768] [serial = 2242] [outer = 0x0]
00:39:29 INFO - PROCESS | 1768 | ++DOMWINDOW == 190 (0x1167a0000) [pid = 1768] [serial = 2243] [outer = 0x1150e4800]
00:39:29 INFO - PROCESS | 1768 | 1462347569913 Marionette DEBUG loaded listener.js
00:39:29 INFO - PROCESS | 1768 | ++DOMWINDOW == 191 (0x11c013c00) [pid = 1768] [serial = 2244] [outer = 0x1150e4800]
00:39:30 INFO - PROCESS | 1768 | --DOMWINDOW == 190 (0x12b36d800) [pid = 1768] [serial = 2102] [outer = 0x0] [url = about:blank]
00:39:30 INFO - PROCESS | 1768 | --DOMWINDOW == 189 (0x12650c800) [pid = 1768] [serial = 2110] [outer = 0x0] [url = about:blank]
00:39:30 INFO - PROCESS | 1768 | --DOMWINDOW == 188 (0x11530c800) [pid = 1768] [serial = 2104] [outer = 0x0] [url = about:blank]
00:39:30 INFO - PROCESS | 1768 | --DOMWINDOW == 187 (0x11bbe3800) [pid = 1768] [serial = 2107] [outer = 0x0] [url = about:blank]
00:39:30 INFO - PROCESS | 1768 | --DOMWINDOW == 186 (0x12652f800) [pid = 1768] [serial = 2131] [outer = 0x0] [url = http://www1.web-platform.test:8000/cors/resources/remote-xhrer.html]
00:39:30 INFO - PROCESS | 1768 | --DOMWINDOW == 185 (0x12c25b800) [pid = 1768] [serial = 2134] [outer = 0x0] [url = about:blank]
00:39:30 INFO - PROCESS | 1768 | --DOMWINDOW == 184 (0x12c263400) [pid = 1768] [serial = 2136] [outer = 0x0] [url = about:blank]
00:39:30 INFO - PROCESS | 1768 | --DOMWINDOW == 183 (0x12ba13c00) [pid = 1768] [serial = 2129] [outer = 0x0] [url = about:blank]
00:39:30 INFO - PROCESS | 1768 | --DOMWINDOW == 182 (0x11c591c00) [pid = 1768] [serial = 2119] [outer = 0x0] [url = about:blank]
00:39:30 INFO - PROCESS | 1768 | --DOMWINDOW == 181 (0x1271c9c00) [pid = 1768] [serial = 2123] [outer = 0x0] [url = about:blank]
00:39:30 INFO - PROCESS | 1768 | --DOMWINDOW == 180 (0x12603c000) [pid = 1768] [serial = 2120] [outer = 0x0] [url = about:blank]
00:39:30 INFO - PROCESS | 1768 | --DOMWINDOW == 179 (0x116578400) [pid = 1768] [serial = 2117] [outer = 0x0] [url = about:blank]
00:39:30 INFO - PROCESS | 1768 | --DOMWINDOW == 178 (0x12c214000) [pid = 1768] [serial = 2133] [outer = 0x0] [url = about:blank]
00:39:30 INFO - PROCESS | 1768 | --DOMWINDOW == 177 (0x12c853000) [pid = 1768] [serial = 2137] [outer = 0x0] [url = about:blank]
00:39:30 INFO - PROCESS | 1768 | --DOMWINDOW == 176 (0x126531800) [pid = 1768] [serial = 2122] [outer = 0x0] [url = about:blank]
00:39:30 INFO - PROCESS | 1768 | --DOMWINDOW == 175 (0x129740800) [pid = 1768] [serial = 2125] [outer = 0x0] [url = about:blank]
00:39:30 INFO - PROCESS | 1768 | --DOMWINDOW == 174 (0x12ba05800) [pid = 1768] [serial = 2128] [outer = 0x0] [url = about:blank]
00:39:30 INFO - PROCESS | 1768 | --DOMWINDOW == 173 (0x1150edc00) [pid = 1768] [serial = 2116] [outer = 0x0] [url = about:blank]
00:39:30 INFO - PROCESS | 1768 | --DOMWINDOW == 172 (0x12a15ec00) [pid = 1768] [serial = 2113] [outer = 0x0] [url = about:blank]
00:39:30 INFO - PROCESS | 1768 | --DOMWINDOW == 171 (0x12b370800) [pid = 1768] [serial = 2126] [outer = 0x0] [url = about:blank]
00:39:30 INFO - PROCESS | 1768 | 1462347570232 Marionette TRACE conn2 <- [1,2762,null,{"value":["/dom/events/EventTarget-addEventListener.html",0,null,null,[["Adding a null event listener should succeed",0,null,null]]]}]
00:39:30 INFO - TEST-PASS | /dom/events/EventTarget-addEventListener.html | Adding a null event listener should succeed
00:39:30 INFO - TEST-OK | /dom/events/EventTarget-addEventListener.html | took 570ms
00:39:30 INFO - PROCESS | 1768 | 1462347570264 Marionette TRACE conn2 -> [0,2763,"getWindowHandle",null]
00:39:30 INFO - PROCESS | 1768 | 1462347570266 Marionette TRACE conn2 <- [1,2763,null,{"value":"7"}]
00:39:30 INFO - TEST-START | /dom/events/EventTarget-dispatchEvent-returnvalue.html
00:39:30 INFO - PROCESS | 1768 | 1462347570271 Marionette TRACE conn2 -> [0,2764,"setScriptTimeout",{"ms":35000}]
00:39:30 INFO - PROCESS | 1768 | 1462347570272 Marionette TRACE conn2 <- [1,2764,null,{}]
00:39:30 INFO - PROCESS | 1768 | 1462347570275 Marionette TRACE conn2 -> [0,2765,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"executormarionette.py","script":"if (window.wrappedJSObject.win) {window.wrappedJSObject.win.close()}","sandbox":"default","line":398}]
00:39:30 INFO - PROCESS | 1768 | 1462347570358 Marionette TRACE conn2 <- [1,2765,null,{"value":null}]
00:39:30 INFO - PROCESS | 1768 | 1462347570369 Marionette TRACE conn2 -> [0,2766,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":false,"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distributed with this\n * file, You can obtain one at http://mozilla.org/MPL/2.0/. */\n\nwindow.wrappedJSObject.timeout_multiplier = 3;\nwindow.wrappedJSObject.explicit_timeout = 0;\n\nwindow.wrappedJSObject.addEventListener(\"message\", function listener(event) {\n if (event.data.type != \"complete\") {\n return;\n }\n window.wrappedJSObject.removeEventListener(\"message\", listener);\n clearTimeout(timer);\n var tests = event.data.tests;\n var status = event.data.status;\n\n var subtest_results = tests.map(function(x) {\n return [x.name, x.status, x.message, x.stack]\n });\n\n marionetteScriptFinished([\"/dom/events/EventTarget-dispatchEvent-returnvalue.html\",\n status.status,\n status.message,\n status.stack,\n subtest_results]);\n}, false);\n\nwindow.wrappedJSObject.win = window.open(\"http://web-platform.test:8000/dom/events/EventTarget-dispatchEvent-returnvalue.html\", \"2ced755f-84b6-4663-9dfa-fcbe7c8049e0\");\n\nvar timer = null;\nif (30000) {\n timer = setTimeout(function() {\n log(\"Timeout fired\");\n window.wrappedJSObject.win.timeout();\n }, 30000);\n}\n","newSandbox":false,"line":412,"args":[],"filename":"executormarionette.py"}]
00:39:30 INFO - PROCESS | 1768 | ++DOCSHELL 0x12a143800 == 38 [pid = 1768] [id = 766]
00:39:30 INFO - PROCESS | 1768 | ++DOMWINDOW == 172 (0x126249800) [pid = 1768] [serial = 2245] [outer = 0x0]
00:39:30 INFO - PROCESS | 1768 | ++DOMWINDOW == 173 (0x12650b800) [pid = 1768] [serial = 2246] [outer = 0x126249800]
00:39:30 INFO - PROCESS | 1768 | 1462347570405 Marionette DEBUG loaded listener.js
00:39:30 INFO - PROCESS | 1768 | ++DOMWINDOW == 174 (0x126530400) [pid = 1768] [serial = 2247] [outer = 0x126249800]
00:39:30 INFO - PROCESS | 1768 | 1462347570887 Marionette TRACE conn2 <- [1,2766,null,{"value":["/dom/events/EventTarget-dispatchEvent-returnvalue.html",0,null,null,[["Return value of EventTarget.dispatchEvent.",0,null,null]]]}]
00:39:30 INFO - TEST-PASS | /dom/events/EventTarget-dispatchEvent-returnvalue.html | Return value of EventTarget.dispatchEvent.
00:39:30 INFO - TEST-OK | /dom/events/EventTarget-dispatchEvent-returnvalue.html | took 674ms
00:39:30 INFO - PROCESS | 1768 | 1462347570945 Marionette TRACE conn2 -> [0,2767,"getWindowHandle",null]
00:39:30 INFO - PROCESS | 1768 | 1462347570948 Marionette TRACE conn2 <- [1,2767,null,{"value":"7"}]
00:39:30 INFO - TEST-START | /dom/events/EventTarget-dispatchEvent.html
00:39:30 INFO - PROCESS | 1768 | 1462347570959 Marionette TRACE conn2 -> [0,2768,"setScriptTimeout",{"ms":35000}]
00:39:30 INFO - PROCESS | 1768 | 1462347570964 Marionette TRACE conn2 <- [1,2768,null,{}]
00:39:30 INFO - PROCESS | 1768 | 1462347570967 Marionette TRACE conn2 -> [0,2769,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"executormarionette.py","script":"if (window.wrappedJSObject.win) {window.wrappedJSObject.win.close()}","sandbox":"default","line":398}]
00:39:31 INFO - PROCESS | 1768 | 1462347571052 Marionette TRACE conn2 <- [1,2769,null,{"value":null}]
00:39:31 INFO - PROCESS | 1768 | 1462347571056 Marionette TRACE conn2 -> [0,2770,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":false,"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distributed with this\n * file, You can obtain one at http://mozilla.org/MPL/2.0/. */\n\nwindow.wrappedJSObject.timeout_multiplier = 3;\nwindow.wrappedJSObject.explicit_timeout = 0;\n\nwindow.wrappedJSObject.addEventListener(\"message\", function listener(event) {\n if (event.data.type != \"complete\") {\n return;\n }\n window.wrappedJSObject.removeEventListener(\"message\", listener);\n clearTimeout(timer);\n var tests = event.data.tests;\n var status = event.data.status;\n\n var subtest_results = tests.map(function(x) {\n return [x.name, x.status, x.message, x.stack]\n });\n\n marionetteScriptFinished([\"/dom/events/EventTarget-dispatchEvent.html\",\n status.status,\n status.message,\n status.stack,\n subtest_results]);\n}, false);\n\nwindow.wrappedJSObject.win = window.open(\"http://web-platform.test:8000/dom/events/EventTarget-dispatchEvent.html\", \"2ced755f-84b6-4663-9dfa-fcbe7c8049e0\");\n\nvar timer = null;\nif (30000) {\n timer = setTimeout(function() {\n log(\"Timeout fired\");\n window.wrappedJSObject.win.timeout();\n }, 30000);\n}\n","newSandbox":false,"line":412,"args":[],"filename":"executormarionette.py"}]
00:39:31 INFO - PROCESS | 1768 | ++DOCSHELL 0x12ed16800 == 39 [pid = 1768] [id = 767]
00:39:31 INFO - PROCESS | 1768 | ++DOMWINDOW == 175 (0x126b58000) [pid = 1768] [serial = 2248] [outer = 0x0]
00:39:31 INFO - PROCESS | 1768 | ++DOMWINDOW == 176 (0x129b60800) [pid = 1768] [serial = 2249] [outer = 0x126b58000]
00:39:31 INFO - PROCESS | 1768 | 1462347571085 Marionette DEBUG loaded listener.js
00:39:31 INFO - PROCESS | 1768 | ++DOMWINDOW == 177 (0x12a322400) [pid = 1768] [serial = 2250] [outer = 0x126b58000]
00:39:31 INFO - PROCESS | 1768 | JavaScript error: http://web-platform.test:8000/dom/events/EventTarget-dispatchEvent.html, line 20: TypeError: aliases.forEach is not a function
00:39:31 INFO - PROCESS | 1768 | 1462347571418 Marionette TRACE conn2 <- [1,2770,null,{"value":["/dom/events/EventTarget-dispatchEvent.html",0,null,null,[["Calling dispatchEvent(null).",0,null,null]]]}]
00:39:31 INFO - TEST-PASS | /dom/events/EventTarget-dispatchEvent.html | Calling dispatchEvent(null).
00:39:31 INFO - TEST-OK | /dom/events/EventTarget-dispatchEvent.html | took 478ms
00:39:31 INFO - TEST-START | /dom/events/EventTarget-removeEventListener.html
00:39:31 INFO - PROCESS | 1768 | 1462347571432 Marionette TRACE conn2 -> [0,2771,"getWindowHandle",null]
00:39:31 INFO - PROCESS | 1768 | 1462347571433 Marionette TRACE conn2 <- [1,2771,null,{"value":"7"}]
00:39:31 INFO - PROCESS | 1768 | 1462347571435 Marionette TRACE conn2 -> [0,2772,"setScriptTimeout",{"ms":35000}]
00:39:31 INFO - PROCESS | 1768 | 1462347571436 Marionette TRACE conn2 <- [1,2772,null,{}]
00:39:31 INFO - PROCESS | 1768 | 1462347571438 Marionette TRACE conn2 -> [0,2773,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"executormarionette.py","script":"if (window.wrappedJSObject.win) {window.wrappedJSObject.win.close()}","sandbox":"default","line":398}]
00:39:31 INFO - PROCESS | 1768 | 1462347571546 Marionette TRACE conn2 <- [1,2773,null,{"value":null}]
00:39:31 INFO - PROCESS | 1768 | 1462347571554 Marionette TRACE conn2 -> [0,2774,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":false,"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distributed with this\n * file, You can obtain one at http://mozilla.org/MPL/2.0/. */\n\nwindow.wrappedJSObject.timeout_multiplier = 3;\nwindow.wrappedJSObject.explicit_timeout = 0;\n\nwindow.wrappedJSObject.addEventListener(\"message\", function listener(event) {\n if (event.data.type != \"complete\") {\n return;\n }\n window.wrappedJSObject.removeEventListener(\"message\", listener);\n clearTimeout(timer);\n var tests = event.data.tests;\n var status = event.data.status;\n\n var subtest_results = tests.map(function(x) {\n return [x.name, x.status, x.message, x.stack]\n });\n\n marionetteScriptFinished([\"/dom/events/EventTarget-removeEventListener.html\",\n status.status,\n status.message,\n status.stack,\n subtest_results]);\n}, false);\n\nwindow.wrappedJSObject.win = window.open(\"http://web-platform.test:8000/dom/events/EventTarget-removeEventListener.html\", \"2ced755f-84b6-4663-9dfa-fcbe7c8049e0\");\n\nvar timer = null;\nif (30000) {\n timer = setTimeout(function() {\n log(\"Timeout fired\");\n window.wrappedJSObject.win.timeout();\n }, 30000);\n}\n","newSandbox":false,"line":412,"args":[],"filename":"executormarionette.py"}]
00:39:31 INFO - PROCESS | 1768 | ++DOCSHELL 0x12f1bf000 == 40 [pid = 1768] [id = 768]
00:39:31 INFO - PROCESS | 1768 | ++DOMWINDOW == 178 (0x12b36dc00) [pid = 1768] [serial = 2251] [outer = 0x0]
00:39:31 INFO - PROCESS | 1768 | ++DOMWINDOW == 179 (0x12ba0a000) [pid = 1768] [serial = 2252] [outer = 0x12b36dc00]
00:39:31 INFO - PROCESS | 1768 | 1462347571580 Marionette DEBUG loaded listener.js
00:39:31 INFO - PROCESS | 1768 | ++DOMWINDOW == 180 (0x12bbd6c00) [pid = 1768] [serial = 2253] [outer = 0x12b36dc00]
00:39:31 INFO - PROCESS | 1768 | 1462347571853 Marionette TRACE conn2 <- [1,2774,null,{"value":["/dom/events/EventTarget-removeEventListener.html",0,null,null,[["removing a null event listener should succeed",0,null,null]]]}]
00:39:31 INFO - TEST-PASS | /dom/events/EventTarget-removeEventListener.html | removing a null event listener should succeed
00:39:31 INFO - TEST-OK | /dom/events/EventTarget-removeEventListener.html | took 468ms
00:39:31 INFO - TEST-START | /dom/events/ProgressEvent.html
00:39:31 INFO - PROCESS | 1768 | 1462347571904 Marionette TRACE conn2 -> [0,2775,"getWindowHandle",null]
00:39:31 INFO - PROCESS | 1768 | 1462347571905 Marionette TRACE conn2 <- [1,2775,null,{"value":"7"}]
00:39:31 INFO - PROCESS | 1768 | 1462347571907 Marionette TRACE conn2 -> [0,2776,"setScriptTimeout",{"ms":35000}]
00:39:31 INFO - PROCESS | 1768 | 1462347571911 Marionette TRACE conn2 <- [1,2776,null,{}]
00:39:31 INFO - PROCESS | 1768 | 1462347571914 Marionette TRACE conn2 -> [0,2777,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"executormarionette.py","script":"if (window.wrappedJSObject.win) {window.wrappedJSObject.win.close()}","sandbox":"default","line":398}]
00:39:31 INFO - PROCESS | 1768 | 1462347571996 Marionette TRACE conn2 <- [1,2777,null,{"value":null}]
00:39:32 INFO - PROCESS | 1768 | 1462347572001 Marionette TRACE conn2 -> [0,2778,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":false,"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distributed with this\n * file, You can obtain one at http://mozilla.org/MPL/2.0/. */\n\nwindow.wrappedJSObject.timeout_multiplier = 3;\nwindow.wrappedJSObject.explicit_timeout = 0;\n\nwindow.wrappedJSObject.addEventListener(\"message\", function listener(event) {\n if (event.data.type != \"complete\") {\n return;\n }\n window.wrappedJSObject.removeEventListener(\"message\", listener);\n clearTimeout(timer);\n var tests = event.data.tests;\n var status = event.data.status;\n\n var subtest_results = tests.map(function(x) {\n return [x.name, x.status, x.message, x.stack]\n });\n\n marionetteScriptFinished([\"/dom/events/ProgressEvent.html\",\n status.status,\n status.message,\n status.stack,\n subtest_results]);\n}, false);\n\nwindow.wrappedJSObject.win = window.open(\"http://web-platform.test:8000/dom/events/ProgressEvent.html\", \"2ced755f-84b6-4663-9dfa-fcbe7c8049e0\");\n\nvar timer = null;\nif (30000) {\n timer = setTimeout(function() {\n log(\"Timeout fired\");\n window.wrappedJSObject.win.timeout();\n }, 30000);\n}\n","newSandbox":false,"line":412,"args":[],"filename":"executormarionette.py"}]
00:39:32 INFO - PROCESS | 1768 | ++DOCSHELL 0x12ff97800 == 41 [pid = 1768] [id = 769]
00:39:32 INFO - PROCESS | 1768 | ++DOMWINDOW == 181 (0x12c16a800) [pid = 1768] [serial = 2254] [outer = 0x0]
00:39:32 INFO - PROCESS | 1768 | ++DOMWINDOW == 182 (0x12c214800) [pid = 1768] [serial = 2255] [outer = 0x12c16a800]
00:39:32 INFO - PROCESS | 1768 | 1462347572033 Marionette DEBUG loaded listener.js
00:39:32 INFO - PROCESS | 1768 | ++DOMWINDOW == 183 (0x12c853000) [pid = 1768] [serial = 2256] [outer = 0x12c16a800]
00:39:32 INFO - PROCESS | 1768 | 1462347572379 Marionette TRACE conn2 <- [1,2778,null,{"value":["/dom/events/ProgressEvent.html",0,null,null,[["Default event values.",0,null,null],["document.createEvent() should not work with ProgressEvent.",0,null,null]]]}]
00:39:32 INFO - TEST-PASS | /dom/events/ProgressEvent.html | Default event values.
00:39:32 INFO - TEST-PASS | /dom/events/ProgressEvent.html | document.createEvent() should not work with ProgressEvent.
00:39:32 INFO - TEST-OK | /dom/events/ProgressEvent.html | took 522ms
00:39:32 INFO - PROCESS | 1768 | 1462347572430 Marionette TRACE conn2 -> [0,2779,"getWindowHandle",null]
00:39:32 INFO - PROCESS | 1768 | 1462347572431 Marionette TRACE conn2 <- [1,2779,null,{"value":"7"}]
00:39:33 WARNING - u'runner_teardown' ()
00:39:33 INFO - No more tests
00:39:33 INFO - Got 0 unexpected results
00:39:33 INFO - SUITE-END | took 1506s
00:39:33 INFO - Closing logging queue
00:39:33 INFO - queue closed
00:39:33 INFO - Return code: 0
00:39:33 WARNING - # TBPL SUCCESS #
00:39:33 INFO - Running post-action listener: _resource_record_post_action
00:39:33 INFO - Running post-run listener: _resource_record_post_run
00:39:34 INFO - Total resource usage - Wall time: 1530s; CPU: 43.0%; Read bytes: 34706432; Write bytes: 1041545216; Read time: 361; Write time: 5730
00:39:34 INFO - pull - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
00:39:34 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 173318656; Write bytes: 171341824; Read time: 14184; Write time: 409
00:39:34 INFO - run-tests - Wall time: 1510s; CPU: 43.0%; Read bytes: 33768448; Write bytes: 839847936; Read time: 339; Write time: 5265
00:39:34 INFO - Running post-run listener: _upload_blobber_files
00:39:34 INFO - Blob upload gear active.
00:39:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir.
00:39:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with
branch at the following location(s): https://blobupload.elasticbeanstalk.com
00:39:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'fx-team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json']
00:39:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b fx-team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json
00:39:35 INFO - (blobuploader) - INFO - Open directory for files ...
00:39:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/wpt_errorsummary.log ...
00:39:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
00:39:35 INFO - (blobuploader) - INFO - Uploading, attempt #1.
00:39:35 INFO - (blobuploader) - INFO - TinderboxPrint: wpt_errorsummary.log: uploaded
00:39:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
00:39:35 INFO - (blobuploader) - INFO - Done attempting.
00:39:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/wpt_raw.log ...
00:39:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
00:39:36 INFO - (blobuploader) - INFO - Uploading, attempt #1.
00:39:37 INFO - (blobuploader) - INFO - TinderboxPrint: wpt_raw.log: uploaded
00:39:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
00:39:37 INFO - (blobuploader) - INFO - Done attempting.
00:39:37 INFO - (blobuploader) - INFO - Iteration through files over.
00:39:37 INFO - Return code: 0
00:39:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json
00:39:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1
00:39:37 INFO - Setting buildbot property blobber_files to {"wpt_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/fx-team/sha512/8ed7658e6b95fc0e08b332a383b8eaa0ef77ce850f01e189366f86c8dba31b69f0b373efcb5dcd5fa4ae2206d0928a3221c97e754db22e23d97960b6aeed2307", "wpt_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/fx-team/sha512/53a651bdb59cb88dac410cd0c5114939ea47833dc9eeae7ccc06528a1ee3b56b70dc282e48fb3dd8ef7b399d0ebaf87c92e37dcbe27f6610006a6fece3ef880c"}
00:39:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files
00:39:37 INFO - Writing to file /builds/slave/test/properties/blobber_files
00:39:37 INFO - Contents:
00:39:37 INFO - blobber_files:{"wpt_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/fx-team/sha512/8ed7658e6b95fc0e08b332a383b8eaa0ef77ce850f01e189366f86c8dba31b69f0b373efcb5dcd5fa4ae2206d0928a3221c97e754db22e23d97960b6aeed2307", "wpt_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/fx-team/sha512/53a651bdb59cb88dac410cd0c5114939ea47833dc9eeae7ccc06528a1ee3b56b70dc282e48fb3dd8ef7b399d0ebaf87c92e37dcbe27f6610006a6fece3ef880c"}
00:39:37 INFO - Running post-run listener: copy_logs_to_upload_dir
00:39:37 INFO - Copying logs to upload dir...
00:39:37 INFO - mkdir: /builds/slave/test/build/upload/logs
00:39:37 INFO - Copying logs to upload dir...
program finished with exit code 0
elapsedTime=2490.074242
========= master_lag: 9.32 =========
========= Finished '/tools/buildbot/bin/python scripts/scripts/web_platform_tests.py ...' (results: 0, elapsed: 41 mins, 39 secs) (at 2016-05-04 00:39:46.081220) =========
========= Started set props: build_url blobber_files symbols_url (results: 0, elapsed: 3 secs) (at 2016-05-04 00:39:46.090155) =========
bash -c 'for file in `ls -1`; do cat $file; done'
in dir /builds/slave/test/properties (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done']
environment:
Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ExU3ExQwVj/Render
GIT_SHARE_BASE_DIR=/builds/git-shared
HG_SHARE_BASE_DIR=/builds/hg-shared
HOME=/Users/cltbld
IDLEIZER_DISABLE_SHUTDOWN=true
LOGNAME=cltbld
PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
PWD=/builds/slave/test/properties
RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
SHELL=/bin/bash
SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.PNyT7S59wE/Listeners
TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/
TWISTD_LOG_PATH=/builds/slave/twistd.log
USER=cltbld
VERSIONER_PYTHON_PREFER_32_BIT=no
VERSIONER_PYTHON_VERSION=2.7
XPC_FLAGS=0x0
XPC_SERVICE_NAME=0
__CF_USER_TEXT_ENCODING=0x1C:0:0
using PTY: False
blobber_files:{"wpt_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/fx-team/sha512/8ed7658e6b95fc0e08b332a383b8eaa0ef77ce850f01e189366f86c8dba31b69f0b373efcb5dcd5fa4ae2206d0928a3221c97e754db22e23d97960b6aeed2307", "wpt_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/fx-team/sha512/53a651bdb59cb88dac410cd0c5114939ea47833dc9eeae7ccc06528a1ee3b56b70dc282e48fb3dd8ef7b399d0ebaf87c92e37dcbe27f6610006a6fece3ef880c"}
build_url:https://queue.taskcluster.net/v1/task/VZpwFx4_QS-DTebSd7tiOw/artifacts/public/build/firefox-49.0a1.en-US.mac64.dmg
symbols_url:https://queue.taskcluster.net/v1/task/VZpwFx4_QS-DTebSd7tiOw/artifacts/public/build/firefox-49.0a1.en-US.mac64.crashreporter-symbols.zip
program finished with exit code 0
elapsedTime=0.012846
build_url: 'https://queue.taskcluster.net/v1/task/VZpwFx4_QS-DTebSd7tiOw/artifacts/public/build/firefox-49.0a1.en-US.mac64.dmg'
blobber_files: '{"wpt_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/fx-team/sha512/8ed7658e6b95fc0e08b332a383b8eaa0ef77ce850f01e189366f86c8dba31b69f0b373efcb5dcd5fa4ae2206d0928a3221c97e754db22e23d97960b6aeed2307", "wpt_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/fx-team/sha512/53a651bdb59cb88dac410cd0c5114939ea47833dc9eeae7ccc06528a1ee3b56b70dc282e48fb3dd8ef7b399d0ebaf87c92e37dcbe27f6610006a6fece3ef880c"}'
symbols_url: 'https://queue.taskcluster.net/v1/task/VZpwFx4_QS-DTebSd7tiOw/artifacts/public/build/firefox-49.0a1.en-US.mac64.crashreporter-symbols.zip'
========= master_lag: 3.61 =========
========= Finished set props: build_url blobber_files symbols_url (results: 0, elapsed: 3 secs) (at 2016-05-04 00:39:49.717581) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 00:39:49.717969) =========
rm -f oauth.txt
in dir /builds/slave/test/. (timeout 1200 secs)
watching logfiles {}
argv: ['rm', '-f', 'oauth.txt']
environment:
Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ExU3ExQwVj/Render
GIT_SHARE_BASE_DIR=/builds/git-shared
HG_SHARE_BASE_DIR=/builds/hg-shared
HOME=/Users/cltbld
IDLEIZER_DISABLE_SHUTDOWN=true
LOGNAME=cltbld
PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
PWD=/builds/slave/test
RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
SHELL=/bin/bash
SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.PNyT7S59wE/Listeners
TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/
TWISTD_LOG_PATH=/builds/slave/twistd.log
USER=cltbld
VERSIONER_PYTHON_PREFER_32_BIT=no
VERSIONER_PYTHON_VERSION=2.7
XPC_FLAGS=0x0
XPC_SERVICE_NAME=0
__CF_USER_TEXT_ENCODING=0x1C:0:0
using PTY: False
program finished with exit code 0
elapsedTime=0.004883
========= master_lag: 0.19 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 00:39:49.915966) =========
========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-04 00:39:49.916276) =========
========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-04 00:39:50.256590) =========
========= Total master_lag: 13.18 =========