Thread: JDBC executeBatch() hangs without error

JDBC executeBatch() hangs without error

From

vinay_s

Date:

26 September 2013, 13:17:37

Postgres Version Used : 9.1.9 - 64 bit
JDBC Driver used : PostgreSQL 9.2 JDBC4 (build 1003)
JDK used : 1.6u45 - 64 bit
OS: Windows 7 - 64 bit

I have simple insert query using which I'm trying to import around 20,000
rows by splitting them into 10 batches of 2000 each

insert into Datapool (datapool_id,fk_template_column,fk_branch,value)
values(?,?,?,?)

is the JDBC prepared statement.

Every 2000 rows, I add as a batch using

stmt.addBatch();

and and then call

stmt.executeBatch();

Program hangs at executeBatch() indefinitely and does not terminate.

To debug further,
- I took the source for the JDBC Driver
- Enabled log_statement ='all' in postgresql.conf(restarted the service of
course)
- Appended ?loglevel=2 in the JDBC Connection URL

I execute the program and saw that the executeBatch of 2000 entries just
halts after 254 insert queries are bound.


Output from the postgres log shows only one insert query
---------------------------------------------------------
2013-09-26 18:19:16 IST LOG:  execute S_1: insert into Datapool
(datapool_id,fk_template_column,fk_branch,value) values($1,$2,$3,$4)
2013-09-26 18:19:16 IST DETAIL:  parameters: $1 = '32056', $2 = '2215', $3 =
'21', $4 = 'col1'
----------------------------------------------------------

