1318865570564 Sync.Service DEBUG User-Agent: Firefox/9.0a2 FxSync/1.12.0.20111013042015. 1318865570565 Sync.Service INFO Starting sync at 2011-10-17 11:32:50 1318865570566 Sync.SyncScheduler DEBUG Clearing sync triggers. 1318865570566 Sync.Service INFO In sync(). 1318865570959 Sync.Resource DEBUG mesg: GET success 200 https://phx-sync259.services.mozilla.com/1.1/kbrosnan/info/collections?v=1.12.0 1318865570959 Sync.Resource DEBUG GET success 200 https://phx-sync259.services.mozilla.com/1.1/kbrosnan/info/collections?v=1.12.0 1318865570960 Sync.Service DEBUG Fetching global metadata record 1318865570960 Sync.Service DEBUG Weave Version: 1.12.0 Local Storage: 5 Remote Storage: 5 1318865570960 Sync.Service INFO Sync key is up-to-date: no need to upgrade. 1318865570960 Sync.Service DEBUG Fetching and verifying -- or generating -- symmetric keys. 1318865570961 Sync.Service INFO Testing info/collections: {"passwords":1318852420.24,"tabs":1318864792.13,"clients":1318865533.95,"crypto":1317936820.27,"forms":1318865543.06,"client":1309403645.59,"meta":1317940291.52,"key":1285334582.26,"bookmarks":1318865536.68,"prefs":1318579576.89,"history":1318864791.96} 1318865570961 Sync.CollectionKeys INFO Testing for updateNeeded. Last modified: 1317936784.24 1318865570961 Sync.Service INFO CollectionKeys reports that a key update is needed. 1318865571064 Sync.Resource DEBUG mesg: GET success 200 https://phx-sync259.services.mozilla.com/1.1/kbrosnan/storage/crypto/keys 1318865571065 Sync.Resource DEBUG GET success 200 https://phx-sync259.services.mozilla.com/1.1/kbrosnan/storage/crypto/keys 1318865571065 Sync.CollectionKeys INFO Updating collection keys... 1318865571066 Sync.CollectionKeys INFO Setting CollectionKeys contents. Our last modified: 1317936784.24, input modified: 1317936784.24. 1318865571066 Sync.BulkKeyBundle INFO BulkKeyBundle being created for [default] 1318865571067 Sync.CollectionKeys INFO Processing downloaded per-collection keys. 1318865571067 Sync.CollectionKeys INFO New keys are the same as our old keys! Bumped local modified time. 1318865571067 Sync.CollectionKeys INFO Collection keys updated. 1318865571067 Sync.Service DEBUG Refreshing client list. 1318865571068 Sync.Engine.Clients INFO 0 outgoing items pre-reconciliation 1318865571184 Sync.Collection DEBUG mesg: GET success 200 https://phx-sync259.services.mozilla.com/1.1/kbrosnan/storage/clients?newer=1318680442.74&full=1 1318865571185 Sync.Collection DEBUG GET success 200 https://phx-sync259.services.mozilla.com/1.1/kbrosnan/storage/clients?newer=1318680442.74&full=1 1318865571185 Sync.Engine.Clients INFO Records: 3 applied, 0 failed to apply, 0 newly failed to apply, 0 reconciled. 1318865571186 Sync.Service INFO Updating enabled engines: 9 clients. 1318865571188 Sync.Engine.Bookmarks INFO 0 outgoing items pre-reconciliation 1318865573560 Sync.Collection WARN Got exception calling onProgress handler during fetch of https://phx-sync259.services.mozilla.com/1.1/kbrosnan/storage/bookmarks?newer=1318798611.57&full=1 1318865573560 Sync.Collection DEBUG JSON.parse: unexpected character JS Stack trace: deserialize("")@record.js:97 < ()@record.js:827 < Channel_onDataAvail([object XPCWrappedNative_NoHelper],null,[object XPCWrappedNative_NoHelper],0,358)@resource.js:569 1318865573562 Sync.ErrorHandler DEBUG bookmarks failed: NS_ERROR_XPC_JAVASCRIPT_ERROR_WITH_DETAILS JS Stack trace: Res_get()@resource.js:473 < SyncEngine__processIncoming()@engines.js:912 < _processIncoming()@bookmarks.js:415 < SyncEngine__sync()@engines.js:1209 < wrappedSync(null)@bookmarks.js:253 < _sync()@bookmarks.js:259 < WrappedNotify()@util.js:148 < Engine_sync()@engines.js:517 < WeaveSvc__syncEngine([object Object])@service.js:1484 < ()@service.js:1377 < WrappedNotify()@util.js:148 < WrappedLock()@util.js:103 < _lockedSync()@service.js:1284 < ()@service.js:1275 < WrappedCatch()@util.js:77 < sync()@service.js:1263 1318865573562 Sync.Engine.Forms INFO 0 outgoing items pre-reconciliation 1318865573803 Sync.Collection DEBUG mesg: GET success 200 https://phx-sync259.services.mozilla.com/1.1/kbrosnan/storage/forms?newer=1318798601.67&full=1 1318865573803 Sync.Collection DEBUG GET success 200 https://phx-sync259.services.mozilla.com/1.1/kbrosnan/storage/forms?newer=1318798601.67&full=1 1318865573836 Sync.Engine.Forms INFO Records: 2 applied, 0 failed to apply, 0 newly failed to apply, 1 reconciled. 1318865573837 Sync.Engine.History INFO 5 outgoing items pre-reconciliation 1318865578000 Sync.Collection DEBUG mesg: GET success 200 https://phx-sync259.services.mozilla.com/1.1/kbrosnan/storage/history?newer=1318798601.86&full=1 1318865578000 Sync.Collection DEBUG GET success 200 https://phx-sync259.services.mozilla.com/1.1/kbrosnan/storage/history?newer=1318798601.86&full=1 1318865578105 Sync.Engine.History INFO Records: 155 applied, 0 failed to apply, 0 newly failed to apply, 2 reconciled. 1318865578125 Sync.Engine.History INFO Uploading all of 5 records 1318865578126 Sync.Collection DEBUG POST Length: 4090 1318865578648 Sync.Collection DEBUG mesg: POST success 200 https://phx-sync259.services.mozilla.com/1.1/kbrosnan/storage/history 1318865578648 Sync.Collection DEBUG POST success 200 https://phx-sync259.services.mozilla.com/1.1/kbrosnan/storage/history 1318865578806 Sync.Collection DEBUG mesg: DELETE success 200 https://phx-sync259.services.mozilla.com/1.1/kbrosnan/storage/history?ids=0NVfG4LFeyhG,QsMlbVtwDCAQ,jvfmFItrLnez,kX0dTc77lRyS,jz-qcCdE3K3w 1318865578806 Sync.Collection DEBUG DELETE success 200 https://phx-sync259.services.mozilla.com/1.1/kbrosnan/storage/history?ids=0NVfG4LFeyhG,QsMlbVtwDCAQ,jvfmFItrLnez,kX0dTc77lRyS,jz-qcCdE3K3w 1318865578807 Sync.Engine.Passwords INFO 0 outgoing items pre-reconciliation 1318865578918 Sync.Collection DEBUG mesg: GET success 200 https://phx-sync259.services.mozilla.com/1.1/kbrosnan/storage/passwords?newer=1318623579.2&full=1 1318865578918 Sync.Collection DEBUG GET success 200 https://phx-sync259.services.mozilla.com/1.1/kbrosnan/storage/passwords?newer=1318623579.2&full=1 1318865578918 Sync.Engine.Passwords INFO Records: 0 applied, 0 failed to apply, 0 newly failed to apply, 1 reconciled. 1318865578919 Sync.Engine.Prefs INFO 0 outgoing items pre-reconciliation 1318865578919 Sync.Engine.Prefs INFO Records: 0 applied, 0 failed to apply, 0 newly failed to apply, 0 reconciled. 1318865578920 Sync.Engine.Tabs INFO 1 outgoing items pre-reconciliation 1318865579085 Sync.Store.Tabs DEBUG Adding remote tabs from kbrosnan's Firefox Beta on T-Mobile G2 1318865579089 Sync.Store.Tabs DEBUG Adding remote tabs from kbrosnan's Aurora on Transformer TF101 1318865579240 Sync.Store.Tabs DEBUG Adding remote tabs from kevin's Firefox on trunk-myhost 1318865579241 Sync.Store.Tabs DEBUG Adding remote tabs from kbrosnan's Firefox Beta on T-Mobile G2 1318865579403 Sync.Store.Tabs DEBUG Adding remote tabs from Kevin's Nightly on Windows NT 6.1; Win64; x64 1318865579409 Sync.Store.Tabs DEBUG Adding remote tabs from Kevin's Firefox on Kevin-PC 1318865579411 Sync.Store.Tabs DEBUG Adding remote tabs from kevin's Firefox on myhost 1318865579414 Sync.Store.Tabs DEBUG Adding remote tabs from kbrosnan's Nightly on Transformer TF101 1318865579415 Sync.Collection DEBUG mesg: GET success 200 https://phx-sync259.services.mozilla.com/1.1/kbrosnan/storage/tabs?newer=1318798602.49&full=1 1318865579415 Sync.Collection DEBUG GET success 200 https://phx-sync259.services.mozilla.com/1.1/kbrosnan/storage/tabs?newer=1318798602.49&full=1 1318865579416 Sync.Engine.Tabs INFO Records: 9 applied, 0 failed to apply, 0 newly failed to apply, 0 reconciled. 1318865579448 Sync.Engine.Tabs INFO Uploading all of 1 records 1318865579449 Sync.Collection DEBUG POST Length: 1828 1318865579602 Sync.Collection DEBUG mesg: POST success 200 https://phx-sync259.services.mozilla.com/1.1/kbrosnan/storage/tabs 1318865579602 Sync.Collection DEBUG POST success 200 https://phx-sync259.services.mozilla.com/1.1/kbrosnan/storage/tabs 1318865579604 Sync.Service INFO Sync completed at 2011-10-17 11:32:59 after 9.04 secs. 1318865579604 Sync.ErrorHandler DEBUG Some engines did not sync correctly.