Обсуждение: JDBC executeBatch() hangs without error
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.
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'
----------------------------------------------------------
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 JOn the other Win 7, it hasn’t been working since Day 1.Where do I look?- VinayFrom: 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 errorSo 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.htmlGist of that debugging info is thatProgram hangs exactly at
int read = wrapped.read(buffer, endIndex, canFit);
in VisibleBufferedInputStream.javaexecuteBatch() works fine on Win2008, whereas hangs on Win7 (different instance of Win 7 too)Any help here would be great.Thanks.- VinayFrom: 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 errorI can't really say where the issue is.Can you try using batches of less than 254 to see if that works ?
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'
----------------------------------------------------------
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
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
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
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
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.
View this message in context: Re: JDBC executeBatch() hangs without error
Sent from the PostgreSQL - jdbc mailing list archive at Nabble.com.