Output on the java console has the following
---------------------------------------------------------
18:10:12.836 (21) PostgreSQL 9.2 JDBC4 (build 1003)
18:10:12.837 (21) Trying to establish a protocol version 3 connection to
localhost:5432
18:10:12.840 (21) Receive Buffer Size is 8192
18:10:12.840 (21) Send Buffer Size is 64512
18:10:12.840 (21)  FE=> StartupPacket(user=ucdt_db_user, database=ucdt,
client_encoding=UTF8, DateStyle=ISO, extra_float_digits=2,
TimeZone=Asia/Calcutta)
18:10:13.038 (21)  <=BE AuthenticationReqMD5(salt=dc711f14)
18:10:13.038 (21)  FE=>
Password(md5digest=md51508769482319c06f81993cc465a6e57)
18:10:13.045 (21)  <=BE AuthenticationOk
18:10:13.045 (21)  <=BE ParameterStatus(application_name = )
18:10:13.045 (21)  <=BE ParameterStatus(client_encoding = UTF8)
18:10:13.045 (21)  <=BE ParameterStatus(DateStyle = ISO, MDY)
18:10:13.045 (21)  <=BE ParameterStatus(integer_datetimes = on)
18:10:13.046 (21)  <=BE ParameterStatus(IntervalStyle = postgres)
18:10:13.046 (21)  <=BE ParameterStatus(is_superuser = on)
18:10:13.046 (21)  <=BE ParameterStatus(server_encoding = UTF8)
18:10:13.046 (21)  <=BE ParameterStatus(server_version = 9.1.9)
18:10:13.046 (21)  <=BE ParameterStatus(session_authorization =
ucdt_db_user)
18:10:13.046 (21)  <=BE ParameterStatus(standard_conforming_strings = on)
18:10:13.046 (21)  <=BE ParameterStatus(TimeZone = Asia/Calcutta)
18:10:13.046 (21)  <=BE BackendKeyData(pid=2844,ckey=387433590)
18:10:13.046 (21)  <=BE ReadyForQuery(I)
18:10:13.047 (21) simple execute,
handler=org.postgresql.core.SetupQueryRunner$SimpleResultHandler@49d3bb7b,
maxRows=0, fetchSize=0, flags=23
18:10:13.047 (21)  FE=> Parse(stmt=null,query="SET extra_float_digits =
3",oids={})
18:10:13.047 (21)  FE=> Bind(stmt=null,portal=null)
18:10:13.047 (21)  FE=> Execute(portal=null,limit=1)
18:10:13.047 (21)  FE=> Sync
18:10:13.049 (21)  <=BE ParseComplete [null]
18:10:13.049 (21)  <=BE BindComplete [null]
18:10:13.049 (21)  <=BE CommandStatus(SET)
18:10:13.049 (21)  <=BE ReadyForQuery(I)
18:10:13.050 (21)     compatible = 9.2
18:10:13.050 (21)     loglevel = 2
18:10:13.050 (21)     prepare threshold = 5
18:10:13.059 (21)     types using binary send =

INT8_ARRAY,TIMESTAMPTZ,FLOAT4_ARRAY,FLOAT8_ARRAY,UUID,TEXT_ARRAY,VARCHAR_ARRAY,BYTEA,TIME,FLOAT4,FLOAT8,INT2_ARRAY,TIMETZ,INT2,INT8,INT4_ARRAY,INT4,TIMESTAMP,POINT,BOX
18:10:13.061 (21)     types using binary receive =

INT8_ARRAY,TIMESTAMPTZ,FLOAT4_ARRAY,FLOAT8_ARRAY,UUID,TEXT_ARRAY,VARCHAR_ARRAY,BYTEA,TIME,DATE,FLOAT4,FLOAT8,INT2_ARRAY,TIMETZ,INT2,INT8,INT4_ARRAY,INT4,TIMESTAMP,POINT,BOX
18:10:13.061 (21)     integer date/time = true
getConnection returning
driver[className=org.postgresql.Driver,org.postgresql.Driver@d09099d]
18:15:53.392 (21) batch execute 2000 queries,
handler=org.postgresql.jdbc2.AbstractJdbc2Statement$BatchResultHandler@786c4ad7,
maxRows=0, fetchSize=0, flags=20
18:18:26.100 (21)  FE=> Parse(stmt=S_1,query="insert into Datapool
(datapool_id,fk_template_column,fk_branch,value)
values($1,$2,$3,$4)",oids={23,23,23,1043})
18:18:45.015 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32056>,$2=<2215>,$3=<21>,$4=<'col1'>)
18:18:48.386 (21)  FE=> Describe(portal=null)
18:18:50.153 (21)  FE=> Execute(portal=null,limit=1)
18:19:04.752 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32057>,$2=<2216>,$3=<21>,$4=<''>)
18:19:04.753 (21)  FE=> Describe(portal=null)
18:19:04.754 (21)  FE=> Execute(portal=null,limit=1)
18:19:07.757 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32058>,$2=<2217>,$3=<21>,$4=<''>)
18:19:07.758 (21)  FE=> Describe(portal=null)
18:19:07.758 (21)  FE=> Execute(portal=null,limit=1)
18:19:10.274 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32059>,$2=<2218>,$3=<21>,$4=<'col5'>)
18:19:10.275 (21)  FE=> Describe(portal=null)
18:19:10.276 (21)  FE=> Execute(portal=null,limit=1)
18:19:11.855 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32060>,$2=<2219>,$3=<21>,$4=<''>)
18:19:11.856 (21)  FE=> Describe(portal=null)
18:19:11.856 (21)  FE=> Execute(portal=null,limit=1)
18:19:13.140 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32061>,$2=<2220>,$3=<21>,$4=<''>)
18:19:13.141 (21)  FE=> Describe(portal=null)
18:19:13.141 (21)  FE=> Execute(portal=null,limit=1)
18:19:14.449 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32062>,$2=<2221>,$3=<21>,$4=<''>)
18:19:14.450 (21)  FE=> Describe(portal=null)
18:19:14.450 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.032 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32063>,$2=<2222>,$3=<21>,$4=<''>)
18:19:16.032 (21)  FE=> Describe(portal=null)
18:19:16.032 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.032 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32064>,$2=<2223>,$3=<21>,$4=<'col8'>)
18:19:16.032 (21)  FE=> Describe(portal=null)
18:19:16.033 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.033 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32065>,$2=<2224>,$3=<21>,$4=<''>)
18:19:16.033 (21)  FE=> Describe(portal=null)
18:19:16.033 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.033 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32066>,$2=<2225>,$3=<21>,$4=<''>)
18:19:16.033 (21)  FE=> Describe(portal=null)
18:19:16.033 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.034 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32067>,$2=<2226>,$3=<21>,$4=<''>)
18:19:16.034 (21)  FE=> Describe(portal=null)
18:19:16.034 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.034 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32068>,$2=<2227>,$3=<21>,$4=<''>)
18:19:16.034 (21)  FE=> Describe(portal=null)
18:19:16.034 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.034 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32069>,$2=<2228>,$3=<21>,$4=<''>)
18:19:16.035 (21)  FE=> Describe(portal=null)
18:19:16.035 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.035 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32070>,$2=<2229>,$3=<21>,$4=<''>)
18:19:16.035 (21)  FE=> Describe(portal=null)
18:19:16.035 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.035 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32071>,$2=<2230>,$3=<21>,$4=<''>)
18:19:16.035 (21)  FE=> Describe(portal=null)
18:19:16.036 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.036 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32072>,$2=<2231>,$3=<21>,$4=<''>)
18:19:16.036 (21)  FE=> Describe(portal=null)
18:19:16.036 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.036 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32073>,$2=<2232>,$3=<21>,$4=<''>)
18:19:16.036 (21)  FE=> Describe(portal=null)
18:19:16.037 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.037 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32074>,$2=<2233>,$3=<21>,$4=<''>)
18:19:16.039 (21)  FE=> Describe(portal=null)
18:19:16.039 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.040 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32075>,$2=<2234>,$3=<21>,$4=<''>)
18:19:16.040 (21)  FE=> Describe(portal=null)
18:19:16.040 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.040 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32076>,$2=<2235>,$3=<21>,$4=<''>)
18:19:16.040 (21)  FE=> Describe(portal=null)
18:19:16.040 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.040 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32077>,$2=<2236>,$3=<21>,$4=<''>)
18:19:16.041 (21)  FE=> Describe(portal=null)
18:19:16.041 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.041 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32078>,$2=<2237>,$3=<21>,$4=<''>)
18:19:16.041 (21)  FE=> Describe(portal=null)
18:19:16.041 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.041 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32079>,$2=<2238>,$3=<21>,$4=<''>)
18:19:16.041 (21)  FE=> Describe(portal=null)
18:19:16.041 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.042 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32080>,$2=<2239>,$3=<21>,$4=<''>)
18:19:16.042 (21)  FE=> Describe(portal=null)
18:19:16.043 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.043 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32081>,$2=<2240>,$3=<21>,$4=<''>)
18:19:16.043 (21)  FE=> Describe(portal=null)
18:19:16.043 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.043 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32082>,$2=<2241>,$3=<21>,$4=<''>)
18:19:16.043 (21)  FE=> Describe(portal=null)
18:19:16.043 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.043 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32083>,$2=<2242>,$3=<21>,$4=<''>)
18:19:16.044 (21)  FE=> Describe(portal=null)
18:19:16.044 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.045 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32084>,$2=<2243>,$3=<21>,$4=<''>)
18:19:16.045 (21)  FE=> Describe(portal=null)
18:19:16.045 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.045 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32085>,$2=<2244>,$3=<21>,$4=<''>)
18:19:16.045 (21)  FE=> Describe(portal=null)
18:19:16.045 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.045 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32086>,$2=<2245>,$3=<21>,$4=<''>)
18:19:16.046 (21)  FE=> Describe(portal=null)
18:19:16.046 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.046 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32087>,$2=<2246>,$3=<21>,$4=<''>)
18:19:16.046 (21)  FE=> Describe(portal=null)
18:19:16.046 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.046 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32088>,$2=<2247>,$3=<21>,$4=<''>)
18:19:16.046 (21)  FE=> Describe(portal=null)
18:19:16.046 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.047 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32089>,$2=<2248>,$3=<21>,$4=<''>)
18:19:16.047 (21)  FE=> Describe(portal=null)
18:19:16.047 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.047 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32090>,$2=<2249>,$3=<21>,$4=<''>)
18:19:16.047 (21)  FE=> Describe(portal=null)
18:19:16.047 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.047 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32091>,$2=<2250>,$3=<21>,$4=<''>)
18:19:16.047 (21)  FE=> Describe(portal=null)
18:19:16.048 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.048 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32092>,$2=<2251>,$3=<21>,$4=<''>)
18:19:16.048 (21)  FE=> Describe(portal=null)
18:19:16.048 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.048 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32093>,$2=<2252>,$3=<21>,$4=<''>)
18:19:16.048 (21)  FE=> Describe(portal=null)
18:19:16.048 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.048 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32094>,$2=<2253>,$3=<21>,$4=<''>)
18:19:16.049 (21)  FE=> Describe(portal=null)
18:19:16.049 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.049 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32095>,$2=<2254>,$3=<21>,$4=<''>)
18:19:16.049 (21)  FE=> Describe(portal=null)
18:19:16.049 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.049 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32096>,$2=<2255>,$3=<21>,$4=<''>)
18:19:16.050 (21)  FE=> Describe(portal=null)
18:19:16.050 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.050 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32097>,$2=<2256>,$3=<21>,$4=<''>)
18:19:16.050 (21)  FE=> Describe(portal=null)
18:19:16.050 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.051 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32098>,$2=<2257>,$3=<21>,$4=<''>)
18:19:16.051 (21)  FE=> Describe(portal=null)
18:19:16.051 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.051 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32099>,$2=<2258>,$3=<21>,$4=<''>)
18:19:16.051 (21)  FE=> Describe(portal=null)
18:19:16.051 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.051 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32100>,$2=<2259>,$3=<21>,$4=<''>)
18:19:16.052 (21)  FE=> Describe(portal=null)
18:19:16.052 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.052 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32101>,$2=<2260>,$3=<21>,$4=<''>)
18:19:16.052 (21)  FE=> Describe(portal=null)
18:19:16.052 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.052 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32102>,$2=<2261>,$3=<21>,$4=<''>)
18:19:16.052 (21)  FE=> Describe(portal=null)
18:19:16.052 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.053 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32103>,$2=<2262>,$3=<21>,$4=<''>)
18:19:16.053 (21)  FE=> Describe(portal=null)
18:19:16.053 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.053 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32104>,$2=<2263>,$3=<21>,$4=<''>)
18:19:16.053 (21)  FE=> Describe(portal=null)
18:19:16.053 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.053 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32105>,$2=<2264>,$3=<21>,$4=<''>)
18:19:16.054 (21)  FE=> Describe(portal=null)
18:19:16.054 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.054 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32106>,$2=<2265>,$3=<21>,$4=<''>)
18:19:16.054 (21)  FE=> Describe(portal=null)
18:19:16.054 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.054 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32107>,$2=<2266>,$3=<21>,$4=<''>)
18:19:16.054 (21)  FE=> Describe(portal=null)
18:19:16.055 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.055 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32108>,$2=<2267>,$3=<21>,$4=<''>)
18:19:16.055 (21)  FE=> Describe(portal=null)
18:19:16.055 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.055 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32109>,$2=<2268>,$3=<21>,$4=<''>)
18:19:16.055 (21)  FE=> Describe(portal=null)
18:19:16.055 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.056 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32110>,$2=<2269>,$3=<21>,$4=<''>)
18:19:16.056 (21)  FE=> Describe(portal=null)
18:19:16.056 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.056 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32111>,$2=<2270>,$3=<21>,$4=<''>)
18:19:16.056 (21)  FE=> Describe(portal=null)
18:19:16.056 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.056 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32112>,$2=<2271>,$3=<21>,$4=<''>)
18:19:16.056 (21)  FE=> Describe(portal=null)
18:19:16.057 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.057 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32113>,$2=<2272>,$3=<21>,$4=<''>)
18:19:16.057 (21)  FE=> Describe(portal=null)
18:19:16.057 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.057 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32114>,$2=<2273>,$3=<21>,$4=<''>)
18:19:16.057 (21)  FE=> Describe(portal=null)
18:19:16.057 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.058 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32115>,$2=<2274>,$3=<21>,$4=<''>)
18:19:16.058 (21)  FE=> Describe(portal=null)
18:19:16.058 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.058 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32116>,$2=<2275>,$3=<21>,$4=<''>)
18:19:16.058 (21)  FE=> Describe(portal=null)
18:19:16.058 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.058 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32117>,$2=<2276>,$3=<21>,$4=<''>)
18:19:16.058 (21)  FE=> Describe(portal=null)
18:19:16.059 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.059 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32118>,$2=<2277>,$3=<21>,$4=<''>)
18:19:16.059 (21)  FE=> Describe(portal=null)
18:19:16.059 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.059 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32119>,$2=<2278>,$3=<21>,$4=<''>)
18:19:16.059 (21)  FE=> Describe(portal=null)
18:19:16.059 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.059 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32120>,$2=<2279>,$3=<21>,$4=<''>)
18:19:16.060 (21)  FE=> Describe(portal=null)
18:19:16.060 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.060 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32121>,$2=<2280>,$3=<21>,$4=<''>)
18:19:16.060 (21)  FE=> Describe(portal=null)
18:19:16.061 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.061 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32122>,$2=<2281>,$3=<21>,$4=<''>)
18:19:16.061 (21)  FE=> Describe(portal=null)
18:19:16.061 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.061 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32123>,$2=<2282>,$3=<21>,$4=<''>)
18:19:16.061 (21)  FE=> Describe(portal=null)
18:19:16.061 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.061 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32124>,$2=<2283>,$3=<21>,$4=<''>)
18:19:16.062 (21)  FE=> Describe(portal=null)
18:19:16.062 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.062 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32125>,$2=<2284>,$3=<21>,$4=<''>)
18:19:16.062 (21)  FE=> Describe(portal=null)
18:19:16.062 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.062 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32126>,$2=<2285>,$3=<21>,$4=<''>)
18:19:16.063 (21)  FE=> Describe(portal=null)
18:19:16.063 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.063 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32127>,$2=<2286>,$3=<21>,$4=<''>)
18:19:16.063 (21)  FE=> Describe(portal=null)
18:19:16.063 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.063 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32128>,$2=<2287>,$3=<21>,$4=<''>)
18:19:16.063 (21)  FE=> Describe(portal=null)
18:19:16.063 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.064 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32129>,$2=<2288>,$3=<21>,$4=<''>)
18:19:16.064 (21)  FE=> Describe(portal=null)
18:19:16.064 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.064 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32130>,$2=<2289>,$3=<21>,$4=<''>)
18:19:16.064 (21)  FE=> Describe(portal=null)
18:19:16.064 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.064 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32131>,$2=<2290>,$3=<21>,$4=<''>)
18:19:16.065 (21)  FE=> Describe(portal=null)
18:19:16.065 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.065 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32132>,$2=<2291>,$3=<21>,$4=<''>)
18:19:16.065 (21)  FE=> Describe(portal=null)
18:19:16.065 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.065 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32133>,$2=<2292>,$3=<21>,$4=<''>)
18:19:16.065 (21)  FE=> Describe(portal=null)
18:19:16.065 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.066 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32134>,$2=<2293>,$3=<21>,$4=<''>)
18:19:16.066 (21)  FE=> Describe(portal=null)
18:19:16.066 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.066 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32135>,$2=<2294>,$3=<21>,$4=<''>)
18:19:16.066 (21)  FE=> Describe(portal=null)
18:19:16.066 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.067 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32136>,$2=<2295>,$3=<21>,$4=<''>)
18:19:16.067 (21)  FE=> Describe(portal=null)
18:19:16.067 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.067 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32137>,$2=<2296>,$3=<21>,$4=<''>)
18:19:16.068 (21)  FE=> Describe(portal=null)
18:19:16.068 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.068 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32138>,$2=<2297>,$3=<21>,$4=<''>)
18:19:16.068 (21)  FE=> Describe(portal=null)
18:19:16.068 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.069 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32139>,$2=<2298>,$3=<21>,$4=<''>)
18:19:16.069 (21)  FE=> Describe(portal=null)
18:19:16.069 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.069 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32140>,$2=<2299>,$3=<21>,$4=<''>)
18:19:16.070 (21)  FE=> Describe(portal=null)
18:19:16.070 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.070 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32141>,$2=<2300>,$3=<21>,$4=<''>)
18:19:16.070 (21)  FE=> Describe(portal=null)
18:19:16.070 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.071 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32142>,$2=<2301>,$3=<21>,$4=<''>)
18:19:16.071 (21)  FE=> Describe(portal=null)
18:19:16.071 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.071 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32143>,$2=<2302>,$3=<21>,$4=<''>)
18:19:16.071 (21)  FE=> Describe(portal=null)
18:19:16.071 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.072 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32144>,$2=<2303>,$3=<21>,$4=<''>)
18:19:16.072 (21)  FE=> Describe(portal=null)
18:19:16.072 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.072 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32145>,$2=<2304>,$3=<21>,$4=<''>)
18:19:16.073 (21)  FE=> Describe(portal=null)
18:19:16.073 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.073 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32146>,$2=<2305>,$3=<21>,$4=<''>)
18:19:16.073 (21)  FE=> Describe(portal=null)
18:19:16.073 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.074 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32147>,$2=<2306>,$3=<21>,$4=<''>)
18:19:16.074 (21)  FE=> Describe(portal=null)
18:19:16.074 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.074 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32148>,$2=<2307>,$3=<21>,$4=<''>)
18:19:16.074 (21)  FE=> Describe(portal=null)
18:19:16.075 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.075 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32149>,$2=<2308>,$3=<21>,$4=<''>)
18:19:16.075 (21)  FE=> Describe(portal=null)
18:19:16.075 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.075 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32150>,$2=<2309>,$3=<21>,$4=<''>)
18:19:16.076 (21)  FE=> Describe(portal=null)
18:19:16.076 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.076 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32151>,$2=<2310>,$3=<21>,$4=<''>)
18:19:16.076 (21)  FE=> Describe(portal=null)
18:19:16.076 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.077 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32152>,$2=<2311>,$3=<21>,$4=<''>)
18:19:16.077 (21)  FE=> Describe(portal=null)
18:19:16.077 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.077 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32153>,$2=<2312>,$3=<21>,$4=<''>)
18:19:16.077 (21)  FE=> Describe(portal=null)
18:19:16.077 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.077 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32154>,$2=<2313>,$3=<21>,$4=<''>)
18:19:16.078 (21)  FE=> Describe(portal=null)
18:19:16.078 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.078 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32155>,$2=<2314>,$3=<21>,$4=<''>)
18:19:16.078 (21)  FE=> Describe(portal=null)
18:19:16.078 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.079 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32156>,$2=<2315>,$3=<21>,$4=<''>)
18:19:16.079 (21)  FE=> Describe(portal=null)
18:19:16.079 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.079 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32157>,$2=<2316>,$3=<21>,$4=<''>)
18:19:16.079 (21)  FE=> Describe(portal=null)
18:19:16.079 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.080 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32158>,$2=<2317>,$3=<21>,$4=<''>)
18:19:16.080 (21)  FE=> Describe(portal=null)
18:19:16.080 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.080 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32159>,$2=<2318>,$3=<21>,$4=<''>)
18:19:16.080 (21)  FE=> Describe(portal=null)
18:19:16.080 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.081 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32160>,$2=<2319>,$3=<21>,$4=<''>)
18:19:16.081 (21)  FE=> Describe(portal=null)
18:19:16.081 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.081 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32161>,$2=<2320>,$3=<21>,$4=<''>)
18:19:16.081 (21)  FE=> Describe(portal=null)
18:19:16.081 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.082 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32162>,$2=<2321>,$3=<21>,$4=<''>)
18:19:16.082 (21)  FE=> Describe(portal=null)
18:19:16.082 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.082 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32163>,$2=<2322>,$3=<21>,$4=<''>)
18:19:16.083 (21)  FE=> Describe(portal=null)
18:19:16.083 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.083 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32164>,$2=<2323>,$3=<21>,$4=<''>)
18:19:16.083 (21)  FE=> Describe(portal=null)
18:19:16.083 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.084 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32165>,$2=<2324>,$3=<21>,$4=<''>)
18:19:16.084 (21)  FE=> Describe(portal=null)
18:19:16.084 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.084 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32166>,$2=<2325>,$3=<21>,$4=<''>)
18:19:16.084 (21)  FE=> Describe(portal=null)
18:19:16.085 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.085 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32167>,$2=<2326>,$3=<21>,$4=<''>)
18:19:16.085 (21)  FE=> Describe(portal=null)
18:19:16.085 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.085 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32168>,$2=<2327>,$3=<21>,$4=<''>)
18:19:16.086 (21)  FE=> Describe(portal=null)
18:19:16.086 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.086 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32169>,$2=<2328>,$3=<21>,$4=<''>)
18:19:16.086 (21)  FE=> Describe(portal=null)
18:19:16.086 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.087 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32170>,$2=<2329>,$3=<21>,$4=<''>)
18:19:16.087 (21)  FE=> Describe(portal=null)
18:19:16.087 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.087 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32171>,$2=<2330>,$3=<21>,$4=<''>)
18:19:16.088 (21)  FE=> Describe(portal=null)
18:19:16.088 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.088 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32172>,$2=<2331>,$3=<21>,$4=<''>)
18:19:16.088 (21)  FE=> Describe(portal=null)
18:19:16.088 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.089 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32173>,$2=<2332>,$3=<21>,$4=<''>)
18:19:16.089 (21)  FE=> Describe(portal=null)
18:19:16.089 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.089 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32174>,$2=<2333>,$3=<21>,$4=<''>)
18:19:16.090 (21)  FE=> Describe(portal=null)
18:19:16.090 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.090 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32175>,$2=<2334>,$3=<21>,$4=<''>)
18:19:16.090 (21)  FE=> Describe(portal=null)
18:19:16.090 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.090 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32176>,$2=<2335>,$3=<21>,$4=<''>)
18:19:16.090 (21)  FE=> Describe(portal=null)
18:19:16.091 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.091 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32177>,$2=<2336>,$3=<21>,$4=<''>)
18:19:16.091 (21)  FE=> Describe(portal=null)
18:19:16.091 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.091 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32178>,$2=<2337>,$3=<21>,$4=<''>)
18:19:16.091 (21)  FE=> Describe(portal=null)
18:19:16.092 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.092 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32179>,$2=<2338>,$3=<21>,$4=<''>)
18:19:16.092 (21)  FE=> Describe(portal=null)
18:19:16.092 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.093 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32180>,$2=<2339>,$3=<21>,$4=<''>)
18:19:16.093 (21)  FE=> Describe(portal=null)
18:19:16.093 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.093 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32181>,$2=<2340>,$3=<21>,$4=<''>)
18:19:16.093 (21)  FE=> Describe(portal=null)
18:19:16.093 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.094 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32182>,$2=<2341>,$3=<21>,$4=<''>)
18:19:16.094 (21)  FE=> Describe(portal=null)
18:19:16.094 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.094 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32183>,$2=<2342>,$3=<21>,$4=<''>)
18:19:16.094 (21)  FE=> Describe(portal=null)
18:19:16.094 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.094 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32184>,$2=<2343>,$3=<21>,$4=<''>)
18:19:16.095 (21)  FE=> Describe(portal=null)
18:19:16.095 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.095 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32185>,$2=<2344>,$3=<21>,$4=<''>)
18:19:16.095 (21)  FE=> Describe(portal=null)
18:19:16.095 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.095 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32186>,$2=<2345>,$3=<21>,$4=<''>)
18:19:16.095 (21)  FE=> Describe(portal=null)
18:19:16.095 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.096 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32187>,$2=<2346>,$3=<21>,$4=<''>)
18:19:16.096 (21)  FE=> Describe(portal=null)
18:19:16.096 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.096 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32188>,$2=<2347>,$3=<21>,$4=<''>)
18:19:16.096 (21)  FE=> Describe(portal=null)
18:19:16.096 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.096 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32189>,$2=<2348>,$3=<21>,$4=<''>)
18:19:16.097 (21)  FE=> Describe(portal=null)
18:19:16.097 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.097 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32190>,$2=<2349>,$3=<21>,$4=<''>)
18:19:16.097 (21)  FE=> Describe(portal=null)
18:19:16.097 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.097 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32191>,$2=<2350>,$3=<21>,$4=<''>)
18:19:16.097 (21)  FE=> Describe(portal=null)
18:19:16.097 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.098 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32192>,$2=<2351>,$3=<21>,$4=<''>)
18:19:16.098 (21)  FE=> Describe(portal=null)
18:19:16.098 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.098 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32193>,$2=<2352>,$3=<21>,$4=<''>)
18:19:16.098 (21)  FE=> Describe(portal=null)
18:19:16.098 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.098 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32194>,$2=<2353>,$3=<21>,$4=<''>)
18:19:16.098 (21)  FE=> Describe(portal=null)
18:19:16.099 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.099 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32195>,$2=<2354>,$3=<21>,$4=<''>)
18:19:16.099 (21)  FE=> Describe(portal=null)
18:19:16.099 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.099 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32196>,$2=<2355>,$3=<21>,$4=<''>)
18:19:16.099 (21)  FE=> Describe(portal=null)
18:19:16.099 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.100 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32197>,$2=<2356>,$3=<21>,$4=<''>)
18:19:16.100 (21)  FE=> Describe(portal=null)
18:19:16.100 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.100 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32198>,$2=<2357>,$3=<21>,$4=<''>)
18:19:16.100 (21)  FE=> Describe(portal=null)
18:19:16.100 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.100 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32199>,$2=<2358>,$3=<21>,$4=<''>)
18:19:16.100 (21)  FE=> Describe(portal=null)
18:19:16.101 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.101 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32200>,$2=<2359>,$3=<21>,$4=<''>)
18:19:16.101 (21)  FE=> Describe(portal=null)
18:19:16.101 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.101 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32201>,$2=<2360>,$3=<21>,$4=<''>)
18:19:16.101 (21)  FE=> Describe(portal=null)
18:19:16.101 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.101 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32202>,$2=<2361>,$3=<21>,$4=<''>)
18:19:16.102 (21)  FE=> Describe(portal=null)
18:19:16.102 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.102 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32203>,$2=<2362>,$3=<21>,$4=<''>)
18:19:16.102 (21)  FE=> Describe(portal=null)
18:19:16.102 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.102 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32204>,$2=<2363>,$3=<21>,$4=<''>)
18:19:16.102 (21)  FE=> Describe(portal=null)
18:19:16.103 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.103 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32205>,$2=<2364>,$3=<21>,$4=<''>)
18:19:16.103 (21)  FE=> Describe(portal=null)
18:19:16.103 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.103 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32206>,$2=<2365>,$3=<21>,$4=<''>)
18:19:16.103 (21)  FE=> Describe(portal=null)
18:19:16.104 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.104 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32207>,$2=<2366>,$3=<21>,$4=<''>)
18:19:16.104 (21)  FE=> Describe(portal=null)
18:19:16.104 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.104 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32208>,$2=<2367>,$3=<21>,$4=<''>)
18:19:16.104 (21)  FE=> Describe(portal=null)
18:19:16.104 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.105 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32209>,$2=<2368>,$3=<21>,$4=<''>)
18:19:16.105 (21)  FE=> Describe(portal=null)
18:19:16.105 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.105 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32210>,$2=<2369>,$3=<21>,$4=<''>)
18:19:16.105 (21)  FE=> Describe(portal=null)
18:19:16.105 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.105 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32211>,$2=<2370>,$3=<21>,$4=<''>)
18:19:16.106 (21)  FE=> Describe(portal=null)
18:19:16.106 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.106 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32212>,$2=<2371>,$3=<21>,$4=<''>)
18:19:16.106 (21)  FE=> Describe(portal=null)
18:19:16.106 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.106 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32213>,$2=<2372>,$3=<21>,$4=<''>)
18:19:16.106 (21)  FE=> Describe(portal=null)
18:19:16.106 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.107 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32214>,$2=<2373>,$3=<21>,$4=<''>)
18:19:16.107 (21)  FE=> Describe(portal=null)
18:19:16.107 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.107 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32215>,$2=<2374>,$3=<21>,$4=<''>)
18:19:16.107 (21)  FE=> Describe(portal=null)
18:19:16.107 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.107 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32216>,$2=<2375>,$3=<21>,$4=<''>)
18:19:16.107 (21)  FE=> Describe(portal=null)
18:19:16.108 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.108 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32217>,$2=<2376>,$3=<21>,$4=<''>)
18:19:16.108 (21)  FE=> Describe(portal=null)
18:19:16.108 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.108 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32218>,$2=<2377>,$3=<21>,$4=<''>)
18:19:16.108 (21)  FE=> Describe(portal=null)
18:19:16.108 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.108 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32219>,$2=<2378>,$3=<21>,$4=<''>)
18:19:16.109 (21)  FE=> Describe(portal=null)
18:19:16.109 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.109 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32220>,$2=<2379>,$3=<21>,$4=<''>)
18:19:16.109 (21)  FE=> Describe(portal=null)
18:19:16.109 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.109 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32221>,$2=<2380>,$3=<21>,$4=<''>)
18:19:16.109 (21)  FE=> Describe(portal=null)
18:19:16.109 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.110 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32222>,$2=<2381>,$3=<21>,$4=<''>)
18:19:16.110 (21)  FE=> Describe(portal=null)
18:19:16.110 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.110 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32223>,$2=<2382>,$3=<21>,$4=<''>)
18:19:16.110 (21)  FE=> Describe(portal=null)
18:19:16.110 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.111 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32224>,$2=<2383>,$3=<21>,$4=<''>)
18:19:16.111 (21)  FE=> Describe(portal=null)
18:19:16.111 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.111 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32225>,$2=<2384>,$3=<21>,$4=<''>)
18:19:16.111 (21)  FE=> Describe(portal=null)
18:19:16.111 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.111 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32226>,$2=<2385>,$3=<21>,$4=<''>)
18:19:16.111 (21)  FE=> Describe(portal=null)
18:19:16.112 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.112 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32227>,$2=<2386>,$3=<21>,$4=<''>)
18:19:16.112 (21)  FE=> Describe(portal=null)
18:19:16.112 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.112 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32228>,$2=<2387>,$3=<21>,$4=<''>)
18:19:16.112 (21)  FE=> Describe(portal=null)
18:19:16.112 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.112 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32229>,$2=<2388>,$3=<21>,$4=<''>)
18:19:16.113 (21)  FE=> Describe(portal=null)
18:19:16.113 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.113 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32230>,$2=<2389>,$3=<21>,$4=<''>)
18:19:16.113 (21)  FE=> Describe(portal=null)
18:19:16.113 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.113 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32231>,$2=<2390>,$3=<21>,$4=<''>)
18:19:16.113 (21)  FE=> Describe(portal=null)
18:19:16.114 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.114 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32232>,$2=<2391>,$3=<21>,$4=<''>)
18:19:16.114 (21)  FE=> Describe(portal=null)
18:19:16.114 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.114 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32233>,$2=<2392>,$3=<21>,$4=<''>)
18:19:16.114 (21)  FE=> Describe(portal=null)
18:19:16.114 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.115 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32234>,$2=<2393>,$3=<21>,$4=<''>)
18:19:16.115 (21)  FE=> Describe(portal=null)
18:19:16.115 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.115 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32235>,$2=<2394>,$3=<21>,$4=<''>)
18:19:16.115 (21)  FE=> Describe(portal=null)
18:19:16.115 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.115 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32236>,$2=<2395>,$3=<21>,$4=<''>)
18:19:16.116 (21)  FE=> Describe(portal=null)
18:19:16.116 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.116 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32237>,$2=<2396>,$3=<21>,$4=<''>)
18:19:16.116 (21)  FE=> Describe(portal=null)
18:19:16.116 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.116 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32238>,$2=<2397>,$3=<21>,$4=<''>)
18:19:16.116 (21)  FE=> Describe(portal=null)
18:19:16.116 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.117 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32239>,$2=<2398>,$3=<21>,$4=<''>)
18:19:16.117 (21)  FE=> Describe(portal=null)
18:19:16.117 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.117 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32240>,$2=<2399>,$3=<21>,$4=<''>)
18:19:16.117 (21)  FE=> Describe(portal=null)
18:19:16.117 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.117 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32241>,$2=<2400>,$3=<21>,$4=<''>)
18:19:16.117 (21)  FE=> Describe(portal=null)
18:19:16.118 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.118 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32242>,$2=<2401>,$3=<21>,$4=<''>)
18:19:16.118 (21)  FE=> Describe(portal=null)
18:19:16.118 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.118 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32243>,$2=<2402>,$3=<21>,$4=<''>)
18:19:16.118 (21)  FE=> Describe(portal=null)
18:19:16.118 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.118 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32244>,$2=<2403>,$3=<21>,$4=<''>)
18:19:16.119 (21)  FE=> Describe(portal=null)
18:19:16.119 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.119 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32245>,$2=<2404>,$3=<21>,$4=<''>)
18:19:16.119 (21)  FE=> Describe(portal=null)
18:19:16.119 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.119 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32246>,$2=<2405>,$3=<21>,$4=<''>)
18:19:16.119 (21)  FE=> Describe(portal=null)
18:19:16.120 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.120 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32247>,$2=<2406>,$3=<21>,$4=<''>)
18:19:16.120 (21)  FE=> Describe(portal=null)
18:19:16.120 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.120 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32248>,$2=<2407>,$3=<21>,$4=<''>)
18:19:16.120 (21)  FE=> Describe(portal=null)
18:19:16.121 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.121 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32249>,$2=<2408>,$3=<21>,$4=<''>)
18:19:16.121 (21)  FE=> Describe(portal=null)
18:19:16.121 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.121 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32250>,$2=<2409>,$3=<21>,$4=<''>)
18:19:16.122 (21)  FE=> Describe(portal=null)
18:19:16.122 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.122 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32251>,$2=<2410>,$3=<21>,$4=<''>)
18:19:16.122 (21)  FE=> Describe(portal=null)
18:19:16.122 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.123 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32252>,$2=<2411>,$3=<21>,$4=<''>)
18:19:16.123 (21)  FE=> Describe(portal=null)
18:19:16.123 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.123 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32253>,$2=<2412>,$3=<21>,$4=<''>)
18:19:16.123 (21)  FE=> Describe(portal=null)
18:19:16.124 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.124 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32254>,$2=<2413>,$3=<21>,$4=<''>)
18:19:16.124 (21)  FE=> Describe(portal=null)
18:19:16.124 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.124 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32255>,$2=<2414>,$3=<21>,$4=<''>)
18:19:16.124 (21)  FE=> Describe(portal=null)
18:19:16.125 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.125 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32256>,$2=<2415>,$3=<21>,$4=<''>)
18:19:16.125 (21)  FE=> Describe(portal=null)
18:19:16.125 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.125 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32257>,$2=<2416>,$3=<21>,$4=<''>)
18:19:16.125 (21)  FE=> Describe(portal=null)
18:19:16.125 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.125 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32258>,$2=<2417>,$3=<21>,$4=<''>)
18:19:16.126 (21)  FE=> Describe(portal=null)
18:19:16.126 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.126 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32259>,$2=<2418>,$3=<21>,$4=<''>)
18:19:16.126 (21)  FE=> Describe(portal=null)
18:19:16.126 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.126 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32260>,$2=<2419>,$3=<21>,$4=<''>)
18:19:16.126 (21)  FE=> Describe(portal=null)
18:19:16.127 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.127 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32261>,$2=<2420>,$3=<21>,$4=<''>)
18:19:16.127 (21)  FE=> Describe(portal=null)
18:19:16.127 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.127 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32262>,$2=<2421>,$3=<21>,$4=<''>)
18:19:16.127 (21)  FE=> Describe(portal=null)
18:19:16.127 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.127 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32263>,$2=<2422>,$3=<21>,$4=<''>)
18:19:16.128 (21)  FE=> Describe(portal=null)
18:19:16.128 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.128 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32264>,$2=<2423>,$3=<21>,$4=<''>)
18:19:16.128 (21)  FE=> Describe(portal=null)
18:19:16.128 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.128 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32265>,$2=<2424>,$3=<21>,$4=<''>)
18:19:16.128 (21)  FE=> Describe(portal=null)
18:19:16.128 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.129 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32266>,$2=<2425>,$3=<21>,$4=<''>)
18:19:16.129 (21)  FE=> Describe(portal=null)
18:19:16.129 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.129 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32267>,$2=<2426>,$3=<21>,$4=<''>)
18:19:16.129 (21)  FE=> Describe(portal=null)
18:19:16.129 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.129 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32268>,$2=<2427>,$3=<21>,$4=<''>)
18:19:16.130 (21)  FE=> Describe(portal=null)
18:19:16.130 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.130 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32269>,$2=<2428>,$3=<21>,$4=<''>)
18:19:16.130 (21)  FE=> Describe(portal=null)
18:19:16.130 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.130 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32270>,$2=<2429>,$3=<21>,$4=<''>)
18:19:16.130 (21)  FE=> Describe(portal=null)
18:19:16.130 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.131 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32271>,$2=<2430>,$3=<21>,$4=<''>)
18:19:16.131 (21)  FE=> Describe(portal=null)
18:19:16.131 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.131 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32272>,$2=<2431>,$3=<21>,$4=<''>)
18:19:16.132 (21)  FE=> Describe(portal=null)
18:19:16.132 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.132 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32273>,$2=<2432>,$3=<21>,$4=<''>)
18:19:16.132 (21)  FE=> Describe(portal=null)
18:19:16.132 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.132 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32274>,$2=<2433>,$3=<21>,$4=<''>)
18:19:16.133 (21)  FE=> Describe(portal=null)
18:19:16.133 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.133 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32275>,$2=<2434>,$3=<21>,$4=<''>)
18:19:16.133 (21)  FE=> Describe(portal=null)
18:19:16.133 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.133 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32276>,$2=<2435>,$3=<21>,$4=<''>)
18:19:16.133 (21)  FE=> Describe(portal=null)
18:19:16.133 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.134 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32277>,$2=<2436>,$3=<21>,$4=<''>)
18:19:16.134 (21)  FE=> Describe(portal=null)
18:19:16.134 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.134 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32278>,$2=<2437>,$3=<21>,$4=<''>)
18:19:16.134 (21)  FE=> Describe(portal=null)
18:19:16.134 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.134 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32279>,$2=<2438>,$3=<21>,$4=<''>)
18:19:16.135 (21)  FE=> Describe(portal=null)
18:19:16.135 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.135 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32280>,$2=<2439>,$3=<21>,$4=<''>)
18:19:16.135 (21)  FE=> Describe(portal=null)
18:19:16.135 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.135 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32281>,$2=<2440>,$3=<21>,$4=<''>)
18:19:16.135 (21)  FE=> Describe(portal=null)
18:19:16.135 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.136 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32282>,$2=<2441>,$3=<21>,$4=<''>)
18:19:16.136 (21)  FE=> Describe(portal=null)
18:19:16.136 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.136 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32283>,$2=<2442>,$3=<21>,$4=<''>)
18:19:16.136 (21)  FE=> Describe(portal=null)
18:19:16.136 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.136 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32284>,$2=<2443>,$3=<21>,$4=<''>)
18:19:16.137 (21)  FE=> Describe(portal=null)
18:19:16.137 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.137 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32285>,$2=<2444>,$3=<21>,$4=<''>)
18:19:16.137 (21)  FE=> Describe(portal=null)
18:19:16.137 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.137 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32286>,$2=<2445>,$3=<21>,$4=<''>)
18:19:16.137 (21)  FE=> Describe(portal=null)
18:19:16.137 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.138 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32287>,$2=<2446>,$3=<21>,$4=<''>)
18:19:16.138 (21)  FE=> Describe(portal=null)
18:19:16.138 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.138 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32288>,$2=<2447>,$3=<21>,$4=<''>)
18:19:16.138 (21)  FE=> Describe(portal=null)
18:19:16.138 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.138 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32289>,$2=<2448>,$3=<21>,$4=<''>)
18:19:16.138 (21)  FE=> Describe(portal=null)
18:19:16.139 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.139 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32290>,$2=<2449>,$3=<21>,$4=<''>)
18:19:16.139 (21)  FE=> Describe(portal=null)
18:19:16.139 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.139 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32291>,$2=<2450>,$3=<21>,$4=<''>)
18:19:16.140 (21)  FE=> Describe(portal=null)
18:19:16.140 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.140 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32292>,$2=<2451>,$3=<21>,$4=<''>)
18:19:16.140 (21)  FE=> Describe(portal=null)
18:19:16.140 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.140 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32293>,$2=<2452>,$3=<21>,$4=<''>)
18:19:16.140 (21)  FE=> Describe(portal=null)
18:19:16.141 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.141 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32294>,$2=<2453>,$3=<21>,$4=<''>)
18:19:16.141 (21)  FE=> Describe(portal=null)
18:19:16.141 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.141 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32295>,$2=<2454>,$3=<21>,$4=<''>)
18:19:16.141 (21)  FE=> Describe(portal=null)
18:19:16.142 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.142 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32296>,$2=<2455>,$3=<21>,$4=<''>)
18:19:16.142 (21)  FE=> Describe(portal=null)
18:19:16.142 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.142 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32297>,$2=<2456>,$3=<21>,$4=<''>)
18:19:16.142 (21)  FE=> Describe(portal=null)
18:19:16.142 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.143 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32298>,$2=<2457>,$3=<21>,$4=<''>)
18:19:16.143 (21)  FE=> Describe(portal=null)
18:19:16.143 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.143 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32299>,$2=<2458>,$3=<21>,$4=<''>)
18:19:16.143 (21)  FE=> Describe(portal=null)
18:19:16.143 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.144 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32300>,$2=<2459>,$3=<21>,$4=<''>)
18:19:16.144 (21)  FE=> Describe(portal=null)
18:19:16.144 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.144 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32301>,$2=<2460>,$3=<21>,$4=<''>)
18:19:16.144 (21)  FE=> Describe(portal=null)
18:19:16.144 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.145 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32302>,$2=<2461>,$3=<21>,$4=<''>)
18:19:16.145 (21)  FE=> Describe(portal=null)
18:19:16.145 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.145 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32303>,$2=<2462>,$3=<21>,$4=<''>)
18:19:16.145 (21)  FE=> Describe(portal=null)
18:19:16.145 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.145 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32304>,$2=<2463>,$3=<21>,$4=<''>)
18:19:16.146 (21)  FE=> Describe(portal=null)
18:19:16.146 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.146 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32305>,$2=<2464>,$3=<21>,$4=<''>)
18:19:16.146 (21)  FE=> Describe(portal=null)
18:19:16.146 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.146 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32306>,$2=<2465>,$3=<21>,$4=<''>)
18:19:16.146 (21)  FE=> Describe(portal=null)
18:19:16.146 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.147 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32307>,$2=<2466>,$3=<21>,$4=<''>)
18:19:16.147 (21)  FE=> Describe(portal=null)
18:19:16.147 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.147 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32308>,$2=<2467>,$3=<21>,$4=<''>)
18:19:16.147 (21)  FE=> Describe(portal=null)
18:19:16.147 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.148 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32309>,$2=<2468>,$3=<21>,$4=<''>)
18:19:16.148 (21)  FE=> Describe(portal=null)
18:19:16.148 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.148 (21)  FE=>
Bind(stmt=S_1,portal=null,$1=<32310>,$2=<2469>,$3=<21>,$4=<''>)
18:19:16.148 (21)  FE=> Describe(portal=null)
18:19:16.148 (21)  FE=> Execute(portal=null,limit=1)
18:19:16.148 (21)  FE=> Sync
---------------------------------------------------------------------------

