Closed
Bug 1469904
Opened 7 years ago
Closed 7 years ago
Perma-failing tier2 TEST-UNEXPECTED-TIMEOUT | toolkit/mozapps/extensions/test/xpcshell/test_temporary.js | Test timed out
Categories
(Toolkit :: Add-ons Manager, defect)
Toolkit
Add-ons Manager
Tracking
()
RESOLVED
FIXED
mozilla66
| Tracking | Status | |
|---|---|---|
| firefox66 | --- | fixed |
People
(Reporter: intermittent-bug-filer, Assigned: hsivonen)
References
Details
(Keywords: intermittent-failure, Whiteboard: [stockwell disabled])
Attachments
(2 files)
|
706 bytes,
patch
|
jmaher
:
review+
|
Details | Diff | Splinter Review |
|
1.01 KB,
patch
|
aswan
:
review+
|
Details | Diff | Splinter Review |
Filed by: apavel [at] mozilla.com
https://treeherder.mozilla.org/logviewer.html#?job_id=183975352&repo=mozilla-central
https://queue.taskcluster.net/v1/task/RLB63N8VRheNR9OlLe-a7A/runs/0/artifacts/public/logs/live_backing.log
14:06:10 INFO - TEST-START | xpcshell.ini:toolkit/mozapps/extensions/test/xpcshell/test_temporary.js
14:11:10 WARNING - TEST-UNEXPECTED-TIMEOUT | xpcshell.ini:toolkit/mozapps/extensions/test/xpcshell/test_temporary.js | Test timed out
14:11:10 INFO - TEST-INFO took 300000ms
14:11:10 INFO - >>>>>>>
14:11:10 INFO - PID 7268 | [7268, Main Thread] WARNING: Couldn't get the user appdata directory. Crash events may not be produced.: file z:/build/build/src/toolkit/crashreporter/nsExceptionHandler.cpp, line 2682
14:11:10 INFO - PID 7268 | JavaScript strict warning: resource://testing-common/AddonTestUtils.jsm, line 310: ReferenceError: reference to undefined property "testScope"
14:11:10 INFO - "CONSOLE_MESSAGE: (warn) [JavaScript Warning: "ReferenceError: reference to undefined property "testScope"" {file: "resource://testing-common/AddonTestUtils.jsm" line: 310}]"
14:11:10 INFO - PID 7268 | [7268, LoadRoots] WARNING: This method is lossy. Use GetCanonicalPath !: file z:/build/build/src/xpcom/io/nsLocalFileWin.cpp, line 3464
14:11:10 INFO - PID 7268 | [7268, LoadRoots] WARNING: This method is lossy. Use GetCanonicalPath !: file z:/build/build/src/xpcom/io/nsLocalFileWin.cpp, line 3464
14:11:10 INFO - PID 7268 | [7268, LoadRoots] WARNING: This method is lossy. Use GetCanonicalPath !: file z:/build/build/src/xpcom/io/nsLocalFileWin.cpp, line 3464
14:11:10 INFO - (xpcshell/head.js) | test MAIN run_test pending (1)
14:11:10 INFO - (xpcshell/head.js) | test run_next_test 0 pending (2)
14:11:10 INFO - (xpcshell/head.js) | test MAIN run_test finished (2)
14:11:10 INFO - running event loop
14:11:10 INFO - xpcshell.ini:toolkit/mozapps/extensions/test/xpcshell/test_temporary.js | Starting test_new_temporary
14:11:10 INFO - (xpcshell/head.js) | test test_new_temporary pending (2)
14:11:10 INFO - PID 7268 | 1529503571931 addons.manager DEBUG Application has been upgraded
14:11:10 INFO - PID 7268 | 1529503572010 addons.manager DEBUG Loaded provider scope for resource://gre/modules/addons/XPIProvider.jsm: ["XPIProvider", "XPIInternal"]
14:11:10 INFO - PID 7268 | 1529503572037 addons.manager DEBUG Loaded provider scope for resource://gre/modules/LightweightThemeManager.jsm: ["LightweightThemeManager"]
14:11:10 INFO - PID 7268 | 1529503572071 addons.manager DEBUG Loaded provider scope for resource://gre/modules/addons/GMPProvider.jsm
14:11:10 INFO - PID 7268 | 1529503572084 addons.manager DEBUG Loaded provider scope for resource://gre/modules/addons/PluginProvider.jsm
14:11:10 INFO - PID 7268 | 1529503572088 addons.manager DEBUG Starting provider: XPIProvider
14:11:10 INFO - PID 7268 | 1529503572091 addons.xpi DEBUG startup
14:11:10 INFO - PID 7268 | 1529503572092 addons.xpi WARN List of valid built-in add-ons could not be parsed.: [Exception... "Component returned failure code: 0xc1f30001 (NS_ERROR_NOT_INITIALIZED) [nsIXPCComponents_Utils.readUTF8URI]" nsresult: "0xc1f30001 (NS_ERROR_NOT_INITIALIZED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm :: startup :: line 2093" data: no] Stack trace: startup()@resource://gre/modules/addons/XPIProvider.jsm:2093
14:11:10 INFO - PID 7268 | callProvider()@resource://gre/modules/AddonManager.jsm:206
14:11:10 INFO - PID 7268 | _startProvider()@resource://gre/modules/AddonManager.jsm:654
14:11:10 INFO - PID 7268 | startup()@resource://gre/modules/AddonManager.jsm:813
14:11:10 INFO - PID 7268 | startup()@resource://gre/modules/AddonManager.jsm:2808
14:11:10 INFO - PID 7268 | observe()@jar:file:///Z:/task_1529500723/build/application/firefox/omni.ja!/components/addonManager.js:66
14:11:10 INFO - PID 7268 | promiseStartupManager()@resource://testing-common/AddonTestUtils.jsm:768
14:11:10 INFO - PID 7268 | 1529503572109 addons.xpi INFO SystemAddonLocation directory is missing
14:11:10 INFO - PID 7268 | 1529503572205 addons.xpi INFO Removing all system add-on upgrades.
14:11:10 INFO - PID 7268 | 1529503572212 addons.xpi DEBUG checkForChanges
14:11:10 INFO - PID 7268 | 1529503572215 addons.xpi DEBUG Loaded add-on state: ${}
14:11:10 INFO - PID 7268 | 1529503572219 addons.xpi DEBUG scanForChanges changed: false, state: {}
14:11:10 INFO - PID 7268 | 1529503572222 addons.xpi DEBUG Empty XPI database, setting schema version preference to 27
14:11:10 INFO - PID 7268 | 1529503572223 addons.xpi DEBUG No changes found
14:11:10 INFO - PID 7268 | 1529503572285 addons.manager DEBUG Registering shutdown blocker for XPIProvider
14:11:10 INFO - PID 7268 | 1529503572287 addons.manager DEBUG Provider finished startup: XPIProvider
14:11:10 INFO - PID 7268 | 1529503572288 addons.manager DEBUG Starting provider: LightweightThemeManager
14:11:10 INFO - PID 7268 | 1529503572288 addons.manager DEBUG Registering shutdown blocker for LightweightThemeManager
14:11:10 INFO - PID 7268 | 1529503572290 addons.manager DEBUG Provider finished startup: LightweightThemeManager
14:11:10 INFO - PID 7268 | 1529503572294 addons.manager DEBUG Starting provider: GMPProvider
14:11:10 INFO - PID 7268 | 1529503572307 addons.manager DEBUG Registering shutdown blocker for GMPProvider
14:11:10 INFO - PID 7268 | 1529503572308 addons.manager DEBUG Provider finished startup: GMPProvider
14:11:10 INFO - PID 7268 | 1529503572309 addons.manager DEBUG Starting provider: PluginProvider
14:11:10 INFO - PID 7268 | 1529503572310 addons.manager DEBUG Registering shutdown blocker for PluginProvider
14:11:10 INFO - PID 7268 | 1529503572311 addons.manager DEBUG Provider finished startup: PluginProvider
14:11:10 INFO - PID 7268 | JavaScript strict warning: resource://gre/modules/LightweightThemeManager.jsm, line 694: ReferenceError: reference to undefined property "version"
14:11:10 INFO - PID 7268 | 1529503572343 addons.manager DEBUG Completed startup sequence
14:11:10 INFO - (xpcshell/head.js) | test run_next_test 0 finished (2)
14:11:10 INFO - "CONSOLE_MESSAGE: (info) 1529503571931 addons.manager DEBUG Application has been upgraded"
14:11:10 INFO - "CONSOLE_MESSAGE: (info) 1529503572010 addons.manager DEBUG Loaded provider scope for resource://gre/modules/addons/XPIProvider.jsm: ["XPIProvider", "XPIInternal"]"
14:11:10 INFO - "CONSOLE_MESSAGE: (info) 1529503572037 addons.manager DEBUG Loaded provider scope for resource://gre/modules/LightweightThemeManager.jsm: ["LightweightThemeManager"]"
14:11:10 INFO - "CONSOLE_MESSAGE: (info) 1529503572071 addons.manager DEBUG Loaded provider scope for resource://gre/modules/addons/GMPProvider.jsm"
14:11:10 INFO - "CONSOLE_MESSAGE: (info) 1529503572084 addons.manager DEBUG Loaded provider scope for resource://gre/modules/addons/PluginProvider.jsm"
14:11:10 INFO - "CONSOLE_MESSAGE: (info) 1529503572088 addons.manager DEBUG Starting provider: XPIProvider"
14:11:10 INFO - "CONSOLE_MESSAGE: (info) 1529503572091 addons.xpi DEBUG startup"
14:11:10 INFO - "CONSOLE_MESSAGE: (info) 1529503572092 addons.xpi WARN List of valid built-in add-ons could not be parsed.: [Exception... "Component returned failure code: 0xc1f30001 (NS_ERROR_NOT_INITIALIZED) [nsIXPCComponents_Utils.readUTF8URI]" nsresult: "0xc1f30001 (NS_ERROR_NOT_INITIALIZED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm :: startup :: line 2093" data: no] Stack trace: startup()@resource://gre/modules/addons/XPIProvider.jsm:2093
14:11:10 INFO - callProvider()@resource://gre/modules/AddonManager.jsm:206
14:11:10 INFO - _startProvider()@resource://gre/modules/AddonManager.jsm:654
14:11:10 INFO - startup()@resource://gre/modules/AddonManager.jsm:813
14:11:10 INFO - startup()@resource://gre/modules/AddonManager.jsm:2808
14:11:10 INFO - observe()@jar:file:///Z:/task_1529500723/build/application/firefox/omni.ja!/components/addonManager.js:66
14:11:10 INFO - promiseStartupManager()@resource://testing-common/AddonTestUtils.jsm:768"
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
Updated•7 years ago
|
Summary: Intermittent TEST-UNEXPECTED-TIMEOUT | toolkit/mozapps/extensions/test/xpcshell/test_temporary.js | Test timed out → Perma-failing tier2 ccov TEST-UNEXPECTED-TIMEOUT | toolkit/mozapps/extensions/test/xpcshell/test_temporary.js | Test timed out
Comment 4•7 years ago
|
||
This failures became perma on tier 2 after this merge: https://treeherder.mozilla.org/#/jobs?repo=mozilla-central&revision=681eb7dfa324dd50403c382888929ea8b8b11b00
Looked into the merge, presumably the cause is https://bugzilla.mozilla.org/show_bug.cgi?id=1463635
:marco is this something you can look into?
Flags: needinfo?(mcastelluccio)
| Comment hidden (Intermittent Failures Robot) |
Comment 6•7 years ago
|
||
Redirecting needinfo to :kmag, author of bug 1463635. Perhaps it's just a matter of increasing the timeout?
Blocks: 1463635
Flags: needinfo?(mcastelluccio) → needinfo?(kmaglione+bmo)
Comment 7•7 years ago
|
||
Hm. No, it looks like this always fails in the same place. It's probably a race.
Assignee: nobody → kmaglione+bmo
Flags: needinfo?(kmaglione+bmo)
Comment 8•7 years ago
|
||
(In reply to Kris Maglione [:kmag] from comment #7)
> Hm. No, it looks like this always fails in the same place. It's probably a
> race.
Okay, so is disabling the test a solution in this case or can you fix it?
Flags: needinfo?(kmaglione+bmo)
| Comment hidden (Intermittent Failures Robot) |
Comment 10•7 years ago
|
||
There are 33 failures for the past 7 days, all on windows10-64-ccov platform debug.
Recent log failure: https://treeherder.mozilla.org/logviewer.html#?job_id=188671566&repo=mozilla-central&lineNumber=3460
Relevant part of the log:
00:54:23 INFO - TEST-START | toolkit/modules/tests/xpcshell/test_DeferredTask.js
00:54:32 INFO - TEST-PASS | toolkit/modules/tests/xpcshell/test_DeferredTask.js | took 9174ms
00:54:32 INFO - TEST-START | xpcshell.ini:toolkit/mozapps/extensions/test/xpcshell/test_temporary.js
00:59:32 WARNING - TEST-UNEXPECTED-TIMEOUT | xpcshell.ini:toolkit/mozapps/extensions/test/xpcshell/test_temporary.js | Test timed out
00:59:32 INFO - TEST-INFO took 300001ms
00:59:32 INFO - >>>>>>>
00:59:32 INFO - PID 3168 | [3168, Main Thread] WARNING: Couldn't get the user appdata directory. Crash events may not be produced.: file z:/build/build/src/toolkit/crashreporter/nsExceptionHandler.cpp, line 2707
00:59:32 INFO - PID 3168 | JavaScript strict warning: resource://testing-common/AddonTestUtils.jsm, line 310: ReferenceError: reference to undefined property "testScope"
00:59:32 INFO - "CONSOLE_MESSAGE: (warn) [JavaScript Warning: "ReferenceError: reference to undefined property "testScope"" {file: "resource://testing-common/AddonTestUtils.jsm" line: 310}]"
00:59:32 INFO - PID 3168 | [3168, LoadRoots] WARNING: This method is lossy. Use GetCanonicalPath !: file z:/build/build/src/xpcom/io/nsLocalFileWin.cpp, line 3459
00:59:32 INFO - PID 3168 | [3168, LoadRoots] WARNING: This method is lossy. Use GetCanonicalPath !: file z:/build/build/src/xpcom/io/nsLocalFileWin.cpp, line 3459
00:59:32 INFO - PID 3168 | [3168, LoadRoots] WARNING: This method is lossy. Use GetCanonicalPath !: file z:/build/build/src/xpcom/io/nsLocalFileWin.cpp, line 3459
00:59:32 INFO - (xpcshell/head.js) | test MAIN run_test pending (1)
00:59:32 INFO - (xpcshell/head.js) | test run_next_test 0 pending (2)
00:59:32 INFO - (xpcshell/head.js) | test MAIN run_test finished (2)
00:59:32 INFO - running event loop
00:59:32 INFO - xpcshell.ini:toolkit/mozapps/extensions/test/xpcshell/test_temporary.js | Starting test_new_temporary
00:59:32 INFO - (xpcshell/head.js) | test test_new_temporary pending (2)
:kmag could you please take a look at this?
| Comment hidden (Intermittent Failures Robot) |
Comment 13•7 years ago
|
||
Update: there were 43 failures in the last 7 days:
- 1 failure on linux64-jsdcov opt
- 33 failures on windows10-64-ccov debug
- 9 failures on windows7-32-msvc debug
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
Comment 16•7 years ago
|
||
There have been 41 failures in the last 7 days.
All occurrences are on the debug build type.
windows10-64-ccov: 39 failures
windows10-64: 1 failure
windows7-32-msvc: 1 failure
Recent log file and snippet with the failure:
https://treeherder.mozilla.org/logviewer.html#?job_id=191502063&repo=mozilla-central&lineNumber=3708
01:51:02 INFO - TEST-START | toolkit/components/url-classifier/tests/unit/test_listmanager.js
01:51:09 INFO - TEST-PASS | toolkit/components/url-classifier/tests/unit/test_listmanager.js | took 7058ms
01:51:09 INFO - TEST-START | toolkit/modules/tests/xpcshell/test_DeferredTask.js
01:51:19 INFO - TEST-PASS | toolkit/modules/tests/xpcshell/test_DeferredTask.js | took 9601ms
01:51:19 INFO - TEST-START | xpcshell.ini:toolkit/mozapps/extensions/test/xpcshell/test_system_update_fail.js
01:52:15 INFO - TEST-PASS | xpcshell.ini:toolkit/mozapps/extensions/test/xpcshell/test_system_update_fail.js | took 56371ms
01:52:15 INFO - TEST-START | xpcshell.ini:toolkit/mozapps/extensions/test/xpcshell/test_temporary.js
01:57:15 WARNING - TEST-UNEXPECTED-TIMEOUT | xpcshell.ini:toolkit/mozapps/extensions/test/xpcshell/test_temporary.js | Test timed out
01:57:15 INFO - TEST-INFO took 300000ms
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
Comment 19•7 years ago
|
||
Attachment #9001831 -
Flags: review?(jmaher)
Comment 20•7 years ago
|
||
Comment on attachment 9001831 [details] [diff] [review]
disablewin10ccov_bug1469904
Review of attachment 9001831 [details] [diff] [review]:
-----------------------------------------------------------------
thanks!
Attachment #9001831 -
Flags: review?(jmaher) → review+
Updated•7 years ago
|
Keywords: checkin-needed,
leave-open
Whiteboard: [stockwell disable-recommended] → [stockwell disabled]
Comment 21•7 years ago
|
||
Pushed by nerli@mozilla.com:
https://hg.mozilla.org/integration/mozilla-inbound/rev/845be8b8ba05
Disable test_temporary.js for failures on windows10-64-ccov r=jmaher
Keywords: checkin-needed
Comment 22•7 years ago
|
||
| bugherder | ||
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
Comment 25•7 years ago
|
||
In the IFV there are no failures between the 24th and 29th because they didnt run on windows7-32-msvc debug:
https://treeherder.mozilla.org/#/jobs?repo=mozilla-central&filter-searchStr=windows7-32-msvc%20debug&tochange=a33ef251cb467a34aad71b0d94a4289addc9590f&filter-resultStatus=testfailed&filter-resultStatus=busted&filter-resultStatus=exception&filter-resultStatus=success&filter-resultStatus=usercancel&filter-resultStatus=running&filter-resultStatus=pending&filter-resultStatus=runnable&fromchange=7b78aeca32ed9b21e11e7ff76be8743aced52408
They started to fail again from: https://treeherder.mozilla.org/#/jobs?repo=mozilla-central&filter-searchStr=windows7-32-msvc%20debug&tochange=a33ef251cb467a34aad71b0d94a4289addc9590f&filter-resultStatus=testfailed&filter-resultStatus=busted&filter-resultStatus=exception&filter-resultStatus=success&filter-resultStatus=usercancel&filter-resultStatus=running&filter-resultStatus=pending&filter-resultStatus=runnable&fromchange=7b78aeca32ed9b21e11e7ff76be8743aced52408&selectedJob=196851447
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
Updated•7 years ago
|
Flags: needinfo?(kmaglione+bmo)
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
Updated•7 years ago
|
Summary: Perma-failing tier2 ccov TEST-UNEXPECTED-TIMEOUT | toolkit/mozapps/extensions/test/xpcshell/test_temporary.js | Test timed out → Perma-failing tier2 TEST-UNEXPECTED-TIMEOUT | toolkit/mozapps/extensions/test/xpcshell/test_temporary.js | Test timed out
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
Updated•7 years ago
|
Assignee: kmaglione+bmo → nobody
| Assignee | ||
Comment 33•7 years ago
|
||
Assignee: nobody → hsivonen
Attachment #9035670 -
Flags: review?(aswan)
Updated•7 years ago
|
Attachment #9035670 -
Flags: review?(aswan) → review+
Comment 35•7 years ago
|
||
Pushed by hsivonen@mozilla.com:
https://hg.mozilla.org/integration/mozilla-inbound/rev/f88248b391c6
Disable test_temporary.js on Windows, because it fails with increased run-time stack size. r=aswan.
Comment 37•7 years ago
|
||
Thank you.
Comment 38•7 years ago
|
||
| bugherder | ||
Status: NEW → RESOLVED
Closed: 7 years ago
status-firefox66:
--- → fixed
Resolution: --- → FIXED
Target Milestone: --- → mozilla66
You need to log in
before you can comment on or make changes to this bug.
Description
•