1448722 - Intermittent browser/base/content/test/general/browser_bug553455.js Automation Error: mozprocess timed out after 1000 seconds running ['/builds/worker/workspace/build/venv/bin/python', '-u', '/builds/worker/workspace/build/tests/mochitest/runtests.py

Status: RESOLVED DUPLICATE of bug 1416929

(Firefox :: General, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: csabou [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=170175732&repo=mozilla-central

https://queue.taskcluster.net/v1/task/f9AEHXT5RgWwaMxrZHj4oQ/runs/0/artifacts/public/logs/live_backing.log

[task 2018-03-25T21:32:07.659Z] 21:32:07     INFO - TEST-START | browser/base/content/test/general/browser_bug553455.js
[task 2018-03-25T21:32:07.801Z] 21:32:07     INFO - GECKO(1223) | Sending InstallTriggered
[task 2018-03-25T21:32:07.802Z] 21:32:07     INFO - GECKO(1223) | 1522013527795	addons.xpi	DEBUG	Cancelling download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/amosigned.xpi
[task 2018-03-25T21:32:07.802Z] 21:32:07     INFO - GECKO(1223) | 1522013527795	addons.xpi	DEBUG	removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/amosigned.xpi does not own temp file
[task 2018-03-25T21:32:07.988Z] 21:32:07     INFO - GECKO(1223) | Sending InstallTriggered
[task 2018-03-25T21:32:08.085Z] 21:32:08     INFO - GECKO(1223) | 1522013528074	addons.xpi	DEBUG	Download started for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/amosigned.xpi to file /tmp/tmp-m6w.xpi
[task 2018-03-25T21:32:08.086Z] 21:32:08     INFO - GECKO(1223) | 1522013528077	addons.xpi	DEBUG	Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/amosigned.xpi completed.
[task 2018-03-25T21:32:08.101Z] 21:32:08     INFO - GECKO(1223) | 1522013528095	addons.repository	DEBUG	cacheAddons: enabled false IDs ["[e-mail]"]
[task 2018-03-25T21:32:08.142Z] 21:32:08     INFO - GECKO(1223) | 1522013528137	addons.xpi	DEBUG	Starting install of [e-mail] from http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/amosigned.xpi
[task 2018-03-25T21:32:08.171Z] 21:32:08     INFO - GECKO(1223) | 1522013528165	addons.xpi	DEBUG	Addon [e-mail] will be installed as a packed xpi
[task 2018-03-25T21:32:08.312Z] 21:32:08     INFO - GECKO(1223) | 1522013528308	addons.xpi	DEBUG	Staged install of [e-mail] from http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/amosigned.xpi ready; waiting for restart.
[task 2018-03-25T21:32:08.320Z] 21:32:08     INFO - GECKO(1223) | 1522013528316	addons.xpi	DEBUG	removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/amosigned.xpi removing temp file /tmp/tmp-m6w.xpi
[task 2018-03-25T21:32:08.356Z] 21:32:08     INFO - GECKO(1223) | 1522013528348	addons.xpi	DEBUG	Cancelling install of [e-mail]
[task 2018-03-25T21:32:08.502Z] 21:32:08     INFO - GECKO(1223) | Sending InstallTriggered
[task 2018-03-25T21:32:08.550Z] 21:32:08     INFO - GECKO(1223) | 1522013528547	addons.xpi	DEBUG	Download started for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/amosigned.xpi to file /tmp/tmp-lr2.xpi
[task 2018-03-25T21:32:08.552Z] 21:32:08     INFO - GECKO(1223) | 1522013528549	addons.xpi	DEBUG	Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/amosigned.xpi completed.
[task 2018-03-25T21:32:08.572Z] 21:32:08     INFO - GECKO(1223) | 1522013528569	addons.repository	DEBUG	cacheAddons: enabled false IDs ["[e-mail]"]
[task 2018-03-25T21:32:08.730Z] 21:32:08     INFO - GECKO(1223) | 1522013528725	addons.xpi	DEBUG	Starting install of [e-mail] from http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/amosigned.xpi
[task 2018-03-25T21:32:08.771Z] 21:32:08     INFO - GECKO(1223) | 1522013528766	addons.xpi	DEBUG	Addon [e-mail] will be installed as a packed xpi
[task 2018-03-25T21:32:08.820Z] 21:32:08     INFO - GECKO(1223) | 1522013528814	addons.xpi	DEBUG	Staged install of [e-mail] from http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/amosigned.xpi ready; waiting for restart.
[task 2018-03-25T21:32:08.828Z] 21:32:08     INFO - GECKO(1223) | 1522013528821	addons.xpi	DEBUG	removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/amosigned.xpi removing temp file /tmp/tmp-lr2.xpi
[task 2018-03-25T21:32:08.828Z] 21:32:08     INFO - GECKO(1223) | Sending InstallComplete
[task 2018-03-25T21:32:08.877Z] 21:32:08     INFO - GECKO(1223) | 1522013528871	addons.xpi	DEBUG	Cancelling install of [e-mail]
[task 2018-03-25T21:32:09.063Z] 21:32:09     INFO - GECKO(1223) | Sending InstallTriggered
[task 2018-03-25T21:32:09.160Z] 21:32:09     INFO - GECKO(1223) | 1522013529148	addons.xpi	DEBUG	Download started for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/missing.xpi to file /tmp/tmp-b3y.xpi
[task 2018-03-25T21:32:09.160Z] 21:32:09     INFO - GECKO(1223) | 1522013529149	addons.xpi	DEBUG	Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/missing.xpi completed.
[task 2018-03-25T21:32:09.161Z] 21:32:09     INFO - GECKO(1223) | 1522013529149	addons.xpi	WARN	Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/missing.xpi failed: 404 Not Found
[task 2018-03-25T21:32:09.181Z] 21:32:09     INFO - GECKO(1223) | 1522013529171	addons.xpi	DEBUG	downloadFailed: removing temp file for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/missing.xpi
[task 2018-03-25T21:32:09.183Z] 21:32:09     INFO - GECKO(1223) | 1522013529171	addons.xpi	DEBUG	removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/missing.xpi removing temp file /tmp/tmp-b3y.xpi
[task 2018-03-25T21:32:09.184Z] 21:32:09     INFO - GECKO(1223) | Sending InstallComplete
[task 2018-03-25T21:32:09.386Z] 21:32:09     INFO - GECKO(1223) | Sending InstallTriggered
[task 2018-03-25T21:32:09.503Z] 21:32:09     INFO - GECKO(1223) | 1522013529492	addons.xpi	DEBUG	Download started for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/corrupt.xpi to file /tmp/tmp-yhy.xpi
[task 2018-03-25T21:32:09.504Z] 21:32:09     INFO - GECKO(1223) | 1522013529494	addons.xpi	DEBUG	Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/corrupt.xpi completed.
[task 2018-03-25T21:32:09.505Z] 21:32:09     INFO - GECKO(1223) | 1522013529494	addons.xpi	DEBUG	removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/corrupt.xpi removing temp file /tmp/tmp-yhy.xpi
[task 2018-03-25T21:32:09.506Z] 21:32:09     INFO - GECKO(1223) | 1522013529495	addons.xpi	WARN	Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/corrupt.xpi failed: [Exception... "Component returned failure code: 0x8052000b (NS_ERROR_FILE_CORRUPTED) [nsIZipReader.open]"  nsresult: "0x8052000b (NS_ERROR_FILE_CORRUPTED)"  location: "JS frame :: resource://gre/modules/addons/XPIInstall.jsm :: loadManifest :: line 1530"  data: no] Stack trace: loadManifest()@resource://gre/modules/addons/XPIInstall.jsm:1530
[task 2018-03-25T21:32:09.522Z] 21:32:09     INFO - GECKO(1223) | 1522013529516	addons.xpi	DEBUG	downloadFailed: removing temp file for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/corrupt.xpi
[task 2018-03-25T21:32:09.522Z] 21:32:09     INFO - GECKO(1223) | 1522013529516	addons.xpi	DEBUG	removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/corrupt.xpi does not own temp file
[task 2018-03-25T21:32:09.539Z] 21:32:09     INFO - GECKO(1223) | Sending InstallComplete
[task 2018-03-25T21:32:09.782Z] 21:32:09     INFO - GECKO(1223) | Sending InstallTriggered
[task 2018-03-25T21:32:09.883Z] 21:32:09     INFO - GECKO(1223) | 1522013529871	addons.xpi	DEBUG	Download started for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/incompatible.xpi to file /tmp/tmp-96q.xpi
[task 2018-03-25T21:32:09.884Z] 21:32:09     INFO - GECKO(1223) | 1522013529872	addons.xpi	DEBUG	Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/incompatible.xpi completed.
[task 2018-03-25T21:32:09.900Z] 21:32:09     INFO - GECKO(1223) | 1522013529887	addons.xpi	WARN	Add-on [e-mail] is not compatible with application version.
[task 2018-03-25T21:32:09.902Z] 21:32:09     INFO - GECKO(1223) | 1522013529887	addons.xpi	WARN	Add-on [e-mail] is not compatible with application version.
[task 2018-03-25T21:32:09.903Z] 21:32:09     INFO - GECKO(1223) | 1522013529888	addons.repository	DEBUG	cacheAddons: enabled false IDs ["[e-mail]"]
[task 2018-03-25T21:32:09.903Z] 21:32:09     INFO - GECKO(1223) | 1522013529888	addons.xpi	WARN	Add-on [e-mail] is not compatible with application version.
[task 2018-03-25T21:32:09.903Z] 21:32:09     INFO - GECKO(1223) | 1522013529891	addons.update-checker	DEBUG	Requesting http://127.0.0.1:8888/extensions-dummy/updateURL
[task 2018-03-25T21:32:09.913Z] 21:32:09     INFO - GECKO(1223) | 1522013529908	addons.update-checker	WARN	Request failed: http://127.0.0.1:8888/extensions-dummy/updateURL - 404: Not Found
[task 2018-03-25T21:32:09.914Z] 21:32:09     INFO - GECKO(1223) | 1522013529910	addons.xpi	WARN	Add-on [e-mail] is not compatible with application version.
[task 2018-03-25T21:32:09.916Z] 21:32:09     INFO - GECKO(1223) | 1522013529911	addons.xpi	DEBUG	Cancelling download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/incompatible.xpi
[task 2018-03-25T21:32:09.916Z] 21:32:09     INFO - GECKO(1223) | 1522013529911	addons.xpi	DEBUG	removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/incompatible.xpi removing temp file /tmp/tmp-96q.xpi
[task 2018-03-25T21:32:09.953Z] 21:32:09     INFO - GECKO(1223) | Sending InstallComplete
[task 2018-03-25T21:32:10.212Z] 21:32:10     INFO - GECKO(1223) | Sending InstallTriggered
[task 2018-03-25T21:32:10.591Z] 21:32:10     INFO - GECKO(1223) | 1522013530577	addons.xpi	DEBUG	Download started for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi to file /tmp/tmp-3w8.xpi
[task 2018-03-25T21:32:10.592Z] 21:32:10     INFO - GECKO(1223) | 1522013530578	addons.xpi	DEBUG	Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi completed.
[task 2018-03-25T21:32:10.596Z] 21:32:10     INFO - GECKO(1223) | 1522013530591	addons.repository	DEBUG	cacheAddons: enabled false IDs ["[e-mail]"]
[task 2018-03-25T21:32:10.672Z] 21:32:10     INFO - GECKO(1223) | 1522013530659	addons.xpi	DEBUG	Starting install of [e-mail] from http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi
[task 2018-03-25T21:32:10.673Z] 21:32:10     INFO - GECKO(1223) | 1522013530670	addons.xpi	DEBUG	Addon [e-mail] will be installed as a packed xpi
[task 2018-03-25T21:32:10.677Z] 21:32:10     INFO - GECKO(1223) | 1522013530674	addons.xpi-utils	DEBUG	Make addon app-profile:[e-mail] visible
[task 2018-03-25T21:32:10.678Z] 21:32:10     INFO - GECKO(1223) | 1522013530675	addons.xpi	DEBUG	XPIStates adding add-on [e-mail] in app-profile: /tmp/tmpnd8jQy.mozrunner/extensions/[e-mail]
[task 2018-03-25T21:32:10.681Z] 21:32:10     INFO - GECKO(1223) | 1522013530676	addons.xpi	DEBUG	Updating XPIState for {"id":"[e-mail]","syncGUID":"{5e181782-aacb-4caa-a46a-0352cc49b523}","location":"app-profile","version":"2.0","type":"extension","internalName":null,"updateURL":null,"optionsURL":null,"optionsType":null,"aboutURL":null,"defaultLocale":{"name":"XPI Test","description":null,"creator":null,"homepageURL":null},"visible":true,"active":true,"userDisabled":false,"appDisabled":false,"installDate":1522013530591,"updateDate":1522013530591,"applyBackgroundUpdates":1,"bootstrap":true,"path":"/tmp/tmpnd8jQy.mozrunner/extensions/[e-mail]","skinnable":false,"size":5334,"sourceURI":"http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi","releaseNotesURI":null,"softDisabled":false,"foreignInstall":false,"strictCompatibility":false,"locales":[],"targetApplications":[{"id":"{ec8030f7-c20a-464f-9b0e-13a3a9e97384}","minVersion":"0.3","maxVersion":"*"},{"id":"[e-mail]","minVersion":"0","maxVersion":"*"}],"targetPlatforms":[],"signedState":1,"seen":true,"dependencies":[],"hasEmbeddedWebExtension":false,"userPermissions":null,"icons":{},"iconURL":null,"icon64URL":null,"blocklistState":0,"blocklistURL":null,"startupData":null}
[task 2018-03-25T21:32:10.684Z] 21:32:10     INFO - GECKO(1223) | 1522013530678	addons.xpi	DEBUG	Loading bootstrap scope from /tmp/tmpnd8jQy.mozrunner/extensions/[e-mail]
[task 2018-03-25T21:32:10.685Z] 21:32:10     INFO - GECKO(1223) | 1522013530679	addons.xpi	WARN	Error loading bootstrap.js for [e-mail]: Error opening input stream (invalid filename?): jar:file:///tmp/tmpnd8jQy.mozrunner/extensions/[e-mail]!/bootstrap.js
[task 2018-03-25T21:32:10.685Z] 21:32:10     INFO - GECKO(1223) | 1522013530680	addons.xpi	WARN	Add-on [e-mail] is missing bootstrap method install
[task 2018-03-25T21:32:10.686Z] 21:32:10     INFO - GECKO(1223) | 1522013530682	addons.xpi	DEBUG	Install of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi completed.
[task 2018-03-25T21:32:10.703Z] 21:32:10     INFO - GECKO(1223) | 1522013530690	addons.xpi	DEBUG	Registering manifest for /tmp/tmpnd8jQy.mozrunner/extensions/[e-mail]
[task 2018-03-25T21:32:10.703Z] 21:32:10     INFO - GECKO(1223) | 1522013530691	addons.xpi	WARN	Add-on [e-mail] is missing bootstrap method startup
[task 2018-03-25T21:32:10.704Z] 21:32:10     INFO - GECKO(1223) | 1522013530692	addons.xpi	DEBUG	removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi removing temp file /tmp/tmp-3w8.xpi
[task 2018-03-25T21:32:10.724Z] 21:32:10     INFO - GECKO(1223) | Sending InstallComplete
[task 2018-03-25T21:32:10.745Z] 21:32:10     INFO - GECKO(1223) | 1522013530741	addons.xpi	WARN	Add-on [e-mail] is missing bootstrap method shutdown
[task 2018-03-25T21:32:10.746Z] 21:32:10     INFO - GECKO(1223) | 1522013530741	addons.xpi	DEBUG	Removing manifest for /tmp/tmpnd8jQy.mozrunner/extensions/[e-mail]
[task 2018-03-25T21:32:10.754Z] 21:32:10     INFO - GECKO(1223) | 1522013530747	addons.xpi	WARN	Add-on [e-mail] is missing bootstrap method uninstall
[task 2018-03-25T21:32:10.754Z] 21:32:10     INFO - GECKO(1223) | 1522013530747	addons.xpi	DEBUG	Disabling XPIState for [e-mail]
[task 2018-03-25T21:32:10.762Z] 21:32:10     INFO - GECKO(1223) | 1522013530758	addons.xpi	DEBUG	uninstallAddon: flushing jar cache /tmp/tmpnd8jQy.mozrunner/extensions/[e-mail] for addon [e-mail]
[task 2018-03-25T21:32:10.764Z] 21:32:10     INFO - GECKO(1223) | 1522013530758	addons.xpi	DEBUG	Removing XPIState for app-profile:[e-mail]
[task 2018-03-25T21:32:10.764Z] 21:32:10     INFO - GECKO(1223) | 1522013530758	addons.xpi	DEBUG	Removing XPIState for app-profile:[e-mail]
[task 2018-03-25T21:32:10.981Z] 21:32:10     INFO - GECKO(1223) | Sending InstallTriggered
[task 2018-03-25T21:32:11.038Z] 21:32:11     INFO - GECKO(1223) | 1522013531025	addons.xpi	DEBUG	Download started for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless-unsigned.xpi to file /tmp/tmp-lod.xpi
[task 2018-03-25T21:32:11.039Z] 21:32:11     INFO - GECKO(1223) | 1522013531026	addons.xpi	DEBUG	Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless-unsigned.xpi completed.
[task 2018-03-25T21:32:11.042Z] 21:32:11     INFO - GECKO(1223) | 1522013531038	addons.repository	DEBUG	cacheAddons: enabled false IDs ["[e-mail]"]
[task 2018-03-25T21:32:11.099Z] 21:32:11     INFO - GECKO(1223) | 1522013531095	addons.xpi	DEBUG	Starting install of [e-mail] from http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless-unsigned.xpi
[task 2018-03-25T21:32:11.115Z] 21:32:11     INFO - GECKO(1223) | 1522013531106	addons.xpi	DEBUG	Addon [e-mail] will be installed as a packed xpi
[task 2018-03-25T21:32:11.116Z] 21:32:11     INFO - GECKO(1223) | 1522013531110	addons.xpi-utils	DEBUG	Make addon app-profile:[e-mail] visible
[task 2018-03-25T21:32:11.118Z] 21:32:11     INFO - GECKO(1223) | 1522013531110	addons.xpi	DEBUG	XPIStates adding add-on [e-mail] in app-profile: /tmp/tmpnd8jQy.mozrunner/extensions/[e-mail]
[task 2018-03-25T21:32:11.119Z] 21:32:11     INFO - GECKO(1223) | 1522013531111	addons.xpi	DEBUG	Updating XPIState for {"id":"[e-mail]","syncGUID":"{fb0ab9ae-b591-487f-90a3-f16df77cd696}","location":"app-profile","version":"2.0","type":"extension","internalName":null,"updateURL":null,"optionsURL":null,"optionsType":null,"aboutURL":null,"defaultLocale":{"name":"XPI Test","description":null,"creator":null,"homepageURL":null},"visible":true,"active":true,"userDisabled":false,"appDisabled":false,"installDate":1522013531039,"updateDate":1522013531039,"applyBackgroundUpdates":1,"bootstrap":true,"path":"/tmp/tmpnd8jQy.mozrunner/extensions/[e-mail]","skinnable":false,"size":872,"sourceURI":"http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless-unsigned.xpi","releaseNotesURI":null,"softDisabled":false,"foreignInstall":false,"strictCompatibility":false,"locales":[],"targetApplications":[{"id":"{ec8030f7-c20a-464f-9b0e-13a3a9e97384}","minVersion":"0.3","maxVersion":"*"},{"id":"[e-mail]","minVersion":"0","maxVersion":"*"}],"targetPlatforms":[],"signedState":0,"seen":true,"dependencies":[],"hasEmbeddedWebExtension":false,"userPermissions":null,"icons":{},"iconURL":null,"icon64URL":null,"blocklistState":0,"blocklistURL":null,"startupData":null}
[task 2018-03-25T21:32:11.120Z] 21:32:11     INFO - GECKO(1223) | 1522013531112	addons.xpi	DEBUG	Loading bootstrap scope from /tmp/tmpnd8jQy.mozrunner/extensions/[e-mail]
[task 2018-03-25T21:32:11.121Z] 21:32:11     INFO - GECKO(1223) | 1522013531113	addons.xpi	WARN	Error loading bootstrap.js for [e-mail]: Error opening input stream (invalid filename?): jar:file:///tmp/tmpnd8jQy.mozrunner/extensions/[e-mail]!/bootstrap.js
[task 2018-03-25T21:32:11.122Z] 21:32:11     INFO - GECKO(1223) | 1522013531114	addons.xpi	WARN	Add-on [e-mail] is missing bootstrap method install
[task 2018-03-25T21:32:11.122Z] 21:32:11     INFO - GECKO(1223) | 1522013531115	addons.xpi	DEBUG	Install of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless-unsigned.xpi completed.
[task 2018-03-25T21:32:11.125Z] 21:32:11     INFO - GECKO(1223) | 1522013531122	addons.xpi	DEBUG	Registering manifest for /tmp/tmpnd8jQy.mozrunner/extensions/[e-mail]
[task 2018-03-25T21:32:11.126Z] 21:32:11     INFO - GECKO(1223) | 1522013531123	addons.xpi	WARN	Add-on [e-mail] is missing bootstrap method startup
[task 2018-03-25T21:32:11.128Z] 21:32:11     INFO - GECKO(1223) | 1522013531124	addons.xpi	DEBUG	removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless-unsigned.xpi removing temp file /tmp/tmp-lod.xpi
[task 2018-03-25T21:32:11.156Z] 21:32:11     INFO - GECKO(1223) | Sending InstallComplete
[task 2018-03-25T21:32:11.172Z] 21:32:11     INFO - GECKO(1223) | 1522013531169	addons.xpi	WARN	Add-on [e-mail] is missing bootstrap method shutdown
[task 2018-03-25T21:32:11.173Z] 21:32:11     INFO - GECKO(1223) | 1522013531169	addons.xpi	DEBUG	Removing manifest for /tmp/tmpnd8jQy.mozrunner/extensions/[e-mail]
[task 2018-03-25T21:32:11.182Z] 21:32:11     INFO - GECKO(1223) | 1522013531174	addons.xpi	WARN	Add-on [e-mail] is missing bootstrap method uninstall
[task 2018-03-25T21:32:11.182Z] 21:32:11     INFO - GECKO(1223) | 1522013531174	addons.xpi	DEBUG	Disabling XPIState for [e-mail]
[task 2018-03-25T21:32:11.182Z] 21:32:11     INFO - GECKO(1223) | 1522013531176	addons.xpi	DEBUG	uninstallAddon: flushing jar cache /tmp/tmpnd8jQy.mozrunner/extensions/[e-mail] for addon [e-mail]
[task 2018-03-25T21:32:11.182Z] 21:32:11     INFO - GECKO(1223) | 1522013531176	addons.xpi	DEBUG	Removing XPIState for app-profile:[e-mail]
[task 2018-03-25T21:32:11.182Z] 21:32:11     INFO - GECKO(1223) | 1522013531177	addons.xpi	DEBUG	Removing XPIState for app-profile:[e-mail]
[task 2018-03-25T21:32:11.392Z] 21:32:11     INFO - GECKO(1223) | 1522013531387	addons.xpi	DEBUG	Download started for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/amosigned.xpi to file /tmp/tmp-wrp.xpi
[task 2018-03-25T21:32:11.393Z] 21:32:11     INFO - GECKO(1223) | 1522013531388	addons.xpi	DEBUG	Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/amosigned.xpi completed.
[task 2018-03-25T21:32:11.414Z] 21:32:11     INFO - GECKO(1223) | 1522013531407	addons.repository	DEBUG	cacheAddons: enabled false IDs ["[e-mail]"]
[task 2018-03-25T21:32:11.456Z] 21:32:11     INFO - GECKO(1223) | 1522013531454	addons.xpi	DEBUG	Starting install of [e-mail] from http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/amosigned.xpi
[task 2018-03-25T21:32:11.473Z] 21:32:11     INFO - GECKO(1223) | 1522013531465	addons.xpi	DEBUG	Addon [e-mail] will be installed as a packed xpi
[task 2018-03-25T21:32:11.473Z] 21:32:11     INFO - GECKO(1223) | 1522013531469	addons.xpi	DEBUG	Staged install of [e-mail] from http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/amosigned.xpi ready; waiting for restart.
[task 2018-03-25T21:32:11.482Z] 21:32:11     INFO - GECKO(1223) | 1522013531477	addons.xpi	DEBUG	removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/amosigned.xpi removing temp file /tmp/tmp-wrp.xpi
[task 2018-03-25T21:32:11.504Z] 21:32:11     INFO - GECKO(1223) | 1522013531500	addons.xpi	DEBUG	Cancelling install of [e-mail]
[task 2018-03-25T21:32:11.613Z] 21:32:11     INFO - GECKO(1223) | 1522013531605	addons.xpi	WARN	Invalid XPI: [Exception... "Component returned failure code: 0x8052000b (NS_ERROR_FILE_CORRUPTED) [nsIZipReader.open]"  nsresult: "0x8052000b (NS_ERROR_FILE_CORRUPTED)"  location: "JS frame :: resource://gre/modules/addons/XPIInstall.jsm :: loadManifest :: line 1530"  data: no] Stack trace: loadManifest()@resource://gre/modules/addons/XPIInstall.jsm:1530
[task 2018-03-25T21:32:11.775Z] 21:32:11     INFO - GECKO(1223) | 1522013531770	addons.xpi	DEBUG	Download started for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/amosigned.xpi to file /tmp/tmp-v6a.xpi
[task 2018-03-25T21:32:11.776Z] 21:32:11     INFO - GECKO(1223) | 1522013531771	addons.xpi	DEBUG	Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/amosigned.xpi completed.
[task 2018-03-25T21:32:11.797Z] 21:32:11     INFO - GECKO(1223) | 1522013531786	addons.repository	DEBUG	cacheAddons: enabled false IDs ["[e-mail]"]
[task 2018-03-25T21:32:11.834Z] 21:32:11     INFO - GECKO(1223) | 1522013531829	addons.xpi	DEBUG	Cancelling download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/amosigned.xpi
[task 2018-03-25T21:32:11.835Z] 21:32:11     INFO - GECKO(1223) | 1522013531830	addons.xpi	DEBUG	removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/amosigned.xpi removing temp file /tmp/tmp-v6a.xpi
[task 2018-03-25T21:32:11.972Z] 21:32:11     INFO - GECKO(1223) | Sending InstallTriggered
[task 2018-03-25T21:32:12.014Z] 21:32:12     INFO - GECKO(1223) | 1522013532006	addons.xpi	DEBUG	Download started for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/amosigned.xpi to file /tmp/tmp-xoc.xpi
[task 2018-03-25T21:32:12.015Z] 21:32:12     INFO - GECKO(1223) | 1522013532007	addons.xpi	DEBUG	Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/amosigned.xpi completed.
[task 2018-03-25T21:32:12.031Z] 21:32:12     INFO - GECKO(1223) | 1522013532021	addons.repository	DEBUG	cacheAddons: enabled false IDs ["[e-mail]"]
[task 2018-03-25T21:32:12.059Z] 21:32:12     INFO - GECKO(1223) | 1522013532055	addons.xpi	DEBUG	Cancelling download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/amosigned.xpi
[task 2018-03-25T21:32:12.062Z] 21:32:12     INFO - GECKO(1223) | 1522013532059	addons.xpi	DEBUG	removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/amosigned.xpi removing temp file /tmp/tmp-xoc.xpi
[task 2018-03-25T21:32:12.077Z] 21:32:12     INFO - GECKO(1223) | Sending InstallComplete
[task 2018-03-25T21:38:48.383Z] 21:38:48     INFO - GECKO(1223) | 1522013928380	addons.manager	DEBUG	Background update check beginning
[task 2018-03-25T21:38:48.384Z] 21:38:48     INFO - GECKO(1223) | 1522013928381	addons.manager	DEBUG	Background update check complete
[task 2018-03-25T21:40:48.390Z] 21:40:48     INFO - GECKO(1223) | *** Blocklist::notify: Requesting http://127.0.0.1:8888/extensions-dummy/blocklistURL
[task 2018-03-25T21:40:48.410Z] 21:40:48     INFO - GECKO(1223) | *** Blocklist::onXMLLoad: there was an error during load, got status: 404
[task 2018-03-25T21:57:28.449Z] 21:57:28     INFO - Automation Error: mozprocess timed out after 1000 seconds running ['/builds/worker/workspace/build/venv/bin/python', '-u', '/builds/worker/workspace/build/tests/mochitest/runtests.py', '--disable-e10s', '--total-chunks', '7', '--this-chunk', '2', '--jscov-dir-prefix=/builds/worker/workspace/build/blobber_upload_dir', '--appname=/builds/worker/workspace/build/application/firefox/firefox', '--utility-path=tests/bin', '--extra-profile-file=tests/bin/plugins', '--symbols-path=https://queue.taskcluster.net/v1/task/PlYcOELJREG6pG6YPn-9XQ/artifacts/public/build/target.crashreporter-symbols.zip', '--certificate-path=tests/certs', '--setpref=webgl.force-enabled=true', '--quiet', '--log-raw=/builds/worker/workspace/build/blobber_upload_dir/browser-chrome-coverage_raw.log', '--log-errorsummary=/builds/worker/workspace/build/blobber_upload_dir/browser-chrome-coverage_errorsummary.log', '--use-test-media-devices', '--screenshot-on-fail', '--cleanup-crashes', '--marionette-startup-timeout=180', '--sandbox-read-whitelist=/builds/worker/workspace/build', '--log-raw=-', '--flavor=browser', '--chunk-by-runtime', '--timeout=1200']
[task 2018-03-25T21:57:28.485Z] 21:57:28    ERROR - timed out after 1000 seconds of no output
[task 2018-03-25T21:57:28.485Z] 21:57:28    ERROR - Return code: -15
[task 2018-03-25T21:57:28.486Z] 21:57:28    ERROR - No suite end message was emitted by this harness.
[task 2018-03-25T21:57:28.487Z] 21:57:28     INFO - TinderboxPrint: mochitest-browser-chrome-coverage<br/>73/0/0
[task 2018-03-25T21:57:28.487Z] 21:57:28    ERROR - # TBPL FAILURE #
[task 2018-03-25T21:57:28.487Z] 21:57:28  WARNING - setting return code to 2
[task 2018-03-25T21:57:28.488Z] 21:57:28    ERROR - The mochitest suite: browser-chrome-coverage ran with return status: FAILURE
[task 2018-03-25T21:57:28.488Z] 21:57:28     INFO - Running post-action listener: _package_coverage_data
[task 2018-03-25T21:57:28.489Z] 21:57:28     INFO - Beginning compression of JSDCov artifacts...
[task 2018-03-25T21:57:28.492Z] 21:57:28     INFO - Running command: ['zip', '-r', '-q', '/builds/worker/workspace/build/blobber_upload_dir/jsdcov_artifacts.zip', '.', '-i', 'jscov*.json'] in /builds/worker/workspace/build/blobber_upload_dir
[task 2018-03-25T21:57:28.492Z] 21:57:28     INFO - Copy/paste: zip -r -q /builds/worker/workspace/build/blobber_upload_dir/jsdcov_artifacts.zip . -i jscov*.json
[task 2018-03-25T21:57:29.376Z] 21:57:29     INFO - Return code: 0

Comment 1

[Cosmin Sabou [:CosminS]]

This started failing from this merge: 
https://treeherder.mozilla.org/#/jobs?repo=mozilla-central&filter-resultStatus=testfailed&filter-resultStatus=busted&filter-resultStatus=exception&fromchange=6862624e24d005fb4f8fb07c6800d2acef1d287e&selectedJob=170118509&filter-searchStr=c912631caac9ff698c1c5e4066e1ea10c6e7f40b

Comment 2

[Intermittent Failures Robot]

19 failures in 822 pushes (0.023 failures/push) were associated with this bug in the last 7 days.    

Repository breakdown:
* mozilla-central: 19

Platform breakdown:
* linux64-jsdcov: 19

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1448722&startday=2018-03-20&endday=2018-03-26&tree=trunk

Comment 3

[Eliza Balazs [:ebalazs_]]

I did some retriggers on central but the results are unrelated https://treeherder.mozilla.org/#/jobs?repo=mozilla-central&fromchange=28d966d1881897e84a816a7c760e94905741bc85&filter-resultStatus=testfailed&filter-resultStatus=busted&filter-resultStatus=exception&filter-resultStatus=runnable&filter-resultStatus=success&filter-resultStatus=pending&filter-resultStatus=running&filter-searchStr=linux64-jsdcov%20browser-chrome-2&selectedJob=170118509

Comment 4

[Joel Maher ( :jmaher ) (UTC -8)]

this is a jsdcov specific failure- and it looks like it moved between chunks, so retriggering on bc2 will not work going back in history.

in rev 1401aaec5676 it ran in bc7 and failed there.  then a few pushes back in rev 3e6b7490c719 it moved back to bc2 (and has continued to fail there).

I think we need to focus more on regular builds (not ccov, not jsdcov)

Comment 5

[Intermittent Failures Robot]

8 failures in 718 pushes (0.011 failures/push) were associated with this bug in the last 7 days.    

Repository breakdown:
* mozilla-central: 8

Platform breakdown:
* linux64-jsdcov: 8

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1448722&startday=2018-03-26&endday=2018-04-01&tree=trunk