The rows bound started from 32056 and ended at 32310 with a FE=> Sync

Is this an issue with the JDBC4 build?

Any help will be appreciated...








--
View this message in context:
http://postgresql.1045698.n5.nabble.com/JDBC-executeBatch-hangs-without-error-tp5772465.html
Sent from the PostgreSQL - jdbc mailing list archive at Nabble.com.

Re: JDBC executeBatch() hangs without error

From

"Vinay S (vinas)"

Date:

26 September 2013, 17:32:49

Let me also add that there is inconsistency there too. For eg., this same program has been working on Win 7 on 1 system until yesterday, it just decided it wouldn’t J

On the other Win 7, it hasn’t been working since Day 1.

Where do I look?

- Vinay

From: Dave Cramer [mailto:davecramer@gmail.com]
Sent: Thursday, September 26, 2013 10:59 PM
To: Vinay S (vinas)
Cc: List
Subject: Re: [JDBC] JDBC executeBatch() hangs without error

So this is only win7 ??? sounds pretty strange as this is through tcp, and a java vm. Must be something in the O/S blocking it.

Dave Cramer

On Thu, Sep 26, 2013 at 1:04 PM, Vinay S (vinas) <vinas@cisco.com> wrote:

Hi Dave,

Thanks for the reply.

I did try debugging a bit more and have more info to share. Short answer, executeBatch() simply hangs for even 1 row.

