[pgsql-jp: 34173] Re: pgpoolのリードエラーについて

[Naoki Kaneto]

金戸です、よろしくお願いします。


> このログを見ると，
> 
> SELECT * FROM aaa_v WHERE id='13';
> 
> の結果，70件の行が抽出されているように見えます(read kind...が1行に対応
> する)．
> 
> たしか，
> 
> > 統合viewがあり、その統合view1,500件から64件(id='13')と50件(id='14')抽出
> > しました。
> 
> ということだったので，64件のデータが抽出されるのが正解かと思うんですが，
> どうなんでしょう？
> 
はい、64件です。ログを張り付けるときに失敗しました。

> また，マスタとセカンダリで，
> 
> SELECT * FROM aaa_v WHERE id='13';
> 
> の結果件数が違う，あるいはデータの中身が一致していない，っていうことは
> ないですよね？
> --
はい、pgpool,DB1,DB2ともに64件返されます。

rsync で同期を取ってから２個のDBを起動してpgpoolを起動していますが
まずい点有りますでしょうか？

成功ログと失敗ログで違いが出るところがあります。共通部分と違う部分です
58件読んだ後に成功例はread kind from backend Dが入りますが、失敗例は
入らないようです。

----ここから共通部分
DEBUG: pid 9670: Protocol Major: 3 Minor: 0 database: hoge user: kane
DEBUG: pid 9670: read kind from frontend Q(51)
DEBUG: pid 9670: Query: SELECT version()
DEBUG: pid 9670: read kind from backend T
DEBUG: pid 9670: pool_process_query: waiting for secondary for data
ready
DEBUG: pid 9670: read kind from backend pending data D len: 87 po: 33
DEBUG: pid 9670: read kind from backend pending data C len: 17 po: 103
DEBUG: pid 9670: read kind from backend pending data Z len: 5 po: 115
DEBUG: pid 9670: ReadyForQuery: message length: 5
DEBUG: pid 9670: ReadyForQuery: transaction state: I
DEBUG: pid 9670: read kind from frontend Q(51)
DEBUG: pid 9670: Query: SELECT * FROM aaa_v WHERE inp_date='13';
DEBUG: pid 9670: read kind from backend T
DEBUG: pid 9670: pool_process_query: waiting for secondary for data
ready
DEBUG: pid 9670: read kind from backend pending data D len: 835 po: 188
DEBUG: pid 9670: read kind from backend pending data D len: 507 po: 516
DEBUG: pid 9670: read kind from backend pending data D len: 179 po: 844
DEBUG: pid 9670: read kind from backend D
DEBUG: pid 9670: pool_process_query: waiting for secondary for data
ready
DEBUG: pid 9670: read kind from backend pending data D len: 695 po: 328
DEBUG: pid 9670: read kind from backend pending data D len: 367 po: 656
DEBUG: pid 9670: read kind from backend pending data D len: 39 po: 984
DEBUG: pid 9670: read kind from backend D
DEBUG: pid 9670: pool_process_query: waiting for secondary for data
ready
DEBUG: pid 9670: read kind from backend pending data D len: 695 po: 328
DEBUG: pid 9670: read kind from backend pending data D len: 367 po: 656
DEBUG: pid 9670: read kind from backend pending data D len: 39 po: 984
DEBUG: pid 9670: read kind from backend D
DEBUG: pid 9670: pool_process_query: waiting for secondary for data
ready
DEBUG: pid 9670: read kind from backend pending data D len: 695 po: 328
DEBUG: pid 9670: read kind from backend pending data D len: 367 po: 656
DEBUG: pid 9670: read kind from backend pending data D len: 39 po: 984
DEBUG: pid 9670: read kind from backend D
DEBUG: pid 9670: pool_process_query: waiting for secondary for data
ready
DEBUG: pid 9670: read kind from backend pending data D len: 695 po: 328
DEBUG: pid 9670: read kind from backend pending data D len: 367 po: 656
DEBUG: pid 9670: read kind from backend pending data D len: 39 po: 984
DEBUG: pid 9670: read kind from backend D
DEBUG: pid 9670: pool_process_query: waiting for secondary for data
ready
DEBUG: pid 9670: read kind from backend pending data D len: 695 po: 328
DEBUG: pid 9670: read kind from backend pending data D len: 367 po: 656
DEBUG: pid 9670: read kind from backend pending data D len: 39 po: 984
DEBUG: pid 9670: read kind from backend D
DEBUG: pid 9670: pool_process_query: waiting for secondary for data
ready
DEBUG: pid 9670: read kind from backend pending data D len: 695 po: 328
DEBUG: pid 9670: read kind from backend pending data D len: 367 po: 656
DEBUG: pid 9670: read kind from backend pending data D len: 39 po: 984
DEBUG: pid 9670: read kind from backend D
DEBUG: pid 9670: pool_process_query: waiting for secondary for data
ready
DEBUG: pid 9670: read kind from backend pending data D len: 695 po: 328
DEBUG: pid 9670: read kind from backend pending data D len: 367 po: 656
DEBUG: pid 9670: read kind from backend pending data D len: 39 po: 984
DEBUG: pid 9670: read kind from backend D
DEBUG: pid 9670: pool_process_query: waiting for secondary for data
ready
DEBUG: pid 9670: read kind from backend pending data D len: 695 po: 328
DEBUG: pid 9670: read kind from backend pending data D len: 367 po: 656
DEBUG: pid 9670: read kind from backend pending data D len: 39 po: 984
DEBUG: pid 9670: read kind from backend D
DEBUG: pid 9670: pool_process_query: waiting for secondary for data
ready
DEBUG: pid 9670: read kind from backend pending data D len: 695 po: 328
DEBUG: pid 9670: read kind from backend pending data D len: 367 po: 656
DEBUG: pid 9670: read kind from backend pending data D len: 39 po: 984
DEBUG: pid 9670: read kind from backend D
DEBUG: pid 9670: pool_process_query: waiting for secondary for data
ready
DEBUG: pid 9670: read kind from backend pending data D len: 695 po: 328
DEBUG: pid 9670: read kind from backend pending data D len: 367 po: 656
DEBUG: pid 9670: read kind from backend pending data D len: 39 po: 984
DEBUG: pid 9670: read kind from backend D
DEBUG: pid 9670: pool_process_query: waiting for secondary for data
ready
DEBUG: pid 9670: read kind from backend pending data D len: 695 po: 328
DEBUG: pid 9670: read kind from backend pending data D len: 367 po: 656
DEBUG: pid 9670: read kind from backend pending data D len: 39 po: 984
DEBUG: pid 9670: read kind from backend D
DEBUG: pid 9670: pool_process_query: waiting for secondary for data
ready
DEBUG: pid 9670: read kind from backend pending data D len: 695 po: 328
DEBUG: pid 9670: read kind from backend pending data D len: 367 po: 656
DEBUG: pid 9670: read kind from backend pending data D len: 39 po: 984
DEBUG: pid 9670: pool_process_query: waiting for secondary for data
ready
DEBUG: pid 9670: read kind from backend pending data D len: 695 po: 328
DEBUG: pid 9670: read kind from backend pending data D len: 367 po: 656
DEBUG: pid 9670: read kind from backend pending data D len: 39 po: 984
DEBUG: pid 9670: pool_process_query: waiting for secondary for data
ready
DEBUG: pid 9670: read kind from backend pending data D len: 695 po: 328
DEBUG: pid 9670: read kind from backend pending data D len: 367 po: 656
DEBUG: pid 9670: read kind from backend pending data D len: 39 po: 984
----ここまで58件リード

