Closed Bug 1260593 Opened 8 years ago Closed 4 years ago

Intermittent browser_context_menu.js | Test timed out - | Found a tab after previous test timed out: multiple_forms.html -

Categories

(Toolkit :: Password Manager, defect, P3)

Product:
Toolkit
Component:
Password Manager
Type:
defect

Tracking

()

Status:
RESOLVED INACTIVE
Tracking Flags:
Tracking Status
firefox48 --- affected

People

(Reporter: KWierso, Unassigned)

References

Details

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

Bulk assigning P3 to all open intermittent bugs without a priority set in Firefox components per bug 1298978.
Priority: -- → P3
Although this bug has been open for a while, there were only a few failures before the changes in bug 1337772; failure frequency has definitely increased since then.
Blocks: 1337772
Flags: needinfo?(jhofmann)
Summary: Intermittent browser_context_menu.js Test timed out - | Found a tab after previous test timed out: multiple_forms.html - → Intermittent browser_context_menu.js | Test timed out - | Found a tab after previous test timed out: multiple_forms.html -
Summary: Intermittent browser_context_menu.js | Test timed out - | Found a tab after previous test timed out: multiple_forms.html - → Intermittent toolkit/components/passwordmgr/test/browser/browser_context_menu.js | Test timed out - | Found a tab after previous test timed out: multiple_forms.html -
Whiteboard: [stockwell needswork]
this started up on April 7th and has for the most part remained steady since then.

I am trying some retriggers near the start of this failure, not sure if this will help figure out the root cause, but maybe it will give some hints:
https://treeherder.mozilla.org/#/jobs?repo=autoland&filter-searchStr=win%20vm%20debug%20bc%20m-e10s(bc1)&tochange=6b8483bcad1156275a56a6e590d1a8cd74ce9f5a&fromchange=72fc7df213df538de510bf734acc3ae1fa88c6ce&selectedJob=89572281

from a log:
https://treeherder.mozilla.org/logviewer.html#?repo=autoland&job_id=89649711&lineNumber=19541