I updated my post to reflect the debugging info here http://postgresql.1045698.n5.nabble.com/JDBC-executeBatch-hangs-without-error-td5772465.html

Gist of that debugging info is that

Program hangs exactly at
int read = wrapped.read(buffer, endIndex, canFit);

in VisibleBufferedInputStream.java

executeBatch() works fine on Win2008, whereas hangs on Win7 (different instance of Win 7 too)

Any help here would be great.

Thanks.

- Vinay

From: davecramer@gmail.com [mailto:davecramer@gmail.com] On Behalf Of Dave Cramer
Sent: Thursday, September 26, 2013 9:55 PM
To: Vinay S (vinas)
Cc: List
Subject: Re: [JDBC] JDBC executeBatch() hangs without error

I can't really say where the issue is.

Can you try using batches of less than 254 to see if that works ?

Dave Cramer

dave.cramer(at)credativ(dot)ca
http://www.credativ.ca

On Thu, Sep 26, 2013 at 9:17 AM, vinay_s <vinas@cisco.com> wrote:

Postgres Version Used : 9.1.9 - 64 bit
JDBC Driver used : PostgreSQL 9.2 JDBC4 (build 1003)
JDK used : 1.6u45 - 64 bit
OS: Windows 7 - 64 bit

I have simple insert query using which I'm trying to import around 20,000
rows by splitting them into 10 batches of 2000 each

