[pgpool-general-jp: 1360] エラー時に無応答のケースについて

近藤 skond66 @ gmail.com
2015年 3月 9日 (月) 12:01:13 JST


お世話になっております。近藤です。

pgpool 3.3.5 の以下の環境で応答が停止するケースがあり、確認をお願いいたします。

環境
 centos 5.11
 php  5.1.6
 pgpool  3.3.5
 postgreSQL 9.3.6

設定
replicate_select = off
load_balance_mode = on

(この組み合わせだけで発生するようです)

実行SQL (PHP の pdo経由です)

begin;
select 1 from aaaaa;

(aaaaaテーブルは存在しないので、エラーになります。)

症状

phpから pdo 経由で begin 後に 上記select をした際に時々無応答になり、pgpoolの接続が1つ固まります。

pgpoolを動作させているサーバで ps すると、

pgpool: ******** test 127.0.0.1(53856) SELECT


DBサーバ上で ps すると、どちらのサーバでも
postgres: ********* test ***.***.****.****(47851) idle in transaction

となっています。


詳細なログを見ると、DBノード0にselect が行った時は正常にエラー表示されて終了し、DBノード1にselect が行くと、固まってしまうようです。

デバッグ状態で実行した詳細なログを以下に追記いたします。よろしくお願いいたします


