[前][次][番号順一覧][スレッド一覧]

mysql:11329

From: Ryuji Matsushita <Ryuji Matsushita <maturyu@xxxxxxxxxx>>
Date: Fri, 15 Apr 2005 15:32:28 +0900
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
+++++++++++++++++++++++++++++++++++++++++++++++++++


[前][次][番号順一覧][スレッド一覧]

     11324 2005-04-14 22:59 [柴垣 大樹 <sibagaki] レプリケーションについて                
     11326 2005-04-15 09:34 ┗[Ryuji Matsushita <ma]                                       
     11328 2005-04-15 14:12  ┗[柴垣 大樹 <sibagaki]                                     
->   11329 2005-04-15 15:32   ┗[Ryuji Matsushita <ma]                                   
     11330 2005-04-15 16:22    ┗[柴垣 大樹 <sibagaki]                                 
     11331 2005-04-15 17:25     ┗[Ryuji Matsushita <ma]                               
     11333 2005-04-18 14:08      ┗[柴垣 大樹 <sibagaki]