insert into Datapool (datapool_id,fk_template_column,fk_branch,value)
values(?,?,?,?)

is the JDBC prepared statement.

Every 2000 rows, I add as a batch using

stmt.addBatch();

and and then call

stmt.executeBatch();

Program hangs at executeBatch() indefinitely and does not terminate.

To debug further,
- I took the source for the JDBC Driver
- Enabled log_statement ='all' in postgresql.conf(restarted the service of
course)
- Appended ?loglevel=2 in the JDBC Connection URL

I execute the program and saw that the executeBatch of 2000 entries just
halts after 254 insert queries are bound.

Output from the postgres log shows only one insert query
---------------------------------------------------------
2013-09-26 18:19:16 IST LOG: execute S_1: insert into Datapool
(datapool_id,fk_template_column,fk_branch,value) values($1,$2,$3,$4)
2013-09-26 18:19:16 IST DETAIL: parameters: $1 = '32056', $2 = '2215', $3 =
'21', $4 = 'col1'
----------------------------------------------------------

Re: JDBC executeBatch() hangs without error

From

Kevin Wooten

Date:

26 September 2013, 17:41:18

Could this be related to the note in QueryExecutorImpl.java ~ line 287 titled "Deadlock Avoidance"?

If I remember correctly it's specifically related to batched queries and synchronous TCP.