<正常な場合>
2015-03-09 11:25:18 DEBUG: pid 19166: ProcessFrontendResponse: kind from
frontend Q(51)
2015-03-09 11:25:18 DEBUG: pid 19166:
pool_unset_doing_extended_query_message: done
2015-03-09 11:25:18 DEBUG: pid 19166: statement2: begin
2015-03-09 11:25:18 DEBUG: pid 19166: pool_set_query_in_progress: done
2015-03-09 11:25:18 DEBUG: pid 19166: wait_for_query_response: waiting for
backend 0 completing the query
2015-03-09 11:25:18 DEBUG: pid 19166: detect_error: kind: C
2015-03-09 11:25:18 DEBUG: pid 19166: detect_error: kind: C
2015-03-09 11:25:18 DEBUG: pid 19166: detect_error: kind: C
2015-03-09 11:25:18 DEBUG: pid 19166: detect_error: kind: C
2015-03-09 11:25:18 DEBUG: pid 19166: wait_for_query_response: waiting for
backend 1 completing the query
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: kind: C from
0 th backend
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: read kind
from 0 th backend C NUM_BACKENDS: 2
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: kind: C from
1 th backend
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: read kind
from 1 th backend C NUM_BACKENDS: 2
2015-03-09 11:25:18 DEBUG: pid 19166: ProcessBackendResponse: kind from
backend: C
2015-03-09 11:25:18 DEBUG: pid 19166: pool_unset_writing_transaction: done
2015-03-09 11:25:18 DEBUG: pid 19166: pool_unset_failed_transaction: done
2015-03-09 11:25:18 DEBUG: pid 19166: pool_unset_transaction_isolation: done
2015-03-09 11:25:18 DEBUG: pid 19166: pool_set_command_success: done
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: kind: Z from
0 th backend
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: read kind
from 0 th backend Z NUM_BACKENDS: 2
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: kind: Z from
1 th backend
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: read kind
from 1 th backend Z NUM_BACKENDS: 2
2015-03-09 11:25:18 DEBUG: pid 19166: ProcessBackendResponse: kind from
backend: Z
2015-03-09 11:25:18 DEBUG: pid 19166: pool_read_message_length: slot: 0
length: 5
2015-03-09 11:25:18 DEBUG: pid 19166: pool_read_message_length: slot: 1
length: 5
2015-03-09 11:25:18 DEBUG: pid 19166: ReadyForQuery: transaction state:T
2015-03-09 11:25:18 DEBUG: pid 19166: ReadyForQuery: transaction state:T
2015-03-09 11:25:18 DEBUG: pid 19166: pool_unset_writing_transaction: done
2015-03-09 11:25:18 DEBUG: pid 19166: pool_unset_failed_transaction: done
2015-03-09 11:25:18 DEBUG: pid 19166: pool_unset_transaction_isolation: done
2015-03-09 11:25:18 DEBUG: pid 19166: pool_unset_query_in_progress: done
2015-03-09 11:25:18 DEBUG: pid 19166: pool_unset_query_in_progress: done
2015-03-09 11:25:18 DEBUG: pid 19166: ProcessBackendResponse: Ready For
Query
2015-03-09 11:25:18 DEBUG: pid 19166: ProcessFrontendResponse: kind from
frontend Q(51)
2015-03-09 11:25:18 DEBUG: pid 19166:
pool_unset_doing_extended_query_message: done
2015-03-09 11:25:18 DEBUG: pid 19166: statement2: select 1 from aaaaa
2015-03-09 11:25:18 DEBUG: pid 19166: pool_set_query_in_progress: done
2015-03-09 11:25:18 DEBUG: pid 19166: do_query: extended:0 query:SELECT
current_setting('transaction_isolation')
2015-03-09 11:25:18 DEBUG: pid 19166: do_query: kind: T
2015-03-09 11:25:18 DEBUG: pid 19166: do_query: row description received
2015-03-09 11:25:18 DEBUG: pid 19166: num_fileds: 1
2015-03-09 11:25:18 DEBUG: pid 19166: do_query: kind: D
2015-03-09 11:25:18 DEBUG: pid 19166: do_query: data row received
2015-03-09 11:25:18 DEBUG: pid 19166: do_query: kind: C
2015-03-09 11:25:18 DEBUG: pid 19166: do_query: Command complete received
2015-03-09 11:25:18 DEBUG: pid 19166: do_query: kind: Z
2015-03-09 11:25:18 DEBUG: pid 19166: do_query: Ready for query
2015-03-09 11:25:18 DEBUG: pid 19166: wait_for_query_response: waiting for
backend 0 completing the query
2015-03-09 11:25:18 LOG:   pid 19166: pool_send_and_wait: Error or notice
message from backend: : DB node id: 0 backend pid: 15213 statement: select
1 from aaaaa message: relation "aaaaa" does not exist
2015-03-09 11:25:18 DEBUG: pid 19166: detect_error: kind: E
2015-03-09 11:25:18 DEBUG: pid 19166: detect_error: kind: E
2015-03-09 11:25:18 DEBUG: pid 19166: detect_error: kind: E
2015-03-09 11:25:18 DEBUG: pid 19166: detect_error: kind: E
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: kind: E from
0 th backend
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: read kind
from 0 th backend E NUM_BACKENDS: 2
2015-03-09 11:25:18 DEBUG: pid 19166: ProcessBackendResponse: kind from
backend: E
2015-03-09 11:25:18 DEBUG: pid 19166: do_error_command: kind: E
2015-03-09 11:25:18 DEBUG: pid 19166: pool_unset_command_success: done
2015-03-09 11:25:18 DEBUG: pid 19166: pool_set_failed_transaction: done
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: kind: Z from
0 th backend
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: read kind
from 0 th backend Z NUM_BACKENDS: 2
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: kind: Z from
1 th backend
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: read kind
from 1 th backend Z NUM_BACKENDS: 2
2015-03-09 11:25:18 DEBUG: pid 19166: ProcessBackendResponse: kind from
backend: Z
2015-03-09 11:25:18 DEBUG: pid 19166: pool_read_message_length: slot: 0
length: 5
2015-03-09 11:25:18 DEBUG: pid 19166: pool_read_message_length: slot: 1
length: 5
2015-03-09 11:25:18 DEBUG: pid 19166: ReadyForQuery: transaction state:T
2015-03-09 11:25:18 DEBUG: pid 19166: ReadyForQuery: transaction state:E
2015-03-09 11:25:18 DEBUG: pid 19166: pool_unset_query_in_progress: done
2015-03-09 11:25:18 DEBUG: pid 19166: pool_unset_query_in_progress: done
2015-03-09 11:25:18 DEBUG: pid 19166: ProcessBackendResponse: Ready For
Query
2015-03-09 11:25:18 DEBUG: pid 19166: ProcessFrontendResponse: kind from
frontend Q(51)
2015-03-09 11:25:18 DEBUG: pid 19166:
pool_unset_doing_extended_query_message: done
2015-03-09 11:25:18 DEBUG: pid 19166: statement2: commit
2015-03-09 11:25:18 DEBUG: pid 19166: pool_set_query_in_progress: done
2015-03-09 11:25:18 DEBUG: pid 19166: wait_for_query_response: waiting for
backend 1 completing the query
2015-03-09 11:25:18 DEBUG: pid 19166: wait_for_query_response: waiting for
backend 0 completing the query
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: kind: C from
0 th backend
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: read kind
from 0 th backend C NUM_BACKENDS: 2
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: kind: C from
1 th backend
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: read kind
from 1 th backend C NUM_BACKENDS: 2
2015-03-09 11:25:18 DEBUG: pid 19166: ProcessBackendResponse: kind from
backend: C
2015-03-09 11:25:18 DEBUG: pid 19166: pool_set_command_success: done
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: kind: Z from
0 th backend
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: read kind
from 0 th backend Z NUM_BACKENDS: 2
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: kind: Z from
1 th backend
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: read kind
from 1 th backend Z NUM_BACKENDS: 2
2015-03-09 11:25:18 DEBUG: pid 19166: ProcessBackendResponse: kind from
backend: Z
2015-03-09 11:25:18 DEBUG: pid 19166: pool_read_message_length: slot: 0
length: 5
2015-03-09 11:25:18 DEBUG: pid 19166: pool_read_message_length: slot: 1
length: 5
2015-03-09 11:25:18 DEBUG: pid 19166: ReadyForQuery: transaction state:E
2015-03-09 11:25:18 DEBUG: pid 19166: ReadyForQuery: transaction state:I
2015-03-09 11:25:18 DEBUG: pid 19166: pool_unset_writing_transaction: done
2015-03-09 11:25:18 DEBUG: pid 19166: pool_unset_failed_transaction: done
2015-03-09 11:25:18 DEBUG: pid 19166: pool_unset_transaction_isolation: done
2015-03-09 11:25:18 DEBUG: pid 19166: pool_unset_query_in_progress: done
2015-03-09 11:25:18 DEBUG: pid 19166: pool_unset_query_in_progress: done
2015-03-09 11:25:18 DEBUG: pid 19166: ProcessBackendResponse: Ready For
Query
2015-03-09 11:25:18 DEBUG: pid 19166: ProcessFrontendResponse: kind from
frontend X(58)
2015-03-09 11:25:18 DEBUG: pid 19166:
pool_unset_doing_extended_query_message: done
2015-03-09 11:25:18 DEBUG: pid 19166: pool_unset_query_in_progress: done
2015-03-09 11:25:18 DEBUG: pid 19166: pool_unset_query_in_progress: done
2015-03-09 11:25:18 DEBUG: pid 19166: statement2:  DISCARD ALL
2015-03-09 11:25:18 DEBUG: pid 19166: pool_set_query_in_progress: done
2015-03-09 11:25:18 DEBUG: pid 19166: wait_for_query_response: waiting for
backend 0 completing the query
2015-03-09 11:25:18 DEBUG: pid 19166: detect_error: kind: S
2015-03-09 11:25:18 DEBUG: pid 19166: detect_error: kind: S
2015-03-09 11:25:18 DEBUG: pid 19166: detect_error: kind: S
2015-03-09 11:25:18 DEBUG: pid 19166: detect_error: kind: S
2015-03-09 11:25:18 DEBUG: pid 19166: wait_for_query_response: waiting for
backend 1 completing the query
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: kind: S from
0 th backend
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: parameter
name: is_superuser value: on
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: kind: S from
0 th backend
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: parameter
name: session_authorization value: **********
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: kind: C from
0 th backend
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: read kind
from 0 th backend C NUM_BACKENDS: 2
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: kind: S from
1 th backend
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: parameter
name: is_superuser value: on
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: kind: S from
1 th backend
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: parameter
name: session_authorization value: **********
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: kind: C from
1 th backend
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: read kind
from 1 th backend C NUM_BACKENDS: 2
2015-03-09 11:25:18 DEBUG: pid 19166: ProcessBackendResponse: kind from
backend: C
2015-03-09 11:25:18 DEBUG: pid 19166: pool_set_command_success: done
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: kind: Z from
0 th backend
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: read kind
from 0 th backend Z NUM_BACKENDS: 2
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: kind: Z from
1 th backend
2015-03-09 11:25:18 DEBUG: pid 19166: read_kind_from_backend: read kind
from 1 th backend Z NUM_BACKENDS: 2
2015-03-09 11:25:18 DEBUG: pid 19166: ProcessBackendResponse: kind from
backend: Z
2015-03-09 11:25:18 DEBUG: pid 19166: pool_read_message_length: slot: 0
length: 5
2015-03-09 11:25:18 DEBUG: pid 19166: pool_read_message_length: slot: 1
length: 5
2015-03-09 11:25:18 DEBUG: pid 19166: ReadyForQuery: transaction state:I
2015-03-09 11:25:18 DEBUG: pid 19166: ReadyForQuery: transaction state:I
2015-03-09 11:25:18 DEBUG: pid 19166: pool_unset_query_in_progress: done
2015-03-09 11:25:18 DEBUG: pid 19166: pool_unset_query_in_progress: done
2015-03-09 11:25:18 DEBUG: pid 19166: ProcessBackendResponse: Ready For
Query
2015-03-09 11:25:18 DEBUG: pid 19166: pool_unset_query_in_progress: done
2015-03-09 11:25:18 DEBUG: pid 19166: pool_connection_pool_timer: set close
time 1425867918
2015-03-09 11:25:18 DEBUG: pid 19166: pool_connection_pool_timer: set alarm
after 30 seconds




