Closed Bug 1449788 Opened 6 years ago Closed 6 years ago

Intermittent toolkit/mozapps/extensions/test/xpinstall/browser_httphash6.js | Test timed out -

Categories

(Toolkit :: Add-ons Manager, defect)

defect
Not set
normal

Tracking

()

RESOLVED FIXED
mozilla62
Tracking Status
firefox62 --- fixed

People

(Reporter: intermittent-bug-filer, Assigned: kmag)

Details

(Keywords: intermittent-failure, Whiteboard: [stockwell disabled])

Filed by: ncsoregi [at] mozilla.com

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

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

23:13:04     INFO -  Buffered messages finished
23:13:04    ERROR -  1008 INFO TEST-UNEXPECTED-FAIL | toolkit/mozapps/extensions/test/xpinstall/browser_httphash6.js | Test timed out -
23:13:04     INFO -  1009 INFO TEST-PASS | toolkit/mozapps/extensions/test/xpinstall/browser_httphash6.js | Should be no active installs at the end of the test -
23:13:04     INFO -  GECKO(2308) | MEMORY STAT | vsize 2099032MB | vsizeMaxContiguous 129900788MB | residentFast 274MB | heapAllocated 76MB
23:13:04     INFO -  1010 INFO TEST-OK | toolkit/mozapps/extensions/test/xpinstall/browser_httphash6.js | took 90121ms
23:13:04     INFO -  Not taking screenshot here: see the one that was previously logged
23:13:04    ERROR -  1011 INFO TEST-UNEXPECTED-FAIL | toolkit/mozapps/extensions/test/xpinstall/browser_httphash6.js | Found a tab after previous test timed out: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/installtrigger.html?%7B%22Unsigned%20XPI%22%3A%7B%22URL%22%3A%22https%3A%2F%2Fexample.com%2Fbrowser%2Ftoolkit%2Fmozapps%2Fextensions%2Ftest%2Fxpinstall%2Fredirect.sjs%3Fmode%3Dredirect%22%7D%7D -
23:13:04     INFO -  GECKO(2308) | 1522278784629	addons.xpi	WARN	Failed to remove temporary file C:\Users\GenericWorker\AppData\Local\Temp\tmp-kxl.xpi for addon https://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/redirect.sjs?mode=redirect: [Exception... "Component returned failure code: 0x80520015 (NS_ERROR_FILE_ACCESS_DENIED) [nsIFile.remove]"  nsresult: "0x80520015 (NS_ERROR_FILE_ACCESS_DENIED)"  location: "JS frame :: resource://gre/modules/addons/XPIInstall.jsm :: removeTemporaryFile :: line 1476"  data: no] Stack trace: removeTemporaryFile()@resource://gre/modules/addons/XPIInstall.jsm:1476
23:13:04     INFO -  GECKO(2308) | cancel()@resource://gre/modules/addons/XPIInstall.jsm:1401
23:13:04     INFO -  GECKO(2308) | cancel()@resource://gre/modules/addons/XPIInstall.jsm:2101
23:13:04     INFO -  GECKO(2308) | cancel()@resource://gre/modules/addons/XPIInstall.jsm:2524
23:13:04     INFO -  GECKO(2308) | cancelInstall()@resource://gre/modules/AddonManager.jsm:377
23:13:04     INFO -  GECKO(2308) | observe()@resource://gre/modules/AddonManager.jsm:389
23:13:04     INFO -  GECKO(2308) | _endRemoveTab()@tabbrowser.js:2905
23:13:04     INFO -  GECKO(2308) | removeTab()@tabbrowser.js:2639
23:13:04     INFO -  GECKO(2308) | Tester_waitForWindowsState()@browser-test.js:545
23:13:04     INFO -  GECKO(2308) | Tester.prototype.nextTest<()@browser-test.js:873
23:13:04     INFO -  GECKO(2308) | TaskImpl_run()@resource://gre/modules/Task.jsm:326
23:13:04     INFO -  GECKO(2308) | ++DOCSHELL 00000210BFB33800 == 1 [pid = 9052] [id = {47cae9ed-a1b7-46c1-9d2a-aab38c52307c}]
23:13:04     INFO -  GECKO(2308) | ++DOMWINDOW == 1 (00000210C4CBB800) [pid = 9052] [serial = 113] [outer = 0000000000000000]
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
Status: NEW → RESOLVED
Closed: 6 years ago
Resolution: --- → INCOMPLETE
Recent failure log: https://treeherder.mozilla.org/logviewer.html#?job_id=178686314&repo=autoland&lineNumber=23719