On Sep 26, 2013, at 10:32 AM, "Vinay S (vinas)" <vinas@cisco.com> wrote:

Let me also add that there is inconsistency there too. For eg., this same program has been working on Win 7 on 1 system until yesterday, it just decided it wouldn’t J

On the other Win 7, it hasn’t been working since Day 1.

Where do I look?

- Vinay

From: Dave Cramer [mailto:davecramer@gmail.com]
Sent: Thursday, September 26, 2013 10:59 PM
To: Vinay S (vinas)
Cc: List
Subject: Re: [JDBC] JDBC executeBatch() hangs without error

So this is only win7 ??? sounds pretty strange as this is through tcp, and a java vm. Must be something in the O/S blocking it.

Dave Cramer

On Thu, Sep 26, 2013 at 1:04 PM, Vinay S (vinas) <vinas@cisco.com> wrote:
Hi Dave,
Thanks for the reply.

I did try debugging a bit more and have more info to share. Short answer, executeBatch() simply hangs for even 1 row.

I updated my post to reflect the debugging info here http://postgresql.1045698.n5.nabble.com/JDBC-executeBatch-hangs-without-error-td5772465.html

Gist of that debugging info is that

Program hangs exactly at
int read = wrapped.read(buffer, endIndex, canFit);

in VisibleBufferedInputStream.java

