2010-09-27 17:58:17 DEBUG: pid 25743: key: listen_addresses
2010-09-27 17:58:17 DEBUG: pid 25743: value: '*' kind: 4
2010-09-27 17:58:17 DEBUG: pid 25743: key: port
2010-09-27 17:58:17 DEBUG: pid 25743: value: 9999 kind: 2
2010-09-27 17:58:17 DEBUG: pid 25743: key: pcp_port
2010-09-27 17:58:17 DEBUG: pid 25743: value: 9898 kind: 2
2010-09-27 17:58:17 DEBUG: pid 25743: key: socket_dir
2010-09-27 17:58:17 DEBUG: pid 25743: value: '/tmp' kind: 4
2010-09-27 17:58:17 DEBUG: pid 25743: key: pcp_socket_dir
2010-09-27 17:58:17 DEBUG: pid 25743: value: '/tmp' kind: 4
2010-09-27 17:58:17 DEBUG: pid 25743: key: backend_socket_dir
2010-09-27 17:58:17 DEBUG: pid 25743: value: '/tmp' kind: 4
2010-09-27 17:58:17 DEBUG: pid 25743: key: pcp_timeout
2010-09-27 17:58:17 DEBUG: pid 25743: value: 10 kind: 2
2010-09-27 17:58:17 DEBUG: pid 25743: key: num_init_children
2010-09-27 17:58:17 DEBUG: pid 25743: value: 32 kind: 2
2010-09-27 17:58:17 DEBUG: pid 25743: key: max_pool
2010-09-27 17:58:17 DEBUG: pid 25743: value: 4 kind: 2
2010-09-27 17:58:17 DEBUG: pid 25743: key: child_life_time
2010-09-27 17:58:17 DEBUG: pid 25743: value: 300 kind: 2
2010-09-27 17:58:17 DEBUG: pid 25743: key: connection_life_time
2010-09-27 17:58:17 DEBUG: pid 25743: value: 0 kind: 2
2010-09-27 17:58:17 DEBUG: pid 25743: key: child_max_connections
2010-09-27 17:58:17 DEBUG: pid 25743: value: 0 kind: 2
2010-09-27 17:58:17 DEBUG: pid 25743: key: client_idle_limit
2010-09-27 17:58:17 DEBUG: pid 25743: value: 0 kind: 2
2010-09-27 17:58:17 DEBUG: pid 25743: key: authentication_timeout
2010-09-27 17:58:17 DEBUG: pid 25743: value: 60 kind: 2
2010-09-27 17:58:17 DEBUG: pid 25743: key: logdir
2010-09-27 17:58:17 DEBUG: pid 25743: value: '/usr/local/pgpool2/logs' kind: 4
2010-09-27 17:58:17 DEBUG: pid 25743: key: pid_file_name
2010-09-27 17:58:17 DEBUG: pid 25743: value: '/usr/local/pgpool2/etc/pgpool.pid' kind: 4
2010-09-27 17:58:17 DEBUG: pid 25743: key: replication_mode
2010-09-27 17:58:17 DEBUG: pid 25743: value: true kind: 1
2010-09-27 17:58:17 DEBUG: pid 25743: key: load_balance_mode
2010-09-27 17:58:17 DEBUG: pid 25743: value: true kind: 1
2010-09-27 17:58:17 DEBUG: pid 25743: key: replication_stop_on_mismatch
2010-09-27 17:58:17 DEBUG: pid 25743: value: false kind: 1
2010-09-27 17:58:17 DEBUG: pid 25743: replication_stop_on_mismatch: 0
2010-09-27 17:58:17 DEBUG: pid 25743: key: failover_if_affected_tuples_mismatch
2010-09-27 17:58:17 DEBUG: pid 25743: value: false kind: 1
2010-09-27 17:58:17 DEBUG: pid 25743: failover_if_affected_tuples_mismatch: 0
2010-09-27 17:58:17 DEBUG: pid 25743: key: replicate_select
2010-09-27 17:58:17 DEBUG: pid 25743: value: false kind: 1
2010-09-27 17:58:17 DEBUG: pid 25743: replicate_select: 0
2010-09-27 17:58:17 DEBUG: pid 25743: key: reset_query_list
2010-09-27 17:58:17 DEBUG: pid 25743: value: 'ABORT; DISCARD ALL' kind: 4
2010-09-27 17:58:17 DEBUG: pid 25743: extract_string_tokens: token: ABORT
2010-09-27 17:58:17 DEBUG: pid 25743: extract_string_tokens: token:  DISCARD ALL
2010-09-27 17:58:17 DEBUG: pid 25743: key: white_function_list
2010-09-27 17:58:17 DEBUG: pid 25743: value: '' kind: 4
2010-09-27 17:58:17 DEBUG: pid 25743: key: black_function_list
2010-09-27 17:58:17 DEBUG: pid 25743: value: 'nextval,setval' kind: 4
2010-09-27 17:58:17 DEBUG: pid 25743: extract_string_tokens: token: nextval
2010-09-27 17:58:17 DEBUG: pid 25743: extract_string_tokens: token: setval
2010-09-27 17:58:17 DEBUG: pid 25743: key: print_timestamp
2010-09-27 17:58:17 DEBUG: pid 25743: value: true kind: 1
2010-09-27 17:58:17 DEBUG: pid 25743: key: master_slave_mode
2010-09-27 17:58:17 DEBUG: pid 25743: value: false kind: 1
2010-09-27 17:58:17 DEBUG: pid 25743: key: master_slave_sub_mode
2010-09-27 17:58:17 DEBUG: pid 25743: value: 'slony' kind: 4
2010-09-27 17:58:17 DEBUG: pid 25743: key: delay_threshold
2010-09-27 17:58:17 DEBUG: pid 25743: value: 0 kind: 2
2010-09-27 17:58:17 DEBUG: pid 25743: key: log_standby_delay
2010-09-27 17:58:17 DEBUG: pid 25743: value: 'none' kind: 4
2010-09-27 17:58:17 DEBUG: pid 25743: key: connection_cache
2010-09-27 17:58:17 DEBUG: pid 25743: value: true kind: 1
2010-09-27 17:58:17 DEBUG: pid 25743: key: health_check_timeout
2010-09-27 17:58:17 DEBUG: pid 25743: value: 20 kind: 2
2010-09-27 17:58:17 DEBUG: pid 25743: key: health_check_period
2010-09-27 17:58:17 DEBUG: pid 25743: value: 0 kind: 2
2010-09-27 17:58:17 DEBUG: pid 25743: key: health_check_user
2010-09-27 17:58:17 DEBUG: pid 25743: value: 'nobody' kind: 4
2010-09-27 17:58:17 DEBUG: pid 25743: key: failover_command
2010-09-27 17:58:17 DEBUG: pid 25743: value: '' kind: 4
2010-09-27 17:58:17 DEBUG: pid 25743: key: failback_command
2010-09-27 17:58:17 DEBUG: pid 25743: value: '' kind: 4
2010-09-27 17:58:17 DEBUG: pid 25743: key: fail_over_on_backend_error
2010-09-27 17:58:17 DEBUG: pid 25743: value: true kind: 1
2010-09-27 17:58:17 DEBUG: pid 25743: key: insert_lock
2010-09-27 17:58:17 DEBUG: pid 25743: value: true kind: 1
2010-09-27 17:58:17 DEBUG: pid 25743: key: ignore_leading_white_space
2010-09-27 17:58:17 DEBUG: pid 25743: value: true kind: 1
2010-09-27 17:58:17 DEBUG: pid 25743: key: log_statement
2010-09-27 17:58:17 DEBUG: pid 25743: value: true kind: 1
2010-09-27 17:58:17 DEBUG: pid 25743: key: log_per_node_statement
2010-09-27 17:58:17 DEBUG: pid 25743: value: true kind: 1
2010-09-27 17:58:17 DEBUG: pid 25743: key: log_connections
2010-09-27 17:58:17 DEBUG: pid 25743: value: true kind: 1
2010-09-27 17:58:17 DEBUG: pid 25743: key: log_hostname
2010-09-27 17:58:17 DEBUG: pid 25743: value: true kind: 1
2010-09-27 17:58:17 DEBUG: pid 25743: key: parallel_mode
2010-09-27 17:58:17 DEBUG: pid 25743: value: false kind: 1
2010-09-27 17:58:17 DEBUG: pid 25743: key: enable_query_cache
2010-09-27 17:58:17 DEBUG: pid 25743: value: false kind: 1
2010-09-27 17:58:17 DEBUG: pid 25743: key: pgpool2_hostname
2010-09-27 17:58:17 DEBUG: pid 25743: value: '' kind: 4
2010-09-27 17:58:17 DEBUG: pid 25743: key: system_db_hostname
2010-09-27 17:58:17 DEBUG: pid 25743: value: 'localhost' kind: 4
2010-09-27 17:58:17 DEBUG: pid 25743: key: system_db_port
2010-09-27 17:58:17 DEBUG: pid 25743: value: 5432 kind: 2
2010-09-27 17:58:17 DEBUG: pid 25743: key: system_db_dbname
2010-09-27 17:58:17 DEBUG: pid 25743: value: 'pgpool' kind: 4
2010-09-27 17:58:17 DEBUG: pid 25743: key: system_db_schema
2010-09-27 17:58:17 DEBUG: pid 25743: value: 'pgpool_catalog' kind: 4
2010-09-27 17:58:17 DEBUG: pid 25743: key: system_db_user
2010-09-27 17:58:17 DEBUG: pid 25743: value: 'pgpool' kind: 4
2010-09-27 17:58:17 DEBUG: pid 25743: key: system_db_password
2010-09-27 17:58:17 DEBUG: pid 25743: value: '' kind: 4
2010-09-27 17:58:17 DEBUG: pid 25743: key: backend_hostname0
2010-09-27 17:58:17 DEBUG: pid 25743: value: 'localhost' kind: 4
2010-09-27 17:58:17 DEBUG: pid 25743: key: backend_port0
2010-09-27 17:58:17 DEBUG: pid 25743: value: 5432 kind: 2
2010-09-27 17:58:17 DEBUG: pid 25743: pool_config: port slot number 0 
2010-09-27 17:58:17 DEBUG: pid 25743: key: backend_weight0
2010-09-27 17:58:17 DEBUG: pid 25743: value: 1 kind: 2
2010-09-27 17:58:17 DEBUG: pid 25743: pool_config: weight slot number 0 weight: 1.000000
2010-09-27 17:58:17 DEBUG: pid 25743: key: backend_data_directory0
2010-09-27 17:58:17 DEBUG: pid 25743: value: '/usr/local/pgsql/data' kind: 4
2010-09-27 17:58:17 DEBUG: pid 25743: key: enable_pool_hba
2010-09-27 17:58:17 DEBUG: pid 25743: value: false kind: 1
2010-09-27 17:58:17 DEBUG: pid 25743: key: recovery_user
2010-09-27 17:58:17 DEBUG: pid 25743: value: 'nobody' kind: 4
2010-09-27 17:58:17 DEBUG: pid 25743: key: recovery_password
2010-09-27 17:58:17 DEBUG: pid 25743: value: '' kind: 4
2010-09-27 17:58:17 DEBUG: pid 25743: key: recovery_1st_stage_command
2010-09-27 17:58:17 DEBUG: pid 25743: value: '' kind: 4
2010-09-27 17:58:17 DEBUG: pid 25743: key: recovery_2nd_stage_command
2010-09-27 17:58:17 DEBUG: pid 25743: value: '' kind: 4
2010-09-27 17:58:17 DEBUG: pid 25743: key: recovery_timeout
2010-09-27 17:58:17 DEBUG: pid 25743: value: 90 kind: 2
2010-09-27 17:58:17 DEBUG: pid 25743: key: client_idle_limit_in_recovery
2010-09-27 17:58:17 DEBUG: pid 25743: value: 0 kind: 2
2010-09-27 17:58:17 DEBUG: pid 25743: key: lobj_lock_table
2010-09-27 17:58:17 DEBUG: pid 25743: value: '' kind: 4
2010-09-27 17:58:17 DEBUG: pid 25743: key: ssl
2010-09-27 17:58:17 DEBUG: pid 25743: value: false kind: 1
2010-09-27 17:58:17 DEBUG: pid 25743: key: debug_level
2010-09-27 17:58:17 DEBUG: pid 25743: value: 1 kind: 2
2010-09-27 17:58:17 DEBUG: pid 25743: num_backends: 1 total_weight: 1.000000
2010-09-27 17:58:17 DEBUG: pid 25743: backend 0 weight: 2147483647.000000
2010-09-27 17:58:17 DEBUG: pid 25745: I am 25745
2010-09-27 17:58:17 DEBUG: pid 25746: I am 25746
2010-09-27 17:58:17 DEBUG: pid 25747: I am 25747
2010-09-27 17:58:17 DEBUG: pid 25748: I am 25748
2010-09-27 17:58:17 DEBUG: pid 25749: I am 25749
2010-09-27 17:58:17 DEBUG: pid 25750: I am 25750
2010-09-27 17:58:17 DEBUG: pid 25751: I am 25751
2010-09-27 17:58:17 DEBUG: pid 25752: I am 25752
2010-09-27 17:58:17 DEBUG: pid 25753: I am 25753
2010-09-27 17:58:17 DEBUG: pid 25754: I am 25754
2010-09-27 17:58:17 DEBUG: pid 25755: I am 25755
2010-09-27 17:58:17 DEBUG: pid 25756: I am 25756
2010-09-27 17:58:17 DEBUG: pid 25757: I am 25757
2010-09-27 17:58:17 DEBUG: pid 25758: I am 25758
2010-09-27 17:58:17 DEBUG: pid 25759: I am 25759
2010-09-27 17:58:17 DEBUG: pid 25760: I am 25760
2010-09-27 17:58:17 DEBUG: pid 25761: I am 25761
2010-09-27 17:58:17 DEBUG: pid 25762: I am 25762
2010-09-27 17:58:17 DEBUG: pid 25763: I am 25763
2010-09-27 17:58:17 DEBUG: pid 25764: I am 25764
2010-09-27 17:58:17 DEBUG: pid 25765: I am 25765
2010-09-27 17:58:17 DEBUG: pid 25766: I am 25766
2010-09-27 17:58:17 DEBUG: pid 25767: I am 25767
2010-09-27 17:58:17 DEBUG: pid 25768: I am 25768
2010-09-27 17:58:17 DEBUG: pid 25769: I am 25769
2010-09-27 17:58:17 DEBUG: pid 25770: I am 25770
2010-09-27 17:58:17 DEBUG: pid 25771: I am 25771
2010-09-27 17:58:17 DEBUG: pid 25772: I am 25772
2010-09-27 17:58:17 DEBUG: pid 25773: I am 25773
2010-09-27 17:58:17 DEBUG: pid 25774: I am 25774
2010-09-27 17:58:17 DEBUG: pid 25775: I am 25775
2010-09-27 17:58:17 DEBUG: pid 25776: I am 25776
2010-09-27 17:58:17 LOG:   pid 25743: pgpool-II successfully started. version 3.0 (umiyameboshi)
2010-09-27 17:58:17 DEBUG: pid 25778: I am 25778
2010-09-27 17:58:51 DEBUG: pid 25776: I am 25776 accept fd 6
2010-09-27 17:58:51 LOG:   pid 25776: connection received: host=[local]
2010-09-27 17:58:51 DEBUG: pid 25776: Protocol Major: 3 Minor: 0 database: postgres user: postgres
2010-09-27 17:58:51 DEBUG: pid 25776: new_connection: connecting 0 backend
2010-09-27 17:58:51 DEBUG: pid 25776: pool_ssl: SSL requested but SSL support is not available
2010-09-27 17:58:51 DEBUG: pid 25776: pool_read_message_length: slot: 0 length: 8
2010-09-27 17:58:51 DEBUG: pid 25776: pool_read_message_length2: master slot: 0 length: 25
2010-09-27 17:58:51 DEBUG: pid 25776: 0 th backend: name: client_encoding value: UTF8
2010-09-27 17:58:51 DEBUG: pid 25776: pool_read_message_length2: master slot: 0 length: 23
2010-09-27 17:58:51 DEBUG: pid 25776: 0 th backend: name: DateStyle value: ISO, YMD
2010-09-27 17:58:51 DEBUG: pid 25776: pool_read_message_length2: master slot: 0 length: 25
2010-09-27 17:58:51 DEBUG: pid 25776: 0 th backend: name: integer_datetimes value: on
2010-09-27 17:58:51 DEBUG: pid 25776: pool_read_message_length2: master slot: 0 length: 27
2010-09-27 17:58:51 DEBUG: pid 25776: 0 th backend: name: IntervalStyle value: postgres
2010-09-27 17:58:51 DEBUG: pid 25776: pool_read_message_length2: master slot: 0 length: 20
2010-09-27 17:58:51 DEBUG: pid 25776: 0 th backend: name: is_superuser value: on
2010-09-27 17:58:51 DEBUG: pid 25776: pool_read_message_length2: master slot: 0 length: 25
2010-09-27 17:58:51 DEBUG: pid 25776: 0 th backend: name: server_encoding value: UTF8
2010-09-27 17:58:51 DEBUG: pid 25776: pool_read_message_length2: master slot: 0 length: 25
2010-09-27 17:58:51 DEBUG: pid 25776: 0 th backend: name: server_version value: 8.4.2
2010-09-27 17:58:51 DEBUG: pid 25776: pool_read_message_length2: master slot: 0 length: 35
2010-09-27 17:58:51 DEBUG: pid 25776: 0 th backend: name: session_authorization value: postgres
2010-09-27 17:58:51 DEBUG: pid 25776: pool_read_message_length2: master slot: 0 length: 36
2010-09-27 17:58:51 DEBUG: pid 25776: 0 th backend: name: standard_conforming_strings value: off
2010-09-27 17:58:51 DEBUG: pid 25776: pool_read_message_length2: master slot: 0 length: 19
2010-09-27 17:58:51 DEBUG: pid 25776: 0 th backend: name: TimeZone value: Japan
2010-09-27 17:58:51 DEBUG: pid 25776: pool_read_message_length: slot: 0 length: 12
2010-09-27 17:58:51 DEBUG: pid 25776: pool_do_auth: cp->info[i]:0xb7fbd000 pid:25830
2010-09-27 17:58:51 DEBUG: pid 25776: pool_send_auth_ok: send pid 25830 to frontend
2010-09-27 17:58:51 DEBUG: pid 25776: select_load_balancing_node: selected backend id is 0
2010-09-27 17:58:51 DEBUG: pid 25776: selected load balancing node: 0
2010-09-27 17:58:51 DEBUG: pid 25776: pool_unset_query_in_progress: done
2010-09-27 17:58:51 DEBUG: pid 25776: pool_unset_skip_reading_from_backends: done
2010-09-27 17:58:51 DEBUG: pid 25776: pool_unset_ignore_till_sync: done
2010-09-27 17:58:51 DEBUG: pid 25776: read_kind_from_backend: read kind from 0 th backend Z NUM_BACKENDS: 1
2010-09-27 17:58:51 DEBUG: pid 25776: ProcessBackendResponse: kind from backend: Z
2010-09-27 17:58:51 DEBUG: pid 25776: pool_read_message_length: slot: 0 length: 5
2010-09-27 17:58:56 DEBUG: pid 25776: ProcessFrontendResponse: kind from frontend Q(51)
2010-09-27 17:58:56 DEBUG: pid 25776: pool_unset_doing_extended_query_message: done
2010-09-27 17:58:56 LOG:   pid 25776: statement: show pool_status;
2010-09-27 17:58:56 DEBUG: pid 25776: pool_set_query_in_progress: done
2010-09-27 17:58:56 DEBUG: pid 25776: config reporting
2010-09-27 17:58:56 DEBUG: pid 25776: pool_unset_query_in_progress: done
2010-09-27 17:58:56 DEBUG: pid 25776: pool_set_skip_reading_from_backends: done
2010-09-27 17:58:56 DEBUG: pid 25776: pool_unset_skip_reading_from_backends: done
2010-09-27 17:59:12 DEBUG: pid 25776: ProcessFrontendResponse: kind from frontend Q(51)
2010-09-27 17:59:12 DEBUG: pid 25776: pool_unset_doing_extended_query_message: done
2010-09-27 17:59:12 LOG:   pid 25776: statement: show pool_nodes;
2010-09-27 17:59:12 DEBUG: pid 25776: pool_set_query_in_progress: done
2010-09-27 17:59:12 DEBUG: pid 25776: nodes reporting
2010-09-27 17:59:12 DEBUG: pid 25776: pool_unset_query_in_progress: done
2010-09-27 17:59:12 DEBUG: pid 25776: pool_set_skip_reading_from_backends: done
2010-09-27 17:59:12 DEBUG: pid 25776: pool_unset_skip_reading_from_backends: done
2010-09-27 17:59:22 DEBUG: pid 25773: I am 25773 accept fd 6
2010-09-27 17:59:22 LOG:   pid 25773: connection received: host=wcyh01c192 port=1182
2010-09-27 17:59:22 DEBUG: pid 25773: Protocol Major: 3 Minor: 0 database: toybox-bcas user: postgres
2010-09-27 17:59:22 DEBUG: pid 25773: new_connection: connecting 0 backend
2010-09-27 17:59:22 DEBUG: pid 25773: pool_ssl: SSL requested but SSL support is not available
2010-09-27 17:59:22 DEBUG: pid 25773: pool_read_message_length: slot: 0 length: 8
2010-09-27 17:59:22 DEBUG: pid 25773: pool_read_message_length2: master slot: 0 length: 28
2010-09-27 17:59:22 DEBUG: pid 25773: 0 th backend: name: client_encoding value: UNICODE
2010-09-27 17:59:22 DEBUG: pid 25773: pool_read_message_length2: master slot: 0 length: 23
2010-09-27 17:59:22 DEBUG: pid 25773: 0 th backend: name: DateStyle value: ISO, YMD
2010-09-27 17:59:22 DEBUG: pid 25773: pool_read_message_length2: master slot: 0 length: 25
2010-09-27 17:59:22 DEBUG: pid 25773: 0 th backend: name: integer_datetimes value: on
2010-09-27 17:59:22 DEBUG: pid 25773: pool_read_message_length2: master slot: 0 length: 27
2010-09-27 17:59:22 DEBUG: pid 25773: 0 th backend: name: IntervalStyle value: postgres
2010-09-27 17:59:22 DEBUG: pid 25773: pool_read_message_length2: master slot: 0 length: 20
2010-09-27 17:59:22 DEBUG: pid 25773: 0 th backend: name: is_superuser value: on
2010-09-27 17:59:22 DEBUG: pid 25773: pool_read_message_length2: master slot: 0 length: 25
2010-09-27 17:59:22 DEBUG: pid 25773: 0 th backend: name: server_encoding value: UTF8
2010-09-27 17:59:22 DEBUG: pid 25773: pool_read_message_length2: master slot: 0 length: 25
2010-09-27 17:59:22 DEBUG: pid 25773: 0 th backend: name: server_version value: 8.4.2
2010-09-27 17:59:22 DEBUG: pid 25773: pool_read_message_length2: master slot: 0 length: 35
2010-09-27 17:59:22 DEBUG: pid 25773: 0 th backend: name: session_authorization value: postgres
2010-09-27 17:59:22 DEBUG: pid 25773: pool_read_message_length2: master slot: 0 length: 36
2010-09-27 17:59:22 DEBUG: pid 25773: 0 th backend: name: standard_conforming_strings value: off
2010-09-27 17:59:22 DEBUG: pid 25773: pool_read_message_length2: master slot: 0 length: 19
2010-09-27 17:59:22 DEBUG: pid 25773: 0 th backend: name: TimeZone value: Japan
2010-09-27 17:59:22 DEBUG: pid 25773: pool_read_message_length: slot: 0 length: 12
2010-09-27 17:59:22 DEBUG: pid 25773: pool_do_auth: cp->info[i]:0xb7f8d000 pid:25834
2010-09-27 17:59:22 DEBUG: pid 25773: pool_send_auth_ok: send pid 25834 to frontend
2010-09-27 17:59:22 DEBUG: pid 25773: select_load_balancing_node: selected backend id is 0
2010-09-27 17:59:22 DEBUG: pid 25773: selected load balancing node: 0
2010-09-27 17:59:22 DEBUG: pid 25773: pool_unset_query_in_progress: done
2010-09-27 17:59:22 DEBUG: pid 25773: pool_unset_skip_reading_from_backends: done
2010-09-27 17:59:22 DEBUG: pid 25773: pool_unset_ignore_till_sync: done
2010-09-27 17:59:22 DEBUG: pid 25773: read_kind_from_backend: read kind from 0 th backend Z NUM_BACKENDS: 1
2010-09-27 17:59:22 DEBUG: pid 25773: ProcessBackendResponse: kind from backend: Z
2010-09-27 17:59:22 DEBUG: pid 25773: pool_read_message_length: slot: 0 length: 5
2010-09-27 17:59:22 DEBUG: pid 25773: ProcessFrontendResponse: kind from frontend P(50)
2010-09-27 17:59:22 DEBUG: pid 25773: pool_unset_doing_extended_query_message: done
2010-09-27 17:59:22 DEBUG: pid 25773: pool_set_doing_extended_query_message: done
2010-09-27 17:59:22 DEBUG: pid 25773: pool_set_query_in_progress: done
2010-09-27 17:59:22 DEBUG: pid 25773: Parse: statement name <S_1>
2010-09-27 17:59:22 DEBUG: pid 25773: pool_set_query_in_progress: done
2010-09-27 17:59:22 DEBUG: pid 25773: pool_read_message_length: slot: 0 length: 5
2010-09-27 17:59:22 DEBUG: pid 25773: Parse: waiting for master completing the query
2010-09-27 17:59:22 LOG:   pid 25773: DB node id: 0 backend pid: 25834 statement: S_1
2010-09-27 17:59:22 DEBUG: pid 25773: wait_for_query_response: waiting for backend 0 completing the query
2010-09-27 17:59:22 DEBUG: pid 25773: detect_error: kind: 1
2010-09-27 17:59:22 DEBUG: pid 25773: read_kind_from_backend: read kind from 0 th backend 1 NUM_BACKENDS: 1
2010-09-27 17:59:22 DEBUG: pid 25773: ProcessBackendResponse: kind from backend: 1
2010-09-27 17:59:22 DEBUG: pid 25773: pool_unset_query_in_progress: done
2010-09-27 17:59:22 DEBUG: pid 25773: ProcessFrontendResponse: kind from frontend B(42)
2010-09-27 17:59:22 DEBUG: pid 25773: pool_unset_doing_extended_query_message: done
2010-09-27 17:59:22 DEBUG: pid 25773: pool_set_doing_extended_query_message: done
2010-09-27 17:59:22 DEBUG: pid 25773: pool_set_query_in_progress: done
2010-09-27 17:59:22 DEBUG: pid 25773: Bind: waiting for master completing the query
2010-09-27 17:59:22 LOG:   pid 25773: DB node id: 0 backend pid: 25834 statement: 
2010-09-27 17:59:22 DEBUG: pid 25773: wait_for_query_response: waiting for backend 0 completing the query
2010-09-27 17:59:22 DEBUG: pid 25773: read_kind_from_backend: read kind from 0 th backend 2 NUM_BACKENDS: 1
2010-09-27 17:59:22 DEBUG: pid 25773: ProcessBackendResponse: kind from backend: 2
2010-09-27 17:59:22 DEBUG: pid 25773: pool_unset_query_in_progress: done
2010-09-27 17:59:22 DEBUG: pid 25773: ProcessFrontendResponse: kind from frontend E(45)
2010-09-27 17:59:22 DEBUG: pid 25773: pool_unset_doing_extended_query_message: done
2010-09-27 17:59:22 DEBUG: pid 25773: pool_set_doing_extended_query_message: done
2010-09-27 17:59:22 DEBUG: pid 25773: pool_set_query_in_progress: done
2010-09-27 17:59:22 DEBUG: pid 25773: Execute: portal name <>
2010-09-27 17:59:22 DEBUG: pid 25773: Execute: query: BEGIN
2010-09-27 17:59:22 LOG:   pid 25773: DB node id: 0 backend pid: 25834 statement: 
2010-09-27 17:59:22 DEBUG: pid 25773: wait_for_query_response: waiting for backend 0 completing the query
2010-09-27 17:59:22 DEBUG: pid 25773: detect_error: kind: C
2010-09-27 17:59:22 DEBUG: pid 25773: detect_error: kind: C
2010-09-27 17:59:22 DEBUG: pid 25773: detect_error: kind: C
2010-09-27 17:59:22 DEBUG: pid 25773: detect_error: kind: C
2010-09-27 17:59:22 DEBUG: pid 25773: read_kind_from_backend: read kind from 0 th backend C NUM_BACKENDS: 1
2010-09-27 17:59:22 DEBUG: pid 25773: ProcessBackendResponse: kind from backend: C
2010-09-27 17:59:22 DEBUG: pid 25773: pool_unset_query_in_progress: done
2010-09-27 17:59:22 DEBUG: pid 25773: ProcessFrontendResponse: kind from frontend P(50)
2010-09-27 17:59:22 DEBUG: pid 25773: pool_unset_doing_extended_query_message: done
2010-09-27 17:59:22 DEBUG: pid 25773: pool_set_doing_extended_query_message: done
2010-09-27 17:59:22 DEBUG: pid 25773: pool_set_query_in_progress: done
2010-09-27 17:59:22 DEBUG: pid 25773: Parse: statement name <S_2>
2010-09-27 17:59:22 DEBUG: pid 25773: pool_set_query_in_progress: done
2010-09-27 17:59:22 DEBUG: pid 25773: Parse: waiting for master completing the query
2010-09-27 17:59:22 LOG:   pid 25773: DB node id: 0 backend pid: 25834 statement: S_2
2010-09-27 17:59:22 DEBUG: pid 25773: wait_for_query_response: waiting for backend 0 completing the query
2010-09-27 17:59:22 DEBUG: pid 25773: detect_error: kind: 1
2010-09-27 17:59:22 DEBUG: pid 25773: read_kind_from_backend: read kind from 0 th backend 1 NUM_BACKENDS: 1
2010-09-27 17:59:22 DEBUG: pid 25773: ProcessBackendResponse: kind from backend: 1
2010-09-27 17:59:22 DEBUG: pid 25773: pool_unset_query_in_progress: done
2010-09-27 17:59:22 DEBUG: pid 25773: ProcessFrontendResponse: kind from frontend B(42)
2010-09-27 17:59:22 DEBUG: pid 25773: pool_unset_doing_extended_query_message: done
2010-09-27 17:59:22 DEBUG: pid 25773: pool_set_doing_extended_query_message: done
2010-09-27 17:59:22 DEBUG: pid 25773: pool_set_query_in_progress: done
2010-09-27 17:59:22 DEBUG: pid 25773: Bind: waiting for master completing the query
2010-09-27 17:59:22 LOG:   pid 25773: DB node id: 0 backend pid: 25834 statement: C_3
2010-09-27 17:59:22 DEBUG: pid 25773: wait_for_query_response: waiting for backend 0 completing the query
2010-09-27 17:59:22 DEBUG: pid 25773: read_kind_from_backend: read kind from 0 th backend 2 NUM_BACKENDS: 1
2010-09-27 17:59:22 DEBUG: pid 25773: ProcessBackendResponse: kind from backend: 2
2010-09-27 17:59:22 DEBUG: pid 25773: pool_unset_query_in_progress: done
2010-09-27 17:59:22 DEBUG: pid 25773: ProcessFrontendResponse: kind from frontend D(44)
2010-09-27 17:59:22 DEBUG: pid 25773: pool_unset_doing_extended_query_message: done
2010-09-27 17:59:22 DEBUG: pid 25773: pool_set_doing_extended_query_message: done
2010-09-27 17:59:22 DEBUG: pid 25773: pool_set_query_in_progress: done
2010-09-27 17:59:22 DEBUG: pid 25773: Describe: waiting for master completing the query
2010-09-27 17:59:22 LOG:   pid 25773: DB node id: 0 backend pid: 25834 statement: PC_3
2010-09-27 17:59:22 DEBUG: pid 25773: wait_for_query_response: waiting for backend 0 completing the query
2010-09-27 17:59:22 DEBUG: pid 25773: read_kind_from_backend: read kind from 0 th backend T NUM_BACKENDS: 1
2010-09-27 17:59:22 DEBUG: pid 25773: ProcessBackendResponse: kind from backend: T
2010-09-27 17:59:22 DEBUG: pid 25773: pool_unset_query_in_progress: done
2010-09-27 17:59:22 DEBUG: pid 25773: ProcessFrontendResponse: kind from frontend E(45)
2010-09-27 17:59:22 DEBUG: pid 25773: pool_unset_doing_extended_query_message: done
2010-09-27 17:59:22 DEBUG: pid 25773: pool_set_doing_extended_query_message: done
2010-09-27 17:59:22 DEBUG: pid 25773: pool_set_query_in_progress: done
2010-09-27 17:59:22 DEBUG: pid 25773: Execute: portal name <C_3>
2010-09-27 17:59:22 DEBUG: pid 25773: Execute: query: select nextval('HandleHistory_handleID_seq') as handleID
2010-09-27 17:59:22 LOG:   pid 25773: DB node id: 0 backend pid: 25834 statement: C_3
2010-09-27 17:59:22 DEBUG: pid 25773: wait_for_query_response: waiting for backend 0 completing the query
2010-09-27 17:59:22 DEBUG: pid 25773: detect_error: kind: D
2010-09-27 17:59:22 DEBUG: pid 25773: detect_error: kind: D
2010-09-27 17:59:22 DEBUG: pid 25773: detect_error: kind: D
2010-09-27 17:59:22 DEBUG: pid 25773: detect_error: kind: D
2010-09-27 17:59:22 DEBUG: pid 25773: read_kind_from_backend: read kind from 0 th backend D NUM_BACKENDS: 1
2010-09-27 17:59:22 DEBUG: pid 25773: ProcessBackendResponse: kind from backend: D
2010-09-27 17:59:22 DEBUG: pid 25773: read_kind_from_backend: read kind from 0 th backend C NUM_BACKENDS: 1
2010-09-27 17:59:22 DEBUG: pid 25773: ProcessBackendResponse: kind from backend: C
2010-09-27 17:59:22 DEBUG: pid 25773: pool_unset_query_in_progress: done
2010-09-27 17:59:22 DEBUG: pid 25773: ProcessFrontendResponse: kind from frontend S(53)
2010-09-27 17:59:22 DEBUG: pid 25773: pool_unset_doing_extended_query_message: done
2010-09-27 17:59:22 DEBUG: pid 25773: pool_set_doing_extended_query_message: done
2010-09-27 17:59:22 DEBUG: pid 25773: pool_set_query_in_progress: done
2010-09-27 17:59:22 DEBUG: pid 25773: read_kind_from_backend: read kind from 0 th backend Z NUM_BACKENDS: 1
2010-09-27 17:59:22 DEBUG: pid 25773: ProcessBackendResponse: kind from backend: Z
2010-09-27 17:59:22 DEBUG: pid 25773: pool_read_message_length: slot: 0 length: 5
2010-09-27 17:59:22 DEBUG: pid 25773: pool_unset_query_in_progress: done
2010-09-27 17:59:22 DEBUG: pid 25773: ProcessFrontendResponse: kind from frontend C(43)
2010-09-27 17:59:22 DEBUG: pid 25773: pool_unset_doing_extended_query_message: done
2010-09-27 17:59:22 DEBUG: pid 25773: pool_set_query_in_progress: done
2010-09-27 17:59:22 DEBUG: pid 25773: Close: waiting for master completing the query
2010-09-27 17:59:22 LOG:   pid 25773: DB node id: 0 backend pid: 25834 statement: SS_2
2010-09-27 17:59:22 DEBUG: pid 25773: wait_for_query_response: waiting for backend 0 completing the query
2010-09-27 17:59:22 DEBUG: pid 25773: read_kind_from_backend: read kind from 0 th backend 3 NUM_BACKENDS: 1
2010-09-27 17:59:22 DEBUG: pid 25773: ProcessBackendResponse: kind from backend: 3
2010-09-27 17:59:22 DEBUG: pid 25773: pool_unset_query_in_progress: done
2010-09-27 17:59:22 DEBUG: pid 25773: pool_set_query_in_progress: done
2010-09-27 17:59:22 DEBUG: pid 25773: pool_unset_query_in_progress: done
2010-09-27 17:59:22 DEBUG: pid 25773: ProcessFrontendResponse: kind from frontend C(43)
2010-09-27 17:59:22 DEBUG: pid 25773: pool_unset_doing_extended_query_message: done
2010-09-27 17:59:22 DEBUG: pid 25773: pool_set_query_in_progress: done
2010-09-27 17:59:22 ERROR: pid 25773: Close: cannot get portal
2010-09-27 17:59:22 LOG:   pid 25773: do_child: exits with status 1 due to error
2010-09-27 17:59:22 DEBUG: pid 25743: reap_handler called
2010-09-27 17:59:22 DEBUG: pid 25743: reap_handler: call wait3
2010-09-27 17:59:22 DEBUG: pid 25743: child 25773 exits with status 256
2010-09-27 17:59:22 DEBUG: pid 25835: I am 25835
2010-09-27 17:59:22 DEBUG: pid 25743: fork a new child pid 25835
2010-09-27 17:59:22 DEBUG: pid 25743: reap_handler: normally exited
2010-09-27 17:59:25 DEBUG: pid 25776: ProcessFrontendResponse: kind from frontend Q(51)
2010-09-27 17:59:25 DEBUG: pid 25776: pool_unset_doing_extended_query_message: done
2010-09-27 17:59:25 LOG:   pid 25776: statement: show pool_nodes;
2010-09-27 17:59:25 DEBUG: pid 25776: pool_set_query_in_progress: done
2010-09-27 17:59:25 DEBUG: pid 25776: nodes reporting
2010-09-27 17:59:25 DEBUG: pid 25776: pool_unset_query_in_progress: done
2010-09-27 17:59:25 DEBUG: pid 25776: pool_set_skip_reading_from_backends: done
2010-09-27 17:59:25 DEBUG: pid 25776: pool_unset_skip_reading_from_backends: done
2010-09-27 18:00:01 DEBUG: pid 25776: ProcessFrontendResponse: kind from frontend X(58)
2010-09-27 18:00:01 DEBUG: pid 25776: pool_unset_doing_extended_query_message: done
2010-09-27 18:00:01 DEBUG: pid 25776: pool_unset_query_in_progress: done
2010-09-27 18:01:26 LOG:   pid 25743: received smart shutdown request
2010-09-27 18:01:26 DEBUG: pid 25745: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25746: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25747: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25748: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25749: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25750: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25751: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25752: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25753: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25754: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25755: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25763: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25756: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25757: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25758: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25759: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25760: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25761: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25762: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25764: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25765: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25766: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25767: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25768: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25769: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25770: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25771: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25772: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25835: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25774: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25775: child received shutdown request signal 15
2010-09-27 18:01:26 DEBUG: pid 25776: child received shutdown request signal 15
2010-09-27 18:01:26 ERROR: pid 25743: Could not open status file /usr/local/pgpool2/logs/pgpool_status
2010-09-27 18:01:26 DEBUG: pid 25743: shmem_exit(0)
2010-09-27 18:01:37 DEBUG: pid 25906: key: listen_addresses
2010-09-27 18:01:37 DEBUG: pid 25906: value: '*' kind: 4
2010-09-27 18:01:37 DEBUG: pid 25906: key: port
2010-09-27 18:01:37 DEBUG: pid 25906: value: 9999 kind: 2
2010-09-27 18:01:37 DEBUG: pid 25906: key: pcp_port
2010-09-27 18:01:37 DEBUG: pid 25906: value: 9898 kind: 2
2010-09-27 18:01:37 DEBUG: pid 25906: key: socket_dir
2010-09-27 18:01:37 DEBUG: pid 25906: value: '/tmp' kind: 4
2010-09-27 18:01:37 DEBUG: pid 25906: key: pcp_socket_dir
2010-09-27 18:01:37 DEBUG: pid 25906: value: '/tmp' kind: 4
2010-09-27 18:01:37 DEBUG: pid 25906: key: backend_socket_dir
2010-09-27 18:01:37 DEBUG: pid 25906: value: '/tmp' kind: 4
2010-09-27 18:01:37 DEBUG: pid 25906: key: pcp_timeout
2010-09-27 18:01:37 DEBUG: pid 25906: value: 10 kind: 2
2010-09-27 18:01:37 DEBUG: pid 25906: key: num_init_children
2010-09-27 18:01:37 DEBUG: pid 25906: value: 32 kind: 2
2010-09-27 18:01:37 DEBUG: pid 25906: key: max_pool
2010-09-27 18:01:37 DEBUG: pid 25906: value: 4 kind: 2
2010-09-27 18:01:37 DEBUG: pid 25906: key: child_life_time
2010-09-27 18:01:37 DEBUG: pid 25906: value: 300 kind: 2
2010-09-27 18:01:37 DEBUG: pid 25906: key: connection_life_time
2010-09-27 18:01:37 DEBUG: pid 25906: value: 0 kind: 2
2010-09-27 18:01:37 DEBUG: pid 25906: key: child_max_connections
2010-09-27 18:01:37 DEBUG: pid 25906: value: 0 kind: 2
2010-09-27 18:01:37 DEBUG: pid 25906: key: client_idle_limit
2010-09-27 18:01:37 DEBUG: pid 25906: value: 0 kind: 2
2010-09-27 18:01:37 DEBUG: pid 25906: key: authentication_timeout
2010-09-27 18:01:37 DEBUG: pid 25906: value: 60 kind: 2
2010-09-27 18:01:37 DEBUG: pid 25906: key: logdir
2010-09-27 18:01:37 DEBUG: pid 25906: value: '/usr/local/pgpool2/logs' kind: 4
2010-09-27 18:01:37 DEBUG: pid 25906: key: pid_file_name
2010-09-27 18:01:37 DEBUG: pid 25906: value: '/usr/local/pgpool2/etc/pgpool.pid' kind: 4
2010-09-27 18:01:37 DEBUG: pid 25906: key: replication_mode
2010-09-27 18:01:37 DEBUG: pid 25906: value: true kind: 1
2010-09-27 18:01:37 DEBUG: pid 25906: key: load_balance_mode
2010-09-27 18:01:37 DEBUG: pid 25906: value: true kind: 1
2010-09-27 18:01:37 DEBUG: pid 25906: key: replication_stop_on_mismatch
2010-09-27 18:01:37 DEBUG: pid 25906: value: false kind: 1
2010-09-27 18:01:37 DEBUG: pid 25906: replication_stop_on_mismatch: 0
2010-09-27 18:01:37 DEBUG: pid 25906: key: failover_if_affected_tuples_mismatch
2010-09-27 18:01:37 DEBUG: pid 25906: value: false kind: 1
2010-09-27 18:01:37 DEBUG: pid 25906: failover_if_affected_tuples_mismatch: 0
2010-09-27 18:01:37 DEBUG: pid 25906: key: replicate_select
2010-09-27 18:01:37 DEBUG: pid 25906: value: false kind: 1
2010-09-27 18:01:37 DEBUG: pid 25906: replicate_select: 0
2010-09-27 18:01:37 DEBUG: pid 25906: key: reset_query_list
2010-09-27 18:01:37 DEBUG: pid 25906: value: 'ABORT; DISCARD ALL' kind: 4
2010-09-27 18:01:37 DEBUG: pid 25906: extract_string_tokens: token: ABORT
2010-09-27 18:01:37 DEBUG: pid 25906: extract_string_tokens: token:  DISCARD ALL
2010-09-27 18:01:37 DEBUG: pid 25906: key: white_function_list
2010-09-27 18:01:37 DEBUG: pid 25906: value: '' kind: 4
2010-09-27 18:01:37 DEBUG: pid 25906: key: black_function_list
2010-09-27 18:01:37 DEBUG: pid 25906: value: 'nextval,setval' kind: 4
2010-09-27 18:01:37 DEBUG: pid 25906: extract_string_tokens: token: nextval
2010-09-27 18:01:37 DEBUG: pid 25906: extract_string_tokens: token: setval
2010-09-27 18:01:37 DEBUG: pid 25906: key: print_timestamp
2010-09-27 18:01:37 DEBUG: pid 25906: value: true kind: 1
2010-09-27 18:01:37 DEBUG: pid 25906: key: master_slave_mode
2010-09-27 18:01:37 DEBUG: pid 25906: value: false kind: 1
2010-09-27 18:01:37 DEBUG: pid 25906: key: master_slave_sub_mode
2010-09-27 18:01:37 DEBUG: pid 25906: value: 'slony' kind: 4
2010-09-27 18:01:37 DEBUG: pid 25906: key: delay_threshold
2010-09-27 18:01:37 DEBUG: pid 25906: value: 0 kind: 2
2010-09-27 18:01:37 DEBUG: pid 25906: key: log_standby_delay
2010-09-27 18:01:37 DEBUG: pid 25906: value: 'none' kind: 4
2010-09-27 18:01:37 DEBUG: pid 25906: key: connection_cache
2010-09-27 18:01:37 DEBUG: pid 25906: value: true kind: 1
2010-09-27 18:01:37 DEBUG: pid 25906: key: health_check_timeout
2010-09-27 18:01:37 DEBUG: pid 25906: value: 20 kind: 2
2010-09-27 18:01:37 DEBUG: pid 25906: key: health_check_period
2010-09-27 18:01:37 DEBUG: pid 25906: value: 0 kind: 2
2010-09-27 18:01:37 DEBUG: pid 25906: key: health_check_user
2010-09-27 18:01:37 DEBUG: pid 25906: value: 'nobody' kind: 4
2010-09-27 18:01:37 DEBUG: pid 25906: key: failover_command
2010-09-27 18:01:37 DEBUG: pid 25906: value: '' kind: 4
2010-09-27 18:01:37 DEBUG: pid 25906: key: failback_command
2010-09-27 18:01:37 DEBUG: pid 25906: value: '' kind: 4
2010-09-27 18:01:37 DEBUG: pid 25906: key: fail_over_on_backend_error
2010-09-27 18:01:37 DEBUG: pid 25906: value: true kind: 1
2010-09-27 18:01:37 DEBUG: pid 25906: key: insert_lock
2010-09-27 18:01:37 DEBUG: pid 25906: value: true kind: 1
2010-09-27 18:01:37 DEBUG: pid 25906: key: ignore_leading_white_space
2010-09-27 18:01:37 DEBUG: pid 25906: value: true kind: 1
2010-09-27 18:01:37 DEBUG: pid 25906: key: log_statement
2010-09-27 18:01:37 DEBUG: pid 25906: value: true kind: 1
2010-09-27 18:01:37 DEBUG: pid 25906: key: log_per_node_statement
2010-09-27 18:01:37 DEBUG: pid 25906: value: true kind: 1
2010-09-27 18:01:37 DEBUG: pid 25906: key: log_connections
2010-09-27 18:01:37 DEBUG: pid 25906: value: true kind: 1
2010-09-27 18:01:37 DEBUG: pid 25906: key: log_hostname
2010-09-27 18:01:37 DEBUG: pid 25906: value: true kind: 1
2010-09-27 18:01:37 DEBUG: pid 25906: key: parallel_mode
2010-09-27 18:01:37 DEBUG: pid 25906: value: false kind: 1
2010-09-27 18:01:37 DEBUG: pid 25906: key: enable_query_cache
2010-09-27 18:01:37 DEBUG: pid 25906: value: false kind: 1
2010-09-27 18:01:37 DEBUG: pid 25906: key: pgpool2_hostname
2010-09-27 18:01:37 DEBUG: pid 25906: value: '' kind: 4
2010-09-27 18:01:37 DEBUG: pid 25906: key: system_db_hostname
2010-09-27 18:01:37 DEBUG: pid 25906: value: 'localhost' kind: 4
2010-09-27 18:01:37 DEBUG: pid 25906: key: system_db_port
2010-09-27 18:01:37 DEBUG: pid 25906: value: 5432 kind: 2
2010-09-27 18:01:37 DEBUG: pid 25906: key: system_db_dbname
2010-09-27 18:01:37 DEBUG: pid 25906: value: 'pgpool' kind: 4
2010-09-27 18:01:37 DEBUG: pid 25906: key: system_db_schema
2010-09-27 18:01:37 DEBUG: pid 25906: value: 'pgpool_catalog' kind: 4
2010-09-27 18:01:37 DEBUG: pid 25906: key: system_db_user
2010-09-27 18:01:37 DEBUG: pid 25906: value: 'pgpool' kind: 4
2010-09-27 18:01:37 DEBUG: pid 25906: key: system_db_password
2010-09-27 18:01:37 DEBUG: pid 25906: value: '' kind: 4
2010-09-27 18:01:37 DEBUG: pid 25906: key: backend_hostname0
2010-09-27 18:01:37 DEBUG: pid 25906: value: 'localhost' kind: 4
2010-09-27 18:01:37 DEBUG: pid 25906: key: backend_port0
2010-09-27 18:01:37 DEBUG: pid 25906: value: 5432 kind: 2
2010-09-27 18:01:37 DEBUG: pid 25906: pool_config: port slot number 0 
2010-09-27 18:01:37 DEBUG: pid 25906: key: backend_weight0
2010-09-27 18:01:37 DEBUG: pid 25906: value: 1 kind: 2
2010-09-27 18:01:37 DEBUG: pid 25906: pool_config: weight slot number 0 weight: 1.000000
2010-09-27 18:01:37 DEBUG: pid 25906: key: backend_data_directory0
2010-09-27 18:01:37 DEBUG: pid 25906: value: '/usr/local/pgsql/data' kind: 4
2010-09-27 18:01:37 DEBUG: pid 25906: key: enable_pool_hba
2010-09-27 18:01:37 DEBUG: pid 25906: value: false kind: 1
2010-09-27 18:01:37 DEBUG: pid 25906: key: recovery_user
2010-09-27 18:01:37 DEBUG: pid 25906: value: 'nobody' kind: 4
2010-09-27 18:01:37 DEBUG: pid 25906: key: recovery_password
2010-09-27 18:01:37 DEBUG: pid 25906: value: '' kind: 4
2010-09-27 18:01:37 DEBUG: pid 25906: key: recovery_1st_stage_command
2010-09-27 18:01:37 DEBUG: pid 25906: value: '' kind: 4
2010-09-27 18:01:37 DEBUG: pid 25906: key: recovery_2nd_stage_command
2010-09-27 18:01:37 DEBUG: pid 25906: value: '' kind: 4
2010-09-27 18:01:37 DEBUG: pid 25906: key: recovery_timeout
2010-09-27 18:01:37 DEBUG: pid 25906: value: 90 kind: 2
2010-09-27 18:01:37 DEBUG: pid 25906: key: client_idle_limit_in_recovery
2010-09-27 18:01:37 DEBUG: pid 25906: value: 0 kind: 2
2010-09-27 18:01:37 DEBUG: pid 25906: key: lobj_lock_table
2010-09-27 18:01:37 DEBUG: pid 25906: value: '' kind: 4
2010-09-27 18:01:37 DEBUG: pid 25906: key: ssl
2010-09-27 18:01:37 DEBUG: pid 25906: value: false kind: 1
2010-09-27 18:01:37 DEBUG: pid 25906: key: debug_level
2010-09-27 18:01:37 DEBUG: pid 25906: value: 1 kind: 2
2010-09-27 18:01:37 DEBUG: pid 25906: num_backends: 1 total_weight: 1.000000
2010-09-27 18:01:37 DEBUG: pid 25906: backend 0 weight: 2147483647.000000
2010-09-27 18:01:37 DEBUG: pid 25908: I am 25908
2010-09-27 18:01:37 DEBUG: pid 25909: I am 25909
2010-09-27 18:01:37 DEBUG: pid 25910: I am 25910
2010-09-27 18:01:37 DEBUG: pid 25911: I am 25911
2010-09-27 18:01:37 DEBUG: pid 25912: I am 25912
2010-09-27 18:01:37 DEBUG: pid 25913: I am 25913
2010-09-27 18:01:37 DEBUG: pid 25914: I am 25914
2010-09-27 18:01:37 DEBUG: pid 25915: I am 25915
2010-09-27 18:01:37 DEBUG: pid 25916: I am 25916
2010-09-27 18:01:37 DEBUG: pid 25917: I am 25917
2010-09-27 18:01:37 DEBUG: pid 25918: I am 25918
2010-09-27 18:01:37 DEBUG: pid 25919: I am 25919
2010-09-27 18:01:37 DEBUG: pid 25920: I am 25920
2010-09-27 18:01:37 DEBUG: pid 25921: I am 25921
2010-09-27 18:01:37 DEBUG: pid 25922: I am 25922
2010-09-27 18:01:37 DEBUG: pid 25923: I am 25923
2010-09-27 18:01:37 DEBUG: pid 25924: I am 25924
2010-09-27 18:01:37 DEBUG: pid 25925: I am 25925
2010-09-27 18:01:37 DEBUG: pid 25926: I am 25926
2010-09-27 18:01:37 DEBUG: pid 25927: I am 25927
2010-09-27 18:01:37 DEBUG: pid 25929: I am 25929
2010-09-27 18:01:37 DEBUG: pid 25928: I am 25928
2010-09-27 18:01:37 DEBUG: pid 25930: I am 25930
2010-09-27 18:01:37 DEBUG: pid 25931: I am 25931
2010-09-27 18:01:37 DEBUG: pid 25932: I am 25932
2010-09-27 18:01:37 DEBUG: pid 25933: I am 25933
2010-09-27 18:01:37 DEBUG: pid 25934: I am 25934
2010-09-27 18:01:37 DEBUG: pid 25935: I am 25935
2010-09-27 18:01:37 DEBUG: pid 25936: I am 25936
2010-09-27 18:01:37 DEBUG: pid 25937: I am 25937
2010-09-27 18:01:37 DEBUG: pid 25938: I am 25938
2010-09-27 18:01:37 DEBUG: pid 25939: I am 25939
2010-09-27 18:01:37 LOG:   pid 25906: pgpool-II successfully started. version 3.0 (umiyameboshi)
2010-09-27 18:01:37 DEBUG: pid 25941: I am 25941
2010-09-27 18:02:16 DEBUG: pid 25934: I am 25934 accept fd 6
2010-09-27 18:02:16 LOG:   pid 25934: connection received: host=wcyh01c192 port=1188
2010-09-27 18:02:16 DEBUG: pid 25934: Protocol Major: 3 Minor: 0 database: toybox-bcas user: postgres
2010-09-27 18:02:16 DEBUG: pid 25934: new_connection: connecting 0 backend
2010-09-27 18:02:16 DEBUG: pid 25934: pool_ssl: SSL requested but SSL support is not available
2010-09-27 18:02:16 DEBUG: pid 25934: pool_read_message_length: slot: 0 length: 8
2010-09-27 18:02:16 DEBUG: pid 25934: pool_read_message_length2: master slot: 0 length: 28
2010-09-27 18:02:16 DEBUG: pid 25934: 0 th backend: name: client_encoding value: UNICODE
2010-09-27 18:02:16 DEBUG: pid 25934: pool_read_message_length2: master slot: 0 length: 23
2010-09-27 18:02:16 DEBUG: pid 25934: 0 th backend: name: DateStyle value: ISO, YMD
2010-09-27 18:02:16 DEBUG: pid 25934: pool_read_message_length2: master slot: 0 length: 25
2010-09-27 18:02:16 DEBUG: pid 25934: 0 th backend: name: integer_datetimes value: on
2010-09-27 18:02:16 DEBUG: pid 25934: pool_read_message_length2: master slot: 0 length: 27
2010-09-27 18:02:16 DEBUG: pid 25934: 0 th backend: name: IntervalStyle value: postgres
2010-09-27 18:02:16 DEBUG: pid 25934: pool_read_message_length2: master slot: 0 length: 20
2010-09-27 18:02:16 DEBUG: pid 25934: 0 th backend: name: is_superuser value: on
2010-09-27 18:02:16 DEBUG: pid 25934: pool_read_message_length2: master slot: 0 length: 25
2010-09-27 18:02:16 DEBUG: pid 25934: 0 th backend: name: server_encoding value: UTF8
2010-09-27 18:02:16 DEBUG: pid 25934: pool_read_message_length2: master slot: 0 length: 25
2010-09-27 18:02:16 DEBUG: pid 25934: 0 th backend: name: server_version value: 8.4.2
2010-09-27 18:02:16 DEBUG: pid 25934: pool_read_message_length2: master slot: 0 length: 35
2010-09-27 18:02:16 DEBUG: pid 25934: 0 th backend: name: session_authorization value: postgres
2010-09-27 18:02:16 DEBUG: pid 25934: pool_read_message_length2: master slot: 0 length: 36
2010-09-27 18:02:16 DEBUG: pid 25934: 0 th backend: name: standard_conforming_strings value: off
2010-09-27 18:02:16 DEBUG: pid 25934: pool_read_message_length2: master slot: 0 length: 19
2010-09-27 18:02:16 DEBUG: pid 25934: 0 th backend: name: TimeZone value: Japan
2010-09-27 18:02:16 DEBUG: pid 25934: pool_read_message_length: slot: 0 length: 12
2010-09-27 18:02:16 DEBUG: pid 25934: pool_do_auth: cp->info[i]:0xb7f1c000 pid:25949
2010-09-27 18:02:16 DEBUG: pid 25934: pool_send_auth_ok: send pid 25949 to frontend
2010-09-27 18:02:16 DEBUG: pid 25934: select_load_balancing_node: selected backend id is 0
2010-09-27 18:02:16 DEBUG: pid 25934: selected load balancing node: 0
2010-09-27 18:02:16 DEBUG: pid 25934: pool_unset_query_in_progress: done
2010-09-27 18:02:16 DEBUG: pid 25934: pool_unset_skip_reading_from_backends: done
2010-09-27 18:02:16 DEBUG: pid 25934: pool_unset_ignore_till_sync: done
2010-09-27 18:02:16 DEBUG: pid 25934: read_kind_from_backend: read kind from 0 th backend Z NUM_BACKENDS: 1
2010-09-27 18:02:16 DEBUG: pid 25934: ProcessBackendResponse: kind from backend: Z
2010-09-27 18:02:16 DEBUG: pid 25934: pool_read_message_length: slot: 0 length: 5
2010-09-27 18:02:16 DEBUG: pid 25934: ProcessFrontendResponse: kind from frontend P(50)
2010-09-27 18:02:16 DEBUG: pid 25934: pool_unset_doing_extended_query_message: done
2010-09-27 18:02:16 DEBUG: pid 25934: pool_set_doing_extended_query_message: done
2010-09-27 18:02:16 DEBUG: pid 25934: pool_set_query_in_progress: done
2010-09-27 18:02:16 DEBUG: pid 25934: Parse: statement name <S_1>
2010-09-27 18:02:16 DEBUG: pid 25934: pool_set_query_in_progress: done
2010-09-27 18:02:16 DEBUG: pid 25934: pool_read_message_length: slot: 0 length: 5
2010-09-27 18:02:16 DEBUG: pid 25934: Parse: waiting for master completing the query
2010-09-27 18:02:16 LOG:   pid 25934: DB node id: 0 backend pid: 25949 statement: S_1
2010-09-27 18:02:16 DEBUG: pid 25934: wait_for_query_response: waiting for backend 0 completing the query
2010-09-27 18:02:16 DEBUG: pid 25934: detect_error: kind: 1
2010-09-27 18:02:16 DEBUG: pid 25934: read_kind_from_backend: read kind from 0 th backend 1 NUM_BACKENDS: 1
2010-09-27 18:02:16 DEBUG: pid 25934: ProcessBackendResponse: kind from backend: 1
2010-09-27 18:02:16 DEBUG: pid 25934: pool_unset_query_in_progress: done
2010-09-27 18:02:16 DEBUG: pid 25934: ProcessFrontendResponse: kind from frontend B(42)
2010-09-27 18:02:16 DEBUG: pid 25934: pool_unset_doing_extended_query_message: done
2010-09-27 18:02:16 DEBUG: pid 25934: pool_set_doing_extended_query_message: done
2010-09-27 18:02:16 DEBUG: pid 25934: pool_set_query_in_progress: done
2010-09-27 18:02:16 DEBUG: pid 25934: Bind: waiting for master completing the query
2010-09-27 18:02:16 LOG:   pid 25934: DB node id: 0 backend pid: 25949 statement: 
2010-09-27 18:02:16 DEBUG: pid 25934: wait_for_query_response: waiting for backend 0 completing the query
2010-09-27 18:02:16 DEBUG: pid 25934: read_kind_from_backend: read kind from 0 th backend 2 NUM_BACKENDS: 1
2010-09-27 18:02:16 DEBUG: pid 25934: ProcessBackendResponse: kind from backend: 2
2010-09-27 18:02:16 DEBUG: pid 25934: pool_unset_query_in_progress: done
2010-09-27 18:02:16 DEBUG: pid 25934: ProcessFrontendResponse: kind from frontend E(45)
2010-09-27 18:02:16 DEBUG: pid 25934: pool_unset_doing_extended_query_message: done
2010-09-27 18:02:16 DEBUG: pid 25934: pool_set_doing_extended_query_message: done
2010-09-27 18:02:16 DEBUG: pid 25934: pool_set_query_in_progress: done
2010-09-27 18:02:16 DEBUG: pid 25934: Execute: portal name <>
2010-09-27 18:02:16 DEBUG: pid 25934: Execute: query: BEGIN
2010-09-27 18:02:16 LOG:   pid 25934: DB node id: 0 backend pid: 25949 statement: 
2010-09-27 18:02:16 DEBUG: pid 25934: wait_for_query_response: waiting for backend 0 completing the query
2010-09-27 18:02:16 DEBUG: pid 25934: detect_error: kind: C
2010-09-27 18:02:16 DEBUG: pid 25934: detect_error: kind: C
2010-09-27 18:02:16 DEBUG: pid 25934: detect_error: kind: C
2010-09-27 18:02:16 DEBUG: pid 25934: detect_error: kind: C
2010-09-27 18:02:16 DEBUG: pid 25934: read_kind_from_backend: read kind from 0 th backend C NUM_BACKENDS: 1
2010-09-27 18:02:16 DEBUG: pid 25934: ProcessBackendResponse: kind from backend: C
2010-09-27 18:02:16 DEBUG: pid 25934: pool_unset_query_in_progress: done
2010-09-27 18:02:16 DEBUG: pid 25934: ProcessFrontendResponse: kind from frontend P(50)
2010-09-27 18:02:16 DEBUG: pid 25934: pool_unset_doing_extended_query_message: done
2010-09-27 18:02:16 DEBUG: pid 25934: pool_set_doing_extended_query_message: done
2010-09-27 18:02:16 DEBUG: pid 25934: pool_set_query_in_progress: done
2010-09-27 18:02:16 DEBUG: pid 25934: Parse: statement name <S_2>
2010-09-27 18:02:16 DEBUG: pid 25934: pool_set_query_in_progress: done
2010-09-27 18:02:16 DEBUG: pid 25934: Parse: waiting for master completing the query
2010-09-27 18:02:16 LOG:   pid 25934: DB node id: 0 backend pid: 25949 statement: S_2
2010-09-27 18:02:16 DEBUG: pid 25934: wait_for_query_response: waiting for backend 0 completing the query
2010-09-27 18:02:16 DEBUG: pid 25934: detect_error: kind: 1
2010-09-27 18:02:16 DEBUG: pid 25934: read_kind_from_backend: read kind from 0 th backend 1 NUM_BACKENDS: 1
2010-09-27 18:02:16 DEBUG: pid 25934: ProcessBackendResponse: kind from backend: 1
2010-09-27 18:02:16 DEBUG: pid 25934: pool_unset_query_in_progress: done
2010-09-27 18:02:16 DEBUG: pid 25934: ProcessFrontendResponse: kind from frontend B(42)
2010-09-27 18:02:16 DEBUG: pid 25934: pool_unset_doing_extended_query_message: done
2010-09-27 18:02:16 DEBUG: pid 25934: pool_set_doing_extended_query_message: done
2010-09-27 18:02:16 DEBUG: pid 25934: pool_set_query_in_progress: done
2010-09-27 18:02:16 DEBUG: pid 25934: Bind: waiting for master completing the query
2010-09-27 18:02:16 LOG:   pid 25934: DB node id: 0 backend pid: 25949 statement: C_3
2010-09-27 18:02:16 DEBUG: pid 25934: wait_for_query_response: waiting for backend 0 completing the query
2010-09-27 18:02:16 DEBUG: pid 25934: read_kind_from_backend: read kind from 0 th backend 2 NUM_BACKENDS: 1
2010-09-27 18:02:16 DEBUG: pid 25934: ProcessBackendResponse: kind from backend: 2
2010-09-27 18:02:16 DEBUG: pid 25934: pool_unset_query_in_progress: done
2010-09-27 18:02:16 DEBUG: pid 25934: ProcessFrontendResponse: kind from frontend D(44)
2010-09-27 18:02:16 DEBUG: pid 25934: pool_unset_doing_extended_query_message: done
2010-09-27 18:02:16 DEBUG: pid 25934: pool_set_doing_extended_query_message: done
2010-09-27 18:02:16 DEBUG: pid 25934: pool_set_query_in_progress: done
2010-09-27 18:02:16 DEBUG: pid 25934: Describe: waiting for master completing the query
2010-09-27 18:02:16 LOG:   pid 25934: DB node id: 0 backend pid: 25949 statement: PC_3
2010-09-27 18:02:16 DEBUG: pid 25934: wait_for_query_response: waiting for backend 0 completing the query
2010-09-27 18:02:16 DEBUG: pid 25934: read_kind_from_backend: read kind from 0 th backend T NUM_BACKENDS: 1
2010-09-27 18:02:16 DEBUG: pid 25934: ProcessBackendResponse: kind from backend: T
2010-09-27 18:02:16 DEBUG: pid 25934: pool_unset_query_in_progress: done
2010-09-27 18:02:16 DEBUG: pid 25934: ProcessFrontendResponse: kind from frontend E(45)
2010-09-27 18:02:16 DEBUG: pid 25934: pool_unset_doing_extended_query_message: done
2010-09-27 18:02:16 DEBUG: pid 25934: pool_set_doing_extended_query_message: done
2010-09-27 18:02:16 DEBUG: pid 25934: pool_set_query_in_progress: done
2010-09-27 18:02:16 DEBUG: pid 25934: Execute: portal name <C_3>
2010-09-27 18:02:16 DEBUG: pid 25934: Execute: query: select nextval('HandleHistory_handleID_seq') as handleID
2010-09-27 18:02:16 LOG:   pid 25934: DB node id: 0 backend pid: 25949 statement: C_3
2010-09-27 18:02:16 DEBUG: pid 25934: wait_for_query_response: waiting for backend 0 completing the query
2010-09-27 18:02:16 DEBUG: pid 25934: detect_error: kind: D
2010-09-27 18:02:16 DEBUG: pid 25934: detect_error: kind: D
2010-09-27 18:02:16 DEBUG: pid 25934: detect_error: kind: D
2010-09-27 18:02:16 DEBUG: pid 25934: detect_error: kind: D
2010-09-27 18:02:16 DEBUG: pid 25934: read_kind_from_backend: read kind from 0 th backend D NUM_BACKENDS: 1
2010-09-27 18:02:16 DEBUG: pid 25934: ProcessBackendResponse: kind from backend: D
2010-09-27 18:02:16 DEBUG: pid 25934: read_kind_from_backend: read kind from 0 th backend C NUM_BACKENDS: 1
2010-09-27 18:02:16 DEBUG: pid 25934: ProcessBackendResponse: kind from backend: C
2010-09-27 18:02:16 DEBUG: pid 25934: pool_unset_query_in_progress: done
2010-09-27 18:02:16 DEBUG: pid 25934: ProcessFrontendResponse: kind from frontend S(53)
2010-09-27 18:02:16 DEBUG: pid 25934: pool_unset_doing_extended_query_message: done
2010-09-27 18:02:16 DEBUG: pid 25934: pool_set_doing_extended_query_message: done
2010-09-27 18:02:16 DEBUG: pid 25934: pool_set_query_in_progress: done
2010-09-27 18:02:16 DEBUG: pid 25934: read_kind_from_backend: read kind from 0 th backend Z NUM_BACKENDS: 1
2010-09-27 18:02:16 DEBUG: pid 25934: ProcessBackendResponse: kind from backend: Z
2010-09-27 18:02:16 DEBUG: pid 25934: pool_read_message_length: slot: 0 length: 5
2010-09-27 18:02:16 DEBUG: pid 25934: pool_unset_query_in_progress: done
2010-09-27 18:02:16 DEBUG: pid 25934: ProcessFrontendResponse: kind from frontend C(43)
2010-09-27 18:02:16 DEBUG: pid 25934: pool_unset_doing_extended_query_message: done
2010-09-27 18:02:16 DEBUG: pid 25934: pool_set_query_in_progress: done
2010-09-27 18:02:16 DEBUG: pid 25934: Close: waiting for master completing the query
2010-09-27 18:02:16 LOG:   pid 25934: DB node id: 0 backend pid: 25949 statement: SS_2
2010-09-27 18:02:16 DEBUG: pid 25934: wait_for_query_response: waiting for backend 0 completing the query
2010-09-27 18:02:16 DEBUG: pid 25934: read_kind_from_backend: read kind from 0 th backend 3 NUM_BACKENDS: 1
2010-09-27 18:02:16 DEBUG: pid 25934: ProcessBackendResponse: kind from backend: 3
2010-09-27 18:02:16 DEBUG: pid 25934: pool_unset_query_in_progress: done
2010-09-27 18:02:16 DEBUG: pid 25934: pool_set_query_in_progress: done
2010-09-27 18:02:16 DEBUG: pid 25934: pool_unset_query_in_progress: done
2010-09-27 18:02:16 DEBUG: pid 25934: ProcessFrontendResponse: kind from frontend C(43)
2010-09-27 18:02:16 DEBUG: pid 25934: pool_unset_doing_extended_query_message: done
2010-09-27 18:02:16 DEBUG: pid 25934: pool_set_query_in_progress: done
2010-09-27 18:02:16 ERROR: pid 25934: Close: cannot get portal
2010-09-27 18:02:16 LOG:   pid 25934: do_child: exits with status 1 due to error
2010-09-27 18:02:16 DEBUG: pid 25906: reap_handler called
2010-09-27 18:02:16 DEBUG: pid 25906: reap_handler: call wait3
2010-09-27 18:02:16 DEBUG: pid 25906: child 25934 exits with status 256
2010-09-27 18:02:16 DEBUG: pid 25906: fork a new child pid 25950
2010-09-27 18:02:16 DEBUG: pid 25906: reap_handler: normally exited
2010-09-27 18:02:16 DEBUG: pid 25950: I am 25950