松下さん

柴垣です。

結局、起動・終了コマンドを見直してみましたが
Errorは変わりませんでした。

悩んだ結果、logディレクトリを消して、もう一度mysqlを
再起動させてみることにしました。

すると、うまくレプリケーションできました。

納得がいかない部分は多々ありますが、とりあえず
復旧方法がわかったのでよかったです。

ありがとうございました。

----- Original Message ----- 
From: "Ryuji Matsushita" <maturyu@xxxxxxxxxx>
To: <ml@xxxxxxxxxx>
Sent: Friday, April 15, 2005 5:25 PM
Subject: [mysql 11331] Re: レプリケーションについて


> 松下です
>
> http://dev.mysql.com/doc/mysql/ja/starting-server.html
>
> ここに起動・終了のコマンドについて詳しく記載されています。
>
> >
> > InnoDBが正しくシャットダウンできてないようですね〜。
> >
> > 申し訳ありませんが、起動方法と停止方法を教えて頂けないでしょうか？
> > よろしくお願い致します。
> >
> > ----- Original Message ----- 
> > From: "Ryuji Matsushita" <maturyu@xxxxxxxxxx>
> > To: <ml@xxxxxxxxxx>
> > Sent: Friday, April 15, 2005 3:32 PM
> > Subject: [mysql 11329] Re: レプリケーションについて
> >
> >
> > > 松下です
> > > インラインにてコメントさせて頂きます。
> > >
> > > 正常にシャットダウンが出来ていなくてリカバリー作業中に書込みが発生して
バイ
> > ナリログの不整合
> > > が発生しているのではないでしょうか？
> > > マスター側スレーブ側ともにクリーンシャットダウンが出来ていません
> > > コマンドが間違っていませんか？
> > > 正常にシャットダウンした場合は下記のログが出ます。
> > > > 050415  2:10:01  InnoDB: Starting shutdown...
> > > > 050415  2:10:04  InnoDB: Shutdown completed
> > > > 050415  2:10:04  /usr/sbin/mysqld: Shutdown Complete
> > >
> > > 私なら
> > > マスター側をクリーンシャットダウンし
> > > OSも一度再起動します。
> > > ディスクスペース等OS側の環境をチェックし
> > > DB再起動
> > > バイナリーログがちゃんととれていることを確認
> > > マスター側のスナップショットを取直す
> > > をします。
> > >
> > > 高トランザクション系のDBでしたらログから追っかけるのはしんどいでしょう
から
> > > 再度スナップショットをとってレプリケーションを張直した方が良い感じがし
ま
> > す。
> > >
> > > もう少し切り分けるなら
> > > マスター側で
> > > SQL>SHOW MASTER STATUS;
> > >
> > > スレーブ側で
> > > SQL>SHOW SLAVE STATUS;
> > > で表示されるメッセージを読んでみてはいかがでしょうか？
> > >
> > > >
> > > >
> > > > マスターは正常にシャットダウンさせました。
> > > ↑シャットダウンのログが無いけど…
> > > >
> > > > レプリケーションできなくなった経緯は以下の通りです。
> > > >
> > > > 21:05　マスターを再起動
> > > > 以下はマスターのログです。
> > > > 050414 21:05:57  mysqld started
> > > > 050414 21:05:57  InnoDB: Database was not shut down normally.
> > > ↑正常にシャットダウン出来ていないとのメッセージ
> > >
> > > > InnoDB: Starting recovery from log files...
> > > > InnoDB: Starting log scan based on checkpoint at
> > > ↑リカバリーを使って起動をしている
> > >
> > > > InnoDB: log sequence number 0 3111453
> > > > InnoDB: Doing recovery: scanned up to log sequence number 0 3111453
> > > > InnoDB: Last MySQL binlog file position 0 628221, file name ./マス
ターの
> > ホス
> > > > ト名-bin.003
> > > > 050414 21:05:58  InnoDB: Flushing modified pages from the buffer
pool...
> > > > 050414 21:05:58  InnoDB: Started
> > > > 050414 21:05:58 Could not use マスターのホスト名-bin for logging
(error
> > 13).
> > > > Turning logging off for the whole duration of th
> > > ↑バイナリーログが追いついていない
> > >
> > > > e MySQL server process. To turn it on again: fix the cause, shutdown
the
> > > > MySQL server and restart it.
> > > > /usr/local/mysql/libexec/mysqld: ready for connections.
> > > > Version: '4.0.24-max-log'  socket: '/tmp/mysql.sock'  port: 3306
Source
> > > > distribution
> > > ↑もう一度クリーンシャットダウンしてくださいって
> > >
> > >
> > >
> > > >
> > > > 21:11　この時点でレプリケーションできなくなっていた。
> > > > 　　　　仕方がなかったのでこんどはスレーブのmysqlを再起動
> > > > 以下はスレーブのログです。
> > > > 050414 21:11:49  mysqld started
> > > > 050414 21:11:49  InnoDB: Database was not shut down normally.
> > > > InnoDB: Starting recovery from log files...
> > > > InnoDB: Starting log scan based on checkpoint at
> > > > InnoDB: log sequence number 0 3173059
> > > > InnoDB: Doing recovery: scanned up to log sequence number 0 3173059
> > > > InnoDB: In a MySQL replication slave the last master binlog file
> > > > InnoDB: position 0 628159, file name ichthyosaurus-bin.003
> > > > 050414 21:11:50  InnoDB: Flushing modified pages from the buffer
pool...
> > > > 050414 21:11:50  InnoDB: Started
> > > > 050414 21:11:50 Slave SQL thread initialized, starting replication
in
> > log '
> > > > マスターのホスト名-bin.003' at position 628221, re
> > > > lay log './スレーブのホスト名-relay-bin.004' position: 628317
> > > > 050414 21:11:50 Slave I/O thread: connected to master
> > > > 'repl@xxxxxxxxxx:3306',  replication started in log 'マスターのホ
スト
> > > > 名-bin.003' at position 628221
> > > > 050414 21:11:50 Error reading packet from server: Binary log is not
open
> > > > (server_errno=1236)
> > > > 050414 21:11:50 Got fatal error 1236: 'Binary log is not open' from
> > master
> > > > when reading data from binary log
> > > > 050414 21:11:50 Slave I/O thread exiting, read up to log 'マスターの
ホス
> > ト
> > > > 名-bin.003', position 628221
> > > > /usr/local/mysql/libexec/mysqld: ready for connections.
> > > > Version: '4.0.24-max-log'  socket: '/tmp/mysql.sock'  port: 3306
Source
> > > > distribution
> > > >
> > > > 簡単に書くとこのような感じです。
> > > > 助言おねがいします。
> > > >
> > > > 以上です。
> > > >
> > > > ----- Original Message ----- 
> > > > From: "Ryuji Matsushita" <maturyu@xxxxxxxxxx>
> > > > To: <ml@xxxxxxxxxx>
> > > > Sent: Friday, April 15, 2005 9:34 AM
> > > > Subject: [mysql 11326] Re: レプリケーションについて
> > > >
> > > >
> > > > > 松下です
> > > > >
> > > > > もう少し状況をお知らせください。
> > > > > 下記のログはスレーブ側のログですよね。
> > > > > マスター側のログはどのようになっていますか？
> > > > > マスターがダウンとは正常にシャットダウンをした場合でしょうか？
> > > > > ダウン時の挙動をマスター側、スレーブ側で時系列に整理してください。
> > > > >
> > > > > マスター側のバイナリーログがOPEN出来ないようですが
> > > > > DBの設定とは異なるところに原因があるのではないでしょうか？
> > > > >
> > > > > 私のところでマスター側を再起動した時のログを貼付けます
> > > > >
> > > > >
> > > > > > 050415  9:25:42  Slave: received 0 length packet from server,
> > apparent
> > > > master shutdown:
> > > > > ↑ここでマスター側をシャットダウン
> > > > >
> > > > > > 050415  9:25:42  Slave I/O thread: Failed reading log event,
> > > > reconnecting to retry, log 'ホスト名-bin.001' position XXXXXXX
> > > > > ↑当然バイナリーログが読めない
> > > > >
> > > > > > 050415  9:25:42  Slave I/O thread: error reconnecting to master
'
> > ユー
> > > > ザー名@マスター側ホスト名:3306': Error: 'Lost connection to MySQL
server
> > > > during query'  errno: 2013  retry-time: 60  retries: 86400
> > > > > ↑スレーブ側で設定したマスタ側へのI/Oのユーザーが接続できない。再
接続
> > 待
> > > > ち。
> > > > >
> > > > > > 050415  9:26:42  Slave: connected to master 'ユーザー名@マスター
側ホ
> > スト
> > > > 名:3306',replication resumed in log 'マスター側ホスト名-bin.001' at
> > position
> > > > XXXXXXXX
> > > > > ↑再接続完了
> > > > >
> > > > >
> > > > >
> > > > > > 050414 22:49:01 Error reading packet from server: Binary log is
not
> > open
> > > > > > (server_errno=1236)
> > > > > > 050414 22:49:01 Got fatal error 1236: 'Binary log is not open'
from
> > > > master
> > > > > > when reading data from binary log
> > > > > > 050414 22:49:01 Slave I/O thread exiting, read up to log 'ホスト
> > > > 名-bin.003',
> > > > > > position 628221
> > > > > > /usr/local/mysql/libexec/mysqld: ready for connections.
> > > > > > Version: '4.0.24-max-log'  socket: '/tmp/mysql.sock'  port: 3306
> > Source
> > > > > > distribution
> > > > >
> > > > > +++++++++++++++++++++++++++++++++++++++++++++++++++
> > > > >  Sony Digital Network Applications Inc.(SDNA)
> > > > >  Navigation Track  Information System
> > > > >  松下　龍士(Ryuji Matsushita) maturyu@xxxxxxxxxx
> > > > > +++++++++++++++++++++++++++++++++++++++++++++++++++
> > > > >
> > > > >
> > > > >
> > >
> > > +++++++++++++++++++++++++++++++++++++++++++++++++++
> > >  Sony Digital Network Applications Inc.(SDNA)
> > >  Navigation Track  Information System
> > >  松下　龍士(Ryuji Matsushita) maturyu@xxxxxxxxxx
> > > +++++++++++++++++++++++++++++++++++++++++++++++++++
> > >
> > >
> > >
>
> +++++++++++++++++++++++++++++++++++++++++++++++++++
>  Sony Digital Network Applications Inc.(SDNA)
>  Navigation Track  Information System
>  松下　龍士(Ryuji Matsushita) maturyu@xxxxxxxxxx
> +++++++++++++++++++++++++++++++++++++++++++++++++++
>
>
>