Closed Bug 952800 Opened 7 years ago Closed 7 years ago

Intermittent TEST-UNEXPECTED-FAIL | browser_form_auto_complete.js | autofill item list length mismatch, some items were not found. - Got 5, expected 6

Categories

(Firefox for Metro Graveyard :: Tests, defect, P2)

All
Windows 8.1
defect

Tracking

(firefox27 unaffected, firefox28 fixed, firefox29 fixed, firefox-esr24 unaffected)

RESOLVED FIXED
Firefox 29
Tracking Status
firefox27 --- unaffected
firefox28 --- fixed
firefox29 --- fixed
firefox-esr24 --- unaffected

People

(Reporter: KWierso, Assigned: rsilveira)

References

Details

(Keywords: intermittent-failure, Whiteboard: [release28] [defect] p=3 [qa-])

Attachments

(1 file)

https://tbpl.mozilla.org/php/getParsedLog.php?id=32327040&tree=Fx-Team
slave: t-w864-ix-070



09:41:05     INFO -  INFO TEST-END | chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/browser_findbar.js | finished in 4738ms
09:41:05     INFO -  TEST-INFO | checking window state
09:41:05     INFO -  TEST-START | chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/browser_form_auto_complete.js
09:41:05     INFO -  TEST-INFO | chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/browser_form_auto_complete.js | SETUP simple auto complete test to insure auto complete code doesn't break.
09:41:06     INFO -  TEST-INFO | chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/browser_form_auto_complete.js | RUN simple auto complete test to insure auto complete code doesn't break.
09:41:06     INFO -  TEST-INFO | chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/browser_form_auto_complete.js | Opening chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/browser_form_auto_complete.html in a new tab
09:41:06     INFO -  ### Content.js loaded
09:41:06     INFO -  ### FormHelper.js loaded
09:41:06     INFO -  ### SelectionPrototype.js loaded
09:41:06     INFO -  ### SelectionHandler.js loaded
09:41:06     INFO -  ### ContextMenuHandler.js loaded
09:41:06     INFO -  ### FindHandler.js loaded
09:41:06     INFO -  ### ConsoleAPIObserver.js loaded
09:41:06     INFO -  TEST-PASS | chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/browser_form_auto_complete.js | chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/browser_form_auto_complete.html is loaded
09:41:06     INFO -  TEST-INFO | chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/browser_form_auto_complete.js | Wating for 500ms
09:41:07     INFO -  TEST-PASS | chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/browser_form_auto_complete.js | input isn't null
09:41:07     INFO -  TEST-INFO | chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/browser_form_auto_complete.js | waitForMs finished waiting, waited for 507ms
09:41:07     INFO -  TEST-PASS | chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/browser_form_auto_complete.js | autofill menu item list error check
09:41:07  WARNING -  TEST-UNEXPECTED-FAIL | chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/browser_form_auto_complete.js | autofill item list length mismatch, some items were not found. - Got 5, expected 6
09:41:07     INFO -  Stack trace:
09:41:07     INFO -      JS frame :: chrome://mochikit/content/browser-test.js :: test_is :: line 705
09:41:07     INFO -      JS frame :: chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/browser_form_auto_complete.js :: checkAutofillMenuItemContents :: line 43
09:41:07     INFO -      JS frame :: chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/browser_form_auto_complete.js :: .run :: line 85
09:41:07     INFO -      JS frame :: resource://gre/modules/Task.jsm :: TaskImpl_run :: line 233
09:41:07     INFO -      JS frame :: resource://gre/modules/commonjs/sdk/core/promise.js :: resolve :: line 118
09:41:07     INFO -      JS frame :: resource://gre/modules/commonjs/sdk/core/promise.js :: then :: line 43
09:41:07     INFO -      JS frame :: resource://gre/modules/commonjs/sdk/core/promise.js :: resolve :: line 185
09:41:07     INFO -      JS frame :: resource://gre/modules/commonjs/sdk/core/promise.js :: resolve :: line 118
09:41:07     INFO -      JS frame :: resource://gre/modules/commonjs/sdk/core/promise.js :: then :: line 43
09:41:07     INFO -      JS frame :: resource://gre/modules/commonjs/sdk/core/promise.js :: resolve :: line 185
09:41:07     INFO -      JS frame :: chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/head.js :: waitForEvent/listener :: line 341
09:41:07     INFO -      JS frame :: chrome://browser/content/helperui/MenuUI.js :: _dispatch :: line 498
09:41:07     INFO -      JS frame :: chrome://browser/content/helperui/MenuUI.js :: popupshown :: line 460
09:41:07     INFO -      native frame :: <unknown filename> :: <TOP_LEVEL> :: line 0
09:41:07     INFO -  TEST-INFO | chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/browser_form_auto_complete.js | TEARDOWN simple auto complete test to insure auto complete code doesn't break.
09:41:07     INFO -  TEST-INFO | chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/browser_form_auto_complete.js | END simple auto complete test to insure auto complete code doesn't break.
09:41:07     INFO -  TEST-INFO | chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/browser_form_auto_complete.js | SETUP Test autocomplete selection with arrow key.
09:41:07     INFO -  TEST-INFO | chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/browser_form_auto_complete.js | RUN Test autocomplete selection with arrow key.
09:41:07     INFO -  TEST-INFO | chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/browser_form_auto_complete.js | Opening chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/browser_form_auto_complete.html in a new tab
09:41:07     INFO -  ### Content.js loaded
09:41:07     INFO -  ### FormHelper.js loaded
09:41:07     INFO -  ### SelectionPrototype.js loaded
09:41:07     INFO -  ### SelectionHandler.js loaded
09:41:07     INFO -  ### ContextMenuHandler.js loaded
09:41:07     INFO -  ### FindHandler.js loaded
09:41:07     INFO -  ### ConsoleAPIObserver.js loaded
09:41:07     INFO -  TEST-PASS | chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/browser_form_auto_complete.js | chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/browser_form_auto_complete.html is loaded
09:41:08     INFO -  TEST-PASS | chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/browser_form_auto_complete.js | Input updated correctly
09:41:08     INFO -  TEST-PASS | chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/browser_form_auto_complete.js | Input updated correctly
09:41:08     INFO -  DownloadNotificationsView handleEvent, got TabClose event for browser: [object XULElement]
09:41:08     INFO -  TEST-INFO | chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/browser_form_auto_complete.js | TEARDOWN Test autocomplete selection with arrow key.
09:41:08     INFO -  TEST-INFO | chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/browser_form_auto_complete.js | END Test autocomplete selection with arrow key.
09:41:08     INFO -  DownloadNotificationsView handleEvent, got TabClose event for browser: [object XULElement]
09:41:08     INFO -  TEST-INFO | MEMORY STAT vsize after test: 587005952
09:41:08     INFO -  TEST-INFO | MEMORY STAT vsizeMaxContiguous after test: 1893662720
09:41:08     INFO -  TEST-INFO | MEMORY STAT residentFast after test: 173576192
09:41:08     INFO -  TEST-INFO | MEMORY STAT heapAllocated after test: 45797404
09:41:08     INFO -  INFO TEST-END | chrome://mochitests/content/metro/browser/metro/base/tests/mochitest/browser_form_auto_complete.js | finished in 3055ms
Blocks: 880298
Component: App Bar → Tests
This regressed ~12-21. The failure implies something in autocomplete stopped working. I think we should investigate this a bit.
Whiteboard: [triage]
Whiteboard: [triage] → [defect] p=0
Whiteboard: [defect] p=0 → [release28] [defect] p=0
Whiteboard: [release28] [defect] p=0 → [release28] [defect] p=3
Assignee: nobody → rsilveira
Blocks: metrov1it23
No longer blocks: metrov1backlog
Status: NEW → ASSIGNED
Priority: -- → P2
QA Contact: jbecerra
Still not 100% sure on what's going on. Seems like a new entry is not being added after form.submit(). Testing if it's related to setting form action right before submission.

