Closed Bug 1087120 Opened 7 years ago Closed 7 years ago

Intermittent browser_ContentSearch.js | Checking message - Structures begin differing at:

Categories

(Firefox :: Search, defect)

x86_64
Linux
defect
Not set
normal

Tracking

()

RESOLVED FIXED
Firefox 36
Tracking Status
firefox34 --- unaffected
firefox35 --- unaffected
firefox36 --- fixed
firefox-esr31 --- unaffected

People

(Reporter: KWierso, Assigned: adw)

Details

(Keywords: intermittent-failure)

Attachments

(1 file)

https://treeherder.mozilla.org/ui/logviewer.html#?job_id=675740&repo=b2g-inbound

builder 	Ubuntu VM 12.04 b2g-inbound debug test mochitest-browser-chrome-1
buildid 	20141021122234
builduid 	620073bb4a3e4cd08643c54bc45dd1b7
results 	warnings (1)
revision 	15099ba111e8
slave 	tst-linux32-spot-464
starttime 	Tue Oct 21 2014 14:08:28 GMT-0700 (Pacific Standard Time)



15:25:16 INFO - 1931 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Search URL loaded
15:25:16 INFO - 1932 INFO Leaving test search
15:25:16 INFO - 1933 INFO Entering test badImage
15:25:16 INFO - 1934 INFO Console message: [JavaScript Error: "Unknown source for search: ContentSearchTest" {file: "resource://gre/modules/HealthReport.jsm" line: 7356}]
15:25:16 INFO - 1935 INFO Waiting for ContentSearch message AddToWhitelistAck...
15:25:16 INFO - 1936 INFO Received ContentSearch message AddToWhitelistAck
15:25:16 INFO - 1937 INFO Waiting for engine to be added: contentSearchBadImage.xml
15:25:16 INFO - 1938 INFO Waiting for ContentSearchTest message CurrentState...
15:25:16 INFO - 1939 INFO Waiting for ContentSearchTest message CurrentState...
15:25:16 INFO - 1940 INFO Waiting for ContentSearchTest message CurrentState...
15:25:16 INFO - 1941 INFO Search engine added: contentSearchBadImage.xml
15:25:16 INFO - 1942 INFO Received ContentSearchTest message CurrentState
15:25:16 INFO - 1943 INFO Received ContentSearchTest message CurrentState
15:25:16 INFO - 1944 INFO Received ContentSearchTest message CurrentState
15:25:16 INFO - 1945 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Sanity check: engine should be in expected state
15:25:16 INFO - 1946 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Sanity check: icon array buffer of engine in expected state should be null: null
15:25:16 INFO - 1947 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Checking message
15:25:16 INFO - 1948 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Actual value is ArrayBuffer.
15:25:16 INFO - 1949 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Expected value is ArrayBuffer.
15:25:16 INFO - 1950 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Array buffers have the same length. - 1173 == 1173
15:25:16 INFO - 1951 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Buffers are equal.
15:25:16 INFO - 1952 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Actual value is ArrayBuffer.
15:25:16 INFO - 1953 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Expected value is ArrayBuffer.
15:25:16 INFO - 1954 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Array buffers have the same length. - 6405 == 6405
15:25:16 INFO - 1955 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Buffers are equal.
15:25:16 INFO - 1956 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Actual value is ArrayBuffer.
15:25:16 INFO - 1957 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Expected value is ArrayBuffer.
15:25:16 INFO - 1958 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Array buffers have the same length. - 3732 == 3732
15:25:16 INFO - 1959 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Buffers are equal.
15:25:16 INFO - 1960 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Actual value is ArrayBuffer.
15:25:16 INFO - 1961 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Expected value is ArrayBuffer.
15:25:16 INFO - 1962 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Array buffers have the same length. - 1219 == 1219
15:25:16 INFO - 1963 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Buffers are equal.
15:25:16 INFO - 1964 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Actual value is ArrayBuffer.
15:25:16 INFO - 1965 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Expected value is ArrayBuffer.
15:25:16 INFO - 1966 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Array buffers have the same length. - 1250 == 1250
15:25:16 INFO - 1967 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Buffers are equal.
15:25:16 INFO - 1968 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Actual value is ArrayBuffer.
15:25:16 INFO - 1969 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Expected value is ArrayBuffer.
15:25:16 INFO - 1970 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Array buffers have the same length. - 1650 == 1650
15:25:16 INFO - 1971 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Buffers are equal.
15:25:16 INFO - 1972 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Actual value is ArrayBuffer.
15:25:16 INFO - 1973 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Expected value is ArrayBuffer.
15:25:16 INFO - 1974 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Array buffers have the same length. - 935 == 935
15:25:16 INFO - 1975 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Buffers are equal.
15:25:16 INFO - 1976 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Actual value is ArrayBuffer.
15:25:16 INFO - 1977 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Expected value is ArrayBuffer.
15:25:16 INFO - 1978 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Array buffers have the same length. - 1173 == 1173
15:25:16 INFO - 1979 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Buffers are equal.
15:25:16 INFO - 1980 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Actual value is ArrayBuffer.
15:25:16 INFO - 1981 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Expected value is ArrayBuffer.
15:25:16 INFO - 1982 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Array buffers have the same length. - 5934 == 5934
15:25:16 INFO - 1983 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Buffers are equal.
15:25:16 INFO - 1984 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Actual value is ArrayBuffer.
15:25:16 INFO - 1985 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Expected value is ArrayBuffer.
15:25:16 INFO - 1986 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Array buffers have the same length. - 12081 == 12081
15:25:16 INFO - 1987 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Buffers are equal.
15:25:16 INFO - 1988 INFO Waiting for ContentSearchTest message CurrentState...
15:25:16 INFO - 1989 INFO Received ContentSearchTest message CurrentState
15:25:16 INFO - 1990 INFO Leaving test badImage
15:25:16 INFO - 1991 INFO Entering test GetSuggestions_AddFormHistoryEntry_RemoveFormHistoryEntry
15:25:16 INFO - 1992 INFO Waiting for ContentSearch message AddToWhitelistAck...
15:25:16 INFO - 1993 INFO Received ContentSearch message AddToWhitelistAck
15:25:16 INFO - 1994 INFO Waiting for engine to be added: contentSearchSuggestions.xml
15:25:16 INFO - 1995 INFO Waiting for ContentSearchTest message CurrentState...
15:25:16 INFO - 1996 INFO Waiting for ContentSearchTest message CurrentState...
15:25:16 INFO - 1997 INFO Search engine added: contentSearchSuggestions.xml
15:25:16 INFO - 1998 INFO Received ContentSearchTest message CurrentState
15:25:16 INFO - 1999 INFO Received ContentSearchTest message CurrentState
15:25:16 INFO - 2000 INFO Waiting for ContentSearchTest message Suggestions...
15:25:16 INFO - 2001 INFO Received ContentSearchTest message Suggestions
15:25:16 INFO - 2002 INFO TEST-PASS | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Checking message
15:25:16 INFO - 2003 INFO Waiting for ContentSearchTest message Suggestions...
15:25:16 INFO - 2004 INFO Console message: [JavaScript Error: "SearchSuggestionController: HTTP Timeout" {file: "resource://gre/modules/SearchSuggestionController.jsm" line: 329}]
15:25:16 INFO - 2005 INFO Received ContentSearchTest message Suggestions
15:25:16 INFO - 2006 INFO TEST-UNEXPECTED-FAIL | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | Checking message - Structures begin differing at:
15:25:16 INFO - got['data']['remote'][0] = [object Object]
15:25:16 INFO - expected['data']['remote'][0] = browser_ContentSearch.js-suggestions-foo
15:25:16 INFO - Stack trace:
15:25:16 INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.isDeeply:1297
15:25:16 INFO - chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js:checkMsg:293
15:25:16 INFO - chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js:GetSuggestions_AddFormHistoryEntry_RemoveFormHistoryEntry:246
15:25:16 INFO - self-hosted:next:884
15:25:16 INFO - Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:865:23
15:25:16 INFO - this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:7
15:25:16 INFO - [Parent 1809] WARNING: NS_ENSURE_TRUE(mMutable) failed: file /builds/slave/b2g-in-lx-d-000000000000000000/build/netwerk/base/src/nsSimpleURI.cpp, line 265
15:25:17 INFO - 2007 INFO TEST-OK | chrome://mochitests/content/browser/browser/modules/test/browser_ContentSearch.js | took 21370ms
15:25:17 INFO - ++DOCSHELL 0x6ac5ac00 == 73 [pid = 1809] [id = 4367]
15:25:17 INFO - ++DOMWINDOW == 335 (0x75707f90) [pid = 1809] [serial = 11848] [outer = (nil)]
15:25:17 INFO - ++DOMWINDOW == 336 (0x7570ac20) [pid = 1809] [serial = 11849] [outer = 0x75707f90]
15:25:17 INFO - [Parent 1809] WARNING: NS_ENSURE_TRUE(mMutable) failed: file /builds/slave/b2g-in-lx-d-000000000000000000/build/netwerk/base/src/nsSimpleURI.cpp, line 265
15:25:17 INFO - 2008 INFO TEST-START | chrome://mochitests/content/browser/browser/modules/test/browser_NetworkPrioritizer.js
The problem:

15:25:16 INFO - 2004 INFO Console message: [JavaScript Error: "SearchSuggestionController: HTTP Timeout" {file: "resource://gre/modules/SearchSuggestionController.jsm" line: 329}]

There were no remote suggestions when the test expected some, and there were no remote suggestions because for whatever reason the test server took too long to respond, so SearchSuggestionController.jsm aborted the request.  ("Too long" is > 5 seconds...)

This just doubles the timeout set by the test to 10 seconds.

rs=MattN IRL.
Assignee: nobody → adw
Status: NEW → ASSIGNED
Attachment #8515308 - Flags: review+
https://hg.mozilla.org/mozilla-central/rev/1ec8dbde7cf8
Status: ASSIGNED → RESOLVED
Closed: 7 years ago
Resolution: --- → FIXED
Target Milestone: --- → Firefox 36
You need to log in before you can comment on or make changes to this bug.