[pgpool-general-jp: 1255] Re: UPDATE後にキャッシュ削除されない

Tatsuo Ishii ishii @ sraoss.co.jp
2014年 1月 25日 (土) 11:01:03 JST


$B:4F#MM(B

$B @ P0f$G$9!#(B

$BD4::$7$?$H$3$m!"$I$&$b(Bpgpool-II$B$N%P%0$N$h$&$G$9!#(Bpgpool-II$B$O!"L@<(E*$J(B
$B%H%i%s%6%/%7%g%s$NCf$G99?7(BSQL(DML)$B$,<B9T$5$l$k$H!"0J9_$N(BSELECT$B$,%/%(%j(B
$B%-%c%C%7%e$+$i7k2L$r$H$j=P$5$J$$$h$&$K@)8f$7$F$$$k$N$G$9$,!"3HD%Ld$$9g(B
$B$o$;(B(JDBC$B7PM3$J$I$GH/9T$5$l$k(B)$B$N>l9g$K$3$N9MN8$,H4$1$F$$$?$h$&$G$9!#(B

$BE:IU$N%Q%C%A$r$*;n$7$$$?$@$1$^$9$G$7$g$&!)(B
--
Tatsuo Ishii
SRA OSS, Inc. Japan
English: http://www.sraoss.co.jp/index_en.php
Japanese: http://www.sraoss.co.jp

From: $B:4F#?5(B <s_sato @ eltex.co.jp>
Subject: Re: [pgpool-general-jp: 1252] UPDATE$B8e$K%-%c%C%7%e:o=|$5$l$J$$(B
Date: Fri, 24 Jan 2014 17:04:24 +0900
Message-ID: <CAD8t+Kmrdq88v2LOrzAsZujWtkRdbOqy3=zRkKS9Zj2J+-S3aA @ mail.gmail.com>

> $B @ P0fMM(B
> 
> $B$*@$OC$K$J$C$F$*$j$^$9!#:4F#$G$9!#(B
> $B0J2<$O(Bconf$B$H%m%0$K$J$j$^$9!#(B
> 
> [pgpool.conf]
> listen_addresses = '*'
> port = 9999
> socket_dir = '/tmp'
> pcp_port = 9898
> pcp_socket_dir = '/tmp'
> backend_hostname0 = 'xs2-sms-db1'
> backend_port0 = 5432
> backend_weight0 = 1
> backend_data_directory0 = '/opt/pgsql'
> backend_flag0 = 'ALLOW_TO_FAILOVER'
> backend_hostname1 = 'xs2-sms-db2'
> backend_port1 = 5432
> backend_weight1 = 3
> backend_data_directory1 = '/opt/pgsql'
> backend_flag1 = 'ALLOW_TO_FAILOVER'
> enable_pool_hba = off
> pool_passwd = 'pool_passwd'
> authentication_timeout = 60
> ssl = off
> num_init_children = 128
> max_pool = 1
> child_life_time = 300
> child_max_connections = 0
> connection_life_time = 0
> client_idle_limit = 0
> log_destination = 'stderr'
> print_timestamp = on
> log_connections = off
> log_hostname = off
> log_statement = on
> log_per_node_statement = on
> log_standby_delay = 'if_over_threshold'
> syslog_facility = 'LOCAL0'
> syslog_ident = 'pgpool'
> debug_level = 0
> pid_file_name = '/var/run/pgpool/pgpool.pid'
> logdir = '/tmp'
> connection_cache = on
> reset_query_list = 'ABORT; DISCARD ALL'
> replication_mode = off
> replicate_select = off
> insert_lock = off
> lobj_lock_table = ''
> replication_stop_on_mismatch = off
> failover_if_affected_tuples_mismatch = off
> load_balance_mode = on
> ignore_leading_white_space = on
> white_function_list = ''
> black_function_list = 'currval,lastval,nextval,setval'
> master_slave_mode = on
> master_slave_sub_mode = 'stream'
> sr_check_period = 10
> sr_check_user = 'postgres'
> sr_check_password = '******'
> delay_threshold = 100
> follow_master_command = '/unyo/shell/bin/follow_master.sh %h %d %H %P'
> parallel_mode = off
> pgpool2_hostname = ''
> health_check_period = 5
> health_check_timeout = 20
> health_check_user = 'postgres'
> health_check_password = '******'
> health_check_max_retries = 1
> health_check_retry_delay = 5
> failover_command = '/unyo/shell/bin/failover.sh %d "%h" %p %D %m %M "%H" %P
> %r %R'
> failback_command = ''
> fail_over_on_backend_error = on
> recovery_user = 'nobody'
> recovery_password = ''
> recovery_1st_stage_command = ''
> recovery_2nd_stage_command = ''
> recovery_timeout = 90
> client_idle_limit_in_recovery = 0
> use_watchdog = on
> trusted_servers = ''
> delegate_IP = '172.18.253.150'
> wd_hostname = 'xs2-sms-pg1'
> wd_port = 9000
> wd_interval = 10
> ping_path = '/bin'
> ifconfig_path = '/sbin'
> if_up_cmd = 'ifconfig eth1:0 inet $_IP_$ netmask 255.255.255.128'
> if_down_cmd = 'ifconfig eth1:0 down'
> arping_path = '/usr/sbin'           # arping command path
> arping_cmd = 'arping -U $_IP_$ -w 1'
> wd_life_point = 3
> wd_lifecheck_query = 'SELECT 1'
> other_pgpool_hostname0 = 'xs2-sms-pg2'
> other_pgpool_port0 = 9999
> other_wd_port0 = 9000
> relcache_expire = 0
> relcache_size = 256
> check_temp_table = on
> memory_cache_enabled = on
> memqcache_method = 'shmem'
> memqcache_memcached_host = 'localhost'
> memqcache_memcached_port = 11211
> memqcache_total_size = 67108864
> memqcache_max_num_cache = 1000000
> memqcache_expire = 3600
> memqcache_auto_cache_invalidation = on
> memqcache_maxcache = 409600
> memqcache_cache_block_size = 1048576
> memqcache_oiddir = '/var/log/pgpool/oiddir'
> white_memqcache_table_list = ''
> black_memqcache_table_list = ''
> 
> 
> [pgpool$B%G%P%C%/%m%0(B]
> 2014-01-23 14:56:31 DEBUG: pid 613: send_to_where: 0 query:  UPDATE
> t_work_flow SET company_no = $1  , action_code = $2  , work_status = $3  ,
> totalization_data = $4  , target_action_code = $5  , admin_user_no = $6  ,
> confirm_user_no1 = $7  , modify_date = $8  , modify_person_id = $9  ,
> modify_ipaddress = $10  , modify_user_agent = $11  , confirm_date1 = $12
>  WHERE work_flow_no = $13 AND (del_flg <> $14  OR del_flg IS NULL)
> 2014-01-23 14:56:31 DEBUG: pid 613: Parse: waiting for master completing
> the query
> 2014-01-23 14:56:31 LOG:   pid 613: DB node id: 0 backend pid: 5317
> statement: Parse:  UPDATE t_work_flow SET company_no = $1  , action_code =
> $2  , work_status = $3  , totalization_data = $4  , target_action_code = $5
>  , admin_user_no = $6  , confirm_user_no1 = $7  , modify_date = $8  ,
> modify_person_id = $9  , modify_ipaddress = $10  , modify_user_agent = $11
>  , confirm_date1 = $12  WHERE work_flow_no = $13 AND (del_flg <> $14  OR
> del_flg IS NULL)
> 2014-01-23 14:56:31 DEBUG: pid 613: wait_for_query_response: waiting for
> backend 0 completing the query
> 2014-01-23 14:56:31 DEBUG: pid 613: detect_error: kind: 1
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_unset_skip_reading_from_backends:
> done
> 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_one_backend: read kind
> from 0 th backend 1
> 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: kind: 1 from 0
> th backend
> 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: read kind from
> 0 th backend 1 NUM_BACKENDS: 2
> 2014-01-23 14:56:31 DEBUG: pid 613: ProcessBackendResponse: kind from
> backend: 1
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_add_sent_message: prepared
> statement "" already exists
> 2014-01-23 14:56:31 DEBUG: pid 613: can_query_context_destroy: query
> context 0x1d4c1e0 is still used. query: SELECT t_work_flow.company_no AS
> T1_C1,t_work_flow.shop_no AS T1_C2,t_work_flow.work_flow_no AS
> T1_C3,t_work_flow.work_code AS T1_C4,t_work_flow.action_code AS
> T1_C5,t_work_flow.work_status AS T1_C6,t_work_flow.target_url AS
> T1_C7,t_work_flow.totalization_data AS T1_C8,t_work_flow.target_action_code
> AS T1_C9,t_work_flow.admin_user_no AS T1_C10,t_work_flow.request_user_no AS
> T1_C11,t_work_flow.confirm_user_no1 AS T1_C12,t_work_flow.confirm_user_no2
> AS T1_C13,t_work_flow.confirm_user_no3 AS
> T1_C14,t_work_flow.confirm_user_no4 AS T1_C15,t_work_flow.confirm_user_no5
> AS T1_C16,t_work_flow.confirm_user_no6 AS
> T1_C17,t_work_flow.confirm_user_no7 AS T1_C18,t_work_flow.confirm_user_no8
> AS T1_C19,t_work_flow.approve_user_no AS T1_C20,t_work_flow.yobi_string1 AS
> T1_C21,t_work_flow.yobi_string2 AS T1_C22,t_work_flow.yobi_string3 AS
> T1_C23,t_work_flow.yobi_string4 AS T1_C24,t_work_flow.yobi_string5 AS
> T1_C25,t_work_flow.yobi_num1 AS T1_C26,t_work_flow.yobi_num2 AS
> T1_C27,t_work_flow.yobi_num3 AS T1_C28,t_work_flow.yobi_num4 AS
> T1_C29,t_work_flow.yobi_num5 AS T1_C30,t_work_flow.yobi_time1 AS
> T1_C31,t_work_flow.yobi_time2 AS T1_C32,t_work_flow.yobi_time3 AS
> T1_C33,t_work_flow.yobi_time4 AS T1_C34,t_work_flow.yobi_time5 AS
> T1_C35,t_work_flow.del_flg AS T1_C36,t_work_flow.del_date AS
> T1_C37,t_work_flow.del_person_id AS T1_C38,t_work_flow.del_ipaddress AS
> T1_C39,t_work_flow.del_user_agent AS T1_C40,t_work_flow.add_date AS
> T1_C41,t_work_flow.add_person_id AS T1_C42,t_work_flow.add_ipaddress AS
> T1_C43,t_work_flow.add_user_agent AS T1_C44,t_work_flow.modify_date AS
> T1_C45,t_work_flow.modify_person_id AS T1_C46,t_work_flow.modify_ipaddress
> AS T1_C47,t_work_flow.modify_user_agent AS T1_C48,t_work_flow.request_date
> AS T1_C49,t_work_flow.confirm_date1 AS T1_C50,t_work_flow.confirm_date2 AS
> T1_C51,t_work_flow.confirm_date3 AS T1_C52,t_work_flow.confirm_date4 AS
> T1_C53,t_work_flow.confirm_date5 AS T1_C54,t_work_flow.confirm_date6 AS
> T1_C55,t_work_flow.confirm_date7 AS T1_C56,t_work_flow.confirm_date8 AS
> T1_C57,t_work_flow.approve_date AS T1_C58 FROM t_work_flow WHERE
> work_flow_no = $1  AND (t_work_flow.del_flg<> $2 OR t_work_flow.del_flg IS
> NULL)
> 2014-01-23 14:56:31 DEBUG: pid 613: can_query_context_destroy: query
> context 0x1d4c1e0 is still used. query: SELECT t_work_flow.company_no AS
> T1_C1,t_work_flow.shop_no AS T1_C2,t_work_flow.work_flow_no AS
> T1_C3,t_work_flow.work_code AS T1_C4,t_work_flow.action_code AS
> T1_C5,t_work_flow.work_status AS T1_C6,t_work_flow.target_url AS
> T1_C7,t_work_flow.totalization_data AS T1_C8,t_work_flow.target_action_code
> AS T1_C9,t_work_flow.admin_user_no AS T1_C10,t_work_flow.request_user_no AS
> T1_C11,t_work_flow.confirm_user_no1 AS T1_C12,t_work_flow.confirm_user_no2
> AS T1_C13,t_work_flow.confirm_user_no3 AS
> T1_C14,t_work_flow.confirm_user_no4 AS T1_C15,t_work_flow.confirm_user_no5
> AS T1_C16,t_work_flow.confirm_user_no6 AS
> T1_C17,t_work_flow.confirm_user_no7 AS T1_C18,t_work_flow.confirm_user_no8
> AS T1_C19,t_work_flow.approve_user_no AS T1_C20,t_work_flow.yobi_string1 AS
> T1_C21,t_work_flow.yobi_string2 AS T1_C22,t_work_flow.yobi_string3 AS
> T1_C23,t_work_flow.yobi_string4 AS T1_C24,t_work_flow.yobi_string5 AS
> T1_C25,t_work_flow.yobi_num1 AS T1_C26,t_work_flow.yobi_num2 AS
> T1_C27,t_work_flow.yobi_num3 AS T1_C28,t_work_flow.yobi_num4 AS
> T1_C29,t_work_flow.yobi_num5 AS T1_C30,t_work_flow.yobi_time1 AS
> T1_C31,t_work_flow.yobi_time2 AS T1_C32,t_work_flow.yobi_time3 AS
> T1_C33,t_work_flow.yobi_time4 AS T1_C34,t_work_flow.yobi_time5 AS
> T1_C35,t_work_flow.del_flg AS T1_C36,t_work_flow.del_date AS
> T1_C37,t_work_flow.del_person_id AS T1_C38,t_work_flow.del_ipaddress AS
> T1_C39,t_work_flow.del_user_agent AS T1_C40,t_work_flow.add_date AS
> T1_C41,t_work_flow.add_person_id AS T1_C42,t_work_flow.add_ipaddress AS
> T1_C43,t_work_flow.add_user_agent AS T1_C44,t_work_flow.modify_date AS
> T1_C45,t_work_flow.modify_person_id AS T1_C46,t_work_flow.modify_ipaddress
> AS T1_C47,t_work_flow.modify_user_agent AS T1_C48,t_work_flow.request_date
> AS T1_C49,t_work_flow.confirm_date1 AS T1_C50,t_work_flow.confirm_date2 AS
> T1_C51,t_work_flow.confirm_date3 AS T1_C52,t_work_flow.confirm_date4 AS
> T1_C53,t_work_flow.confirm_date5 AS T1_C54,t_work_flow.confirm_date6 AS
> T1_C55,t_work_flow.confirm_date7 AS T1_C56,t_work_flow.confirm_date8 AS
> T1_C57,t_work_flow.approve_date AS T1_C58 FROM t_work_flow WHERE
> work_flow_no = $1  AND (t_work_flow.del_flg<> $2 OR t_work_flow.del_flg IS
> NULL)
> 2014-01-23 14:56:31 DEBUG: pid 613: can_query_context_destroy: query
> context 0x1d4c1e0 is still used for 2 times.
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_command_success: done
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_unset_query_in_progress: done
> 2014-01-23 14:56:31 DEBUG: pid 613: ProcessFrontendResponse: kind from
> frontend B(42)
> 2014-01-23 14:56:31 DEBUG: pid 613:
> pool_unset_doing_extended_query_message: done
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_doing_extended_query_message:
> done
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_query_in_progress: done
> 2014-01-23 14:56:31 DEBUG: pid 613: Bind: waiting for master completing the
> query
> 2014-01-23 14:56:31 LOG:   pid 613: DB node id: 0 backend pid: 5317
> statement: B message
> 2014-01-23 14:56:31 DEBUG: pid 613: wait_for_query_response: waiting for
> backend 0 completing the query
> 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_one_backend: read kind
> from 0 th backend 2
> 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: kind: 2 from 0
> th backend
> 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: read kind from
> 0 th backend 2 NUM_BACKENDS: 2
> 2014-01-23 14:56:31 DEBUG: pid 613: ProcessBackendResponse: kind from
> backend: 2
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_add_sent_message: portal ""
> already exists
> 2014-01-23 14:56:31 DEBUG: pid 613: can_query_context_destroy: query
> context 0x1d4c1e0 is still used. query: SELECT t_work_flow.company_no AS
> T1_C1,t_work_flow.shop_no AS T1_C2,t_work_flow.work_flow_no AS
> T1_C3,t_work_flow.work_code AS T1_C4,t_work_flow.action_code AS
> T1_C5,t_work_flow.work_status AS T1_C6,t_work_flow.target_url AS
> T1_C7,t_work_flow.totalization_data AS T1_C8,t_work_flow.target_action_code
> AS T1_C9,t_work_flow.admin_user_no AS T1_C10,t_work_flow.request_user_no AS
> T1_C11,t_work_flow.confirm_user_no1 AS T1_C12,t_work_flow.confirm_user_no2
> AS T1_C13,t_work_flow.confirm_user_no3 AS
> T1_C14,t_work_flow.confirm_user_no4 AS T1_C15,t_work_flow.confirm_user_no5
> AS T1_C16,t_work_flow.confirm_user_no6 AS
> T1_C17,t_work_flow.confirm_user_no7 AS T1_C18,t_work_flow.confirm_user_no8
> AS T1_C19,t_work_flow.approve_user_no AS T1_C20,t_work_flow.yobi_string1 AS
> T1_C21,t_work_flow.yobi_string2 AS T1_C22,t_work_flow.yobi_string3 AS
> T1_C23,t_work_flow.yobi_string4 AS T1_C24,t_work_flow.yobi_string5 AS
> T1_C25,t_work_flow.yobi_num1 AS T1_C26,t_work_flow.yobi_num2 AS
> T1_C27,t_work_flow.yobi_num3 AS T1_C28,t_work_flow.yobi_num4 AS
> T1_C29,t_work_flow.yobi_num5 AS T1_C30,t_work_flow.yobi_time1 AS
> T1_C31,t_work_flow.yobi_time2 AS T1_C32,t_work_flow.yobi_time3 AS
> T1_C33,t_work_flow.yobi_time4 AS T1_C34,t_work_flow.yobi_time5 AS
> T1_C35,t_work_flow.del_flg AS T1_C36,t_work_flow.del_date AS
> T1_C37,t_work_flow.del_person_id AS T1_C38,t_work_flow.del_ipaddress AS
> T1_C39,t_work_flow.del_user_agent AS T1_C40,t_work_flow.add_date AS
> T1_C41,t_work_flow.add_person_id AS T1_C42,t_work_flow.add_ipaddress AS
> T1_C43,t_work_flow.add_user_agent AS T1_C44,t_work_flow.modify_date AS
> T1_C45,t_work_flow.modify_person_id AS T1_C46,t_work_flow.modify_ipaddress
> AS T1_C47,t_work_flow.modify_user_agent AS T1_C48,t_work_flow.request_date
> AS T1_C49,t_work_flow.confirm_date1 AS T1_C50,t_work_flow.confirm_date2 AS
> T1_C51,t_work_flow.confirm_date3 AS T1_C52,t_work_flow.confirm_date4 AS
> T1_C53,t_work_flow.confirm_date5 AS T1_C54,t_work_flow.confirm_date6 AS
> T1_C55,t_work_flow.confirm_date7 AS T1_C56,t_work_flow.confirm_date8 AS
> T1_C57,t_work_flow.approve_date AS T1_C58 FROM t_work_flow WHERE
> work_flow_no = $1  AND (t_work_flow.del_flg<> $2 OR t_work_flow.del_flg IS
> NULL)
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_unset_query_in_progress: done
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_query_in_progress: done
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_command_success: done
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_unset_query_in_progress: done
> 2014-01-23 14:56:31 DEBUG: pid 613: ProcessFrontendResponse: kind from
> frontend D(44)
> 2014-01-23 14:56:31 DEBUG: pid 613:
> pool_unset_doing_extended_query_message: done
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_doing_extended_query_message:
> done
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_query_in_progress: done
> 2014-01-23 14:56:31 DEBUG: pid 613: Describe: waiting for master completing
> the query
> 2014-01-23 14:56:31 LOG:   pid 613: DB node id: 0 backend pid: 5317
> statement: D message
> 2014-01-23 14:56:31 DEBUG: pid 613: wait_for_query_response: waiting for
> backend 0 completing the query
> 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_one_backend: read kind
> from 0 th backend n
> 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: kind: n from 0
> th backend
> 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: read kind from
> 0 th backend n NUM_BACKENDS: 2
> 2014-01-23 14:56:31 DEBUG: pid 613: ProcessBackendResponse: kind from
> backend: n
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_unset_query_in_progress: done
> 2014-01-23 14:56:31 DEBUG: pid 613: ProcessFrontendResponse: kind from
> frontend E(45)
> 2014-01-23 14:56:31 DEBUG: pid 613:
> pool_unset_doing_extended_query_message: done
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_doing_extended_query_message:
> done
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_query_in_progress: done
> 2014-01-23 14:56:31 DEBUG: pid 613: Execute: portal name <>
> 2014-01-23 14:56:31 DEBUG: pid 613: Execute: query string = < UPDATE
> t_work_flow SET company_no = $1  , action_code = $2  , work_status = $3  ,
> totalization_data = $4  , target_action_code = $5  , admin_user_no = $6  ,
> confirm_user_no1 = $7  , modify_date = $8  , modify_person_id = $9  ,
> modify_ipaddress = $10  , modify_user_agent = $11  , confirm_date1 = $12
>  WHERE work_flow_no = $13 AND (del_flg <> $14  OR del_flg IS NULL) >
> 2014-01-23 14:56:31 LOG:   pid 613: DB node id: 0 backend pid: 5317
> statement: Execute:  UPDATE t_work_flow SET company_no = $1  , action_code
> = $2  , work_status = $3  , totalization_data = $4  , target_action_code =
> $5  , admin_user_no = $6  , confirm_user_no1 = $7  , modify_date = $8  ,
> modify_person_id = $9  , modify_ipaddress = $10  , modify_user_agent = $11
>  , confirm_date1 = $12  WHERE work_flow_no = $13 AND (del_flg <> $14  OR
> del_flg IS NULL)
> 2014-01-23 14:56:31 DEBUG: pid 613: wait_for_query_response: waiting for
> backend 0 completing the query
> 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_one_backend: read kind
> from 0 th backend C
> 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: kind: C from 0
> th backend
> 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: read kind from
> 0 th backend C NUM_BACKENDS: 2
> 2014-01-23 14:56:31 DEBUG: pid 613: ProcessBackendResponse: kind from
> backend: C
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_command_success: done
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_unset_query_in_progress: done
> 2014-01-23 14:56:31 DEBUG: pid 613: ProcessFrontendResponse: kind from
> frontend S(53)
> 2014-01-23 14:56:31 DEBUG: pid 613:
> pool_unset_doing_extended_query_message: done
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_doing_extended_query_message:
> done
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_query_in_progress: done
> 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_one_backend: read kind
> from 0 th backend Z
> 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: kind: Z from 0
> th backend
> 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: read kind from
> 0 th backend Z NUM_BACKENDS: 2
> 2014-01-23 14:56:31 DEBUG: pid 613: ProcessBackendResponse: kind from
> backend: Z
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_read_message_length: slot: 0
> length: 5
> 2014-01-23 14:56:31 DEBUG: pid 613: ReadyForQuery: transaction state:T
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_writing_transaction: done
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_unset_query_in_progress: done
> 2014-01-23 14:56:31 DEBUG: pid 613: ProcessBackendResponse: Ready For Query
> 2014-01-23 14:56:31 DEBUG: pid 613: ProcessFrontendResponse: kind from
> frontend P(50)
> 2014-01-23 14:56:31 DEBUG: pid 613:
> pool_unset_doing_extended_query_message: done
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_doing_extended_query_message:
> done
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_query_in_progress: done
> 2014-01-23 14:56:31 DEBUG: pid 613: Parse: statement name <>
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_query_in_progress: done
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_has_insertinto_or_locking_clause:
> returns 0
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_has_non_immutable_function_call: 0
> 2014-01-23 14:56:31 DEBUG: pid 613: temp_table_walker: relname: t_work_flow
> 2014-01-23 14:56:31 DEBUG: pid 613: system_catalog_walker: relname:
> t_work_flow
> 2014-01-23 14:56:31 DEBUG: pid 613: make_table_name_from_rangevar:
> tablename:t_work_flow
> 2014-01-23 14:56:31 DEBUG: pid 613: view_walker: relname: t_work_flow
> 2014-01-23 14:56:31 DEBUG: pid 613: make_table_name_from_rangevar:
> tablename:t_work_flow
> 2014-01-23 14:56:31 DEBUG: pid 613: unlogged_table_walker: relname:
> t_work_flow
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_has_insertinto_or_locking_clause:
> returns 0
> 2014-01-23 14:56:31 DEBUG: pid 613: send_to_where: 2 query: SELECT
> t_work_flow.company_no AS T1_C1,t_work_flow.shop_no AS
> T1_C2,t_work_flow.work_flow_no AS T1_C3,t_work_flow.work_code AS
> T1_C4,t_work_flow.action_code AS T1_C5,t_work_flow.work_status AS
> T1_C6,t_work_flow.target_url AS T1_C7,t_work_flow.totalization_data AS
> T1_C8,t_work_flow.target_action_code AS T1_C9,t_work_flow.admin_user_no AS
> T1_C10,t_work_flow.request_user_no AS T1_C11,t_work_flow.confirm_user_no1
> AS T1_C12,t_work_flow.confirm_user_no2 AS
> T1_C13,t_work_flow.confirm_user_no3 AS T1_C14,t_work_flow.confirm_user_no4
> AS T1_C15,t_work_flow.confirm_user_no5 AS
> T1_C16,t_work_flow.confirm_user_no6 AS T1_C17,t_work_flow.confirm_user_no7
> AS T1_C18,t_work_flow.confirm_user_no8 AS
> T1_C19,t_work_flow.approve_user_no AS T1_C20,t_work_flow.yobi_string1 AS
> T1_C21,t_work_flow.yobi_string2 AS T1_C22,t_work_flow.yobi_string3 AS
> T1_C23,t_work_flow.yobi_string4 AS T1_C24,t_work_flow.yobi_string5 AS
> T1_C25,t_work_flow.yobi_num1 AS T1_C26,t_work_flow.yobi_num2 AS
> T1_C27,t_work_flow.yobi_num3 AS T1_C28,t_work_flow.yobi_num4 AS
> T1_C29,t_work_flow.yobi_num5 AS T1_C30,t_work_flow.yobi_time1 AS
> T1_C31,t_work_flow.yobi_time2 AS T1_C32,t_work_flow.yobi_time3 AS
> T1_C33,t_work_flow.yobi_time4 AS T1_C34,t_work_flow.yobi_time5 AS
> T1_C35,t_work_flow.del_flg AS T1_C36,t_work_flow.del_date AS
> T1_C37,t_work_flow.del_person_id AS T1_C38,t_work_flow.del_ipaddress AS
> T1_C39,t_work_flow.del_user_agent AS T1_C40,t_work_flow.add_date AS
> T1_C41,t_work_flow.add_person_id AS T1_C42,t_work_flow.add_ipaddress AS
> T1_C43,t_work_flow.add_user_agent AS T1_C44,t_work_flow.modify_date AS
> T1_C45,t_work_flow.modify_person_id AS T1_C46,t_work_flow.modify_ipaddress
> AS T1_C47,t_work_flow.modify_user_agent AS T1_C48,t_work_flow.request_date
> AS T1_C49,t_work_flow.confirm_date1 AS T1_C50,t_work_flow.confirm_date2 AS
> T1_C51,t_work_flow.confirm_date3 AS T1_C52,t_work_flow.confirm_date4 AS
> T1_C53,t_work_flow.confirm_date5 AS T1_C54,t_work_flow.confirm_date6 AS
> T1_C55,t_work_flow.confirm_date7 AS T1_C56,t_work_flow.confirm_date8 AS
> T1_C57,t_work_flow.approve_date AS T1_C58 FROM t_work_flow WHERE
> work_flow_no = $1  AND (t_work_flow.del_flg<> $2 OR t_work_flow.del_flg IS
> NULL)
> 2014-01-23 14:56:31 DEBUG: pid 613: Parse: waiting for master completing
> the query
> 2014-01-23 14:56:31 LOG:   pid 613: DB node id: 0 backend pid: 5317
> statement: Parse: SELECT t_work_flow.company_no AS
> T1_C1,t_work_flow.shop_no AS T1_C2,t_work_flow.work_flow_no AS
> T1_C3,t_work_flow.work_code AS T1_C4,t_work_flow.action_code AS
> T1_C5,t_work_flow.work_status AS T1_C6,t_work_flow.target_url AS
> T1_C7,t_work_flow.totalization_data AS T1_C8,t_work_flow.target_action_code
> AS T1_C9,t_work_flow.admin_user_no AS T1_C10,t_work_flow.request_user_no AS
> T1_C11,t_work_flow.confirm_user_no1 AS T1_C12,t_work_flow.confirm_user_no2
> AS T1_C13,t_work_flow.confirm_user_no3 AS
> T1_C14,t_work_flow.confirm_user_no4 AS T1_C15,t_work_flow.confirm_user_no5
> AS T1_C16,t_work_flow.confirm_user_no6 AS
> T1_C17,t_work_flow.confirm_user_no7 AS T1_C18,t_work_flow.confirm_user_no8
> AS T1_C19,t_work_flow.approve_user_no AS T1_C20,t_work_flow.yobi_string1 AS
> T1_C21,t_work_flow.yobi_string2 AS T1_C22,t_work_flow.yobi_string3 AS
> T1_C23,t_work_flow.yobi_string4 AS T1_C24,t_work_flow.yobi_string5 AS
> T1_C25,t_work_flow.yobi_num1 AS T1_C26,t_work_flow.yobi_num2 AS T1_C27,t_
> 2014-01-23 14:56:31 DEBUG: pid 613: wait_for_query_response: waiting for
> backend 0 completing the query
> 2014-01-23 14:56:31 DEBUG: pid 613: detect_error: kind: 1
> 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_one_backend: read kind
> from 0 th backend 1
> 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: kind: 1 from 0
> th backend
> 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: read kind from
> 0 th backend 1 NUM_BACKENDS: 2
> 2014-01-23 14:56:31 DEBUG: pid 613: ProcessBackendResponse: kind from
> backend: 1
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_add_sent_message: prepared
> statement "" already exists
> 2014-01-23 14:56:31 DEBUG: pid 613: can_query_context_destroy: query
> context 0x1b2be60 is still used. query: UPDATE t_work_flow SET company_no =
> $1  , action_code = $2  , work_status = $3  , totalization_data = $4  ,
> target_action_code = $5  , admin_user_no = $6  , confirm_user_no1 = $7  ,
> modify_date = $8  , modify_person_id = $9  , modify_ipaddress = $10  ,
> modify_user_agent = $11  , confirm_date1 = $12  WHERE work_flow_no = $13
> AND (del_flg <> $14  OR del_flg IS NULL)
> 2014-01-23 14:56:31 DEBUG: pid 613: can_query_context_destroy: query
> context 0x1b2be60 is still used. query: UPDATE t_work_flow SET company_no =
> $1  , action_code = $2  , work_status = $3  , totalization_data = $4  ,
> target_action_code = $5  , admin_user_no = $6  , confirm_user_no1 = $7  ,
> modify_date = $8  , modify_person_id = $9  , modify_ipaddress = $10  ,
> modify_user_agent = $11  , confirm_date1 = $12  WHERE work_flow_no = $13
> AND (del_flg <> $14  OR del_flg IS NULL)
> 2014-01-23 14:56:31 DEBUG: pid 613: can_query_context_destroy: query
> context 0x1b2be60 is still used for 2 times.
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_add_buffer: realloc old size:0 new
> size:8192
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_add_buffer: len:1, total:1
> bufsize:8192
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_add_buffer: len:4, total:5
> bufsize:8192
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_command_success: done
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_unset_query_in_progress: done
> 2014-01-23 14:56:31 DEBUG: pid 613: ProcessFrontendResponse: kind from
> frontend B(42)
> 2014-01-23 14:56:31 DEBUG: pid 613:
> pool_unset_doing_extended_query_message: done
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_doing_extended_query_message:
> done
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_query_in_progress: done
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_has_insertinto_or_locking_clause:
> returns 0
> 2014-01-23 14:56:31 DEBUG: pid 613: send_to_where: 2 query: SELECT
> t_work_flow.company_no AS T1_C1,t_work_flow.shop_no AS
> T1_C2,t_work_flow.work_flow_no AS T1_C3,t_work_flow.work_code AS
> T1_C4,t_work_flow.action_code AS T1_C5,t_work_flow.work_status AS
> T1_C6,t_work_flow.target_url AS T1_C7,t_work_flow.totalization_data AS
> T1_C8,t_work_flow.target_action_code AS T1_C9,t_work_flow.admin_user_no AS
> T1_C10,t_work_flow.request_user_no AS T1_C11,t_work_flow.confirm_user_no1
> AS T1_C12,t_work_flow.confirm_user_no2 AS
> T1_C13,t_work_flow.confirm_user_no3 AS T1_C14,t_work_flow.confirm_user_no4
> AS T1_C15,t_work_flow.confirm_user_no5 AS
> T1_C16,t_work_flow.confirm_user_no6 AS T1_C17,t_work_flow.confirm_user_no7
> AS T1_C18,t_work_flow.confirm_user_no8 AS
> T1_C19,t_work_flow.approve_user_no AS T1_C20,t_work_flow.yobi_string1 AS
> T1_C21,t_work_flow.yobi_string2 AS T1_C22,t_work_flow.yobi_string3 AS
> T1_C23,t_work_flow.yobi_string4 AS T1_C24,t_work_flow.yobi_string5 AS
> T1_C25,t_work_flow.yobi_num1 AS T1_C26,t_work_flow.yobi_num2 AS
> T1_C27,t_work_flow.yobi_num3 AS T1_C28,t_work_flow.yobi_num4 AS
> T1_C29,t_work_flow.yobi_num5 AS T1_C30,t_work_flow.yobi_time1 AS
> T1_C31,t_work_flow.yobi_time2 AS T1_C32,t_work_flow.yobi_time3 AS
> T1_C33,t_work_flow.yobi_time4 AS T1_C34,t_work_flow.yobi_time5 AS
> T1_C35,t_work_flow.del_flg AS T1_C36,t_work_flow.del_date AS
> T1_C37,t_work_flow.del_person_id AS T1_C38,t_work_flow.del_ipaddress AS
> T1_C39,t_work_flow.del_user_agent AS T1_C40,t_work_flow.add_date AS
> T1_C41,t_work_flow.add_person_id AS T1_C42,t_work_flow.add_ipaddress AS
> T1_C43,t_work_flow.add_user_agent AS T1_C44,t_work_flow.modify_date AS
> T1_C45,t_work_flow.modify_person_id AS T1_C46,t_work_flow.modify_ipaddress
> AS T1_C47,t_work_flow.modify_user_agent AS T1_C48,t_work_flow.request_date
> AS T1_C49,t_work_flow.confirm_date1 AS T1_C50,t_work_flow.confirm_date2 AS
> T1_C51,t_work_flow.confirm_date3 AS T1_C52,t_work_flow.confirm_date4 AS
> T1_C53,t_work_flow.confirm_date5 AS T1_C54,t_work_flow.confirm_date6 AS
> T1_C55,t_work_flow.confirm_date7 AS T1_C56,t_work_flow.confirm_date8 AS
> T1_C57,t_work_flow.approve_date AS T1_C58 FROM t_work_flow WHERE
> work_flow_no = $1  AND (t_work_flow.del_flg<> $2 OR t_work_flow.del_flg IS
> NULL)
> 2014-01-23 14:56:31 DEBUG: pid 613: Bind: waiting for master completing the
> query
> 2014-01-23 14:56:31 LOG:   pid 613: DB node id: 0 backend pid: 5317
> statement: B message
> 2014-01-23 14:56:31 DEBUG: pid 613: wait_for_query_response: waiting for
> backend 0 completing the query
> 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_one_backend: read kind
> from 0 th backend 2
> 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: kind: 2 from 0
> th backend
> 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: read kind from
> 0 th backend 2 NUM_BACKENDS: 2
> 2014-01-23 14:56:31 DEBUG: pid 613: ProcessBackendResponse: kind from
> backend: 2
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_add_sent_message: portal ""
> already exists
> 2014-01-23 14:56:31 DEBUG: pid 613: can_query_context_destroy: query
> context 0x1b2be60 is still used. query: UPDATE t_work_flow SET company_no =
> $1  , action_code = $2  , work_status = $3  , totalization_data = $4  ,
> target_action_code = $5  , admin_user_no = $6  , confirm_user_no1 = $7  ,
> modify_date = $8  , modify_person_id = $9  , modify_ipaddress = $10  ,
> modify_user_agent = $11  , confirm_date1 = $12  WHERE work_flow_no = $13
> AND (del_flg <> $14  OR del_flg IS NULL)
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_unset_query_in_progress: done
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_query_in_progress: done
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_add_buffer: len:1, total:6
> bufsize:8192
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_add_buffer: len:4, total:10
> bufsize:8192
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_command_success: done
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_unset_query_in_progress: done
> 2014-01-23 14:56:31 DEBUG: pid 613: ProcessFrontendResponse: kind from
> frontend D(44)
> 2014-01-23 14:56:31 DEBUG: pid 613:
> pool_unset_doing_extended_query_message: done
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_doing_extended_query_message:
> done
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_query_in_progress: done
> 2014-01-23 14:56:31 DEBUG: pid 613: Describe: waiting for master completing
> the query
> 2014-01-23 14:56:31 LOG:   pid 613: DB node id: 0 backend pid: 5317
> statement: D message
> 2014-01-23 14:56:31 DEBUG: pid 613: wait_for_query_response: waiting for
> backend 0 completing the query
> 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_one_backend: read kind
> from 0 th backend T
> 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: kind: T from 0
> th backend
> 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: read kind from
> 0 th backend T NUM_BACKENDS: 2
> 2014-01-23 14:56:31 DEBUG: pid 613: ProcessBackendResponse: kind from
> backend: T
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_add_buffer: len:1, total:11
> bufsize:8192
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_add_buffer: len:4, total:15
> bufsize:8192
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_add_buffer: len:1443, total:1458
> bufsize:8192
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_unset_query_in_progress: done
> 2014-01-23 14:56:31 DEBUG: pid 613: ProcessFrontendResponse: kind from
> frontend E(45)
> 2014-01-23 14:56:31 DEBUG: pid 613:
> pool_unset_doing_extended_query_message: done
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_doing_extended_query_message:
> done
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_query_in_progress: done
> 2014-01-23 14:56:31 DEBUG: pid 613: Execute: portal name <>
> 2014-01-23 14:56:31 DEBUG: pid 613: Execute: query string = <SELECT
> t_work_flow.company_no AS T1_C1,t_work_flow.shop_no AS
> T1_C2,t_work_flow.work_flow_no AS T1_C3,t_work_flow.work_code AS
> T1_C4,t_work_flow.action_code AS T1_C5,t_work_flow.work_status AS
> T1_C6,t_work_flow.target_url AS T1_C7,t_work_flow.totalization_data AS
> T1_C8,t_work_flow.target_action_code AS T1_C9,t_work_flow.admin_user_no AS
> T1_C10,t_work_flow.request_user_no AS T1_C11,t_work_flow.confirm_user_no1
> AS T1_C12,t_work_flow.confirm_user_no2 AS
> T1_C13,t_work_flow.confirm_user_no3 AS T1_C14,t_work_flow.confirm_user_no4
> AS T1_C15,t_work_flow.confirm_user_no5 AS
> T1_C16,t_work_flow.confirm_user_no6 AS T1_C17,t_work_flow.confirm_user_no7
> AS T1_C18,t_work_flow.confirm_user_no8 AS
> T1_C19,t_work_flow.approve_user_no AS T1_C20,t_work_flow.yobi_string1 AS
> T1_C21,t_work_flow.yobi_string2 AS T1_C22,t_work_flow.yobi_string3 AS
> T1_C23,t_work_flow.yobi_string4 AS T1_C24,t_work_flow.yobi_string5 AS
> T1_C25,t_work_flow.yobi_num1 AS T1_C26,t_work_flow.yobi_num2 AS
> T1_C27,t_work_flow.yobi_num3 AS T1_C28,t_work_flow.yobi_num4 AS
> T1_C29,t_work_flow.yobi_num5 AS T1_C30,t_work_flow.yobi_time1 AS
> T1_C31,t_work_flow.yobi_time2 AS T1_C32,t_work_flow.yobi_time3 AS
> T1_C33,t_work_flow.yobi_time4 AS T1_C34,t_work_flow.yobi_time5 AS
> T1_C35,t_work_flow.del_flg AS T1_C36,t_work_flow.del_date AS
> T1_C37,t_work_flow.del_person_id AS T1_C38,t_work_flow.del_ipaddress AS
> T1_C39,t_work_flow.del_user_agent AS T1_C40,t_work_flow.add_date AS
> T1_C41,t_work_flow.add_person_id AS T1_C42,t_work_flow.add_ipaddress AS
> T1_C43,t_work_flow.add_user_agent AS T1_C44,t_work_flow.modify_date AS
> T1_C45,t_work_flow.modify_person_id AS T1_C46,t_work_flow.modify_ipaddress
> AS T1_C47,t_work_flow.modify_user_agent AS T1_C48,t_work_flow.request_date
> AS T1_C49,t_work_flow.confirm_date1 AS T1_C50,t_work_flow.confirm_date2 AS
> T1_C51,t_work_flow.confirm_date3 AS T1_C52,t_work_flow.confirm_date4 AS
> T1_C53,t_work_flow.confirm_date5 AS T1_C54,t_work_flow.confirm_date6 AS
> T1_C55,t_work_flow.confirm_date7 AS T1_C56,t_work_flow.confirm_date8 AS
> T1_C57,t_work_flow.approve_date AS T1_C58 FROM t_work_flow WHERE
> work_flow_no = $1  AND (t_work_flow.del_flg<> $2 OR t_work_flow.del_flg IS
> NULL) >
> 2014-01-23 14:56:31 DEBUG: pid 613: encode_key: username xspuser
> 2014-01-23 14:56:31 DEBUG: pid 613: encode_key: database_name xspdb
> 2014-01-23 14:56:31 DEBUG: pid 613: encode_key: query SELECT
> t_work_flow.company_no AS T1_C1,t_work_flow.shop_no AS
> T1_C2,t_work_flow.work_flow_no AS T1_C3,t_work_flow.work_code AS
> T1_C4,t_work_flow.action_code AS T1_C5,t_work_flow.work_status AS
> T1_C6,t_work_flow.target_url AS T1_C7,t_work_flow.totalization_data AS
> T1_C8,t_work_flow.target_action_code AS T1_C9,t_work_flow.admin_user_no AS
> T1_C10,t_work_flow.request_user_no AS T1_C11,t_work_flow.confirm_user_no1
> AS T1_C12,t_work_flow.confirm_user_no2 AS
> T1_C13,t_work_flow.confirm_user_no3 AS T1_C14,t_work_flow.confirm_user_no4
> AS T1_C15,t_work_flow.confirm_user_no5 AS
> T1_C16,t_work_flow.confirm_user_no6 AS T1_C17,t_work_flow.confirm_user_no7
> AS T1_C18,t_work_flow.confirm_user_no8 AS
> T1_C19,t_work_flow.approve_user_no AS T1_C20,t_work_flow.yobi_string1 AS
> T1_C21,t_work_flow.yobi_string2 AS T1_C22,t_work_flow.yobi_string3 AS
> T1_C23,t_work_flow.yobi_string4 AS T1_C24,t_work_flow.yobi_string5 AS
> T1_C25,t_work_flow.yobi_num1 AS T1_C26,t_work_flow.yobi_num2 AS
> T1_C27,t_work_flow.yobi_num3 AS T1_C28,t_work_flow.yobi_num4 AS
> T1_C29,t_work_flow.yobi_num5 AS T1_C30,t_work_flow.yobi_time1 AS
> T1_C31,t_work_flow.yobi_time2 AS T1_C32,t_work_flow.yobi_time3 AS
> T1_C33,t_work_flow.yobi_time4 AS T1_C34,t_work_flow.yobi_time5 AS
> T1_C35,t_work_flow.del_flg AS T1_C36,t_work_flow.del_date AS
> T1_C37,t_work_flow.del_person_id AS T1_C38,t_work_flow.del_ipaddress AS
> T1_C39,t_work_flow.del_user_agent AS T1_C40,t_work_flow.add_date AS
> T1_C41,t_work_flow.add_person_id AS T1_C42,t_work_flow.add_ipaddress AS
> T1_C43,t_work_flow.add_user_agent AS T1_C44,t_work_flow.modify_date AS
> T1_C45,t_work_flow.modify_person_id AS T1_C46,t_work_flow.modify_ipaddress
> AS T1_C47,t_work_flow.modify_user_agent AS T1_C48,t_work_flow.request_date
> AS T1_C49,t_work_flow.confirm_date1 AS T1_C50,t_work_flow.confirm_date2 AS
> T1_C51,t_work_flow.confirm_date3 AS T1_C52,t_work_flow.confirm_date4 AS
> T1_C53,t_work_flow.confirm_date5 AS T1_C54,t_work_flow.confirm_date6 AS
> T1_C55,t_work_flow.confirm_date7 AS T1_C56,t_work_flow.confirm_date8 AS
> T1_C57,t_work_flow.approve_date AS T1_C58 FROM t_work_flow WHERE
> work_flow_no = $1  AND (t_work_flow.del_flg<> $2 OR t_work_flow.del_flg IS
> NULL)  0000000000020000000336333300000001310000
> 2014-01-23 14:56:31 DEBUG: pid 613: encode_key: `xspuserSELECT
> t_work_flow.company_no AS T1_C1,t_work_flow.shop_no AS
> T1_C2,t_work_flow.work_flow_no AS T1_C3,t_work_flow.work_code AS
> T1_C4,t_work_flow.action_code AS T1_C5,t_work_flow.work_status AS
> T1_C6,t_work_flow.target_url AS T1_C7,t_work_flow.totalization_data AS
> T1_C8,t_work_flow.target_action_code AS T1_C9,t_work_flow.admin_user_no AS
> T1_C10,t_work_flow.request_user_no AS T1_C11,t_work_flow.confirm_user_no1
> AS T1_C12,t_work_flow.confirm_user_no2 AS
> T1_C13,t_work_flow.confirm_user_no3 AS T1_C14,t_work_flow.confirm_user_no4
> AS T1_C15,t_work_flow.confirm_user_no5 AS
> T1_C16,t_work_flow.confirm_user_no6 AS T1_C17,t_work_flow.confirm_user_no7
> AS T1_C18,t_work_flow.confirm_user_no8 AS
> T1_C19,t_work_flow.approve_user_no AS T1_C20,t_work_flow.yobi_string1 AS
> T1_C21,t_work_flow.yobi_string2 AS T1_C22,t_work_flow.yobi_string3 AS
> T1_C23,t_work_flow.yobi_string4 AS T1_C24,t_work_flow.yobi_string5 AS
> T1_C25,t_work_flow.yobi_num1 AS T1_C26,t_work_flow.yobi_num2 AS
> T1_C27,t_work_flow.yobi_num3 AS T1_C28,t_work_flow.yobi_num4 AS
> T1_C29,t_work_flow.yobi_num5 AS T1_C30,t_work_flow.yobi_time1 AS
> T1_C31,t_work_flow.yobi_time2 AS T1_C32,t_work_flow.yobi_time3 AS
> T1_C33,t_work_flow.yobi_time4 AS T1_C34,t_work_flow.yobi_time5 AS
> T1_C35,t_work_flow.del_flg AS T1_C36,t_work_flow.del_date AS
> T1_C37,t_work_flow.del_person_id AS T1_C38,t_work_flow.del_ipaddress AS
> T1_C39,t_work_flow.del_user_agent AS T1_C40,t_work_flow.add_date AS
> T1_C41,t_work_flow.add_person_id AS T1_C42,t_work_flow.add_ipaddress AS
> T1_C43,t_work_flow.add_user_agent AS T1_C44,t_work_flow.modify_date AS
> T1_C45,t_work_flow.modify_person_id AS T1_C46,t_work_flow.modify_ipaddress
> AS T1_C47,t_work_flow.modify_user_agent AS T1_C48,t_work_flow.request_date
> AS T1_C49,t_work_flow.confirm_date1 AS T1_C50,t_work_flow.confirm_date2 AS
> T1_C51,t_work_flow.confirm_date3 AS T1_C52,t_work_flow.confirm_date4 AS
> T1_C53,t_work_flow.confirm_date5 AS T1_C54,t_work_flow.confirm_date6 AS
> T1_C55,t_work_flow.confirm_date7 AS T1_C56,t_work_flow.confirm_date8 AS
> T1_C57,t_work_flow.approve_date AS T1_C58 FROM t_work_flow WHERE
> work_flow_no = $1  AND (t_work_flow.del_flg<> $2 OR t_work_flow.del_flg IS
> NULL)  0000000000020000000336333300000001310000xspdb' ->
> `e5455205c36a11c2249b964547032887'
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_fetch_cache: search key
> ==e5455205c36a11c2249b964547032887==
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_fetch_cache: query=SELECT
> t_work_flow.company_no AS T1_C1,t_work_flow.shop_no AS
> T1_C2,t_work_flow.work_flow_no AS T1_C3,t_work_flow.work_code AS
> T1_C4,t_work_flow.action_code AS T1_C5,t_work_flow.work_status AS
> T1_C6,t_work_flow.target_url AS T1_C7,t_work_flow.totalization_data AS
> T1_C8,t_work_flow.target_action_code AS T1_C9,t_work_flow.admin_user_no AS
> T1_C10,t_work_flow.request_user_no AS T1_C11,t_work_flow.confirm_user_no1
> AS T1_C12,t_work_flow.confirm_user_no2 AS
> T1_C13,t_work_flow.confirm_user_no3 AS T1_C14,t_work_flow.confirm_user_no4
> AS T1_C15,t_work_flow.confirm_user_no5 AS
> T1_C16,t_work_flow.confirm_user_no6 AS T1_C17,t_work_flow.confirm_user_no7
> AS T1_C18,t_work_flow.confirm_user_no8 AS
> T1_C19,t_work_flow.approve_user_no AS T1_C20,t_work_flow.yobi_string1 AS
> T1_C21,t_work_flow.yobi_string2 AS T1_C22,t_work_flow.yobi_string3 AS
> T1_C23,t_work_flow.yobi_string4 AS T1_C24,t_work_flow.yobi_string5 AS
> T1_C25,t_work_flow.yobi_num1 AS T1_C26,t_work_flow.yobi_num2 AS
> T1_C27,t_work_flow.yobi_num3 AS T1_C28,t_work_flow.yobi_num4 AS
> T1_C29,t_work_flow.yobi_num5 AS T1_C30,t_work_flow.yobi_time1 AS
> T1_C31,t_work_flow.yobi_time2 AS T1_C32,t_work_flow.yobi_time3 AS
> T1_C33,t_work_flow.yobi_time4 AS T1_C34,t_work_flow.yobi_time5 AS
> T1_C35,t_work_flow.del_flg AS T1_C36,t_work_flow.del_date AS
> T1_C37,t_work_flow.del_person_id AS T1_C38,t_work_flow.del_ipaddress AS
> T1_C39,t_work_flow.del_user_agent AS T1_C40,t_work_flow.add_date AS
> T1_C41,t_work_flow.add_person_id AS T1_C42,t_work_flow.add_ipaddress AS
> T1_C43,t_work_flow.add_user_agent AS T1_C44,t_work_flow.modify_date AS
> T1_C45,t_work_flow.modify_person_id AS T1_C46,t_work_flow.modify_ipaddress
> AS T1_C47,t_work_flow.modify_user_agent AS T1_C48,t_work_flow.request_date
> AS T1_C49,t_work_flow.confirm_date1 AS T1_C50,t_work_flow.confirm_date2 AS
> T1_C51,t_work_flow.confirm_date3 AS T1_C52,t_work_flow.confirm_date4 AS
> T1_C53,t_work_flow.confirm_date5 AS T1_C54,t_work_flow.confirm_date6 AS
> T1_C55,t_work_flow.confirm_date7 AS T1_C56,t_work_flow.confirm_date8 AS
> T1_C57,t_work_flow.approve_date AS T1_C58 FROM t_work_flow WHERE
> work_flow_no = $1  AND (t_work_flow.del_flg<> $2 OR t_work_flow.del_flg IS
> NULL)  0000000000020000000336333300000001310000 len:2175
> 2014-01-23 14:56:31 DEBUG: pid 613: send_cached_messages: D len: 702
> 2014-01-23 14:56:31 DEBUG: pid 613: send_message: kind=D, len=702,
> data=0x1da6077
> 2014-01-23 14:56:31 DEBUG: pid 613: send_cached_messages: C len: 13
> 2014-01-23 14:56:31 DEBUG: pid 613: send_message: kind=C, len=13,
> data=0x1da6336
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_fetch_from_memory_cache: expecting
> sync: S
> 2014-01-23 14:56:31 DEBUG: pid 613: send_message: kind=Z, len=5,
> data=0x7fff8e381bff
> 2014-01-23 14:56:31 LOG:   pid 613: query result fetched from cache.
> statement: SELECT t_work_flow.company_no AS T1_C1,t_work_flow.shop_no AS
> T1_C2,t_work_flow.work_flow_no AS T1_C3,t_work_flow.work_code AS
> T1_C4,t_work_flow.action_code AS T1_C5,t_work_flow.work_status AS
> T1_C6,t_work_flow.target_url AS T1_C7,t_work_flow.totalization_data AS
> T1_C8,t_work_flow.target_action_code AS T1_C9,t_work_flow.admin_user_no AS
> T1_C10,t_work_flow.request_user_no AS T1_C11,t_work_flow.confirm_user_no1
> AS T1_C12,t_work_flow.confirm_user_no2 AS
> T1_C13,t_work_flow.confirm_user_no3 AS T1_C14,t_work_flow.confirm_user_no4
> AS T1_C15,t_work_flow.confirm_user_no5 AS
> T1_C16,t_work_flow.confirm_user_no6 AS T1_C17,t_work_flow.confirm_user_no7
> AS T1_C18,t_work_flow.confirm_user_no8 AS
> T1_C19,t_work_flow.approve_user_no AS T1_C20,t_work_flow.yobi_string1 AS
> T1_C21,t_work_flow.yobi_string2 AS T1_C22,t_work_flow.yobi_string3 AS
> T1_C23,t_work_flow.yobi_string4 AS T1_C24,t_work_flow.yobi_string5 AS
> T1_C25,t_work_flow.yobi_num1 AS T1_C26,t_work_flow.yobi_num2 AS
> T1_C27,t_work_flow.yobi_num3 AS T1_C28,t_work_flow.yobi_num4 AS
> T1_C29,t_work_flow.yobi_num5 AS T1_C30,t_work_flow.yobi_time1 AS
> T1_C31,t_work_flow.yobi_time2 AS T1_C32,t_work_flow.yobi_time3 AS
> T1_C33,t_work_flow.yobi_time4 AS T1_C34,t_work_flow.yobi_time5 AS
> T1_C35,t_work_flow.del_flg AS T1_C36,t_work_flow.del_date AS
> T1_C37,t_work_flow.del_person_id AS T1_C38,t_work_flow.del_ipaddress AS
> T1_C39,t_work_flow.del_user_agent AS T1_C40,t_work_flow.add_date AS
> T1_C41,t_work_flow.add_person_id AS T1_C42,t_work_flow.add_ipaddress AS
> T1_C43,t_work_flow.add_user_agent AS T1_C44,t_work_flow.modify_date AS
> T1_C45,t_work_flow.modify_person_id AS T1_C46,t_work_flow.modify_ipaddress
> AS T1_C47,t_work_flow.modify_user_agent AS T1_C48,t_work_flow.request_date
> AS T1_C49,t_work_flow.confirm_date1 AS T1_C50,t_work_flow.confirm_date2 AS
> T1_C51,t_work_flow.confirm_date3 AS T1_C52,t_work_flow.confirm_date4 AS
> T1_C53,t_work_flow.confirm_date5 AS T1_C54,t_work_flow.confirm_date6 AS
> T1_C55,t_work_flow.confirm_date7 AS T1_C56,t_work_flow.confirm_date8 AS
> T1_C57,t_work_flow.approve_date AS T1_C58 FROM t_work_flow WHERE
> work_flow_no = $1  AND (t_work_flow.del_flg<> $2 OR t_work_flow.del_flg IS
> NULL)  0000000000020000000336333300000001310000
> 2014-01-23 14:56:31 DEBUG: pid 613: pool_fetch_from_memory_cache: a query
> result found in the query cache, SELECT t_work_flow.company_no AS
> T1_C1,t_work_flow.shop_no AS T1_C2,t_work_flow.work_flow_no AS
> T1_C3,t_work_flow.work_code AS T1_C4,t_work_flow.action_code AS
> T1_C5,t_work_flow.work_status AS T1_C6,t_work_flow.target_url AS
> T1_C7,t_work_flow.totalization_data AS T1_C8,t_work_flow.target_action_code
> AS T1_C9,t_work_flow.admin_user_no AS T1_C10,t_work_flow.request_user_no AS
> T1_C11,t_work_flow.confirm_user_no1 AS T1_C12,t_work_flow.confirm_user_no2
> AS T1_C13,t_work_flow.confirm_user_no3 AS
> T1_C14,t_work_flow.confirm_user_no4 AS T1_C15,t_work_flow.confirm_user_no5
> AS T1_C16,t_work_flow.confirm_user_no6 AS
> T1_C17,t_work_flow.confirm_user_no7 AS T1_C18,t_work_flow.confirm_user_no8
> AS T1_C19,t_work_flow.approve_user_no AS T1_C20,t_work_flow.yobi_string1 AS
> T1_C21,t_work_flow.yobi_string2 AS T1_C22,t_work_flow.yobi_string3 AS
> T1_C23,t_work_flow.yobi_string4 AS T1_C24,t_work_flow.yobi_string5 AS
> T1_C25,t_work_flow.yobi_num1 AS T1_C26,t_work_flow.yobi_num2 AS
> T1_C27,t_work_flow.yobi_num3 AS T1_C28,t_work_flow.yobi_num4 AS
> T1_C29,t_work_flow.yobi_num5 AS T1_C30,t_work_flow.yobi_time1 AS
> T1_C31,t_work_flow.yobi_time2 AS T1_C32,t_work_flow.yobi_time3 AS
> T1_C33,t_work_flow.yobi_time4 AS T1_C34,t_work_flow.yobi_time5 AS
> T1_C35,t_work_flow.del_flg AS T1_C36,t_work_flow.del_date AS
> T1_C37,t_work_flow.del_person_id AS T1_C38,t_work_flow.del_ipaddress AS
> T1_C39,t_work_flow.del_user_agent AS T1_C40,t_work_flow.add_date AS
> T1_C41,t_work_flow.add_person_id AS T1_C42,t_work_flow.add_ipaddress AS
> T1_C43,t_work_flow.add_user_agent AS T1_C44,t_work_flow.modify_date AS
> T1_C45,t_work_flow.modify_person_id AS T1_C46,t_work_flow.modify_ipaddress
> AS T1_C47,t_work_flow.modify_user_agent AS T1_C48,t_work_flow.request_date
> AS T1_C49,t_work_flow.confirm_date1 AS T1_C50,t_work_flow.confirm_date2 AS
> T1_C51,t_work_flow.confirm_date3 AS T1_C52,t_work_flow.confirm_date4 AS
> T1_C53,t_work_flow.confirm_date5 AS T1_C54,t_work_flow.confirm_date6 AS
> T1_C55,t_work_flow.confirm_date7 AS T1_C56,t_work_flow.confirm_date8 AS
> T1_C57,t_work_flow.approve_date AS T1_C58 FROM t_work_flow WHERE
> work_flow_no = $1  AND (t_work_flow.del_flg<> $2 OR t_work_flow.del_flg IS
> NULL)  0000000000020000000336333300000001310000
> 
> $B0J>e$K$J$j$^$9!#(B
> $B$h$m$7$/$*4j$$$$$?$7$^$9!#(B
> 
> 
> 2014/1/23 Tatsuo Ishii <ishii @ sraoss.co.jp>
> 
>> $B$3$s$P$s$O!#@P0f$G$9!#(B
>>
>> pgpool.conf$B$r8+$;$F$$$?$@$1$^$9$+!)(B
>>
>> $B$"$H!"%m%0$N3F9T$,ESCf$G @ Z$l$F$$$k$h$&$G$9$,!"40A4$J$b$N$r8+$;$F$$$?$@(B
>> $B$1$^$9$+!)(B
>> --
>> Tatsuo Ishii
>> SRA OSS, Inc. Japan
>> English: http://www.sraoss.co.jp/index_en.php
>> Japanese: http://www.sraoss.co.jp
>>
>> > $B$*@$OC$K$J$C$F$*$j$^$9!#:4F#$H?=$7$^$9!#(B
>> >
>> > pgpool3.3.2$B$N%*%s%a%b%j%/%(%j%-%c%C%7%e$K$D$$$F$N<ALd$G$9!#(B
>> > $B%/%(%j%-%c%C%7%eM-8z$+L58z$+$G(BSELECT$B7k2L$,0c$C$F$7$^$&$H$$$&LdBj$,=P$F$*$j$^$9!#(B
>> >
>> > SELECT$B!"(BUPDATE$B!"(BSELECT$B$N=g$K%"%W%j%1!<%7%g%s$NCf$G<B9T$7$F$$$^$9!#(B
>> > $B:G8e$N(BSELECT$B$G$O!"(BUPDATE$B8e$N7k2L$,JV$k$N$, @ 5$7$$$N$G$9$,!"(B
>> > $B%/%(%j%-%c%C%7%eM-8z$K$7$?>l9g0J2<$N$h$&$JF0$-$K$J$j!"(B
>> > $B-!$H-#$GF1$87k2L$,JV$C$F$-$F$7$^$C$F$$$^$9!#(B
>> >
>> > $B-!(B SELECT $B!&!&!&%-%c%C%7%e:n @ .(B
>> > $B-"(B UPDATE $B!&!&!&%-%c%C%7%e$,$J$<$+:o=|$5$l$J$$(B
>> > $B-#(B SELECT $B!&!&!&%-%c%C%7%e$+$i7k2L$,JV$C$F$7$^$&(B
>> > $B-$(B COMMIT
>> >
>> >
>> > $B0J2<$N$$$:$l$N>l9g$O!"@5>o$J7k2L$,JV$C$F$-$^$9!#(B
>> >   $B%/%(%j%-%c%C%7%e$rL58z$K$7$?>l9g(B
>> >   psql$B$+$i@\B3$7$F(BSQL$B$rN.$7$?>l9g(B
>> >   /*NO QUERY CACHE*/$B!W%3%a%s%H$rIU$1$?>l9g(B
>> >
>> >
>> > pgpool$B$N;EMM>e$N@)Ls$K0z$C$+$+$C$F$$$k$+IT6q9g$@$H;W$$$^$9!#(B
>> > $B2?$+$7$i$N>pJs$rD:$1$^$9$H9,$$$G$9!#(B
>> > $BLdBjH/@8$7$?:]$N(Bpgpool$B$N%m%0$rKvHx$K$D$1$^$7$?$,!"(BUPDATE$B8e$K%-%c%C%7%e$,:o=|$5$l$F$$$J$$$N$,5$$K$J$j$^$9!#(B
>> >
>> >
>> > $B0J2<$K3F<o>pJs$r5-:\$5$;$FD:$-$^$9!#(B
>> >
>> > [$B3F<o4D6-(B]
>> > pgpool-II 3.3.2
>> > PostgreSQL 9.2.4
>> > Web$B%5!<%P!<(B Apache 2.2.23
>> > Tomcat Version 7.0.29
>> > JDBC$B%I%i%$%P!<(B postgresql-9.1-902.jdbc4.jar
>> > Java 1.7.0_05-b06
>> >
>> > [pgpool$B%G%P%C%/%m%0(B]
>> >
>> ----------------------------------------------------------------------------------------------------------------------------------
>> > 2014-01-23 14:56:31 DEBUG: pid 613: send_to_where: 0 query:  UPDATE
>> > t_work_flow SET company_no = $1  , action_code = $2  , work_st
>> > 2014-01-23 14:56:31 DEBUG: pid 613: Parse: waiting for master
>> > completing the query
>> > 2014-01-23 14:56:31 LOG:   pid 613: DB node id: 0 backend pid: 5317
>> > statement: Parse:  UPDATE t_work_flow SET company_no = $1  , a
>> > 2014-01-23 14:56:31 DEBUG: pid 613: wait_for_query_response: waiting
>> > for backend 0 completing the query
>> > 2014-01-23 14:56:31 DEBUG: pid 613: detect_error: kind: 1
>> > 2014-01-23 14:56:31 DEBUG: pid 613:
>> pool_unset_skip_reading_from_backends: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_one_backend: read
>> > kind from 0 th backend 1
>> > 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: kind: 1
>> > from 0 th backend
>> > 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: read kind
>> > from 0 th backend 1 NUM_BACKENDS: 2
>> > 2014-01-23 14:56:31 DEBUG: pid 613: ProcessBackendResponse: kind from
>> backend: 1
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_add_sent_message: prepared
>> > statement "" already exists
>> > 2014-01-23 14:56:31 DEBUG: pid 613: can_query_context_destroy: query
>> > context 0x1d4c1e0 is still used. query: SELECT t_work_flow.co
>> > 2014-01-23 14:56:31 DEBUG: pid 613: can_query_context_destroy: query
>> > context 0x1d4c1e0 is still used. query: SELECT t_work_flow.co
>> > 2014-01-23 14:56:31 DEBUG: pid 613: can_query_context_destroy: query
>> > context 0x1d4c1e0 is still used for 2 times.
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_command_success: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_unset_query_in_progress: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: ProcessFrontendResponse: kind from
>> > frontend B(42)
>> > 2014-01-23 14:56:31 DEBUG: pid 613:
>> > pool_unset_doing_extended_query_message: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613:
>> pool_set_doing_extended_query_message: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_query_in_progress: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: Bind: waiting for master
>> > completing the query
>> > 2014-01-23 14:56:31 LOG:   pid 613: DB node id: 0 backend pid: 5317
>> > statement: B message
>> > 2014-01-23 14:56:31 DEBUG: pid 613: wait_for_query_response: waiting
>> > for backend 0 completing the query
>> > 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_one_backend: read
>> > kind from 0 th backend 2
>> > 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: kind: 2
>> > from 0 th backend
>> > 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: read kind
>> > from 0 th backend 2 NUM_BACKENDS: 2
>> > 2014-01-23 14:56:31 DEBUG: pid 613: ProcessBackendResponse: kind from
>> backend: 2
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_add_sent_message: portal ""
>> > already exists
>> > 2014-01-23 14:56:31 DEBUG: pid 613: can_query_context_destroy: query
>> > context 0x1d4c1e0 is still used. query: SELECT t_work_flow.co
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_unset_query_in_progress: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_query_in_progress: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_command_success: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_unset_query_in_progress: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: ProcessFrontendResponse: kind from
>> > frontend D(44)
>> > 2014-01-23 14:56:31 DEBUG: pid 613:
>> > pool_unset_doing_extended_query_message: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613:
>> pool_set_doing_extended_query_message: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_query_in_progress: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: Describe: waiting for master
>> > completing the query
>> > 2014-01-23 14:56:31 LOG:   pid 613: DB node id: 0 backend pid: 5317
>> > statement: D message
>> > 2014-01-23 14:56:31 DEBUG: pid 613: wait_for_query_response: waiting
>> > for backend 0 completing the query
>> > 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_one_backend: read
>> > kind from 0 th backend n
>> > 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: kind: n
>> > from 0 th backend
>> > 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: read kind
>> > from 0 th backend n NUM_BACKENDS: 2
>> > 2014-01-23 14:56:31 DEBUG: pid 613: ProcessBackendResponse: kind from
>> backend: n
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_unset_query_in_progress: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: ProcessFrontendResponse: kind from
>> > frontend E(45)
>> > 2014-01-23 14:56:31 DEBUG: pid 613:
>> > pool_unset_doing_extended_query_message: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613:
>> pool_set_doing_extended_query_message: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_query_in_progress: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: Execute: portal name <>
>> > 2014-01-23 14:56:31 DEBUG: pid 613: Execute: query string = < UPDATE
>> > t_work_flow SET company_no = $1  , action_code = $2  , work_s
>> > 2014-01-23 14:56:31 LOG:   pid 613: DB node id: 0 backend pid: 5317
>> > statement: Execute:  UPDATE t_work_flow SET company_no = $1  ,
>> > 2014-01-23 14:56:31 DEBUG: pid 613: wait_for_query_response: waiting
>> > for backend 0 completing the query
>> > 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_one_backend: read
>> > kind from 0 th backend C
>> > 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: kind: C
>> > from 0 th backend
>> > 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: read kind
>> > from 0 th backend C NUM_BACKENDS: 2
>> > 2014-01-23 14:56:31 DEBUG: pid 613: ProcessBackendResponse: kind from
>> backend: C
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_command_success: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_unset_query_in_progress: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: ProcessFrontendResponse: kind from
>> > frontend S(53)
>> > 2014-01-23 14:56:31 DEBUG: pid 613:
>> > pool_unset_doing_extended_query_message: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613:
>> pool_set_doing_extended_query_message: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_query_in_progress: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_one_backend: read
>> > kind from 0 th backend Z
>> > 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: kind: Z
>> > from 0 th backend
>> > 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: read kind
>> > from 0 th backend Z NUM_BACKENDS: 2
>> > 2014-01-23 14:56:31 DEBUG: pid 613: ProcessBackendResponse: kind from
>> backend: Z
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_read_message_length: slot: 0
>> length: 5
>> > 2014-01-23 14:56:31 DEBUG: pid 613: ReadyForQuery: transaction state:T
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_writing_transaction: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_unset_query_in_progress: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: ProcessBackendResponse: Ready For
>> Query
>> > 2014-01-23 14:56:31 DEBUG: pid 613: ProcessFrontendResponse: kind from
>> > frontend P(50)
>> > 2014-01-23 14:56:31 DEBUG: pid 613:
>> > pool_unset_doing_extended_query_message: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613:
>> pool_set_doing_extended_query_message: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_query_in_progress: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: Parse: statement name <>
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_query_in_progress: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613:
>> > pool_has_insertinto_or_locking_clause: returns 0
>> > 2014-01-23 14:56:31 DEBUG: pid 613:
>> pool_has_non_immutable_function_call: 0
>> > 2014-01-23 14:56:31 DEBUG: pid 613: temp_table_walker: relname:
>> t_work_flow
>> > 2014-01-23 14:56:31 DEBUG: pid 613: system_catalog_walker: relname:
>> t_work_flow
>> > 2014-01-23 14:56:31 DEBUG: pid 613: make_table_name_from_rangevar:
>> > tablename:t_work_flow
>> > 2014-01-23 14:56:31 DEBUG: pid 613: view_walker: relname: t_work_flow
>> > 2014-01-23 14:56:31 DEBUG: pid 613: make_table_name_from_rangevar:
>> > tablename:t_work_flow
>> > 2014-01-23 14:56:31 DEBUG: pid 613: unlogged_table_walker: relname:
>> t_work_flow
>> > 2014-01-23 14:56:31 DEBUG: pid 613:
>> > pool_has_insertinto_or_locking_clause: returns 0
>> > 2014-01-23 14:56:31 DEBUG: pid 613: send_to_where: 2 query: SELECT
>> > t_work_flow.company_no AS T1_C1,t_work_flow.shop_no AS T1_C2,t_
>> > 2014-01-23 14:56:31 DEBUG: pid 613: Parse: waiting for master
>> > completing the query
>> > 2014-01-23 14:56:31 LOG:   pid 613: DB node id: 0 backend pid: 5317
>> > statement: Parse: SELECT t_work_flow.company_no AS T1_C1,t_wor
>> > 2014-01-23 14:56:31 DEBUG: pid 613: wait_for_query_response: waiting
>> > for backend 0 completing the query
>> > 2014-01-23 14:56:31 DEBUG: pid 613: detect_error: kind: 1
>> > 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_one_backend: read
>> > kind from 0 th backend 1
>> > 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: kind: 1
>> > from 0 th backend
>> > 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: read kind
>> > from 0 th backend 1 NUM_BACKENDS: 2
>> > 2014-01-23 14:56:31 DEBUG: pid 613: ProcessBackendResponse: kind from
>> backend: 1
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_add_sent_message: prepared
>> > statement "" already exists
>> > 2014-01-23 14:56:31 DEBUG: pid 613: can_query_context_destroy: query
>> > context 0x1b2be60 is still used. query: UPDATE t_work_flow SE
>> > 2014-01-23 14:56:31 DEBUG: pid 613: can_query_context_destroy: query
>> > context 0x1b2be60 is still used. query: UPDATE t_work_flow SE
>> > 2014-01-23 14:56:31 DEBUG: pid 613: can_query_context_destroy: query
>> > context 0x1b2be60 is still used for 2 times.
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_add_buffer: realloc old
>> > size:0 new size:8192
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_add_buffer: len:1, total:1
>> bufsize:8192
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_add_buffer: len:4, total:5
>> bufsize:8192
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_command_success: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_unset_query_in_progress: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: ProcessFrontendResponse: kind from
>> > frontend B(42)
>> > 2014-01-23 14:56:31 DEBUG: pid 613:
>> > pool_unset_doing_extended_query_message: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613:
>> pool_set_doing_extended_query_message: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_query_in_progress: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613:
>> > pool_has_insertinto_or_locking_clause: returns 0
>> > 2014-01-23 14:56:31 DEBUG: pid 613: send_to_where: 2 query: SELECT
>> > t_work_flow.company_no AS T1_C1,t_work_flow.shop_no AS T1_C2,t_
>> > 2014-01-23 14:56:31 DEBUG: pid 613: Bind: waiting for master
>> > completing the query
>> > 2014-01-23 14:56:31 LOG:   pid 613: DB node id: 0 backend pid: 5317
>> > statement: B message
>> > 2014-01-23 14:56:31 DEBUG: pid 613: wait_for_query_response: waiting
>> > for backend 0 completing the query
>> > 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_one_backend: read
>> > kind from 0 th backend 2
>> > 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: kind: 2
>> > from 0 th backend
>> > 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: read kind
>> > from 0 th backend 2 NUM_BACKENDS: 2
>> > 2014-01-23 14:56:31 DEBUG: pid 613: ProcessBackendResponse: kind from
>> backend: 2
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_add_sent_message: portal ""
>> > already exists
>> > 2014-01-23 14:56:31 DEBUG: pid 613: can_query_context_destroy: query
>> > context 0x1b2be60 is still used. query: UPDATE t_work_flow SE
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_unset_query_in_progress: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_query_in_progress: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_add_buffer: len:1, total:6
>> bufsize:8192
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_add_buffer: len:4, total:10
>> > bufsize:8192
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_command_success: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_unset_query_in_progress: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: ProcessFrontendResponse: kind from
>> > frontend D(44)
>> > 2014-01-23 14:56:31 DEBUG: pid 613:
>> > pool_unset_doing_extended_query_message: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613:
>> pool_set_doing_extended_query_message: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_query_in_progress: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: Describe: waiting for master
>> > completing the query
>> > 2014-01-23 14:56:31 LOG:   pid 613: DB node id: 0 backend pid: 5317
>> > statement: D message
>> > 2014-01-23 14:56:31 DEBUG: pid 613: wait_for_query_response: waiting
>> > for backend 0 completing the query
>> > 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_one_backend: read
>> > kind from 0 th backend T
>> > 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: kind: T
>> > from 0 th backend
>> > 2014-01-23 14:56:31 DEBUG: pid 613: read_kind_from_backend: read kind
>> > from 0 th backend T NUM_BACKENDS: 2
>> > 2014-01-23 14:56:31 DEBUG: pid 613: ProcessBackendResponse: kind from
>> backend: T
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_add_buffer: len:1, total:11
>> > bufsize:8192
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_add_buffer: len:4, total:15
>> > bufsize:8192
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_add_buffer: len:1443,
>> > total:1458 bufsize:8192
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_unset_query_in_progress: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: ProcessFrontendResponse: kind from
>> > frontend E(45)
>> > 2014-01-23 14:56:31 DEBUG: pid 613:
>> > pool_unset_doing_extended_query_message: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613:
>> pool_set_doing_extended_query_message: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_set_query_in_progress: done
>> > 2014-01-23 14:56:31 DEBUG: pid 613: Execute: portal name <>
>> > 2014-01-23 14:56:31 DEBUG: pid 613: Execute: query string = SELECT
>> > t_work_flow.company_no AS T1_C1,t_work_flow.shop_no AS T1_C2,t
>> > 2014-01-23 14:56:31 DEBUG: pid 613: encode_key: username xspuser
>> > 2014-01-23 14:56:31 DEBUG: pid 613: encode_key: database_name xspdb
>> > 2014-01-23 14:56:31 DEBUG: pid 613: encode_key: query SELECT
>> > t_work_flow.company_no AS T1_C1,t_work_flow.shop_no AS T1_C2,t_work_f
>> > 2014-01-23 14:56:31 DEBUG: pid 613: encode_key: `xspuserSELECT
>> > t_work_flow.company_no AS T1_C1,t_work_flow.shop_no AS T1_C2,t_work
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_fetch_cache: search key
>> > ==e5455205c36a11c2249b964547032887==
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_fetch_cache: query=SELECT
>> > t_work_flow.company_no AS T1_C1,t_work_flow.shop_no AS T1_C2,t_
>> > 2014-01-23 14:56:31 DEBUG: pid 613: send_cached_messages: D len: 702
>> > 2014-01-23 14:56:31 DEBUG: pid 613: send_message: kind=D, len=702,
>> > data=0x1da6077
>> > 2014-01-23 14:56:31 DEBUG: pid 613: send_cached_messages: C len: 13
>> > 2014-01-23 14:56:31 DEBUG: pid 613: send_message: kind=C, len=13,
>> data=0x1da6336
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_fetch_from_memory_cache:
>> > expecting sync: S
>> > 2014-01-23 14:56:31 DEBUG: pid 613: send_message: kind=Z, len=5,
>> > data=0x7fff8e381bff
>> > 2014-01-23 14:56:31 LOG:   pid 613: query result fetched from cache.
>> > statement: SELECT t_work_flow.company_no AS T1_C1,t_work_flow
>> > 2014-01-23 14:56:31 DEBUG: pid 613: pool_fetch_from_memory_cache: a
>> > query result found in the query cache, SELECT t_work_flow.comp
>> >
>> ----------------------------------------------------------------------------------------------------------------------------------
>> >
>> > $B$h$m$7$/$*4j$$$$$?$7$^$9!#(B
>> >
>> > --
>> > $B!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=(B
>> > $B:4F#(B $B?5(B
>> > $B3t<02q<R%(%k%F%C%/%9(B
>> > $B%7%9%F%`%^%M!<%8%a%s%H%5!<%S%9It(B
>> > $B")(B240-0005 $B2#IM;TJ]EZ%vC+6h?@8MD.(B134
>> > $B2#IM%S%8%M%9%Q!<%/(B $B%$!<%9%H%?%o!<(B14$B3,(B
>> > $BEEOC!'(B045-332-7865 Fax$B!'(B045-332-6644
>> > URL $B!'(Bhttp://www.eltex.co.jp/
>> > facebook$B!'(Bhttp://www.facebook.com/ELTEXinc
>> > $B!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=(B(c)ELTEX, Inc.
>>
> 
> 
> 
> -- 
> $B!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=(B
> $B:4F#(B $B?5(B
> $B3t<02q<R%(%k%F%C%/%9(B
> $B%7%9%F%`%^%M!<%8%a%s%H%5!<%S%9It(B
> $B")(B240-0005 $B2#IM;TJ]EZ%vC+6h?@8MD.(B134
> $B2#IM%S%8%M%9%Q!<%/(B $B%$!<%9%H%?%o!<(B14$B3,(B
> $BEEOC!'(B045-332-7865 Fax$B!'(B045-332-6644
> URL $B!'(Bhttp://www.eltex.co.jp/
> facebook$B!'(Bhttp://www.facebook.com/ELTEXinc
> $B!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=!=(B(c)ELTEX, Inc.
-------------- next part --------------
$B%F%-%9%H7A<00J30$NE:IU%U%!%$%k$rJ]4I$7$^$7$?(B...
$B%U%!%$%kL>(B: pool_proto_modules.patch
$B7?(B:         text/x-patch
$B%5%$%:(B:     597 $B%P%$%H(B
$B @ bL@(B:       $BL5$7(B
URL:        <http://www.sraoss.jp/pipermail/pgpool-general-jp/attachments/20140125/6214286b/attachment-0001.bin>


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