[Pgpool-general] Pgpool error and stuck transaction

Nimesh Satam nimesh.satam at gmail.com
Thu Jan 20 05:29:36 UTC 2011


Hi,

We are using postgres-9.0.1 and pgpool-3.01 for postgres streaming
replication and loadbalancing respectively. For some reason we see stuck
"idle in transaction" on the database from a certain user, but not such
"idle in transaction" state on pgpool. All the connection from the
corresponding user are seen in "idle" state between pgpool and the
application.

When we searched for pgpool logs for the given pgpool child process, we
noticed that pgpool has done a failover, but no reason to be seen in the
logs. Can anybdy let us know what might have gone wrong here? Attached are
the pgpool child process logs.

One important concern here is why pgpool is leaving a open transaction when
the pooling child process is showing idle state?

Regards,
Nimesh.
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://pgfoundry.org/pipermail/pgpool-general/attachments/20110120/87d47e61/attachment-0001.html>
-------------- next part --------------
2011-01-19 00:30:42 DEBUG: pid 24873: I am 24873 accept fd 6
2011-01-19 00:30:42 DEBUG: pid 24873: Protocol Major: 1234 Minor: 5679 database:  user:
2011-01-19 00:30:42 DEBUG: pid 24873: SSLRequest from client
2011-01-19 00:30:42 DEBUG: pid 24873: pool_ssl: SSL requested but SSL support is not available
2011-01-19 00:30:42 DEBUG: pid 24873: Protocol Major: 3 Minor: 0 database: reporting user: postgres
2011-01-19 00:30:42 DEBUG: pid 24873: new_connection: connecting 0 backend
2011-01-19 00:30:42 DEBUG: pid 24873: new_connection: connecting 1 backend
2011-01-19 00:30:42 DEBUG: pid 24873: pool_ssl: SSL requested but SSL support is not available
2011-01-19 00:30:42 DEBUG: pid 24873: pool_ssl: SSL requested but SSL support is not available
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length: slot: 0 length: 8
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length: slot: 1 length: 8
2011-01-19 00:30:42 DEBUG: pid 24873: pool_do_auth: auth kind:0
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 0 length: 22
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 1 length: 22
2011-01-19 00:30:42 DEBUG: pid 24873: 0 th backend: name: application_name value:
2011-01-19 00:30:42 DEBUG: pid 24873: 1 th backend: name: application_name value:
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 0 length: 30
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 1 length: 30
2011-01-19 00:30:42 DEBUG: pid 24873: 0 th backend: name: client_encoding value: SQL_ASCII
2011-01-19 00:30:42 DEBUG: pid 24873: 1 th backend: name: client_encoding value: SQL_ASCII
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 0 length: 23
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 1 length: 23
2011-01-19 00:30:42 DEBUG: pid 24873: 0 th backend: name: DateStyle value: ISO, MDY
2011-01-19 00:30:42 DEBUG: pid 24873: 1 th backend: name: DateStyle value: ISO, MDY
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 0 length: 25
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 1 length: 25
2011-01-19 00:30:42 DEBUG: pid 24873: 0 th backend: name: integer_datetimes value: on
2011-01-19 00:30:42 DEBUG: pid 24873: 1 th backend: name: integer_datetimes value: on
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 0 length: 27
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 1 length: 27
2011-01-19 00:30:42 DEBUG: pid 24873: 0 th backend: name: IntervalStyle value: postgres
2011-01-19 00:30:42 DEBUG: pid 24873: 1 th backend: name: IntervalStyle value: postgres
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 0 length: 20
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 1 length: 20
2011-01-19 00:30:42 DEBUG: pid 24873: 0 th backend: name: is_superuser value: on
2011-01-19 00:30:42 DEBUG: pid 24873: 1 th backend: name: is_superuser value: on
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 0 length: 30
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 1 length: 30
2011-01-19 00:30:42 DEBUG: pid 24873: 0 th backend: name: server_encoding value: SQL_ASCII
2011-01-19 00:30:42 DEBUG: pid 24873: 1 th backend: name: server_encoding value: SQL_ASCII
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 0 length: 25
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 1 length: 25
2011-01-19 00:30:42 DEBUG: pid 24873: 0 th backend: name: server_version value: 9.0.1
2011-01-19 00:30:42 DEBUG: pid 24873: 1 th backend: name: server_version value: 9.0.1
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 0 length: 35
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 1 length: 35
2011-01-19 00:30:42 DEBUG: pid 24873: 0 th backend: name: session_authorization value: postgres
2011-01-19 00:30:42 DEBUG: pid 24873: 1 th backend: name: session_authorization value: postgres
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 0 length: 36
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 1 length: 36
2011-01-19 00:30:42 DEBUG: pid 24873: 0 th backend: name: standard_conforming_strings value: off
2011-01-19 00:30:42 DEBUG: pid 24873: 1 th backend: name: standard_conforming_strings value: off
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 0 length: 24
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 1 length: 24
2011-01-19 00:30:42 DEBUG: pid 24873: 0 th backend: name: TimeZone value: US/Pacific
2011-01-19 00:30:42 DEBUG: pid 24873: 1 th backend: name: TimeZone value: US/Pacific
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length: slot: 0 length: 12
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length: slot: 1 length: 12
2011-01-19 00:30:42 DEBUG: pid 24873: pool_do_auth: cp->info[i]:0x7fedb8e68000 pid:19001
2011-01-19 00:30:42 DEBUG: pid 24873: pool_do_auth: cp->info[i]:0x7fedb8e68088 pid:25144
2011-01-19 00:30:42 DEBUG: pid 24873: pool_send_auth_ok: send pid 25144 to frontend
2011-01-19 00:30:42 DEBUG: pid 24873: select_load_balancing_node: selected backend id is 0
2011-01-19 00:30:42 DEBUG: pid 24873: selected load balancing node: 0
2011-01-19 00:30:42 DEBUG: pid 24873: pool_unset_query_in_progress: done
2011-01-19 00:30:42 DEBUG: pid 24873: pool_unset_skip_reading_from_backends: done
2011-01-19 00:30:42 DEBUG: pid 24873: pool_unset_ignore_till_sync: done
2011-01-19 00:30:42 DEBUG: pid 24873: read_kind_from_backend: read kind from 0 th backend Z NUM_BACKENDS: 2
2011-01-19 00:30:42 DEBUG: pid 24873: read_kind_from_backend: read kind from 1 th backend Z NUM_BACKENDS: 2
2011-01-19 00:30:42 DEBUG: pid 24873: ProcessBackendResponse: kind from backend: Z
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length: slot: 0 length: 5
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length: slot: 1 length: 5
2011-01-19 00:30:42 DEBUG: pid 24873: ProcessFrontendResponse: kind from frontend Q(51)
2011-01-19 00:30:42 DEBUG: pid 24873: pool_unset_doing_extended_query_message: done
2011-01-19 00:30:42 DEBUG: pid 24873: statement2: begin
2011-01-19 00:30:42 DEBUG: pid 24873: pool_set_query_in_progress: done
2011-01-19 00:30:42 DEBUG: pid 24873: send_to_where: 0 query: begin
2011-01-19 00:30:42 DEBUG: pid 24873: wait_for_query_response: waiting for backend 0 completing the query
2011-01-19 00:30:42 DEBUG: pid 24873: read_kind_from_backend: read kind from 0 th backend C NUM_BACKENDS: 2
2011-01-19 00:30:42 DEBUG: pid 24873: ProcessBackendResponse: kind from backend: C
2011-01-19 00:30:42 DEBUG: pid 24873: read_kind_from_backend: read kind from 0 th backend Z NUM_BACKENDS: 2
2011-01-19 00:30:42 DEBUG: pid 24873: ProcessBackendResponse: kind from backend: Z
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length: slot: 0 length: 5
2011-01-19 00:30:42 DEBUG: pid 24873: pool_unset_query_in_progress: done
2011-01-19 00:30:42 DEBUG: pid 24873: pool_unset_query_in_progress: done
2011-01-19 00:30:42 DEBUG: pid 24873: ProcessFrontendResponse: kind from frontend Q(51)
2011-01-19 00:30:42 DEBUG: pid 24873: pool_unset_doing_extended_query_message: done
2011-01-19 00:30:42 DEBUG: pid 24873: statement2: INSERT INTO table_xxx (id, type, sqldate, ) VALUES(nextval('id_seq'), 13, '2011-01-18')
2011-01-19 00:30:42 DEBUG: pid 24873: pool_set_query_in_progress: done
2011-01-19 00:30:42 DEBUG: pid 24873: send_to_where: 0 query: INSERT INTO table_xxx (id, type, sqldate, ) VALUES(nextval('id_seq'), 13, '2011-01-18')
2011-01-19 00:30:42 DEBUG: pid 24873: wait_for_query_response: waiting for backend 0 completing the query
2011-01-19 00:30:42 DEBUG: pid 24873: read_kind_from_backend: read kind from 0 th backend C NUM_BACKENDS: 2
2011-01-19 00:30:42 DEBUG: pid 24873: ProcessBackendResponse: kind from backend: C
2011-01-19 00:30:42 DEBUG: pid 24873: read_kind_from_backend: read kind from 0 th backend Z NUM_BACKENDS: 2
2011-01-19 00:30:42 DEBUG: pid 24873: ProcessBackendResponse: kind from backend: Z
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length: slot: 0 length: 5
2011-01-19 00:30:42 DEBUG: pid 24873: pool_unset_query_in_progress: done
2011-01-19 00:30:42 DEBUG: pid 24873: pool_unset_query_in_progress: done
2011-01-19 00:30:42 DEBUG: pid 24873: ProcessFrontendResponse: kind from frontend Q(51)
2011-01-19 00:30:42 DEBUG: pid 24873: pool_unset_doing_extended_query_message: done
2011-01-19 00:30:42 DEBUG: pid 24873: statement2: commit
2011-01-19 00:30:42 DEBUG: pid 24873: pool_set_query_in_progress: done
2011-01-19 00:30:42 DEBUG: pid 24873: send_to_where: 0 query: commit
2011-01-19 00:30:42 DEBUG: pid 24873: wait_for_query_response: waiting for backend 0 completing the query
2011-01-19 00:30:42 DEBUG: pid 24873: read_kind_from_backend: read kind from 0 th backend C NUM_BACKENDS: 2
2011-01-19 00:30:42 DEBUG: pid 24873: ProcessBackendResponse: kind from backend: C
2011-01-19 00:30:42 DEBUG: pid 24873: read_kind_from_backend: read kind from 0 th backend Z NUM_BACKENDS: 2
2011-01-19 00:30:42 DEBUG: pid 24873: ProcessBackendResponse: kind from backend: Z
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length: slot: 0 length: 5
2011-01-19 00:30:42 DEBUG: pid 24873: pool_unset_query_in_progress: done
2011-01-19 00:30:42 DEBUG: pid 24873: pool_unset_query_in_progress: done
2011-01-19 00:30:42 DEBUG: pid 24873: ProcessFrontendResponse: kind from frontend X(58)
2011-01-19 00:30:42 DEBUG: pid 24873: pool_unset_doing_extended_query_message: done
2011-01-19 00:30:42 DEBUG: pid 24873: pool_unset_query_in_progress: done
2011-01-19 00:30:42 DEBUG: pid 24873: I am 24873 accept fd 6
2011-01-19 00:30:42 DEBUG: pid 24873: Protocol Major: 1234 Minor: 5679 database:  user:
2011-01-19 00:30:42 DEBUG: pid 24873: SSLRequest from client
2011-01-19 00:30:42 DEBUG: pid 24873: pool_ssl: SSL requested but SSL support is not available
2011-01-19 00:30:42 DEBUG: pid 24873: Protocol Major: 3 Minor: 0 database: reporting user: postgres
2011-01-19 00:30:42 DEBUG: pid 24873: new_connection: connecting 0 backend
2011-01-19 00:30:42 DEBUG: pid 24873: new_connection: connecting 1 backend
2011-01-19 00:30:42 DEBUG: pid 24873: pool_ssl: SSL requested but SSL support is not available
2011-01-19 00:30:42 DEBUG: pid 24873: pool_ssl: SSL requested but SSL support is not available
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length: slot: 0 length: 8
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length: slot: 1 length: 8
2011-01-19 00:30:42 DEBUG: pid 24873: pool_do_auth: auth kind:0
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 0 length: 22
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 1 length: 22
2011-01-19 00:30:42 DEBUG: pid 24873: 0 th backend: name: application_name value:
2011-01-19 00:30:42 DEBUG: pid 24873: 1 th backend: name: application_name value:
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 0 length: 30
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 1 length: 30
2011-01-19 00:30:42 DEBUG: pid 24873: 0 th backend: name: client_encoding value: SQL_ASCII
2011-01-19 00:30:42 DEBUG: pid 24873: 1 th backend: name: client_encoding value: SQL_ASCII
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 0 length: 23
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 1 length: 23
2011-01-19 00:30:42 DEBUG: pid 24873: 0 th backend: name: DateStyle value: ISO, MDY
2011-01-19 00:30:42 DEBUG: pid 24873: 1 th backend: name: DateStyle value: ISO, MDY
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 0 length: 25
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 1 length: 25
2011-01-19 00:30:42 DEBUG: pid 24873: 0 th backend: name: integer_datetimes value: on
2011-01-19 00:30:42 DEBUG: pid 24873: 1 th backend: name: integer_datetimes value: on
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 0 length: 27
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 1 length: 27
2011-01-19 00:30:42 DEBUG: pid 24873: 0 th backend: name: IntervalStyle value: postgres
2011-01-19 00:30:42 DEBUG: pid 24873: 1 th backend: name: IntervalStyle value: postgres
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 0 length: 20
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 1 length: 20
2011-01-19 00:30:42 DEBUG: pid 24873: 0 th backend: name: is_superuser value: on
2011-01-19 00:30:42 DEBUG: pid 24873: 1 th backend: name: is_superuser value: on
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 0 length: 30
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 1 length: 30
2011-01-19 00:30:42 DEBUG: pid 24873: 0 th backend: name: server_encoding value: SQL_ASCII
2011-01-19 00:30:42 DEBUG: pid 24873: 1 th backend: name: server_encoding value: SQL_ASCII
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 0 length: 25
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 1 length: 25
2011-01-19 00:30:42 DEBUG: pid 24873: 0 th backend: name: server_version value: 9.0.1
2011-01-19 00:30:42 DEBUG: pid 24873: 1 th backend: name: server_version value: 9.0.1
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 0 length: 35
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 1 length: 35
2011-01-19 00:30:42 DEBUG: pid 24873: 0 th backend: name: session_authorization value: postgres
2011-01-19 00:30:42 DEBUG: pid 24873: 1 th backend: name: session_authorization value: postgres
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 0 length: 36
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 1 length: 36
2011-01-19 00:30:42 DEBUG: pid 24873: 0 th backend: name: standard_conforming_strings value: off
2011-01-19 00:30:42 DEBUG: pid 24873: 1 th backend: name: standard_conforming_strings value: off
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 0 length: 24
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length2: master slot: 1 length: 24
2011-01-19 00:30:42 DEBUG: pid 24873: 0 th backend: name: TimeZone value: US/Pacific
2011-01-19 00:30:42 DEBUG: pid 24873: 1 th backend: name: TimeZone value: US/Pacific
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length: slot: 0 length: 12
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length: slot: 1 length: 12
2011-01-19 00:30:42 DEBUG: pid 24873: pool_do_auth: cp->info[i]:0x7fedb8e68000 pid:19002
2011-01-19 00:30:42 DEBUG: pid 24873: pool_do_auth: cp->info[i]:0x7fedb8e68088 pid:25145
2011-01-19 00:30:42 DEBUG: pid 24873: pool_send_auth_ok: send pid 25145 to frontend
2011-01-19 00:30:42 DEBUG: pid 24873: select_load_balancing_node: selected backend id is 0
2011-01-19 00:30:42 DEBUG: pid 24873: selected load balancing node: 0
2011-01-19 00:30:42 DEBUG: pid 24873: pool_unset_query_in_progress: done
2011-01-19 00:30:42 DEBUG: pid 24873: pool_unset_skip_reading_from_backends: done
2011-01-19 00:30:42 DEBUG: pid 24873: pool_unset_ignore_till_sync: done
2011-01-19 00:30:42 DEBUG: pid 24873: read_kind_from_backend: read kind from 0 th backend Z NUM_BACKENDS: 2
2011-01-19 00:30:42 DEBUG: pid 24873: read_kind_from_backend: read kind from 1 th backend Z NUM_BACKENDS: 2
2011-01-19 00:30:42 DEBUG: pid 24873: ProcessBackendResponse: kind from backend: Z
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length: slot: 0 length: 5
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length: slot: 1 length: 5
2011-01-19 00:30:42 DEBUG: pid 24873: ProcessFrontendResponse: kind from frontend Q(51)
2011-01-19 00:30:42 DEBUG: pid 24873: pool_unset_doing_extended_query_message: done
2011-01-19 00:30:42 DEBUG: pid 24873: statement2: begin
2011-01-19 00:30:42 DEBUG: pid 24873: pool_set_query_in_progress: done
2011-01-19 00:30:42 DEBUG: pid 24873: send_to_where: 0 query: begin
2011-01-19 00:30:42 DEBUG: pid 24873: wait_for_query_response: waiting for backend 0 completing the query
2011-01-19 00:30:42 DEBUG: pid 24873: read_kind_from_backend: read kind from 0 th backend C NUM_BACKENDS: 2
2011-01-19 00:30:42 DEBUG: pid 24873: ProcessBackendResponse: kind from backend: C
2011-01-19 00:30:42 DEBUG: pid 24873: read_kind_from_backend: read kind from 0 th backend Z NUM_BACKENDS: 2
2011-01-19 00:30:42 DEBUG: pid 24873: ProcessBackendResponse: kind from backend: Z
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length: slot: 0 length: 5
2011-01-19 00:30:42 DEBUG: pid 24873: pool_unset_query_in_progress: done
2011-01-19 00:30:42 DEBUG: pid 24873: pool_unset_query_in_progress: done
2011-01-19 00:30:42 DEBUG: pid 24873: ProcessFrontendResponse: kind from frontend Q(51)
2011-01-19 00:30:42 DEBUG: pid 24873: pool_unset_doing_extended_query_message: done
2011-01-19 00:30:42 DEBUG: pid 24873: statement2: INSERT INTO table_xxx (id, type, sqldate, ) VALUES(nextval('id_seq'), 13, '2011-01-18')
2011-01-19 00:30:42 DEBUG: pid 24873: pool_set_query_in_progress: done
2011-01-19 00:30:42 DEBUG: pid 24873: send_to_where: 0 query: INSERT INTO table_xxx (id, type, sqldate, ) VALUES(nextval('id_seq'), 13, '2011-01-18')
2011-01-19 00:30:42 DEBUG: pid 24873: wait_for_query_response: waiting for backend 0 completing the query
2011-01-19 00:30:42 DEBUG: pid 24873: read_kind_from_backend: read kind from 0 th backend C NUM_BACKENDS: 2
2011-01-19 00:30:42 DEBUG: pid 24873: ProcessBackendResponse: kind from backend: C
2011-01-19 00:30:42 DEBUG: pid 24873: read_kind_from_backend: read kind from 0 th backend Z NUM_BACKENDS: 2
2011-01-19 00:30:42 DEBUG: pid 24873: ProcessBackendResponse: kind from backend: Z
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length: slot: 0 length: 5
2011-01-19 00:30:42 DEBUG: pid 24873: pool_unset_query_in_progress: done
2011-01-19 00:30:42 DEBUG: pid 24873: pool_unset_query_in_progress: done
2011-01-19 00:30:42 DEBUG: pid 24873: ProcessFrontendResponse: kind from frontend Q(51)
2011-01-19 00:30:42 DEBUG: pid 24873: pool_unset_doing_extended_query_message: done
2011-01-19 00:30:42 DEBUG: pid 24873: statement2: commit
2011-01-19 00:30:42 DEBUG: pid 24873: pool_set_query_in_progress: done
2011-01-19 00:30:42 DEBUG: pid 24873: send_to_where: 0 query: commit
2011-01-19 00:30:42 DEBUG: pid 24873: wait_for_query_response: waiting for backend 0 completing the query
2011-01-19 00:30:42 DEBUG: pid 24873: read_kind_from_backend: read kind from 0 th backend C NUM_BACKENDS: 2
2011-01-19 00:30:42 DEBUG: pid 24873: ProcessBackendResponse: kind from backend: C
2011-01-19 00:30:42 DEBUG: pid 24873: read_kind_from_backend: read kind from 0 th backend Z NUM_BACKENDS: 2
2011-01-19 00:30:42 DEBUG: pid 24873: ProcessBackendResponse: kind from backend: Z
2011-01-19 00:30:42 DEBUG: pid 24873: pool_read_message_length: slot: 0 length: 5
2011-01-19 00:30:42 DEBUG: pid 24873: pool_unset_query_in_progress: done
2011-01-19 00:30:42 DEBUG: pid 24873: pool_unset_query_in_progress: done
2011-01-19 00:30:42 DEBUG: pid 24873: ProcessFrontendResponse: kind from frontend X(58)
2011-01-19 00:30:42 DEBUG: pid 24873: pool_unset_doing_extended_query_message: done
2011-01-19 00:30:42 DEBUG: pid 24873: pool_unset_query_in_progress: done
2011-01-19 00:34:16 DEBUG: pid 24873: key: listen_addresses
2011-01-19 00:34:16 DEBUG: pid 24873: value: '*' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: key: port
2011-01-19 00:34:16 DEBUG: pid 24873: value: 4560 kind: 2
2011-01-19 00:34:16 DEBUG: pid 24873: key: pcp_port
2011-01-19 00:34:16 DEBUG: pid 24873: value: 4561 kind: 2
2011-01-19 00:34:16 DEBUG: pid 24873: key: socket_dir
2011-01-19 00:34:16 DEBUG: pid 24873: value: '/tmp' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: key: pcp_socket_dir
2011-01-19 00:34:16 DEBUG: pid 24873: value: '/tmp' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: key: backend_socket_dir
2011-01-19 00:34:16 DEBUG: pid 24873: value: '/tmp' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: key: pcp_timeout
2011-01-19 00:34:16 DEBUG: pid 24873: value: 10 kind: 2
2011-01-19 00:34:16 DEBUG: pid 24873: key: num_init_children
2011-01-19 00:34:16 DEBUG: pid 24873: value: 32 kind: 2
2011-01-19 00:34:16 DEBUG: pid 24873: key: max_pool
2011-01-19 00:34:16 DEBUG: pid 24873: value: 4 kind: 2
2011-01-19 00:34:16 DEBUG: pid 24873: key: child_life_time
2011-01-19 00:34:16 DEBUG: pid 24873: value: 300 kind: 2
2011-01-19 00:34:16 DEBUG: pid 24873: key: connection_life_time
2011-01-19 00:34:16 DEBUG: pid 24873: value: 0 kind: 2
2011-01-19 00:34:16 DEBUG: pid 24873: key: child_max_connections
2011-01-19 00:34:16 DEBUG: pid 24873: value: 0 kind: 2
2011-01-19 00:34:16 DEBUG: pid 24873: key: client_idle_limit
2011-01-19 00:34:16 DEBUG: pid 24873: value: 0 kind: 2
2011-01-19 00:34:16 DEBUG: pid 24873: key: authentication_timeout
2011-01-19 00:34:16 DEBUG: pid 24873: value: 60 kind: 2
2011-01-19 00:34:16 DEBUG: pid 24873: key: logdir
2011-01-19 00:34:16 DEBUG: pid 24873: value: '/var/log/pgpool' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: key: pid_file_name
2011-01-19 00:34:16 DEBUG: pid 24873: value: '/var/run/pgpool/pgpool.pid' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: key: replication_mode
2011-01-19 00:34:16 DEBUG: pid 24873: value: false kind: 1
2011-01-19 00:34:16 DEBUG: pid 24873: key: load_balance_mode
2011-01-19 00:34:16 DEBUG: pid 24873: value: true kind: 1
2011-01-19 00:34:16 DEBUG: pid 24873: key: replication_stop_on_mismatch
2011-01-19 00:34:16 DEBUG: pid 24873: value: false kind: 1
2011-01-19 00:34:16 DEBUG: pid 24873: replication_stop_on_mismatch: 0
2011-01-19 00:34:16 DEBUG: pid 24873: key: failover_if_affected_tuples_mismatch
2011-01-19 00:34:16 DEBUG: pid 24873: value: false kind: 1
2011-01-19 00:34:16 DEBUG: pid 24873: failover_if_affected_tuples_mismatch: 0
2011-01-19 00:34:16 DEBUG: pid 24873: key: replicate_select
2011-01-19 00:34:16 DEBUG: pid 24873: value: false kind: 1
2011-01-19 00:34:16 DEBUG: pid 24873: replicate_select: 0
2011-01-19 00:34:16 DEBUG: pid 24873: key: reset_query_list
2011-01-19 00:34:16 DEBUG: pid 24873: value: 'ABORT; DISCARD ALL' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: extract_string_tokens: token: ABORT
2011-01-19 00:34:16 DEBUG: pid 24873: extract_string_tokens: token:  DISCARD ALL
2011-01-19 00:34:16 DEBUG: pid 24873: key: white_function_list
2011-01-19 00:34:16 DEBUG: pid 24873: value: '' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: key: black_function_list
2011-01-19 00:34:16 DEBUG: pid 24873: value: 'nextval,setval' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: extract_string_tokens: token: nextval
2011-01-19 00:34:16 DEBUG: pid 24873: extract_string_tokens: token: setval
2011-01-19 00:34:16 DEBUG: pid 24873: key: print_timestamp
2011-01-19 00:34:16 DEBUG: pid 24873: value: true kind: 1
2011-01-19 00:34:16 DEBUG: pid 24873: key: master_slave_mode
2011-01-19 00:34:16 DEBUG: pid 24873: value: true kind: 1
2011-01-19 00:34:16 DEBUG: pid 24873: key: master_slave_sub_mode
2011-01-19 00:34:16 DEBUG: pid 24873: value: 'stream' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: key: delay_threshold
2011-01-19 00:34:16 DEBUG: pid 24873: value: 10000000 kind: 2
2011-01-19 00:34:16 DEBUG: pid 24873: key: log_standby_delay
2011-01-19 00:34:16 DEBUG: pid 24873: value: 'if_over_threshold' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: key: connection_cache
2011-01-19 00:34:16 DEBUG: pid 24873: value: false kind: 1
2011-01-19 00:34:16 DEBUG: pid 24873: key: health_check_timeout
2011-01-19 00:34:16 DEBUG: pid 24873: value: 20 kind: 2
2011-01-19 00:34:16 DEBUG: pid 24873: key: health_check_period
2011-01-19 00:34:16 DEBUG: pid 24873: value: 0 kind: 2
2011-01-19 00:34:16 DEBUG: pid 24873: key: health_check_user
2011-01-19 00:34:16 DEBUG: pid 24873: value: 'postgres' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: key: failover_command
2011-01-19 00:34:16 DEBUG: pid 24873: value: '/usr/local/etc/failover.sh %d "%h" %p %D %m %M "%H" %P' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: key: failback_command
2011-01-19 00:34:16 DEBUG: pid 24873: value: '/bin/rm -f /tmp/trigger_file1' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: key: fail_over_on_backend_error
2011-01-19 00:34:16 DEBUG: pid 24873: value: true kind: 1
2011-01-19 00:34:16 DEBUG: pid 24873: key: insert_lock
2011-01-19 00:34:16 DEBUG: pid 24873: value: false kind: 1
2011-01-19 00:34:16 DEBUG: pid 24873: key: ignore_leading_white_space
2011-01-19 00:34:16 DEBUG: pid 24873: value: true kind: 1
2011-01-19 00:34:16 DEBUG: pid 24873: key: log_statement
2011-01-19 00:34:16 DEBUG: pid 24873: value: false kind: 1
2011-01-19 00:34:16 DEBUG: pid 24873: key: log_per_node_statement
2011-01-19 00:34:16 DEBUG: pid 24873: value: false kind: 1
2011-01-19 00:34:16 DEBUG: pid 24873: key: log_connections
2011-01-19 00:34:16 DEBUG: pid 24873: value: false kind: 1
2011-01-19 00:34:16 DEBUG: pid 24873: key: log_hostname
2011-01-19 00:34:16 DEBUG: pid 24873: value: true kind: 1
2011-01-19 00:34:16 DEBUG: pid 24873: key: parallel_mode
2011-01-19 00:34:16 DEBUG: pid 24873: value: false kind: 1
2011-01-19 00:34:16 DEBUG: pid 24873: key: enable_query_cache
2011-01-19 00:34:16 DEBUG: pid 24873: value: false kind: 1
2011-01-19 00:34:16 DEBUG: pid 24873: key: pgpool2_hostname
2011-01-19 00:34:16 DEBUG: pid 24873: value: '' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: key: system_db_hostname
2011-01-19 00:34:16 DEBUG: pid 24873: value: 'localhost' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: key: system_db_port
2011-01-19 00:34:16 DEBUG: pid 24873: value: 5432 kind: 2
2011-01-19 00:34:16 DEBUG: pid 24873: key: system_db_dbname
2011-01-19 00:34:16 DEBUG: pid 24873: value: 'pgpool' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: key: system_db_schema
2011-01-19 00:34:16 DEBUG: pid 24873: value: 'pgpool_catalog' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: key: system_db_user
2011-01-19 00:34:16 DEBUG: pid 24873: value: 'pgpool' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: key: system_db_password
2011-01-19 00:34:16 DEBUG: pid 24873: value: '' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: key: backend_hostname0
2011-01-19 00:34:16 DEBUG: pid 24873: value: 'host0' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: key: backend_port0
2011-01-19 00:34:16 DEBUG: pid 24873: value: 5432 kind: 2
2011-01-19 00:34:16 DEBUG: pid 24873: key: backend_weight0
2011-01-19 00:34:16 DEBUG: pid 24873: value: 1 kind: 2
2011-01-19 00:34:16 DEBUG: pid 24873: key: backend_data_directory0
2011-01-19 00:34:16 DEBUG: pid 24873: value: '/home/postgres/data' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: key: backend_hostname1
2011-01-19 00:34:16 DEBUG: pid 24873: value: 'host1' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: key: backend_port1
2011-01-19 00:34:16 DEBUG: pid 24873: value: 5432 kind: 2
2011-01-19 00:34:16 DEBUG: pid 24873: key: backend_weight1
2011-01-19 00:34:16 DEBUG: pid 24873: value: 2 kind: 2
2011-01-19 00:34:16 DEBUG: pid 24873: key: backend_data_directory1
2011-01-19 00:34:16 DEBUG: pid 24873: value: '/home/postgres/data' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: key: enable_pool_hba
2011-01-19 00:34:16 DEBUG: pid 24873: value: false kind: 1
2011-01-19 00:34:16 DEBUG: pid 24873: key: recovery_user
2011-01-19 00:34:16 DEBUG: pid 24873: value: 'postgres' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: key: recovery_password
2011-01-19 00:34:16 DEBUG: pid 24873: value: 'pgpoolAdmin' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: key: recovery_1st_stage_command
2011-01-19 00:34:16 DEBUG: pid 24873: value: 'basebackup.sh' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: key: recovery_2nd_stage_command
2011-01-19 00:34:16 DEBUG: pid 24873: value: '' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: key: recovery_timeout
2011-01-19 00:34:16 DEBUG: pid 24873: value: 90 kind: 2
2011-01-19 00:34:16 DEBUG: pid 24873: key: client_idle_limit_in_recovery
2011-01-19 00:34:16 DEBUG: pid 24873: value: 0 kind: 2
2011-01-19 00:34:16 DEBUG: pid 24873: key: lobj_lock_table
2011-01-19 00:34:16 DEBUG: pid 24873: value: '' kind: 4
2011-01-19 00:34:16 DEBUG: pid 24873: key: ssl
2011-01-19 00:34:16 DEBUG: pid 24873: value: false kind: 1
2011-01-19 00:34:16 DEBUG: pid 24873: key: debug_level
2011-01-19 00:34:16 DEBUG: pid 24873: value: 0 kind: 2
2011-01-19 00:53:25 LOG:   pid 24873: pool_send_and_wait: Error or notice message from backend: : DB node id: 0 backend pid: 19775 statement:  message: there is already a transaction in progress
2011-01-19 00:53:25 LOG:   pid 24873: pool_send_and_wait: Error or notice message from backend: : DB node id: 0 backend pid: 19775 statement:  message: there is already a transaction in progress
2011-01-19 01:13:25 LOG:   pid 24873: pool_send_and_wait: Error or notice message from backend: : DB node id: 0 backend pid: 19775 statement:  message: there is already a transaction in progress
2011-01-19 01:13:25 LOG:   pid 24873: pool_send_and_wait: Error or notice message from backend: : DB node id: 0 backend pid: 19775 statement:  message: there is already a transaction in progress
2011-01-19 01:33:25 LOG:   pid 24873: pool_send_and_wait: Error or notice message from backend: : DB node id: 0 backend pid: 19775 statement:  message: there is already a transaction in progress
2011-01-19 01:33:25 LOG:   pid 24873: pool_send_and_wait: Error or notice message from backend: : DB node id: 0 backend pid: 19775 statement:  message: there is already a transaction in progress
2011-01-19 01:53:25 LOG:   pid 24873: pool_send_and_wait: Error or notice message from backend: : DB node id: 0 backend pid: 19775 statement:  message: there is already a transaction in progress
2011-01-19 01:53:25 LOG:   pid 24873: pool_send_and_wait: Error or notice message from backend: : DB node id: 0 backend pid: 19775 statement:  message: there is already a transaction in progress
2011-01-19 02:13:25 LOG:   pid 24873: pool_send_and_wait: Error or notice message from backend: : DB node id: 0 backend pid: 19775 statement:  message: there is already a transaction in progress
2011-01-19 02:13:25 LOG:   pid 24873: pool_send_and_wait: Error or notice message from backend: : DB node id: 0 backend pid: 19775 statement:  message: there is already a transaction in progress
2011-01-19 02:53:25 LOG:   pid 24873: pool_send_and_wait: Error or notice message from backend: : DB node id: 0 backend pid: 19775 statement:  message: there is already a transaction in progress
2011-01-19 02:53:25 LOG:   pid 24873: pool_send_and_wait: Error or notice message from backend: : DB node id: 0 backend pid: 19775 statement:  message: there is already a transaction in progress
2011-01-19 02:53:26 LOG:   pid 24873: pool_send_and_wait: Error or notice message from backend: : DB node id: 0 backend pid: 19775 statement:  message: there is already a transaction in progress
2011-01-19 03:13:25 LOG:   pid 24873: pool_send_and_wait: Error or notice message from backend: : DB node id: 0 backend pid: 19775 statement:  message: there is already a transaction in progress
2011-01-19 03:13:26 LOG:   pid 24873: pool_send_and_wait: Error or notice message from backend: : DB node id: 0 backend pid: 19775 statement:  message: there is already a transaction in progress
2011-01-19 03:33:25 LOG:   pid 24873: pool_send_and_wait: Error or notice message from backend: : DB node id: 0 backend pid: 19775 statement:  message: there is already a transaction in progress
2011-01-19 03:33:26 LOG:   pid 24873: pool_send_and_wait: Error or notice message from backend: : DB node id: 0 backend pid: 19775 statement:  message: there is already a transaction in progress
2011-01-19 03:53:25 LOG:   pid 24873: pool_send_and_wait: Error or notice message from backend: : DB node id: 0 backend pid: 19775 statement:  message: there is already a transaction in progress


More information about the Pgpool-general mailing list