749315 - sync: "Client sent a bad request" to storage/tabs

Status: RESOLVED FIXED

(Cloud Services :: Operations: Miscellaneous, task)

Description

[Jeff Balogh (:jbalogh)]

Attachment: about:sync-log

Saw a sync annoy bar, on latest nightly. (Mozilla/5.0 (Macintosh; Intel Mac OS X 10.6; rv:15.0) Gecko/20120426 Firefox/15.0a1)

I've only seen it once so far.

Here's the juicy bits:

1335468127270	Sync.Collection	DEBUG	mesg: POST fail 400 https://phx-sync598.services.mozilla.com/1.1/jbalogh/storage/tabs
1335468127270	Sync.Collection	DEBUG	POST fail 400 https://phx-sync598.services.mozilla.com/1.1/jbalogh/storage/tabs
1335468127270	Sync.Engine.Tabs	DEBUG	Uploading records failed: <h2>Client sent a bad request.</h2>

1335468127271	Sync.Status	DEBUG	Status for engine tabs: error.engine.reason.record_upload_fail
1335468127271	Sync.Status	DEBUG	Status.service: success.status_ok => error.sync.failed_partial

Comment 1

[Richard Newman [:rnewman]]

Seems to be an nginx/gunicorn keepalive issue. Ops chaps are working on it.

Comment 2

[:Atoll]

zeus upgrade pending to try and resolve the issue

Comment 3

[Blair McBride [:Unfocused] (UNAVAILABLE)]

Hmm, I've been hitting this today. This bug is a little stale, but I see the dependant bug is still open.


1359461808177	Sync.Engine.Tabs	INFO	Uploading all of 1 records
1359461808177	Sync.Collection	DEBUG	POST Length: 26936
1359461808557	Sync.Collection	DEBUG	mesg: POST fail 400 https://phx-sync201.services.mozilla.com/1.1/blur/storage/tabs
1359461808557	Sync.Collection	DEBUG	POST fail 400 https://phx-sync201.services.mozilla.com/1.1/blur/storage/tabs
1359461808557	Sync.Engine.Tabs	DEBUG	Uploading records failed: <h2>Client sent a bad request.</h2>

1359461808557	Sync.Status	DEBUG	Status for engine tabs: error.engine.reason.record_upload_fail
1359461808557	Sync.Status	DEBUG	Status.service: success.status_ok => error.sync.failed_partial
1359461808557	Sync.ErrorHandler	DEBUG	tabs failed: <h2>Client sent a bad request.</h2>

Comment 4

[Edward O]

I think bug has been preventing syncing for me for 2 weeks, on 18.0.1.

I'll add my sync.log in case it helps.

Comment 5

[Edward O]

Attachment: about:sync-log on firefox 18.0.1

Comment 6

[Adam Roach [:abr]]

Attachment: Password sync error log on FF19

FWIW, it appears to be more than just tabs sync, also. I'm seeing this on my password sync for Firefox 19; I suspect we're having infrastructure issues (longer log attached):

1359580371119	Sync.Engine.Passwords	INFO	1 outgoing items pre-reconciliation
1359580371120	Sync.Engine.Passwords	INFO	Records: 0 applied, 0 successfully, 0 failed to apply, 0 newly failed to apply, 0 reconciled.
1359580371123	Sync.Engine.Passwords	INFO	Uploading all of 1 records
1359580371124	Sync.Collection	DEBUG	POST Length: 541
1359580371186	Sync.Collection	DEBUG	mesg: POST fail 400 https://phx-sync245.services.mozilla.com/1.1/qqgfkyd43nwvvxidqpcvsw7q4a4hiwd3/storage/passwords
1359580371186	Sync.Collection	DEBUG	POST fail 400 https://phx-sync245.services.mozilla.com/1.1/qqgfkyd43nwvvxidqpcvsw7q4a4hiwd3/storage/passwords
1359580371186	Sync.Engine.Passwords	DEBUG	Uploading records failed: <h2>Client sent a bad request.</h2>

1359580371187	Sync.Status	DEBUG	Status for engine passwords: error.engine.reason.record_upload_fail
1359580371187	Sync.Status	DEBUG	Status.service: success.status_ok => error.sync.failed_partial
1359580371187	Sync.ErrorHandler	DEBUG	passwords failed: <h2>Client sent a bad request.</h2>
 No traceback available

Comment 7

[André Ziegler]

I also can't sync:

1366089333551	Sync.Engine.History	DEBUG	Uploading records failed: <h2>Client sent a bad request.</h2>

1366089333556	Sync.Status	DEBUG	Status for engine history: error.engine.reason.record_upload_fail
1366089333556	Sync.Status	DEBUG	Status.service: success.status_ok => error.sync.failed_partial
1366089333556	Sync.ErrorHandler	DEBUG	history failed: <h2>Client sent a bad request.</h2>
 No traceback available

Comment 10

[Emilio Lumia]

I can't sync too : (I add my complete log)

--- snip snip snip
1369769053497	Sync.Engine.History	INFO	Uploading 100 - 200 out of 481 records
1369769053499	Sync.Collection	DEBUG	POST Length: 53544
1369769053825	Sync.Collection	DEBUG	mesg: POST fail 400 https://phx-sync533.services.mozilla.com/1.1/nukvxunmdst77mzgqg2kztvdechfv4g7/storage/history
1369769053825	Sync.Collection	DEBUG	POST fail 400 https://phx-sync533.services.mozilla.com/1.1/nukvxunmdst77mzgqg2kztvdechfv4g7/storage/history
1369769053825	Sync.Engine.History	DEBUG	Uploading records failed: <h2>Client sent a bad request.</h2>

1369769053845	Sync.Status	DEBUG	Status for engine history: error.engine.reason.record_upload_fail
1369769053845	Sync.Status	DEBUG	Status.service: success.status_ok => error.sync.failed_partial
1369769053845	Sync.ErrorHandler	DEBUG	history failed: <h2>Client sent a bad request.</h2>
 No traceback available
--- snip snip snip

Comment 11

[Emilio Lumia]

Attachment: Error log

Comment 12

[Justin Lazaro [:jlaz] (use needinfo)]

I believe we're good here now, as we've stabilized the current infra.  Please reopen if you continue to have issues!