firefox syncが2011/6/28の8:00頃からエラー多発・・・Syncをリセットで復旧したみたい。（ログの取り方付き）

WindowsでFirefox 5を使っていたら、Syncのエラーが2011/6/28の8:00頃からエラーが頻発しました。

エラーの内容は、「サーバの設定が間違っている」という趣旨。Windowsのfirefox 6 (Aurora)でもでるので、Ubuntu 11.04 でfirefox4.0.1でも出たので、どうもfirefoxのバージョンやOSの種類ではないみたい。多分、サーバーかな～と・・・

そこで、調べたらログのとり方が分かったので、取ってみました。

とり方は、

1) アドレスバーに　about:config と入れる。

2) services.sync.log.appender.debugLog.enabled のキーの値をtrueにする。

3) 一度firefoxをリスタートする。

4) Syncエラーが起きるのを待つ。（「いますぐ同期」を行ってもよい。とにかくエラーを発生させる。）

5) アドレスバーにabout:sync-logを入れるとログが表示される。これを、コピーして適当なファイルに保存。

6) 取り終わったら、 アドレスバーにabout:configを入れて、services.sync.log.appender.debugLog.enabled のキーの値をfalseに戻し、Firefoxを再起動。　

 

で、その結果。

------------------

1309217278550    Service.Main    INFO    Loading Weave 1.7b1pre
1309217278560    Engine.Bookmarks    DEBUG    Engine initialized
1309217278561    Engine.Forms    DEBUG    Engine initialized
1309217278561    Engine.History    DEBUG    Engine initialized
1309217278562    Engine.Passwords    DEBUG    Engine initialized
1309217278563    Engine.Prefs    DEBUG    Engine initialized
1309217278563    Engine.Tabs    DEBUG    Engine initialized
1309217278563    Engine.Tabs    DEBUG    Resetting tabs last sync time1309217278564    Service.Main    INFO    Mozilla/5.0 (X11; Linux i686; rv:2.0.1) Gecko/20100101 Firefox/4.0.1
1309217278566    Service.Main    DEBUG    Caching URLs under storage user base: https://phx-sync125.services.mozilla.com/1.0/<user_name>/
1309217281052    Service.Main    INFO    Starting sync at 2011-06-28 08:28:01
1309217281053    Service.Main    DEBUG    In sync: should login.
1309217281054    Service.Main    INFO    Logging in user <user_name>
1309217282584    Service.Main    DEBUG    Exception: Could not acquire lock. Label: "service.js: login". No traceback available
1309217282584    Service.Main    INFO    Cannot start sync: already syncing?
1309217282584    Service.Main    DEBUG    Autoconnect failed: success.login; retry in 114 sec.
1309217295688    Service.Main    DEBUG    Clearing sync triggers.
1309217296350    Net.Resource    DEBUG    GET fail 503 https://phx-sync125.services.mozilla.com/1.0/<usr_name>/info/collections
1309217296360    Service.Main    DEBUG    Exception: Login failed: error.login.reason.server No traceback available
1309217296360    Service.Main    DEBUG    Not syncing: login returned false.
1309217296360    Service.Main    DEBUG    Clearing sync triggers.

-------------------

503てHTTPのステータスコードだとしたら、Service Temporarily Unavailable？？

時間を開けてもう一度とったら。下記の行があって200がHTTPのステータスだとしたら、通信には成功してるってことですよね。でも、今度は不明なエラーが頻発。暗号化の符号が不一致？？

-------------------

1309223400143    Collection    WARN    Got exception calling onProgress handler during fetch of https://phx-sync125.services.mozilla.com/1.0/<user_name>/storage/bookmarks
1309223400143    Collection    DEBUG    JSON.parse JS Stack trace:
1309223400144    Service.Main    DEBUG    bookmarks failed:
1309223400144    Engine.Forms    INFO    0 outgoing items pre-reconciliation
1309223400310    Engine.Forms    WARN    Error decrypting record: Record SHA256 HMAC mismatch: should be
1309223400311    Collection    DEBUG    GET success 200 https://phx-sync125.services.mozilla.com/1.0/<user_name>/storage/forms
1309223400311    Engine.Forms    DEBUG    Records that failed to apply:
1309223400311    Service.Main    DEBUG    forms failed to apply some records.
1309223400311    Engine.Forms    INFO    Records: 0 applied, 1 failed to apply, 0 reconciled.

-------------------

※上記ログは、かなりカットしてあります。

 <user_name> には、実際は私のアカウントが入ります。

ひょっとして、サーバー上のデータが壊れたのかな？？と思い。

データがちゃんとしてると思うFirefoxから[オプション（設定）]→[Sync]→[アカウント管理]→[Syncをリセット] でサーバ上のデータをFirefoxのデータで置き換えたら直ったみたい。

適当やったら直ったみたいと言うのが本音。それともタイミングよく偶然直った？？

とにかく、ログの取り方が分ったのと、エラーが発生しなくなっただけいいか・・・

 

 ←誤り訂正技術の本

    昔、符号理論の勉強をしたような・・
    全く忘れてる。

 

タグ：Firefox sync error エラー

コメント 2

管理人さん、こんにちは(^^)
本日firefoxのバージョンアップ(Ver5)をしたところ同じ症状になりました(TT)
syncキーリセット、パスワード変更etc・・・改善せず・・・
こちらでは通信は問題ないみたいなので、他の要因かもしれません、現在追跡中です。
by マヨチュウ♪ (2011-06-28 12:07) 

☆マヨチュウ♪さん☆
「syncをリセット」でも直りませんか・・・
私が直ったのは、偶然かな～？サーバーが違うからかな～？
私の所では、この記事に書いてから、今の所再発していません。
とにかく、早く直るといいですね。

ちなみに、「syncをリセット」で、同期オプションは一番下のやつを選びました。
by あんきょ (2011-06-28 18:09)