Just to clarify, there are three sets of file/position coordinates in SHOW SLAVE STATUS:

1) The position, ON THE MASTER, from which the I/O thread is reading:Master_Log_File/Read_Master_Log_Pos. -----相對於主庫,從庫讀取主庫的二進位制日誌的位置,是IO執行緒

2) The position, IN THE RELAY LOGS, at which the SQL thread is executing:Relay_Log_File/Relay_Log_Pos

3) The position, ON THE MASTER, at which the SQL thread is executing:Relay_Master_Log_File/Exec_Master_Log_Pos ----相對於主庫,是從庫的sql執行緒執行到的位置

Numbers 2) and 3) are the same thing, but one is on the slave and the other is on the master.

mysql > show slave status \G

Master_Log_File: mysql-bin-m.000329

Read_Master_Log_Pos: 863952156　----上面二行代表IO執行緒,相對於主庫的二進位制檔案

Relay_Log_File: mysql-relay.003990

Relay_Log_Pos: 25077069　----上面二行代表了sql執行緒,相對於從庫的中繼日誌檔案

Relay_Master_Log_File: mysql-bin-m.000329

.....

Exec_Master_Log_Pos: 863936961---上面二行代表了sql執行緒,相對主庫

(為了方便演示,我把上面這行提前了.)

Relay_Log_Space: 25092264---當前relay-log檔案的大小

Slave_IO_Running: Yes

Slave_SQL_Running: Yes

從上面可以看到,read_master_log_pos 始終會大於exec_master_log_pos的值(也有可能相等):因為一個值是代表io執行緒,一個值代表sql執行緒;sql執行緒肯定在io執行緒之後.(當然,io執行緒和sql執行緒要讀寫同一個檔案,否則比較就失去意義了) .

在binlog中,Xid代表了提交的事務號.現在我們分別去主從庫看看,驗證一下,在主庫的mysql-bin-m.000329檔案的863936961處是否與從庫的mysql-relay.003990檔案的25077069處有相同的sql語句.

先看主庫的binlog:

# at 863936961

#100111 20:11:39 server id 115000 end_log_pos 863937234 Query thread_id=515886 exec_time=0 error_code=0

use mall00/*!*/;

UPDATE mall00.t_item_sid88 SET item_end_time = 1263816699, item_is_online = 1, item_status = 1 WHERE iid IN (94322390, 94322428, 94322452, 94322473, 94322506, 94322532, 94322604, 94322641, 94322670, 94322706)/*!*/;

# at 863937234

#100111 20:11:39 server id 115000 end_log_pos 863937261 Xid = 1225244590

COMMIT/*!*/;

# at 863937261

#100111 20:11:39 server id 115000 end_log_pos 863937457 Query thread_id=515886 exec_time=0error_code=0

SET TIMESTAMP=1263211899/*!*/;

再看從庫的relaylog:

# at 25077069

#100111 20:11:39 server id 115000 end_log_pos863937234 Query thread_id=515886 exec_time=0 error_code=0

use mall00/*!*/;

UPDATE mall00.t_item_sid88 SET item_end_time = 1263816699, item_is_online = 1, item_status = 1 WHERE iid IN (94322390, 94322428, 94322452, 94322473, 94322506, 94322532, 94322604, 94322641, 94322670, 94322706)/*!*/;

# at 25077342

#100111 20:11:39 server id 115000 end_log_pos 863937261 Xid = 1225244590

COMMIT/*!*/;

從上面的日誌中,可以看到binlog與realy-log的內容是相同的,除了開頭的at位置處的偏移量.因為偏移量始終是相對於檔案自身來說,主庫上相對於binlog本身,從庫上相對於relay-log本身.還可以看到,在每個query語句過後,都有一個Xid 的event,提交該事務,也表明在mysql中是自動提交的,每條語句執行完畢後,系統都自動提交了.那麼在基於行的複製中,可能會看到多條binlog 語句才對應一次commit,自然說明這是基於行的複製.

還有一點,就是主庫和從庫的對應位置的event大小是相同的,例如上面的:

25077342-25077069(從庫上event大小)  =  863937234-863936961(主庫上event大小)

否則,說明從庫的relay-log丟失了,有可能是作業系統快取丟失,也可能是mysql 異常crash導致relay-log buffer中的資料丟失.那麼這時候就需要重設主從同步了.