executeBatch() works fine on Win2008, whereas hangs on Win7 (different instance of Win 7 too)

Any help here would be great.

Thanks.

- Vinay

From: davecramer@gmail.com [mailto:davecramer@gmail.com] On Behalf Of Dave Cramer
Sent: Thursday, September 26, 2013 9:55 PM
To: Vinay S (vinas)
Cc: List
Subject: Re: [JDBC] JDBC executeBatch() hangs without error

I can't really say where the issue is.

Can you try using batches of less than 254 to see if that works ?

Dave Cramer

dave.cramer(at)credativ(dot)ca
http://www.credativ.ca

On Thu, Sep 26, 2013 at 9:17 AM, vinay_s <vinas@cisco.com> wrote:
Postgres Version Used : 9.1.9 - 64 bit
JDBC Driver used : PostgreSQL 9.2 JDBC4 (build 1003)
JDK used : 1.6u45 - 64 bit
OS: Windows 7 - 64 bit

I have simple insert query using which I'm trying to import around 20,000
rows by splitting them into 10 batches of 2000 each

insert into Datapool (datapool_id,fk_template_column,fk_branch,value)
values(?,?,?,?)

is the JDBC prepared statement.

Every 2000 rows, I add as a batch using

stmt.addBatch();

and and then call

stmt.executeBatch();

