700051 - Intermittent test_errorhandler.js | test failed (with xpcshell return code: 0) from test_errorhandler.js | error.login.reason.network == error.login.reason.account

Status: RESOLVED FIXED

(Firefox :: Sync, defect)

Description

[Phil Ringnalda (:philor)]

+++ This bug was initially created as a clone of Bug #684783 +++

https://tbpl.mozilla.org/php/getParsedLog.php?id=7229228&tree=Mozilla-Inbound
Rev4 MacOSX Snow Leopard 10.6 mozilla-inbound opt test xpcshell on 2011-11-05 07:35:48 PDT for push 1a4de3faac05

TEST-UNEXPECTED-FAIL | /Users/cltbld/talos-slave/test/build/xpcshell/tests/services/sync/tests/unit/test_errorhandler.js | test failed (with xpcshell return code: 0), see following log:
...
TEST-INFO | (xpcshell/head.js) | test 2 finished
Sync.Service	DEBUG	User-Agent: XPCShell/1 FxSync/1.13.0.20100621.
Sync.Service	INFO	Starting sync at 2011-11-05 07:45:20
Sync.Service	DEBUG	In sync: should login.
Sync.Service	TRACE	Event: weave:service:login:start
Sync.Status	DEBUG	Status.service: success.status_ok => success.status_ok
Sync.Status	DEBUG	Status.service: success.status_ok => success.status_ok
Sync.Service	INFO	Logging in user janedoe
Sync.Service	TRACE	Event: weave:service:verify-login:start
Sync.Service	DEBUG	Finding cluster for user janedoe
Sync.ErrorHandler	TRACE	Notifying weave:ui:sync:finish. Status.login is success.login. Status.sync is success.sync
Sync.Resource	DEBUG	mesg: GET success 200 https://auth.services.mozilla.com/user/1.0/janedoe/node/weave
Sync.Resource	DEBUG	GET success 200 https://auth.services.mozilla.com/user/1.0/janedoe/node/weave
Sync.Service	TRACE	_findCluster successfully returning https://scl2-sync902.services.mozilla.com/
Sync.Service	DEBUG	Cluster value = https://scl2-sync902.services.mozilla.com/
Sync.Service	DEBUG	Setting cluster to https://scl2-sync902.services.mozilla.com/
Sync.Service	DEBUG	Caching URLs under storage user base: https://scl2-sync902.services.mozilla.com/1.1/janedoe/
Sync.Resource	DEBUG	mesg: GET fail 401 https://scl2-sync902.services.mozilla.com/1.1/janedoe/info/collections
Sync.Resource	DEBUG	GET fail 401 https://scl2-sync902.services.mozilla.com/1.1/janedoe/info/collections
Sync.Service	WARN	401: login failed.
Sync.Service	DEBUG	Finding cluster for user janedoe
Sync.Resource	DEBUG	mesg: GET fail 500 https://auth.services.mozilla.com/user/1.0/janedoe/node/weave
Sync.Resource	DEBUG	GET fail 500 https://auth.services.mozilla.com/user/1.0/janedoe/node/weave
Sync.Service	DEBUG	verifyLogin failed: Unexpected response code: 500 No traceback available
Sync.Status	DEBUG	Status.login: success.login => error.login.reason.network
Sync.Status	DEBUG	Status.service: success.status_ok => error.login.failed
Sync.Service	TRACE	Event: weave:service:verify-login:finish
Sync.Service	TRACE	Event: weave:service:login:error
Got weave:service:login:error in second sync.

TEST-UNEXPECTED-FAIL | /Users/cltbld/talos-slave/test/build/xpcshell/tests/services/sync/tests/unit/test_errorhandler.js | error.login.reason.network == error.login.reason.account - See following stack:
JS frame :: /Users/cltbld/talos-slave/test/build/xpcshell/head.js :: do_throw :: line 453
JS frame :: /Users/cltbld/talos-slave/test/build/xpcshell/head.js :: _do_check_eq :: line 547
JS frame :: /Users/cltbld/talos-slave/test/build/xpcshell/head.js :: do_check_eq :: line 568
JS frame :: /Users/cltbld/talos-slave/test/build/xpcshell/tests/services/sync/tests/unit/test_errorhandler.js :: onLoginError :: line 159
JS frame :: resource://services-sync/ext/Observers.js :: <TOP_LEVEL> :: line 163
JS frame :: resource://services-sync/ext/Observers.js :: <TOP_LEVEL> :: line 122
JS frame :: resource://services-sync/util.js :: <TOP_LEVEL> :: line 142
JS frame :: resource://services-sync/util.js :: WrappedNotify :: line 153
JS frame :: resource://services-sync/util.js :: WrappedLock :: line 103
JS frame :: resource://services-sync/util.js :: WrappedCatch :: line 77
JS frame :: resource:///modules/services-sync/service.js :: WeaveSvc_login :: line 980
JS frame :: resource:///modules/services-sync/service.js :: <TOP_LEVEL> :: line 1272
JS frame :: resource://services-sync/util.js :: WrappedCatch :: line 77
JS frame :: resource:///modules/services-sync/service.js :: sync :: line 1268

TEST-INFO | (xpcshell/head.js) | exiting test
Sync.SyncScheduler	TRACE	Handling weave:service:login:error
Sync.SyncScheduler	DEBUG	Clearing sync triggers and the global score.
Sync.SyncScheduler	TRACE	_checkSync returned "".
Sync.SyncScheduler	DEBUG	Next sync in 86400000 ms.
Sync.ErrorHandler	TRACE	Handling weave:service:login:error
Sync.Service	DEBUG	Exception: Login failed: error.login.reason.network No traceback available
Sync.Service	DEBUG	Not syncing: login returned false.
Sync.ErrorHandler	TRACE	Notifying weave:ui:clear-error. Status.login is error.login.reason.network. Status.sync is success.sync
Sync.SyncScheduler	TRACE	Handling network:offline-status-changed
Sync.SyncScheduler	TRACE	Network offline status change: offline
Sync.SyncScheduler	TRACE	_checkSync returned "Network is offline".
Sync.SyncScheduler	DEBUG	Clearing sync triggers and the global score.
<<<<<<<

Comment 1

[Richard Newman [:rnewman]]

Resolving this, in the expectation that Bug 700071 will prevent this failure from being possible. 

Filing a new server bug for the 500