----ここから成功ログ
DEBUG: pid 9670: read kind from backend D
DEBUG: pid 9670: pool_process_query: waiting for secondary for data
ready
DEBUG: pid 9670: read kind from backend pending data D len: 695 po: 328
DEBUG: pid 9670: read kind from backend pending data D len: 367 po: 656
DEBUG: pid 9670: read kind from backend pending data D len: 39 po: 984
DEBUG: pid 9670: read kind from backend D
DEBUG: pid 9670: pool_process_query: waiting for secondary for data
ready
DEBUG: pid 9670: read kind from backend pending data C len: 17 po: 328
DEBUG: pid 9670: read kind from backend pending data Z len: 5 po: 340
DEBUG: pid 9670: ReadyForQuery: message length: 5
DEBUG: pid 9670: ReadyForQuery: transaction state: I
DEBUG: pid 9670: read kind from frontend X(58)
DEBUG: pid 9670: Query: RESET ALL
DEBUG: pid 9670: read kind from backend C
DEBUG: pid 9670: read kind from secondary backend C
DEBUG: pid 9670: read kind from backend pending data Z len: 5 po: 11
DEBUG: pid 9670: ReadyForQuery: message length: 5
DEBUG: pid 9670: ReadyForQuery: transaction state: I
DEBUG: pid 9670: pool_connection_pool_timer: called
----ここまで

----ここから失敗ログ
DEBUG: pid 9667: pool_process_query: waiting for secondary for data
ready
DEBUG: pid 9667: read kind from backend pending data D len: 695 po: 328
DEBUG: pid 9667: read kind from backend pending data D len: 367 po: 656
DEBUG: pid 9667: read kind from backend pending data D len: 39 po: 984
DEBUG: pid 9667: pool_process_query: waiting for secondary for data
ready
ERROR: pid 9667: pool_check_fd: data is not ready tp->tv_sec 0
tp->tp_usec 0
ERROR: pid 9667: pool_process_query: secondary data is not ready at
synchronous point. abort this session
ERROR: pid 9667:pool_process_query: kind does not match between backends
master(D) secondary()
LOG: pid 9667: do_child: exits with status 1 due to error
DEBUG: pid 9652: child 9667 exits with signal 0
----ここまで