https://tbpl.mozilla.org/?tree=Try&rev=7893bb7a09b2
That failed consistently on try. Now trying to see if waiting for "formhistory-add" can help make sure the item is there.
https://tbpl.mozilla.org/?tree=Try&rev=b66c070facf7

If this doesn't help I'm not sure what else to try. It never failed for me locally.
Attached patch Patch v1Splinter Review
Try came out green on a few runs.
Attachment #8368035 - Flags: review?(jmathies)
Comment on attachment 8368035 [details] [diff] [review]
Patch v1

Review of attachment 8368035 [details] [diff] [review]:
-----------------------------------------------------------------

(In reply to Rodrigo Silveira [:rsilveira] from comment #36)
> Created attachment 8368035 [details] [diff] [review]
> Patch v1
> 
> Try came out green on a few runs.

This was pretty rare, you might want to fire off > 10 mochitest runs to be sure. Code looks good to me.
Attachment #8368035 - Flags: review?(jmathies) → review+
good point, running a few my try tests for good measure.
run a few more times and didn't get the same failure anymore. Landed hoping it got fixed :)
https://hg.mozilla.org/integration/fx-team/rev/83590e071844
https://hg.mozilla.org/mozilla-central/rev/83590e071844
Status: ASSIGNED → RESOLVED
Closed: 7 years ago
Flags: in-testsuite+
Resolution: --- → FIXED
Target Milestone: --- → Firefox 29
Could you please give some guidance in order for the QA to verify this? Thanks!
Flags: needinfo?(rsilveira)
This is an automated test intermittent failure bug, there's no need for QA test. If it fails again we'll be notified by the tbpl bot. Thanks!
Flags: needinfo?(rsilveira)
Whiteboard: [release28] [defect] p=3 → [release28] [defect] p=3 [qa-]
You need to log in before you can comment on or make changes to this bug.