I see this near the failure:
11:48:45     INFO - TEST-PASS | toolkit/components/passwordmgr/test/browser/browser_context_menu.js | Check upgraded login was actually used - "password1" == "password1" - 
11:48:45     INFO - Testing form: Two username and one passwords form, fields prefiled
11:48:45     INFO - Testing password field: test-password-12
11:48:45     INFO - Buffered messages logged at 11:47:27
11:48:45     INFO - TEST-PASS | toolkit/components/passwordmgr/test/browser/browser_context_menu.js | Password filled and correct. - "password1" == "password1" - 
11:48:45     INFO - TEST-PASS | toolkit/components/passwordmgr/test/browser/browser_context_menu.js | Other fields were not changed. - "() => {\n        for (let field of unchangedFields) {\n          if (field.value != field.getAttribute(\"original-value\")) {\n == true - 
11:48:45     INFO - TEST-PASS | toolkit/components/passwordmgr/test/browser/browser_context_menu.js | Check upgraded login was actually used - "password1" == "password1" - 
11:48:45     INFO - Testing form: Two username and one passwords form, one disabled username field
11:48:45     INFO - Testing password field: test-password-13
11:48:45     INFO - TEST-PASS | toolkit/components/passwordmgr/test/browser/browser_context_menu.js | Password filled and correct. - "password1" == "password1" - 
11:48:45     INFO - TEST-PASS | toolkit/components/passwordmgr/test/browser/browser_context_menu.js | Other fields were not changed. - "() => {\n        for (let field of unchangedFields) {\n          if (field.value != field.getAttribute(\"original-value\")) {\n == true - 
11:48:45     INFO - TEST-PASS | toolkit/components/passwordmgr/test/browser/browser_context_menu.js | Check upgraded login was actually used - "password1" == "password1" - 
11:48:45     INFO - Testing form: Second username and password fields with no form
11:48:45     INFO - Testing password field: test-password-14
11:48:45     INFO - TEST-PASS | toolkit/components/passwordmgr/test/browser/browser_context_menu.js | Other fields were not changed. - "() => {\n        for (let field of unchangedFields) {\n          if (field.value != field.getAttribute(\"original-value\")) {\n == true - 
11:48:45     INFO - TEST-PASS | toolkit/components/passwordmgr/test/browser/browser_context_menu.js | Check upgraded login was actually used - "password1" == "password1" - 
11:48:45     INFO - Leaving test bound test_context_menu_password_fill
11:48:45     INFO - Entering test bound test_context_menu_username_login_fill
11:48:45     INFO - Buffered messages logged at 11:47:28
11:48:45     INFO - Testing form: Password only form
11:48:45     INFO - Testing form: Username only form
11:48:45     INFO - Testing username field: test-username-1
11:48:45     INFO - Buffered messages finished
11:48:45     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/passwordmgr/test/browser/browser_context_menu.js | Test timed out - 
11:48:45     INFO - GECKO(4748) | MEMORY STAT | vsize 698MB | vsizeMaxContiguous 787MB | residentFast 203MB | heapAllocated 76MB
11:48:45     INFO - TEST-OK | toolkit/components/passwordmgr/test/browser/browser_context_menu.js | took 90100ms
11:48:45     INFO - Not taking screenshot here: see the one that was previously logged
11:48:45     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/passwordmgr/test/browser/browser_context_menu.js | Found a tab after previous test timed out: https://example.com/browser/toolkit/components/passwordmgr/test/browser/multiple_forms.html - 
11:48:45     INFO - GECKO(4748) | [Parent 4748] WARNING: Cannot set transparency mode on top-level windows.: file c:/builds/moz2_slave/autoland-w32-d-000000000000000/build/src/widget/windows/nsWindow.cpp, line 3057
11:48:45     INFO - GECKO(4748) | [Parent 4748] WARNING: Cannot set transparency mode on top-level windows.: file c:/builds/moz2_slave/autoland-w32-d-000000000000000/build/src/widget/windows/nsWindow.cpp, line 3057
11:48:45     INFO - GECKO(4748) | ++DOCSHELL 00AC1400 == 1 [pid = 3768] [id = {35cd6e6f-5779-433b-a71f-d224d34a079b}]
11:48:45     INFO - GECKO(4748) | ++DOMWINDOW == 1 (03860000) [pid = 3768] [serial = 36] [outer = 00000000]
11:48:45     INFO - GECKO(4748) | [Parent 4748] WARNING: 'NS_FAILED(rv)', file c:/builds/moz2_slave/autoland-w32-d-000000000000000/build/src/caps/BasePrincipal.cpp, line 380
11:48:45     INFO - GECKO(4748) | [Parent 4748] WARNING: Cannot set transparency mode on top-level windows.: file c:/builds/moz2_slave/autoland-w32-d-000000000000000/build/src/widget/windows/nsWindow.cpp, line 3057

and a related screenshot:
http://mozilla-releng-blobs.s3.amazonaws.com/blobs/autoland/sha512/90d75b30facf00ad9008260e172c4dd87e85f8153b2982d66503dc6fd8a85e5058b8a2ffd486c86944be55ecc707c5090d1263b7a949018a35c5d892fada1c08


I assume we get stuck here:
https://dxr.mozilla.org/mozilla-central/source/toolkit/components/passwordmgr/test/browser/browser_context_menu.js?q=test_context_menu_username_login_fill&redirect_type=single#205
Summary: Intermittent toolkit/components/passwordmgr/test/browser/browser_context_menu.js | Test timed out - | Found a tab after previous test timed out: multiple_forms.html - → Intermittent browser_context_menu.js | Test timed out - | Found a tab after previous test timed out: multiple_forms.html -
:mattn, this has been failing consistently for a couple week- right in the range where we would expect it to reproduce reasonably.  I see it failing acorss many OS flavors- as the triage owner for this component, can you help find someone to look at this bug- at least possibly put it in a queue to look at when finished with a milestone sometime in the next couple weeks?
Flags: needinfo?(MattN+bmo)
I've been looking at this already but forgot to assign myself. I haven't been able to reproduce this locally, which has made working on this somewhat hard so far (especially with Photon going on), but I'm looking into it.
Flags: needinfo?(jhofmann)
Flags: needinfo?(MattN+bmo)
Assignee: nobody → jhofmann
Status: NEW → ASSIGNED
this bug has reduced quite a bit in the last 2 weeks, still failing at a medium frequency, so it might come back.
Whiteboard: [stockwell needswork] → [stockwell unknown]
Unassigning myself for now, this one is really tricky and not so frequent anymore. Let's observe it.
Assignee: jhofmann → nobody
Status: ASSIGNED → NEW
Status: NEW → RESOLVED
Closed: 4 years ago
Resolution: --- → INACTIVE
You need to log in before you can comment on or make changes to this bug.