05:46:01     INFO -  TEST-INFO | started process screenshot
05:46:01     INFO -  TEST-INFO | screenshot: exit 0
05:46:01     INFO -  Buffered messages logged at 05:44:31
05:46:01     INFO -  992 INFO TEST-PASS | toolkit/mozapps/extensions/test/xpinstall/browser_httphash6.js | Should have seen the expected number of installs started -
05:46:01     INFO -  993 INFO Console message: [JavaScript Error: "The character encoding of the HTML document was not declared. The document will render with garbled text in some browser configurations if the document contains characters from outside the US-ASCII range. The character encoding of the page must be declared in the document or in the transfer protocol." {file: "http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/installtrigger.html?%7B%22Unsigned%20XPI%22%3A%7B%22URL%22%3A%22https%3A%2F%2Fexample.com%2Fbrowser%2Ftoolkit%2Fmozapps%2Fextensions%2Ftest%2Fxpinstall%2Fredirect.sjs%3Fmode%3Dredirect%22%7D%7D" line: 0}]
05:46:01     INFO -  994 INFO TEST-PASS | toolkit/mozapps/extensions/test/xpinstall/browser_httphash6.js | Should only see failures for started installs -
05:46:01     INFO -  995 INFO TEST-PASS | toolkit/mozapps/extensions/test/xpinstall/browser_httphash6.js | Failed installs should have an error or be appDisabled -
05:46:01     INFO -  996 INFO TEST-PASS | toolkit/mozapps/extensions/test/xpinstall/browser_httphash6.js | Should have seen a hash failure -
05:46:01     INFO -  997 INFO TEST-PASS | toolkit/mozapps/extensions/test/xpinstall/browser_httphash6.js | Should be no running installs left -
05:46:01     INFO -  998 INFO Console message: 1526449471847	addons.xpi	DEBUG	Download started for https://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/redirect.sjs?mode=redirect to file C:\Users\task_1526446209\AppData\Local\Temp\tmp-af.xpi
05:46:01     INFO -  999 INFO Console message: 1526449471850	addons.xpi	DEBUG	Download of https://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/redirect.sjs?mode=redirect completed.
05:46:01     INFO -  1000 INFO Console message: 1526449471850	addons.xpi	WARN	Download of https://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/redirect.sjs?mode=redirect failed: Downloaded file hash (ee95834ad862245a9ef99ccecc2a857cadc16404) did not match provided hash (foo)
05:46:01     INFO -  1001 INFO Console message: 1526449471870	addons.xpi	DEBUG	downloadFailed: removing temp file for https://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/redirect.sjs?mode=redirect
05:46:01     INFO -  1002 INFO Console message: 1526449471870	addons.xpi	DEBUG	removeTemporaryFile: https://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/redirect.sjs?mode=redirect removing temp file C:\Users\task_1526446209\AppData\Local\Temp\tmp-af.xpi
05:46:01     INFO -  1003 INFO TEST-PASS | toolkit/mozapps/extensions/test/xpinstall/browser_httphash6.js | Should have seen the expected number of installs started -
05:46:01     INFO -  1004 INFO Console message: 1526449471969	addons.xpi	DEBUG	removeTemporaryFile: https://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/redirect.sjs?mode=redirect does not own temp file
05:46:01     INFO -  Buffered messages logged at 05:44:32
05:46:01     INFO -  1005 INFO Console message: 1526449472046	addons.xpi	DEBUG	Download started for https://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/redirect.sjs?mode=redirect to file C:\Users\task_1526446209\AppData\Local\Temp\tmp-dym.xpi
05:46:01     INFO -  1006 INFO Console message: 1526449472048	addons.xpi	DEBUG	Download of https://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/redirect.sjs?mode=redirect completed.
05:46:01     INFO -  1007 INFO Console message: 1526449472087	addons.repository	DEBUG	cacheAddons: enabled false IDs ["amosigned-xpi@tests.mozilla.org"]
05:46:01     INFO -  Buffered messages logged at 05:44:52
05:46:01     INFO -  1008 INFO Console message: 1526449492225	addons.productaddons	INFO	Updates are disabled via media.gmp-manager.updateEnabled
05:46:01     INFO -  Buffered messages finished
05:46:01    ERROR -  1009 INFO TEST-UNEXPECTED-FAIL | toolkit/mozapps/extensions/test/xpinstall/browser_httphash6.js | Test timed out -
05:46:01     INFO -  1010 INFO TEST-PASS | toolkit/mozapps/extensions/test/xpinstall/browser_httphash6.js | Should be no active installs at the end of the test -
05:46:01     INFO -  GECKO(6372) | MEMORY STAT | vsize 2099025MB | vsizeMaxContiguous 129663328MB | residentFast 271MB | heapAllocated 75MB
05:46:01     INFO -  1011 INFO TEST-OK | toolkit/mozapps/extensions/test/xpinstall/browser_httphash6.js | took 90133ms
05:46:01     INFO -  Not taking screenshot here: see the one that was previously logged
05:46:01    ERROR -  1012 INFO TEST-UNEXPECTED-FAIL | toolkit/mozapps/extensions/test/xpinstall/browser_httphash6.js | Found a tab after previous test timed out: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/installtrigger.html?%7B%22Unsigned%20XPI%22%3A%7B%22URL%22%3A%22https%3A%2F%2Fexample.com%2Fbrowser%2Ftoolkit%2Fmozapps%2Fextensions%2Ftest%2Fxpinstall%2Fredirect.sjs%3Fmode%3Dredirect%22%7D%7D -
05:46:01     INFO -  GECKO(6372) | ++DOCSHELL 0000023F9F53C800 == 1 [pid = 820] [id = {232e8038-ca57-4d2a-8679-876e8541e36f}]
05:46:01     INFO -  GECKO(6372) | ++DOMWINDOW == 1 (0000023F9F51A800) [pid = 820] [serial = 113] [outer = 0000000000000000]
05:46:01     INFO -  1013 INFO checking window state
05:46:01     INFO -  GECKO(6372) | ++DOMWINDOW == 2 (0000023FA4D8C000) [pid = 820] [serial = 114] [outer = 0000023F9F51A800]
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
There have been 70 failures in the last 7 days.
Failures per platform and build type:
windows10-64 / debug: 64
windows7-32 / debug: 6