Program hangs at executeBatch() indefinitely and does not terminate.

To debug further,
- I took the source for the JDBC Driver
- Enabled log_statement ='all' in postgresql.conf(restarted the service of
course)
- Appended ?loglevel=2 in the JDBC Connection URL

I execute the program and saw that the executeBatch of 2000 entries just
halts after 254 insert queries are bound.

Output from the postgres log shows only one insert query
---------------------------------------------------------
2013-09-26 18:19:16 IST LOG: execute S_1: insert into Datapool
(datapool_id,fk_template_column,fk_branch,value) values($1,$2,$3,$4)
2013-09-26 18:19:16 IST DETAIL: parameters: $1 = '32056', $2 = '2215', $3 =
'21', $4 = 'col1'
----------------------------------------------------------

Re: JDBC executeBatch() hangs without error

From

Kris Jurka

Date:

26 September 2013, 17:48:54

On Thu, 26 Sep 2013, Kevin Wooten wrote:

> Could this be related to the note in QueryExecutorImpl.java ~ line 287
> titled "Deadlock Avoidance"?
> If I remember correctly it's specifically related to batched queries and
> synchronous TCP.

Almost certainly.  The thing to look at is setting the network buffer
sizes to use to large values to avoid the deadlock.  The default values
are machine dependent which also explains it working or not on different
machines.  These are unfortunately not documented, but were introduced in
this commit:

https://github.com/pgjdbc/pgjdbc/commit/4e7f65b91e95d6249c78de6944f09cd34ef1ae87

Kris Jurka

Re: JDBC executeBatch() hangs without error

From

"Vinay S (vinas)"

Date:

26 September 2013, 17:50:14

That sounds about right.

So, I'll try to play around with private static final int MAX_BUFFERED_QUERIES and update you guys.

Thanks a bunch.

- Vinay

-----Original Message-----
From: Kris Jurka [mailto:books@ejurka.com]
Sent: Thursday, September 26, 2013 11:18 PM
To: Kevin Wooten
Cc: Vinay S (vinas); Dave Cramer; List
Subject: Re: [JDBC] JDBC executeBatch() hangs without error

On Thu, 26 Sep 2013, Kevin Wooten wrote:

> Could this be related to the note in QueryExecutorImpl.java ~ line 287
> titled "Deadlock Avoidance"?
> If I remember correctly it's specifically related to batched queries
> and synchronous TCP.

Almost certainly.  The thing to look at is setting the network buffer sizes to use to large values to avoid the
deadlock. The default values are machine dependent which also explains it working or not on different machines.  These
areunfortunately not documented, but were introduced in this commit: 

https://github.com/pgjdbc/pgjdbc/commit/4e7f65b91e95d6249c78de6944f09cd34ef1ae87

Kris Jurka

Re: JDBC executeBatch() hangs without error

From

"Vinay S (vinas)"

Date:

26 September 2013, 18:14:16

This worked!

Increased MAX_BUFFERED_QUERIES to a big enough number for the read/write to take place comfortably and the
executeBatch()worked. 

How can I help with this so somebody else can easily find the answer if they stumble into a similar issue? Can I
benchmarkfor you guys? Run different batchsizes on different OS's? All ears. 

Thanks a bunch again!

- Vinay

-----Original Message-----
From: Vinay S (vinas)
Sent: Thursday, September 26, 2013 11:20 PM
To: 'Kris Jurka'; Kevin Wooten
Cc: Dave Cramer; List
Subject: RE: [JDBC] JDBC executeBatch() hangs without error

That sounds about right.

So, I'll try to play around with private static final int MAX_BUFFERED_QUERIES and update you guys.

Thanks a bunch.

- Vinay

-----Original Message-----
From: Kris Jurka [mailto:books@ejurka.com]
Sent: Thursday, September 26, 2013 11:18 PM
To: Kevin Wooten
Cc: Vinay S (vinas); Dave Cramer; List
Subject: Re: [JDBC] JDBC executeBatch() hangs without error

On Thu, 26 Sep 2013, Kevin Wooten wrote:

> Could this be related to the note in QueryExecutorImpl.java ~ line 287
> titled "Deadlock Avoidance"?
> If I remember correctly it's specifically related to batched queries
> and synchronous TCP.

Almost certainly.  The thing to look at is setting the network buffer sizes to use to large values to avoid the
deadlock. The default values are machine dependent which also explains it working or not on different machines.  These
areunfortunately not documented, but were introduced in this commit: 

https://github.com/pgjdbc/pgjdbc/commit/4e7f65b91e95d6249c78de6944f09cd34ef1ae87

Kris Jurka

Re: JDBC executeBatch() hangs without error

From

Kris Jurka

Date:

01 October 2013, 04:37:41

On Thu, 26 Sep 2013, Vinay S (vinas) wrote:

> Increased MAX_BUFFERED_QUERIES to a big enough number for the read/write
> to take place comfortably and the executeBatch() worked.

That doesn't make a lot of sense.  You should have had to lower
MAX_BUFFERED_QUERIES rather than raise it...

Kris Jurka

Re: JDBC executeBatch() hangs without error

From

Lezzlee

Date:

11 February 2014, 10:30:50

Hi, we found that operations affecting triggers require exclisive lock on the related tables. We got FE=>Sync hang up problem and looked exactly like you described here. It should not be a network issue. It can be reproduced on both windows and linux platforms. However, our script was dropping and (re)creating triggers and not a batch insert that you reported here earlier. The solution was to * close the current connection to postgres * establish a new one and run the script to modify the triggers * at the end commit and close the connection * establsih a new connection to continue the work. I post our solution here because this is the most recent thread on this topic which I've found. I hope this can help others with this magic connection hang. Cheers, L

View this message in context: Re: JDBC executeBatch() hangs without error
Sent from the PostgreSQL - jdbc mailing list archive at Nabble.com.