Closed Bug 1515967 Opened 6 years ago Closed 6 years ago

Intermittent toolkit/components/extensions/test/mochitest/test_ext_storage_cleanup.html | Test timed out.

Categories

(WebExtensions :: General, defect, P5)

Product:
WebExtensions
Component:
General
Type:
defect

Tracking

(Not tracked)

Status:
RESOLVED DUPLICATE of bug 1516136

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, Whiteboard: [retriggered])

Filed by: rgurzau [at] mozilla.com https://treeherder.mozilla.org/logviewer.html#?job_id=218352472&repo=mozilla-inbound https://queue.taskcluster.net/v1/task/EHZPfI5_R5mGyH3SAXYZSQ/runs/0/artifacts/public/logs/live_backing.log [task 2018-12-21T15:55:05.442Z] 15:55:05 INFO - TEST-START | toolkit/components/extensions/test/mochitest/test_ext_storage_cleanup.html [task 2018-12-21T15:55:05.466Z] 15:55:05 INFO - GECKO(3136) | ++DOMWINDOW == 7 (0x7fcecdabe400) [pid = 3236] [serial = 7] [outer = 0x7fcece55c800] [task 2018-12-21T15:55:06.554Z] 15:55:06 INFO - GECKO(3136) | ++DOMWINDOW == 8 (0x7fcecd6c8c00) [pid = 3236] [serial = 8] [outer = 0x7fcece55c800] [task 2018-12-21T15:55:06.996Z] 15:55:06 INFO - GECKO(3136) | [Parent 3136, Main Thread] WARNING: Found a principal with no URI, assuming third-party request: file /builds/worker/workspace/build/src/dom/base/ThirdPartyUtil.cpp, line 226 [task 2018-12-21T15:55:06.997Z] 15:55:06 INFO - GECKO(3136) | [Parent 3136, Main Thread] WARNING: Found a principal with no URI, assuming third-party request: file /builds/worker/workspace/build/src/dom/base/ThirdPartyUtil.cpp, line 226 [task 2018-12-21T15:55:07.079Z] 15:55:07 INFO - GECKO(3136) | Console message: [JavaScript Warning: "The character encoding of a framed document was not declared. The document may appear different if viewed without the document framing it." {file: "http://mochi.test:8888/tests/toolkit/components/extensions/test/mochitest/test_ext_storage_cleanup.html" line: 0}] [task 2018-12-21T15:55:07.262Z] 15:55:07 INFO - GECKO(3136) | [Parent 3136, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80040111: file /builds/worker/workspace/build/src/netwerk/protocol/res/SubstitutingProtocolHandler.cpp, line 318 [task 2018-12-21T15:55:07.307Z] 15:55:07 INFO - GECKO(3136) | ++DOCSHELL 0x7fdeef498800 == 5 [pid = 3136] [id = {2bf7f3c1-fcc6-466e-b87c-0062d3ae79b6}] [task 2018-12-21T15:55:07.308Z] 15:55:07 INFO - GECKO(3136) | ++DOMWINDOW == 11 (0x7fdeeffe0c00) [pid = 3136] [serial = 11] [outer = (nil)] [task 2018-12-21T15:55:07.392Z] 15:55:07 INFO - GECKO(3136) | ++DOMWINDOW == 12 (0x7fdeeffdb400) [pid = 3136] [serial = 12] [outer = 0x7fdeeffe0c00] [task 2018-12-21T15:55:07.440Z] 15:55:07 INFO - GECKO(3136) | ++DOMWINDOW == 13 (0x7fdef0902800) [pid = 3136] [serial = 13] [outer = 0x7fdeeffe0c00] [task 2018-12-21T15:55:07.848Z] 15:55:07 INFO - GECKO(3136) | [Parent 3136, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80040111: file /builds/worker/workspace/build/src/netwerk/protocol/res/SubstitutingProtocolHandler.cpp, line 318 [task 2018-12-21T15:55:07.889Z] 15:55:07 INFO - GECKO(3136) | ++DOCSHELL 0x7fdef0ee6000 == 6 [pid = 3136] [id = {07f1526e-2bf8-49ed-be8e-55b4ad52b19a}] [task 2018-12-21T15:55:07.890Z] 15:55:07 INFO - GECKO(3136) | ++DOMWINDOW == 14 (0x7fdeeffe0400) [pid = 3136] [serial = 14] [outer = (nil)] [task 2018-12-21T15:55:07.906Z] 15:55:07 INFO - GECKO(3136) | ++DOMWINDOW == 15 (0x7fdeeffe3400) [pid = 3136] [serial = 15] [outer = 0x7fdeeffe0400] [task 2018-12-21T15:55:07.926Z] 15:55:07 INFO - GECKO(3136) | ++DOMWINDOW == 16 (0x7fdef0904400) [pid = 3136] [serial = 16] [outer = 0x7fdeeffe0400] [task 2018-12-21T15:55:08.187Z] 15:55:08 INFO - GECKO(3136) | [Parent 3136, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80040111: file /builds/worker/workspace/build/src/netwerk/protocol/res/SubstitutingProtocolHandler.cpp, line 318 [task 2018-12-21T15:55:08.236Z] 15:55:08 INFO - GECKO(3136) | ++DOCSHELL 0x7fdef5153000 == 7 [pid = 3136] [id = {77b0eb40-cb62-43d5-8558-1f298dc0ea4d}] [task 2018-12-21T15:55:08.243Z] 15:55:08 INFO - GECKO(3136) | ++DOMWINDOW == 17 (0x7fdef0e29800) [pid = 3136] [serial = 17] [outer = (nil)] [task 2018-12-21T15:55:08.280Z] 15:55:08 INFO - GECKO(3136) | ++DOMWINDOW == 18 (0x7fdef0e2ac00) [pid = 3136] [serial = 18] [outer = 0x7fdef0e29800] [task 2018-12-21T15:55:08.282Z] 15:55:08 INFO - GECKO(3136) | ++DOMWINDOW == 19 (0x7fdef090b000) [pid = 3136] [serial = 19] [outer = 0x7fdef0e29800] [task 2018-12-21T15:55:08.693Z] 15:55:08 INFO - GECKO(3136) | --DOCSHELL 0x7f633863f800 == 3 [pid = 3217] [id = {54054054-c480-42c5-b728-53af3f24b901}] [task 2018-12-21T15:55:12.745Z] 15:55:12 INFO - GECKO(3136) | --DOMWINDOW == 11 (0x7f63394f4000) [pid = 3217] [serial = 6] [outer = (nil)] [url = about:blank] [task 2018-12-21T15:55:12.746Z] 15:55:12 INFO - GECKO(3136) | --DOMWINDOW == 10 (0x7f63394f7800) [pid = 3217] [serial = 8] [outer = (nil)] [url = about:blank] [task 2018-12-21T15:55:12.747Z] 15:55:12 INFO - GECKO(3136) | --DOMWINDOW == 9 (0x7f63394f6400) [pid = 3217] [serial = 7] [outer = (nil)] [url = about:blank] [task 2018-12-21T15:55:12.748Z] 15:55:12 INFO - GECKO(3136) | --DOMWINDOW == 8 (0x7f6338685800) [pid = 3217] [serial = 5] [outer = (nil)] [url = about:blank] [task 2018-12-21T15:55:13.712Z] 15:55:13 INFO - GECKO(3136) | --DOMWINDOW == 7 (0x7fcece55cc00) [pid = 3236] [serial = 6] [outer = (nil)] [url = about:blank] [task 2018-12-21T15:55:13.713Z] 15:55:13 INFO - GECKO(3136) | --DOMWINDOW == 6 (0x7fcecd518c00) [pid = 3236] [serial = 2] [outer = (nil)] [url = about:blank] [task 2018-12-21T15:55:15.678Z] 15:55:15 INFO - GECKO(3136) | --DOMWINDOW == 7 (0x7f6338682c00) [pid = 3217] [serial = 4] [outer = (nil)] [url = moz-extension://884320e8-4bdb-4fef-a638-b775725eef0c/_generated_background_page.html] [task 2018-12-21T15:55:18.017Z] 15:55:18 INFO - GECKO(3136) | --DOMWINDOW == 6 (0x7f63380c8c00) [pid = 3217] [serial = 12] [outer = (nil)] [url = moz-extension://884320e8-4bdb-4fef-a638-b775725eef0c/_generated_background_page.html] [task 2018-12-21T15:55:18.081Z] 15:55:18 INFO - GECKO(3136) | --DOMWINDOW == 5 (0x7fcecd6c9000) [pid = 3236] [serial = 3] [outer = (nil)] [url = about:blank] [task 2018-12-21T15:55:18.082Z] 15:55:18 INFO - GECKO(3136) | --DOMWINDOW == 4 (0x7fcecdabe400) [pid = 3236] [serial = 7] [outer = (nil)] [url = about:blank] [task 2018-12-21T16:00:05.457Z] 16:00:05 INFO - TEST-INFO | started process screentopng [task 2018-12-21T16:00:05.748Z] 16:00:05 INFO - TEST-INFO | screentopng: exit 0 [task 2018-12-21T16:00:05.750Z] 16:00:05 INFO - Buffered messages logged at 15:55:07 [task 2018-12-21T16:00:05.751Z] 16:00:05 INFO - AddTask.js | Entering test test_setup_keep_uuid_on_uninstall [task 2018-12-21T16:00:05.752Z] 16:00:05 INFO - AddTask.js | Leaving test test_setup_keep_uuid_on_uninstall [task 2018-12-21T16:00:05.753Z] 16:00:05 INFO - AddTask.js | Entering test test_uninstall_with_webapi_storages [task 2018-12-21T16:00:05.754Z] 16:00:05 INFO - Extension loaded [task 2018-12-21T16:00:05.755Z] 16:00:05 INFO - Extension loaded [task 2018-12-21T16:00:05.756Z] 16:00:05 INFO - Buffered messages logged at 15:55:08 [task 2018-12-21T16:00:05.758Z] 16:00:05 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_storage_cleanup.html | localStorage data is still present [task 2018-12-21T16:00:05.759Z] 16:00:05 INFO - TEST-PASS | toolkit/components/extensions/test/mochitest/test_ext_storage_cleanup.html | indexedDB data is still present [task 2018-12-21T16:00:05.761Z] 16:00:05 INFO - Extension loaded [task 2018-12-21T16:00:05.763Z] 16:00:05 INFO - Buffered messages finished [task 2018-12-21T16:00:05.764Z] 16:00:05 INFO - TEST-UNEXPECTED-FAIL | toolkit/components/extensions/test/mochitest/test_ext_storage_cleanup.html | Test timed out. [task 2018-12-21T16:00:05.764Z] 16:00:05 INFO - SimpleTest.ok@SimpleTest/SimpleTest.js:275:7 [task 2018-12-21T16:00:05.765Z] 16:00:05 INFO - reportError@SimpleTest/TestRunner.js:121:7 [task 2018-12-21T16:00:05.765Z] 16:00:05 INFO - TestRunner._checkForHangs@SimpleTest/TestRunner.js:142:7 [task 2018-12-21T16:00:05.765Z] 16:00:05 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-12-21T16:00:05.765Z] 16:00:05 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-12-21T16:00:05.765Z] 16:00:05 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-12-21T16:00:05.766Z] 16:00:05 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-12-21T16:00:05.766Z] 16:00:05 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-12-21T16:00:05.766Z] 16:00:05 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-12-21T16:00:05.766Z] 16:00:05 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-12-21T16:00:05.766Z] 16:00:05 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-12-21T16:00:05.766Z] 16:00:05 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-12-21T16:00:05.766Z] 16:00:05 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-12-21T16:00:05.766Z] 16:00:05 INFO - TestRunner.runTests/<@SimpleTest/TestRunner.js:381:9 [task 2018-12-21T16:00:05.766Z] 16:00:05 INFO - promise callback*TestRunner.runTests@SimpleTest/TestRunner.js:368:50 [task 2018-12-21T16:00:05.766Z] 16:00:05 INFO - RunSet.runtests@SimpleTest/setup.js:201:3 [task 2018-12-21T16:00:05.766Z] 16:00:05 INFO - RunSet.runall@SimpleTest/setup.js:180:5 [task 2018-12-21T16:00:05.766Z] 16:00:05 INFO - hookupTests@SimpleTest/setup.js:273:5 [task 2018-12-21T16:00:05.766Z] 16:00:05 INFO - parseTestManifest@http://mochi.test:8888/manifestLibrary.js:36:5 [task 2018-12-21T16:00:05.766Z] 16:00:05 INFO - getTestManifest/req.onload@http://mochi.test:8888/manifestLibrary.js:49:11 [task 2018-12-21T16:00:05.766Z] 16:00:05 INFO - EventHandlerNonNull*getTestManifest@http://mochi.test:8888/manifestLibrary.js:45:3 [task 2018-12-21T16:00:05.766Z] 16:00:05 INFO - hookup@SimpleTest/setup.js:253:5 [task 2018-12-21T16:00:05.767Z] 16:00:05 INFO - EventHandlerNonNull*@http://mochi.test:8888/tests?autorun=1&closeWhenDone=1&consoleLevel=INFO&manifestFile=tests.json&dumpOutputDirectory=%2Ftmp&cleanupCrashes=true:11:1 [task 2018-12-21T16:00:06.466Z] 16:00:06 INFO - Not taking screenshot here: see the one that was previously logged [task 2018-12-21T16:00:06.467Z] 16:00:06 INFO - TEST-UNEXPECTED-FAIL | toolkit/components/extensions/test/mochitest/test_ext_storage_cleanup.html | Extension left running at test shutdown [task 2018-12-21T16:00:06.467Z] 16:00:06 INFO - SimpleTest.ok@SimpleTest/SimpleTest.js:275:7 [task 2018-12-21T16:00:06.468Z] 16:00:06 INFO - ExtensionTestUtils.loadExtension/<@SimpleTest/ExtensionTestUtils.js:109:7 [task 2018-12-21T16:00:06.468Z] 16:00:06 INFO - executeCleanupFunction@SimpleTest/SimpleTest.js:1215:19 [task 2018-12-21T16:00:06.469Z] 16:00:06 INFO - SimpleTest.finish@SimpleTest/SimpleTest.js:1228:5 [task 2018-12-21T16:00:06.469Z] 16:00:06 INFO - killTest@SimpleTest/TestRunner.js:130:7 [task 2018-12-21T16:00:06.470Z] 16:00:06 INFO - delayedKillTest@SimpleTest/TestRunner.js:157:47 [task 2018-12-21T16:00:06.471Z] 16:00:06 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:157:7 [task 2018-12-21T16:00:06.471Z] 16:00:06 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-12-21T16:00:06.472Z] 16:00:06 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-12-21T16:00:06.472Z] 16:00:06 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-12-21T16:00:06.473Z] 16:00:06 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-12-21T16:00:06.473Z] 16:00:06 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-12-21T16:00:06.474Z] 16:00:06 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-12-21T16:00:06.475Z] 16:00:06 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-12-21T16:00:06.476Z] 16:00:06 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-12-21T16:00:06.476Z] 16:00:06 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-12-21T16:00:06.477Z] 16:00:06 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-12-21T16:00:06.477Z] 16:00:06 INFO - TestRunner.runTests/<@SimpleTest/TestRunner.js:381:9 [task 2018-12-21T16:00:06.478Z] 16:00:06 INFO - promise callback*TestRunner.runTests@SimpleTest/TestRunner.js:368:50 [task 2018-12-21T16:00:06.478Z] 16:00:06 INFO - RunSet.runtests@SimpleTest/setup.js:201:3 [task 2018-12-21T16:00:06.479Z] 16:00:06 INFO - RunSet.runall@SimpleTest/setup.js:180:5 [task 2018-12-21T16:00:06.480Z] 16:00:06 INFO - hookupTests@SimpleTest/setup.js:273:5 [task 2018-12-21T16:00:06.480Z] 16:00:06 INFO - parseTestManifest@http://mochi.test:8888/manifestLibrary.js:36:5 [task 2018-12-21T16:00:06.480Z] 16:00:06 INFO - getTestManifest/req.onload@http://mochi.test:8888/manifestLibrary.js:49:11 [task 2018-12-21T16:00:06.481Z] 16:00:06 INFO - EventHandlerNonNull*getTestManifest@http://mochi.test:8888/manifestLibrary.js:45:3 [task 2018-12-21T16:00:06.481Z] 16:00:06 INFO - hookup@SimpleTest/setup.js:253:5 [task 2018-12-21T16:00:06.481Z] 16:00:06 INFO - EventHandlerNonNull*@http://mochi.test:8888/tests?autorun=1&closeWhenDone=1&consoleLevel=INFO&manifestFile=tests.json&dumpOutputDirectory=%2Ftmp&cleanupCrashes=true:11:1 [task 2018-12-21T16:00:35.461Z] 16:00:35 INFO - Not taking screenshot here: see the one that was previously logged
Looks like they stopped on the 25th due to bug 1516241.
Status: NEW → RESOLVED
Closed: 6 years ago
Resolution: --- → DUPLICATE
You need to log in before you can comment on or make changes to this bug.