Recent log file:
https://treeherder.mozilla.org/logviewer.html#?job_id=179941916&repo=autoland&lineNumber=22407

Snippet with the failure:
3:31:56     INFO -  1000 INFO Console message: 1527132626674	addons.repository	DEBUG	cacheAddons: enabled false IDs ["amosigned-xpi@tests.mozilla.org"]
03:31:56     INFO -  Buffered messages logged at 03:30:46
03:31:56     INFO -  1001 INFO Console message: 1527132646790	addons.productaddons	INFO	Updates are disabled via media.gmp-manager.updateEnabled
03:31:56     INFO -  Buffered messages finished
03:31:56    ERROR -  1002 INFO TEST-UNEXPECTED-FAIL | toolkit/mozapps/extensions/test/xpinstall/browser_httphash6.js | Test timed out -
03:31:56     INFO -  1003 INFO TEST-PASS | toolkit/mozapps/extensions/test/xpinstall/browser_httphash6.js | Should be no active installs at the end of the test -
03:31:56     INFO -  GECKO(6020) | MEMORY STAT | vsize 2099023MB | vsizeMaxContiguous 128864835MB | residentFast 268MB | heapAllocated 75MB
03:31:56     INFO -  1004 INFO TEST-OK | toolkit/mozapps/extensions/test/xpinstall/browser_httphash6.js | took 90138ms
03:31:56     INFO -  Not taking screenshot here: see the one that was previously logged
03:31:56    ERROR -  1005 INFO TEST-UNEXPECTED-FAIL | toolkit/mozapps/extensions/test/xpinstall/browser_httphash6.js | Found a tab after previous test timed out: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/installtrigger.html?%7B%22Unsigned%20XPI%22%3A%7B%22URL%22%3A%22https%3A%2F%2Fexample.com%2Fbrowser%2Ftoolkit%2Fmozapps%2Fextensions%2Ftest%2Fxpinstall%2Fredirect.sjs%3Fmode%3Dredirect%22%7D%7D -
03:31:56     INFO -  GECKO(6020) | ++DOCSHELL 0000023F12943000 == 1 [pid = 7672] [id = {a49509d4-2cfb-4160-9022-50c0e06d1e94}]
03:31:56     INFO -  GECKO(6020) | ++DOMWINDOW == 1 (0000023F1A272E00) [pid = 7672] [serial = 113] [outer = 0000000000000000]
03:31:56     INFO -  GECKO(6020) | ++DOMWINDOW == 2 (0000023F18081C00) [pid = 7672] [serial = 114] [outer = 0000023F1A272E00]
Flags: needinfo?(ddurst)
https://hg.mozilla.org/integration/mozilla-inbound/rev/ba76eaa4b71a91a505fdcb30c619e90175f262bb
Bug 1449788: Disable browser_httphash6 for frequent intermittents and failure to convince me that it serves any purpose. r=me,test-only DONTBUILD
https://hg.mozilla.org/mozilla-central/rev/ba76eaa4b71a
Status: REOPENED → RESOLVED
Closed: 6 years ago6 years ago
Resolution: --- → FIXED
Target Milestone: --- → mozilla62
Assignee: nobody → kmaglione+bmo
Whiteboard: [stockwell needswork:owner] → [stockwell disabled]
Flags: needinfo?(thedurst)
You need to log in before you can comment on or make changes to this bug.