<無応答になる場合>
2015-03-09 11:24:26 DEBUG: pid 19172: I am 19172 accept fd 6
2015-03-09 11:24:26 DEBUG: pid 19172: Protocol Major: 1234 Minor: 5679
database:  user:
2015-03-09 11:24:26 DEBUG: pid 19172: SSLRequest from client
2015-03-09 11:24:26 DEBUG: pid 19172: pool_ssl: SSL requested but SSL
support is not available
2015-03-09 11:24:26 DEBUG: pid 19172: Protocol Major: 3 Minor: 0 database:
test user: **********
2015-03-09 11:24:26 DEBUG: pid 19172: new_connection: connecting 0 backend
2015-03-09 11:24:26 DEBUG: pid 19172: new_connection: connecting 1 backend
2015-03-09 11:24:26 DEBUG: pid 19172: pool_ssl: SSL requested but SSL
support is not available
2015-03-09 11:24:26 DEBUG: pid 19172: pool_ssl: SSL requested but SSL
support is not available
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length: slot: 0
length: 8
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length: slot: 1
length: 8
2015-03-09 11:24:26 DEBUG: pid 19172: pool_do_auth: auth kind:0
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length2: master
slot: 0 length: 22
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length2: master
slot: 1 length: 22
2015-03-09 11:24:26 DEBUG: pid 19172: 0 th backend: name: application_name
value:
2015-03-09 11:24:26 DEBUG: pid 19172: 1 th backend: name: application_name
value:
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length2: master
slot: 0 length: 25
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length2: master
slot: 1 length: 25
2015-03-09 11:24:26 DEBUG: pid 19172: 0 th backend: name: client_encoding
value: SJIS
2015-03-09 11:24:26 DEBUG: pid 19172: 1 th backend: name: client_encoding
value: SJIS
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length2: master
slot: 0 length: 23
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length2: master
slot: 1 length: 23
2015-03-09 11:24:26 DEBUG: pid 19172: 0 th backend: name: DateStyle value:
ISO, YMD
2015-03-09 11:24:26 DEBUG: pid 19172: 1 th backend: name: DateStyle value:
ISO, YMD
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length2: master
slot: 0 length: 25
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length2: master
slot: 1 length: 25
2015-03-09 11:24:26 DEBUG: pid 19172: 0 th backend: name: integer_datetimes
value: on
2015-03-09 11:24:26 DEBUG: pid 19172: 1 th backend: name: integer_datetimes
value: on
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length2: master
slot: 0 length: 27
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length2: master
slot: 1 length: 27
2015-03-09 11:24:26 DEBUG: pid 19172: 0 th backend: name: IntervalStyle
value: postgres
2015-03-09 11:24:26 DEBUG: pid 19172: 1 th backend: name: IntervalStyle
value: postgres
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length2: master
slot: 0 length: 20
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length2: master
slot: 1 length: 20
2015-03-09 11:24:26 DEBUG: pid 19172: 0 th backend: name: is_superuser
value: on
2015-03-09 11:24:26 DEBUG: pid 19172: 1 th backend: name: is_superuser
value: on
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length2: master
slot: 0 length: 25
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length2: master
slot: 1 length: 25
2015-03-09 11:24:26 DEBUG: pid 19172: 0 th backend: name: server_encoding
value: UTF8
2015-03-09 11:24:26 DEBUG: pid 19172: 1 th backend: name: server_encoding
value: UTF8
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length2: master
slot: 0 length: 25
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length2: master
slot: 1 length: 25
2015-03-09 11:24:26 DEBUG: pid 19172: 0 th backend: name: server_version
value: 9.3.6
2015-03-09 11:24:26 DEBUG: pid 19172: 1 th backend: name: server_version
value: 9.3.6
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length2: master
slot: 0 length: 34
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length2: master
slot: 1 length: 34
2015-03-09 11:24:26 DEBUG: pid 19172: 0 th backend: name:
session_authorization value: **********
2015-03-09 11:24:26 DEBUG: pid 19172: 1 th backend: name:
session_authorization value: **********
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length2: master
slot: 0 length: 35
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length2: master
slot: 1 length: 35
2015-03-09 11:24:26 DEBUG: pid 19172: 0 th backend: name:
standard_conforming_strings value: on
2015-03-09 11:24:26 DEBUG: pid 19172: 1 th backend: name:
standard_conforming_strings value: on
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length2: master
slot: 0 length: 19
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length2: master
slot: 1 length: 19
2015-03-09 11:24:26 DEBUG: pid 19172: 0 th backend: name: TimeZone value:
Japan
2015-03-09 11:24:26 DEBUG: pid 19172: 1 th backend: name: TimeZone value:
Japan
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length: slot: 0
length: 12
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length: slot: 1
length: 12
2015-03-09 11:24:26 DEBUG: pid 19172: pool_do_auth:
cp->info[i]:0x2b769c8f8000 pid:15212
2015-03-09 11:24:26 DEBUG: pid 19172: pool_do_auth:
cp->info[i]:0x2b769c8f8088 pid:14885
2015-03-09 11:24:26 DEBUG: pid 19172: pool_send_auth_ok: send pid 14885 to
frontend
2015-03-09 11:24:26 DEBUG: pid 19172: select_load_balancing_node: selected
backend id is 1
2015-03-09 11:24:26 DEBUG: pid 19172: selected load balancing node: 1
2015-03-09 11:24:26 DEBUG: pid 19172: pool_unset_query_in_progress: done
2015-03-09 11:24:26 DEBUG: pid 19172: pool_unset_command_success: done
2015-03-09 11:24:26 DEBUG: pid 19172: pool_unset_writing_transaction: done
2015-03-09 11:24:26 DEBUG: pid 19172: pool_unset_failed_transaction: done
2015-03-09 11:24:26 DEBUG: pid 19172: pool_unset_transaction_isolation: done
2015-03-09 11:24:26 DEBUG: pid 19172:
pool_unset_skip_reading_from_backends: done
2015-03-09 11:24:26 DEBUG: pid 19172: pool_unset_ignore_till_sync: done
2015-03-09 11:24:26 DEBUG: pid 19172: read_kind_from_backend: kind: Z from
0 th backend
2015-03-09 11:24:26 DEBUG: pid 19172: read_kind_from_backend: read kind
from 0 th backend Z NUM_BACKENDS: 2
2015-03-09 11:24:26 DEBUG: pid 19172: read_kind_from_backend: kind: Z from
1 th backend
2015-03-09 11:24:26 DEBUG: pid 19172: read_kind_from_backend: read kind
from 1 th backend Z NUM_BACKENDS: 2
2015-03-09 11:24:26 DEBUG: pid 19172: ProcessBackendResponse: kind from
backend: Z
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length: slot: 0
length: 5
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length: slot: 1
length: 5
2015-03-09 11:24:26 DEBUG: pid 19172: ReadyForQuery: transaction state:
2015-03-09 11:24:26 DEBUG: pid 19172: ReadyForQuery: transaction state:I
2015-03-09 11:24:26 DEBUG: pid 19172: ProcessBackendResponse: Ready For
Query
2015-03-09 11:24:26 DEBUG: pid 19172: ProcessFrontendResponse: kind from
frontend Q(51)
2015-03-09 11:24:26 DEBUG: pid 19172:
pool_unset_doing_extended_query_message: done
2015-03-09 11:24:26 DEBUG: pid 19172: statement2: begin
2015-03-09 11:24:26 DEBUG: pid 19172: pool_set_query_in_progress: done
2015-03-09 11:24:26 DEBUG: pid 19172: wait_for_query_response: waiting for
backend 0 completing the query
2015-03-09 11:24:26 DEBUG: pid 19172: detect_error: kind: C
2015-03-09 11:24:26 DEBUG: pid 19172: detect_error: kind: C
2015-03-09 11:24:26 DEBUG: pid 19172: detect_error: kind: C
2015-03-09 11:24:26 DEBUG: pid 19172: detect_error: kind: C
2015-03-09 11:24:26 DEBUG: pid 19172: wait_for_query_response: waiting for
backend 1 completing the query
2015-03-09 11:24:26 DEBUG: pid 19172: read_kind_from_backend: kind: C from
0 th backend
2015-03-09 11:24:26 DEBUG: pid 19172: read_kind_from_backend: read kind
from 0 th backend C NUM_BACKENDS: 2
2015-03-09 11:24:26 DEBUG: pid 19172: read_kind_from_backend: kind: C from
1 th backend
2015-03-09 11:24:26 DEBUG: pid 19172: read_kind_from_backend: read kind
from 1 th backend C NUM_BACKENDS: 2
2015-03-09 11:24:26 DEBUG: pid 19172: ProcessBackendResponse: kind from
backend: C
2015-03-09 11:24:26 DEBUG: pid 19172: pool_unset_writing_transaction: done
2015-03-09 11:24:26 DEBUG: pid 19172: pool_unset_failed_transaction: done
2015-03-09 11:24:26 DEBUG: pid 19172: pool_unset_transaction_isolation: done
2015-03-09 11:24:26 DEBUG: pid 19172: pool_set_command_success: done
2015-03-09 11:24:26 DEBUG: pid 19172: read_kind_from_backend: kind: Z from
0 th backend
2015-03-09 11:24:26 DEBUG: pid 19172: read_kind_from_backend: read kind
from 0 th backend Z NUM_BACKENDS: 2
2015-03-09 11:24:26 DEBUG: pid 19172: read_kind_from_backend: kind: Z from
1 th backend
2015-03-09 11:24:26 DEBUG: pid 19172: read_kind_from_backend: read kind
from 1 th backend Z NUM_BACKENDS: 2
2015-03-09 11:24:26 DEBUG: pid 19172: ProcessBackendResponse: kind from
backend: Z
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length: slot: 0
length: 5
2015-03-09 11:24:26 DEBUG: pid 19172: pool_read_message_length: slot: 1
length: 5
2015-03-09 11:24:26 DEBUG: pid 19172: ReadyForQuery: transaction state:T
2015-03-09 11:24:26 DEBUG: pid 19172: ReadyForQuery: transaction state:T
2015-03-09 11:24:26 DEBUG: pid 19172: pool_unset_writing_transaction: done
2015-03-09 11:24:26 DEBUG: pid 19172: pool_unset_failed_transaction: done
2015-03-09 11:24:26 DEBUG: pid 19172: pool_unset_transaction_isolation: done
2015-03-09 11:24:26 DEBUG: pid 19172: pool_unset_query_in_progress: done
2015-03-09 11:24:26 DEBUG: pid 19172: pool_unset_query_in_progress: done
2015-03-09 11:24:26 DEBUG: pid 19172: ProcessBackendResponse: Ready For
Query
2015-03-09 11:24:26 DEBUG: pid 19172: ProcessFrontendResponse: kind from
frontend Q(51)
2015-03-09 11:24:26 DEBUG: pid 19172:
pool_unset_doing_extended_query_message: done
2015-03-09 11:24:26 DEBUG: pid 19172: statement2: select 1 from aaaaa
2015-03-09 11:24:26 DEBUG: pid 19172: pool_set_query_in_progress: done
2015-03-09 11:24:26 DEBUG: pid 19172: do_query: extended:0 query:SELECT
current_setting('transaction_isolation')
2015-03-09 11:24:26 DEBUG: pid 19172: do_query: kind: T
2015-03-09 11:24:26 DEBUG: pid 19172: do_query: row description received
2015-03-09 11:24:26 DEBUG: pid 19172: num_fileds: 1
2015-03-09 11:24:26 DEBUG: pid 19172: do_query: kind: D
2015-03-09 11:24:26 DEBUG: pid 19172: do_query: data row received
2015-03-09 11:24:26 DEBUG: pid 19172: do_query: kind: C
2015-03-09 11:24:26 DEBUG: pid 19172: do_query: Command complete received
2015-03-09 11:24:26 DEBUG: pid 19172: do_query: kind: Z
2015-03-09 11:24:26 DEBUG: pid 19172: do_query: Ready for query
2015-03-09 11:24:26 DEBUG: pid 19172: wait_for_query_response: waiting for
backend 1 completing the query
2015-03-09 11:24:26 LOG:   pid 19172: pool_send_and_wait: Error or notice
message from backend: : DB node id: 1 backend pid: 14885 statement: select
1 from aaaaa message: relation "aaaaa" does not exist
2015-03-09 11:24:26 DEBUG: pid 19172: detect_error: kind: E
2015-03-09 11:24:26 DEBUG: pid 19172: detect_error: kind: E
2015-03-09 11:24:26 DEBUG: pid 19172: detect_error: kind: E
2015-03-09 11:24:26 DEBUG: pid 19172: detect_error: kind: E
2015-03-09 11:24:26 DEBUG: pid 19172: read_kind_from_backend: kind: E from
1 th backend
2015-03-09 11:24:26 DEBUG: pid 19172: read_kind_from_backend: read kind
from 1 th backend E NUM_BACKENDS: 2
2015-03-09 11:24:26 DEBUG: pid 19172: ProcessBackendResponse: kind from
backend: E
2015-03-09 11:24:26 DEBUG: pid 19172: do_error_command: kind: Z
2015-03-09 11:24:26 DEBUG: pid 19172: do_error_command: kind: E
2015-03-09 11:24:26 DEBUG: pid 19172: pool_unset_command_success: done
2015-03-09 11:24:26 DEBUG: pid 19172: pool_set_failed_transaction: done
2015-03-09 11:24:26 DEBUG: pid 19170: pool_backend_timer_handler called at
1425867866
2015-03-09 11:24:26 DEBUG: pid 19170: pool_backend_timer_handler: expire
time: 1425867866
2015-03-09 11:24:26 DEBUG: pid 19170: pool_backend_timer_handler: expires
user ********** database test
2015-03-09 11:24:27 DEBUG: pid 19171: pool_backend_timer_handler called at
1425867867
2015-03-09 11:24:27 DEBUG: pid 19171: pool_backend_timer_handler: expire
time: 1425867867
2015-03-09 11:24:27 DEBUG: pid 19171: pool_backend_timer_handler: expires
user ********** database test
2015-03-09 11:24:27 DEBUG: pid 19168: pool_backend_timer_handler called at
1425867867
2015-03-09 11:24:27 DEBUG: pid 19168: pool_backend_timer_handler: expire
time: 1425867867
2015-03-09 11:24:27 DEBUG: pid 19168: pool_backend_timer_handler: expires
user ********** database test
2015-03-09 11:24:28 DEBUG: pid 19157: pool_backend_timer_handler called at
1425867868
2015-03-09 11:24:28 DEBUG: pid 19157: pool_backend_timer_handler: expire
time: 1425867868
2015-03-09 11:24:28 DEBUG: pid 19157: pool_backend_timer_handler: expires
user ********** database test
2015-03-09 11:24:28 DEBUG: pid 19169: pool_backend_timer_handler called at
1425867868
2015-03-09 11:24:28 DEBUG: pid 19169: pool_backend_timer_handler: expire
time: 1425867868
2015-03-09 11:24:28 DEBUG: pid 19169: pool_backend_timer_handler: expires
user ********** database test
2015-03-09 11:24:28 DEBUG: pid 19167: pool_backend_timer_handler called at
1425867868
2015-03-09 11:24:28 DEBUG: pid 19167: pool_backend_timer_handler: expire
time: 1425867868
2015-03-09 11:24:28 DEBUG: pid 19167: pool_backend_timer_handler: expires
user ********** database test


以上。
-------------- next part --------------
HTML$B$NE:IU%U%!%$%k$rJ]4I$7$^$7$?(B...
URL: <http://www.sraoss.jp/pipermail/pgpool-general-jp/attachments/20150309/b8063848/attachment-0001.html>


pgpool-general-jp メーリングリストの案内