sequoiadb-discuss

[Sequoiadb-discuss] Sequoia gets stuck (probably) because of SELECT...FOR UPDATE

[rohit d. <roh...@gm...>]

Hi,

I have been facing some problem with sequoia. I am trying to run
BenchmarkSql-2.3 (http://sourceforge.net/projects/benchmarksql/) with
sequoia over two postgresql-7.3 servers but it seems to get stuck
indefinitely at the same point. I think it's happening because of the
SELECT...FOR UPDATE but not really sure how :( It seems that the
transactions are getting into a deadlock. Here's the out put when I turned
on the debug mode.

02:56:49,388 DEBUG controller.core.PingResponder Received ping data from /
127.0.0.1
02:56:49,388 DEBUG controller.core.PingResponder Response to ping sent to /
127.0.0.1
02:56:49,775 DEBUG sequoia.controller.loadbalancer Building wait-for
graph...
02:56:49,776 DEBUG sequoia.controller.loadbalancer new_order locked by 64
02:56:49,777 DEBUG sequoia.controller.loadbalancer district locked by 65
02:56:49,777 DEBUG sequoia.controller.loadbalancer warehouse locked by 65
02:56:49,777 DEBUG sequoia.controller.loadbalancer Walking wait-for graph...
02:56:49,778 DEBUG sequoia.controller.loadbalancer 64 waits for district
locked by 65
02:56:49,779 DEBUG sequoia.controller.loadbalancer 68 waits for new_order
locked by 64
02:56:49,779 DEBUG sequoia.controller.loadbalancer     64 waits for
district locked by 65
02:56:49,779 DEBUG sequoia.controller.loadbalancer 67 waits for warehouse
locked by 65
02:56:49,779 DEBUG sequoia.controller.loadbalancer 66 waits for new_order
locked by 64
02:56:49,779 DEBUG sequoia.controller.loadbalancer     64 waits for
district locked by 65
02:56:49,779 DEBUG sequoia.controller.loadbalancer Choosing victim node...
02:56:49,779 DEBUG sequoia.controller.loadbalancer 0 cycles detected
02:56:49,779 DEBUG sequoia.controller.loadbalancer No victim
02:56:50,389 DEBUG controller.core.PingResponder Received ping data from /
127.0.0.1
02:56:50,389 DEBUG controller.core.PingResponder Response to ping sent to /
127.0.0.1



Here's my configuration file..

<?xml version="1.0" encoding="UTF-8"?>^M
<!DOCTYPE SEQUOIA PUBLIC "-//Continuent//DTD SEQUOIA @VERSION@//EN" "
http://sequoia.continuent.org/dtds/sequoia-@VERSION@.dtd">^M
^M
<SEQUOIA>^M
^M
  <VirtualDatabase name="tpcw">^M
^M
    <AuthenticationManager>^M
      <Admin>^M
        <User username="postgres" password=""/>^M
      </Admin> ^M
      <VirtualUsers>^M
        <VirtualLogin vLogin="postgres" vPassword=""/>^M
      </VirtualUsers>^M
    </AuthenticationManager>^M
^M
    <DatabaseBackend name="localhost" driver="org.postgresql.Driver"
driverPath="/home/rohit/Software/CJDBC/sequoia-2.10.10-bin/drivers/postgresql7.3.jar"
url="jdbc:postgresql://localhost:6551/tpcw" connectionTestStatement="select
now()">^M

      <ConnectionManager vLogin="postgres" rLogin="postgres" rPassword="">^M
        <VariablePoolConnectionManager initPoolSize="20" minPoolSize="5"
maxPoolSize="0" idleTimeout="180" waitTimeout="0"/>^M
      </ConnectionManager>^M
    </DatabaseBackend>^M
^M
    <DatabaseBackend name="Remote" driver="org.postgresql.Driver"
driverPath="/home/rohit/Software/CJDBC/sequoia-2.10.10-bin/drivers/postgresql7.3.jar"
url="jdbc:postgresql://192.168.164.136:6552/tpcw"
connectionTestStatement="select now()">^M
      <ConnectionManager vLogin="postgres" rLogin="postgres" rPassword="">^M
        <VariablePoolConnectionManager initPoolSize="20" minPoolSize="5"
maxPoolSize="0" idleTimeout="180" waitTimeout="0"/>^M
      </ConnectionManager>^M
    </DatabaseBackend>^M
    <RequestManager>^M
      <RequestScheduler>^M
         <RAIDb-1Scheduler level="passThrough"/>^M
      </RequestScheduler>^M
^M
      <RequestCache>^M
         <MetadataCache/>^M
         <ParsingCache/>                 ^M
         <ResultCache granularity="table" />^M
      </RequestCache>^M
^M
      <LoadBalancer transactionIsolation="serializable">^M
         <RAIDb-1>^M
            <WaitForCompletion policy="all"
            deadlockTimeoutInMs="30000"/>^M
            <RAIDb-1-RoundRobin/>^M
         </RAIDb-1>^M
      </LoadBalancer>^M
    </RequestManager>^M
^M
  </VirtualDatabase>^M
^M
</SEQUOIA>^M

If anybody has anu idea why this happens please let me know. I would
appreciate it a lot. Thanks in advance.

Regards,
Rohit

Re: [Sequoiadb-discuss] Sequoia gets stuck (probably) because of SELECT...FOR UPDATE

[rohit d. <roh...@gm...>]

Hi,

Thank you very much for your quick reply emmanuel.  I have already tried
setting the timeout in load balancer but it doesn't work for me I guess :(
I have been facing this problem with the SELECT.. FOR UPDATE statements.
While going through the source code of sequoia I found this in
sequoia-2.10.10-src/src/org/continuent/sequoia/controller/requests/SelectRequest.java

public class SelectRequest extends AbstractRequest implements Serializable
{
  private static final long      serialVersionUID = 6498520472410320514L;

  /**
   * Set to true if this SelectRequest must be broadcasted on the cluster
   * (useful for queries like SELECT FOR UPDATE
   */
  private boolean                mustBroadcast    = false;
          <Line 76>

Do I have to change mustBroadcast to true and recompile the sequoia to
enable it to do SELECT...FOR UPDATE ?

Also, here's the request log from a similar test (it again got stuck at
same point) .
I apologize for copy pasting the entire log here.

06:42:10,221 DEBUG controller.core.PingResponder Response to ping sent to /
127.0.0.1
06:42:11,207 DEBUG controller.core.PingResponder Received ping data from /
127.0.0.1
06:42:11,207 DEBUG controller.core.PingResponder Response to ping sent to /
127.0.0.1
06:42:12,351 DEBUG sequoia.controller.loadbalancer Building wait-for
graph...
06:42:12,352 DEBUG sequoia.controller.loadbalancer warehouse locked by 13
06:42:12,352 DEBUG sequoia.controller.loadbalancer new_order locked by 12
06:42:12,352 DEBUG sequoia.controller.loadbalancer district locked by 13
06:42:12,352 DEBUG sequoia.controller.loadbalancer Walking wait-for graph...
06:42:12,352 DEBUG sequoia.controller.loadbalancer 17 waits for new_order
locked by 12
06:42:12,352 DEBUG sequoia.controller.loadbalancer     12 waits for
district locked by 13
06:42:12,352 DEBUG sequoia.controller.loadbalancer 15 waits for new_order
locked by 12
06:42:12,352 DEBUG sequoia.controller.loadbalancer     12 waits for
district locked by 13
06:42:12,352 DEBUG sequoia.controller.loadbalancer 14 waits for warehouse
locked by 13
06:42:12,352 DEBUG sequoia.controller.loadbalancer Choosing victim node...
06:42:12,352 DEBUG sequoia.controller.loadbalancer 0 cycles detected
06:42:12,352 DEBUG sequoia.controller.loadbalancer No victim

*Request.log*
06:41:10,856 tpcw B 0
06:41:10,856 tpcw B 1
06:41:10,857 tpcw B 2
06:41:10,857 tpcw B 3
06:41:10,858 tpcw B 4
06:41:10,866 tpcw S 0 2 SELECT d_next_o_id FROM district WHERE d_w_id = ?
AND d_id = ?/<!%I|1|!%><!%I|5|!%>
06:41:10,867 tpcw S 1 1 SELECT c_discount, c_last, c_credit, w_tax  FROM
customer, warehouse WHERE w_id = ? AND w_id = c_w_id AND c_d_id = ? AND
c_id = ?/<!%I|1|!%><!%I|9|!%><!%I|2895|!%>
06:41:10,868 tpcw W 2 3 UPDATE warehouse SET w_ytd = w_ytd + ?  WHERE w_id
= ?/<!%F|2224.39|!%><!%I|3|!%>
06:41:10,869 tpcw W 3 4 UPDATE warehouse SET w_ytd = w_ytd + ?  WHERE w_id
= ?/<!%F|3794.01|!%><!%I|2|!%>
06:41:10,894 tpcw S 4 0 SELECT c_discount, c_last, c_credit, w_tax  FROM
customer, warehouse WHERE w_id = ? AND w_id = c_w_id AND c_d_id = ? AND
c_id = ?/<!%I|2|!%><!%I|8|!%><!%I|1673|!%>
06:41:11,616 tpcw S 5 2 SELECT COUNT(DISTINCT (s_i_id)) AS stock_count FROM
order_line, stock WHERE ol_w_id = ? AND ol_d_id = ? AND ol_o_id < ? AND
ol_o_id >= ? - 20 AND s_w_id = ? AND s_i_id = ol_i_id AND s_quantity <
?/<!%I|1|!%><!%I|5|!%><!%I|3001|!%><!%I|3001|!%><!%I|1|!%><!%I|10|!%>
06:41:11,620 tpcw S 6 3 SELECT w_street_1, w_street_2, w_city, w_state,
w_zip, w_name FROM warehouse WHERE w_id = ?/<!%I|3|!%>
06:41:11,628 tpcw S 7 4 SELECT w_street_1, w_street_2, w_city, w_state,
w_zip, w_name FROM warehouse WHERE w_id = ?/<!%I|2|!%>
06:41:11,629 tpcw W 8 3 UPDATE district SET d_ytd = d_ytd + ? WHERE d_w_id
= ? AND d_id = ?/<!%F|2224.39|!%><!%I|3|!%><!%I|3|!%>
06:41:11,634 tpcw W 9 4 UPDATE district SET d_ytd = d_ytd + ? WHERE d_w_id
= ? AND d_id = ?/<!%F|3794.01|!%><!%I|2|!%><!%I|3|!%>
06:41:11,640 tpcw S 10 1 SELECT d_next_o_id, d_tax FROM district WHERE d_id
= ? AND d_w_id = ? FOR UPDATE/<!%I|9|!%><!%I|1|!%>
06:41:11,649 tpcw S 11 3 SELECT d_street_1, d_street_2, d_city, d_state,
d_zip, d_name FROM district WHERE d_w_id = ? AND d_id =
?/<!%I|3|!%><!%I|3|!%>
06:41:11,659 tpcw S 12 4 SELECT d_street_1, d_street_2, d_city, d_state,
d_zip, d_name FROM district WHERE d_w_id = ? AND d_id =
?/<!%I|2|!%><!%I|3|!%>
06:41:11,660 tpcw S 13 3 SELECT c_first, c_middle, c_last, c_street_1,
c_street_2, c_city, c_state, c_zip,       c_phone, c_credit, c_credit_lim,
c_discount, c_balance, c_since   FROM customer WHERE c_w_id = ? AND c_d_id
= ? AND c_id = ?/<!%I|1|!%><!%I|7|!%><!%I|2065|!%>
06:41:11,671 tpcw S 14 4 SELECT c_first, c_middle, c_last, c_street_1,
c_street_2, c_city, c_state, c_zip,       c_phone, c_credit, c_credit_lim,
c_discount, c_balance, c_since   FROM customer WHERE c_w_id = ? AND c_d_id
= ? AND c_id = ?/<!%I|2|!%><!%I|3|!%><!%I|556|!%>
06:41:11,677 tpcw W 15 1 INSERT INTO NEW_ORDER (no_o_id, no_d_id, no_w_id)
VALUES ( ?, ?, ?)/<!%I|3001|!%><!%I|9|!%><!%I|1|!%>
06:41:11,682 tpcw W 16 1 UPDATE district SET d_next_o_id = d_next_o_id + 1
 WHERE d_id = ? AND d_w_id = ?/<!%I|9|!%><!%I|1|!%>
06:41:11,688 tpcw W 17 1 INSERT INTO OORDER  (o_id, o_d_id, o_w_id, o_c_id,
o_entry_d, o_ol_cnt, o_all_local) VALUES (?, ?, ?, ?, ?, ?,
?)/<!%I|3001|!%><!%I|9|!%><!%I|1|!%><!%I|2895|!%><!%T|2011-11-23
06:41:11.687|!%><!%I|15|!%><!%I|1|!%>
06:41:11,736 tpcw S 18 1 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|59171|!%>
06:41:11,792 tpcw S 19 1 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|59171|!%><!%I|1|!%>
06:41:12,065 tpcw W 20 4 UPDATE customer SET c_balance = ? WHERE c_w_id = ?
AND c_d_id = ? AND c_id = ?/<!%F|3784.01|!%><!%I|2|!%><!%I|3|!%><!%I|556|!%>
06:41:12,097 tpcw S 21 1 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|70974|!%>
06:41:14,573 tpcw S 22 1 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|70974|!%><!%I|1|!%>
06:41:14,725 tpcw S 23 1 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|98499|!%>
06:41:14,757 tpcw S 24 1 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|98499|!%><!%I|1|!%>
06:41:14,803 tpcw C 2
06:41:14,830 tpcw B 5
06:41:14,830 tpcw S 25 5 SELECT c_discount, c_last, c_credit, w_tax  FROM
customer, warehouse WHERE w_id = ? AND w_id = c_w_id AND c_d_id = ? AND
c_id = ?/<!%I|1|!%><!%I|6|!%><!%I|1768|!%>
06:41:14,942 tpcw S 26 1 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|13039|!%>
06:41:14,974 tpcw S 27 1 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|13039|!%><!%I|1|!%>
06:41:14,975 tpcw S 28 5 SELECT d_next_o_id, d_tax FROM district WHERE d_id
= ? AND d_w_id = ? FOR UPDATE/<!%I|6|!%><!%I|1|!%>
06:41:14,990 tpcw W 29 5 INSERT INTO NEW_ORDER (no_o_id, no_d_id, no_w_id)
VALUES ( ?, ?, ?)/<!%I|3001|!%><!%I|6|!%><!%I|1|!%>
06:41:15,150 tpcw S 30 1 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|31245|!%>
06:41:15,151 tpcw W 31 5 UPDATE district SET d_next_o_id = d_next_o_id + 1
 WHERE d_id = ? AND d_w_id = ?/<!%I|6|!%><!%I|1|!%>
06:41:15,182 tpcw S 32 1 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|31245|!%><!%I|1|!%>
06:41:15,716 tpcw S 33 1 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|34982|!%>
06:41:16,059 tpcw S 34 1 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|34982|!%><!%I|1|!%>
06:41:16,188 tpcw S 35 1 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|88369|!%>
06:41:16,226 tpcw S 36 1 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|88369|!%><!%I|1|!%>
06:41:16,364 tpcw S 37 1 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|44082|!%>
06:41:16,400 tpcw S 38 1 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|44082|!%><!%I|1|!%>
06:41:16,532 tpcw S 39 1 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|33528|!%>
06:41:16,564 tpcw S 40 1 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|33528|!%><!%I|1|!%>
06:41:16,692 tpcw S 41 1 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|73682|!%>
06:41:16,774 tpcw S 42 1 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|73682|!%><!%I|1|!%>
06:41:16,901 tpcw S 43 1 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|35368|!%>
06:41:16,932 tpcw S 44 1 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|35368|!%><!%I|1|!%>
06:41:17,060 tpcw S 45 1 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|95292|!%>
06:41:17,120 tpcw S 46 1 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|95292|!%><!%I|1|!%>
06:41:17,248 tpcw S 47 1 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|39205|!%>
06:41:17,274 tpcw S 48 1 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|39205|!%><!%I|1|!%>
06:41:17,399 tpcw S 49 1 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|4967|!%>
06:41:17,467 tpcw S 50 1 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|4967|!%><!%I|1|!%>
06:41:17,598 tpcw S 51 1 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|78394|!%>
06:41:17,632 tpcw S 52 1 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|78394|!%><!%I|1|!%>
06:41:17,756 tpcw W 53 1 INSERT INTO order_line (ol_o_id, ol_d_id, ol_w_id,
ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount, ol_dist_info)
VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|9|!%><!%I|1|!%><!%I|1|!%><!%I|59171|!%><!%I|1|!%><!%I|5|!%><!%F|151.40001|!%><!%S|vrcLlgBRQAuvuzOAZJsAzoy
|!%>
06:41:17,842 tpcw W 54 1 INSERT INTO order_line (ol_o_id, ol_d_id, ol_w_id,
ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount, ol_dist_info)
VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|9|!%><!%I|1|!%><!%I|2|!%><!%I|70974|!%><!%I|1|!%><!%I|1|!%><!%F|86.49|!%><!%S|pZcZaRLCyFcnowFdPfxPDBQ
|!%>
06:41:17,844 tpcw W 55 1 INSERT INTO order_line (ol_o_id, ol_d_id, ol_w_id,
ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount, ol_dist_info)
VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|9|!%><!%I|1|!%><!%I|3|!%><!%I|98499|!%><!%I|1|!%><!%I|9|!%><!%F|485.82|!%><!%S|fUWwSWEyPCRMotSjkebxENF
|!%>
06:41:17,857 tpcw W 56 1 INSERT INTO order_line (ol_o_id, ol_d_id, ol_w_id,
ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount, ol_dist_info)
VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|9|!%><!%I|1|!%><!%I|4|!%><!%I|13039|!%><!%I|1|!%><!%I|1|!%><!%F|62.54|!%><!%S|UVHyzcSZfKMYWXcVhVnalwe
|!%>
06:41:17,864 tpcw W 57 1 INSERT INTO order_line (ol_o_id, ol_d_id, ol_w_id,
ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount, ol_dist_info)
VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|9|!%><!%I|1|!%><!%I|5|!%><!%I|31245|!%><!%I|1|!%><!%I|4|!%><!%F|92.72|!%><!%S|ANhLAfQaCQyCeAmdfcDOjEW
|!%>
06:41:17,893 tpcw W 58 1 INSERT INTO order_line (ol_o_id, ol_d_id, ol_w_id,
ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount, ol_dist_info)
VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|9|!%><!%I|1|!%><!%I|6|!%><!%I|34982|!%><!%I|1|!%><!%I|9|!%><!%F|124.65|!%><!%S|oJnlvWOnGqrLqitJIrpjpAQ
|!%>
06:41:17,895 tpcw W 59 1 INSERT INTO order_line (ol_o_id, ol_d_id, ol_w_id,
ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount, ol_dist_info)
VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|9|!%><!%I|1|!%><!%I|7|!%><!%I|88369|!%><!%I|1|!%><!%I|5|!%><!%F|350.75|!%><!%S|WXfySGpUjACkuhDMEFHByHC
|!%>
06:41:17,918 tpcw W 60 1 INSERT INTO order_line (ol_o_id, ol_d_id, ol_w_id,
ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount, ol_dist_info)
VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|9|!%><!%I|1|!%><!%I|8|!%><!%I|44082|!%><!%I|1|!%><!%I|5|!%><!%F|163.0|!%><!%S|oLZuDzfKxwywpPVnuvWIAiN
|!%>
06:41:17,920 tpcw W 61 1 INSERT INTO order_line (ol_o_id, ol_d_id, ol_w_id,
ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount, ol_dist_info)
VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|9|!%><!%I|1|!%><!%I|9|!%><!%I|33528|!%><!%I|1|!%><!%I|7|!%><!%F|546.56|!%><!%S|RXyGsuHakgICtomGgqXONFG
|!%>
06:41:17,953 tpcw W 62 1 INSERT INTO order_line (ol_o_id, ol_d_id, ol_w_id,
ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount, ol_dist_info)
VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|9|!%><!%I|1|!%><!%I|10|!%><!%I|73682|!%><!%I|1|!%><!%I|5|!%><!%F|367.94998|!%><!%S|aKHJsOmlboDMYvZpIKhwyft
|!%>
06:41:17,959 tpcw W 63 1 INSERT INTO order_line (ol_o_id, ol_d_id, ol_w_id,
ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount, ol_dist_info)
VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|9|!%><!%I|1|!%><!%I|11|!%><!%I|35368|!%><!%I|1|!%><!%I|1|!%><!%F|94.42|!%><!%S|CWqYCBPzPvLqwuXYplcNMea
|!%>
06:41:17,971 tpcw W 64 1 INSERT INTO order_line (ol_o_id, ol_d_id, ol_w_id,
ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount, ol_dist_info)
VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|9|!%><!%I|1|!%><!%I|12|!%><!%I|95292|!%><!%I|1|!%><!%I|10|!%><!%F|145.20001|!%><!%S|ChluQKonyYZKGgOWncwbRYk
|!%>
06:41:17,974 tpcw W 65 1 INSERT INTO order_line (ol_o_id, ol_d_id, ol_w_id,
ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount, ol_dist_info)
VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|9|!%><!%I|1|!%><!%I|13|!%><!%I|39205|!%><!%I|1|!%><!%I|4|!%><!%F|270.8|!%><!%S|BBekwNuZBNFQTJlaNfbBDru
|!%>
06:41:17,975 tpcw W 66 1 INSERT INTO order_line (ol_o_id, ol_d_id, ol_w_id,
ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount, ol_dist_info)
VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|9|!%><!%I|1|!%><!%I|14|!%><!%I|4967|!%><!%I|1|!%><!%I|9|!%><!%F|636.12|!%><!%S|xmfTesGnoIfNeySUBFBfvyE
|!%>
06:41:18,000 tpcw W 67 1 INSERT INTO order_line (ol_o_id, ol_d_id, ol_w_id,
ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount, ol_dist_info)
VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|9|!%><!%I|1|!%><!%I|15|!%><!%I|78394|!%><!%I|1|!%><!%I|6|!%><!%F|524.94|!%><!%S|AEWQvhWKeOoBfvkCcwqzYBE
|!%>
06:41:18,010 tpcw W 68 1 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|54|!%><!%I|5|!%><!%I|0|!%><!%I|59171|!%><!%I|1|!%>
06:41:18,733 tpcw W 69 1 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|17|!%><!%I|1|!%><!%I|0|!%><!%I|70974|!%><!%I|1|!%>
06:41:19,511 tpcw W 70 1 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|64|!%><!%I|9|!%><!%I|0|!%><!%I|98499|!%><!%I|1|!%>
06:41:19,725 tpcw W 71 1 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|75|!%><!%I|1|!%><!%I|0|!%><!%I|13039|!%><!%I|1|!%>
06:41:20,272 tpcw W 72 1 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|61|!%><!%I|4|!%><!%I|0|!%><!%I|31245|!%><!%I|1|!%>
06:41:20,440 tpcw W 73 1 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|92|!%><!%I|9|!%><!%I|0|!%><!%I|34982|!%><!%I|1|!%>
06:41:20,550 tpcw S 74 0 SELECT d_next_o_id, d_tax FROM district WHERE d_id
= ? AND d_w_id = ? FOR UPDATE/<!%I|8|!%><!%I|2|!%>
06:41:20,553 tpcw W 75 4 INSERT INTO history (h_c_d_id, h_c_w_id, h_c_id,
h_d_id, h_w_id, h_date, h_amount, h_data)  VALUES
(?,?,?,?,?,?,?,?)/<!%I|3|!%><!%I|2|!%><!%I|556|!%><!%I|3|!%><!%I|2|!%><!%T|2011-11-23
06:41:20.553|!%><!%F|3794.01|!%><!%S|ETnHrIq    RoJeId|!%>
06:41:20,556 tpcw W 76 0 INSERT INTO NEW_ORDER (no_o_id, no_d_id, no_w_id)
VALUES ( ?, ?, ?)/<!%I|3001|!%><!%I|8|!%><!%I|2|!%>
06:41:20,577 tpcw W 77 3 UPDATE customer SET c_balance = ? WHERE c_w_id = ?
AND c_d_id = ? AND c_id =
?/<!%F|2214.39|!%><!%I|1|!%><!%I|7|!%><!%I|2065|!%>
06:41:20,595 tpcw C 4
06:41:20,646 tpcw B 6
06:41:20,646 tpcw W 78 6 UPDATE warehouse SET w_ytd = w_ytd + ?  WHERE w_id
= ?/<!%F|2043.54|!%><!%I|2|!%>
06:41:20,742 tpcw W 79 1 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|63|!%><!%I|5|!%><!%I|0|!%><!%I|88369|!%><!%I|1|!%>
06:41:20,766 tpcw W 80 3 INSERT INTO history (h_c_d_id, h_c_w_id, h_c_id,
h_d_id, h_w_id, h_date, h_amount, h_data)  VALUES
(?,?,?,?,?,?,?,?)/<!%I|7|!%><!%I|1|!%><!%I|2065|!%><!%I|3|!%><!%I|3|!%><!%T|2011-11-23
06:41:20.766|!%><!%F|2224.39|!%><!%S|KSKFA    EHjrv|!%>
06:41:20,791 tpcw C 3
06:41:20,882 tpcw S 81 6 SELECT w_street_1, w_street_2, w_city, w_state,
w_zip, w_name FROM warehouse WHERE w_id = ?/<!%I|2|!%>
06:41:20,885 tpcw B 7
06:41:20,885 tpcw W 82 7 UPDATE warehouse SET w_ytd = w_ytd + ?  WHERE w_id
= ?/<!%F|1346.25|!%><!%I|3|!%>
06:41:20,886 tpcw W 83 6 UPDATE district SET d_ytd = d_ytd + ? WHERE d_w_id
= ? AND d_id = ?/<!%F|2043.54|!%><!%I|2|!%><!%I|2|!%>
06:41:20,982 tpcw S 84 6 SELECT d_street_1, d_street_2, d_city, d_state,
d_zip, d_name FROM district WHERE d_w_id = ? AND d_id =
?/<!%I|2|!%><!%I|2|!%>
06:41:20,984 tpcw W 85 5 INSERT INTO OORDER  (o_id, o_d_id, o_w_id, o_c_id,
o_entry_d, o_ol_cnt, o_all_local) VALUES (?, ?, ?, ?, ?, ?,
?)/<!%I|3001|!%><!%I|6|!%><!%I|1|!%><!%I|1768|!%><!%T|2011-11-23
06:41:20.984|!%><!%I|7|!%><!%I|0|!%>
06:41:21,001 tpcw W 86 0 UPDATE district SET d_next_o_id = d_next_o_id + 1
 WHERE d_id = ? AND d_w_id = ?/<!%I|8|!%><!%I|2|!%>
06:41:21,004 tpcw S 87 5 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|48526|!%>
06:41:21,015 tpcw W 88 1 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|88|!%><!%I|5|!%><!%I|0|!%><!%I|44082|!%><!%I|1|!%>
06:41:21,016 tpcw S 89 6 SELECT c_first, c_middle, c_last, c_street_1,
c_street_2, c_city, c_state, c_zip,       c_phone, c_credit, c_credit_lim,
c_discount, c_balance, c_since   FROM customer WHERE c_w_id = ? AND c_d_id
= ? AND c_id = ?/<!%I|2|!%><!%I|2|!%><!%I|1719|!%>
06:41:21,023 tpcw S 90 7 SELECT w_street_1, w_street_2, w_city, w_state,
w_zip, w_name FROM warehouse WHERE w_id = ?/<!%I|3|!%>
06:41:21,036 tpcw W 91 7 UPDATE district SET d_ytd = d_ytd + ? WHERE d_w_id
= ? AND d_id = ?/<!%F|1346.25|!%><!%I|3|!%><!%I|5|!%>
06:41:21,103 tpcw S 92 5 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|48526|!%><!%I|1|!%>
06:41:21,124 tpcw W 93 6 UPDATE customer SET c_balance = ? WHERE c_w_id = ?
AND c_d_id = ? AND c_id =
?/<!%F|2033.54|!%><!%I|2|!%><!%I|2|!%><!%I|1719|!%>
06:41:21,352 tpcw W 94 6 INSERT INTO history (h_c_d_id, h_c_w_id, h_c_id,
h_d_id, h_w_id, h_date, h_amount, h_data)  VALUES
(?,?,?,?,?,?,?,?)/<!%I|2|!%><!%I|2|!%><!%I|1719|!%><!%I|2|!%><!%I|2|!%><!%T|2011-11-23
06:41:21.351|!%><!%F|2043.54|!%><!%S|ETnHrIq    aCmlVGpTR|!%>
06:41:21,368 tpcw C 6
06:41:21,369 tpcw S 95 5 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|82743|!%>
06:41:21,370 tpcw W 96 0 INSERT INTO OORDER  (o_id, o_d_id, o_w_id, o_c_id,
o_entry_d, o_ol_cnt, o_all_local) VALUES (?, ?, ?, ?, ?, ?,
?)/<!%I|3001|!%><!%I|8|!%><!%I|2|!%><!%I|1673|!%><!%T|2011-11-23
06:41:21.37|!%><!%I|5|!%><!%I|1|!%>
06:41:21,408 tpcw S 97 5 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|82743|!%><!%I|1|!%>
06:41:21,409 tpcw W 98 1 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|13|!%><!%I|7|!%><!%I|0|!%><!%I|33528|!%><!%I|1|!%>
06:41:21,413 tpcw B 8
06:41:21,414 tpcw S 99 8 SELECT c_discount, c_last, c_credit, w_tax  FROM
customer, warehouse WHERE w_id = ? AND w_id = c_w_id AND c_d_id = ? AND
c_id = ?/<!%I|2|!%><!%I|5|!%><!%I|1045|!%>
06:41:21,602 tpcw S 100 8 SELECT d_next_o_id, d_tax FROM district WHERE
d_id = ? AND d_w_id = ? FOR UPDATE/<!%I|5|!%><!%I|2|!%>
06:41:21,613 tpcw W 101 8 INSERT INTO NEW_ORDER (no_o_id, no_d_id, no_w_id)
VALUES ( ?, ?, ?)/<!%I|3001|!%><!%I|5|!%><!%I|2|!%>
06:41:21,644 tpcw S 102 5 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|91839|!%>
06:41:21,673 tpcw S 103 5 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|91839|!%><!%I|1|!%>
06:41:21,803 tpcw S 104 5 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|69174|!%>
06:41:21,818 tpcw W 105 1 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|84|!%><!%I|5|!%><!%I|0|!%><!%I|73682|!%><!%I|1|!%>
06:41:22,103 tpcw W 106 1 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|14|!%><!%I|1|!%><!%I|0|!%><!%I|35368|!%><!%I|1|!%>
06:41:22,250 tpcw S 107 5 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|69174|!%><!%I|3|!%>
06:41:22,381 tpcw S 108 5 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|74595|!%>
06:41:22,398 tpcw W 109 1 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|15|!%><!%I|10|!%><!%I|0|!%><!%I|95292|!%><!%I|1|!%>
06:41:22,420 tpcw S 110 5 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|74595|!%><!%I|1|!%>
06:41:22,654 tpcw S 111 5 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|29433|!%>
06:41:22,719 tpcw W 112 1 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|60|!%><!%I|4|!%><!%I|0|!%><!%I|39205|!%><!%I|1|!%>
06:41:22,905 tpcw S 113 5 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|29433|!%><!%I|1|!%>
06:41:23,026 tpcw W 114 1 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|26|!%><!%I|9|!%><!%I|0|!%><!%I|4967|!%><!%I|1|!%>
06:41:23,037 tpcw S 115 5 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|56570|!%>
06:41:23,097 tpcw S 116 5 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|56570|!%><!%I|1|!%>
06:41:23,309 tpcw W 117 5 INSERT INTO order_line (ol_o_id, ol_d_id,
ol_w_id, ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount,
ol_dist_info) VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|6|!%><!%I|1|!%><!%I|1|!%><!%I|48526|!%><!%I|1|!%><!%I|3|!%><!%F|60.03|!%><!%S|vEVTlEfvRTxqgaLfwqMMktH
|!%>
06:41:23,358 tpcw W 118 1 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|100|!%><!%I|6|!%><!%I|0|!%><!%I|78394|!%><!%I|1|!%>
06:41:23,598 tpcw W 119 5 INSERT INTO order_line (ol_o_id, ol_d_id,
ol_w_id, ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount,
ol_dist_info) VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|6|!%><!%I|1|!%><!%I|2|!%><!%I|82743|!%><!%I|1|!%><!%I|3|!%><!%F|197.94|!%><!%S|jsbuQENoDVDVBOWDrgzFOlk
|!%>
06:41:23,599 tpcw C 1
06:41:23,600 tpcw S 120 7 SELECT d_street_1, d_street_2, d_city, d_state,
d_zip, d_name FROM district WHERE d_w_id = ? AND d_id =
?/<!%I|3|!%><!%I|5|!%>
06:41:23,615 tpcw S 121 0 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|72586|!%>
06:41:23,616 tpcw S 122 7 SELECT c_first, c_middle, c_last, c_street_1,
c_street_2, c_city, c_state, c_zip,       c_phone, c_credit, c_credit_lim,
c_discount, c_balance, c_since   FROM customer WHERE c_w_id = ? AND c_d_id
= ? AND c_id = ?/<!%I|3|!%><!%I|5|!%><!%I|200|!%>
06:41:23,620 tpcw W 123 5 INSERT INTO order_line (ol_o_id, ol_d_id,
ol_w_id, ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount,
ol_dist_info) VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|6|!%><!%I|1|!%><!%I|3|!%><!%I|91839|!%><!%I|1|!%><!%I|4|!%><!%F|4.96|!%><!%S|RKyukJgHBcMRfXlRvJPitjI
|!%>
06:41:23,620 tpcw W 124 8 UPDATE district SET d_next_o_id = d_next_o_id + 1
 WHERE d_id = ? AND d_w_id = ?/<!%I|5|!%><!%I|2|!%>
06:41:23,648 tpcw S 125 0 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|72586|!%><!%I|2|!%>
06:41:23,665 tpcw B 9
06:41:23,667 tpcw W 126 9 UPDATE warehouse SET w_ytd = w_ytd + ?  WHERE
w_id = ?/<!%F|1812.77|!%><!%I|1|!%>
06:41:23,676 tpcw W 127 5 INSERT INTO order_line (ol_o_id, ol_d_id,
ol_w_id, ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount,
ol_dist_info) VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|6|!%><!%I|1|!%><!%I|4|!%><!%I|69174|!%><!%I|3|!%><!%I|9|!%><!%F|806.30994|!%><!%S|JCqsEIPleHcbXsUcyocJOfv
|!%>
06:41:23,692 tpcw W 128 5 INSERT INTO order_line (ol_o_id, ol_d_id,
ol_w_id, ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount,
ol_dist_info) VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|6|!%><!%I|1|!%><!%I|5|!%><!%I|74595|!%><!%I|1|!%><!%I|5|!%><!%F|142.9|!%><!%S|slKonwWQvzHVOtHYjIODLyv
|!%>
06:41:23,704 tpcw W 129 5 INSERT INTO order_line (ol_o_id, ol_d_id,
ol_w_id, ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount,
ol_dist_info) VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|6|!%><!%I|1|!%><!%I|6|!%><!%I|29433|!%><!%I|1|!%><!%I|8|!%><!%F|336.56|!%><!%S|wEmjoexrhJcDFXiWWevsPok
|!%>
06:41:23,740 tpcw W 130 5 INSERT INTO order_line (ol_o_id, ol_d_id,
ol_w_id, ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount,
ol_dist_info) VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|6|!%><!%I|1|!%><!%I|7|!%><!%I|56570|!%><!%I|1|!%><!%I|10|!%><!%F|223.2|!%><!%S|xwOZxAeysVbTilriDmLQzPb
|!%>
06:41:23,776 tpcw W 131 5 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|57|!%><!%I|3|!%><!%I|0|!%><!%I|48526|!%><!%I|1|!%>
06:41:23,841 tpcw S 132 0 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|92253|!%>
06:41:23,841 tpcw W 133 7 UPDATE customer SET c_balance = ? WHERE c_w_id =
? AND c_d_id = ? AND c_id =
?/<!%F|1336.25|!%><!%I|3|!%><!%I|5|!%><!%I|200|!%>
06:41:23,911 tpcw S 134 0 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|92253|!%><!%I|2|!%>
06:41:24,042 tpcw W 135 7 INSERT INTO history (h_c_d_id, h_c_w_id, h_c_id,
h_d_id, h_w_id, h_date, h_amount, h_data)  VALUES
(?,?,?,?,?,?,?,?)/<!%I|5|!%><!%I|3|!%><!%I|200|!%><!%I|5|!%><!%I|3|!%><!%T|2011-11-23
06:41:24.042|!%><!%F|1346.25|!%><!%S|KSKFA    MaPpAIQZ|!%>
06:41:24,057 tpcw C 7
06:41:24,097 tpcw B 10
06:41:24,097 tpcw S 136 10 SELECT c_discount, c_last, c_credit, w_tax  FROM
customer, warehouse WHERE w_id = ? AND w_id = c_w_id AND c_d_id = ? AND
c_id = ?/<!%I|3|!%><!%I|9|!%><!%I|1667|!%>
06:41:24,116 tpcw S 137 0 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|49995|!%>
06:41:24,117 tpcw W 138 8 INSERT INTO OORDER  (o_id, o_d_id, o_w_id,
o_c_id, o_entry_d, o_ol_cnt, o_all_local) VALUES (?, ?, ?, ?, ?, ?,
?)/<!%I|3001|!%><!%I|5|!%><!%I|2|!%><!%I|1045|!%><!%T|2011-11-23
06:41:24.116|!%><!%I|10|!%><!%I|1|!%>
06:41:24,128 tpcw S 139 9 SELECT w_street_1, w_street_2, w_city, w_state,
w_zip, w_name FROM warehouse WHERE w_id = ?/<!%I|1|!%>
06:41:24,130 tpcw W 140 9 UPDATE district SET d_ytd = d_ytd + ? WHERE
d_w_id = ? AND d_id = ?/<!%F|1812.77|!%><!%I|1|!%><!%I|9|!%>
06:41:24,154 tpcw S 141 0 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|49995|!%><!%I|2|!%>
06:41:24,248 tpcw W 142 5 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|52|!%><!%I|3|!%><!%I|0|!%><!%I|82743|!%><!%I|1|!%>
06:41:24,321 tpcw S 143 10 SELECT d_next_o_id, d_tax FROM district WHERE
d_id = ? AND d_w_id = ? FOR UPDATE/<!%I|9|!%><!%I|3|!%>
06:41:24,332 tpcw S 144 0 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|1321|!%>
06:41:24,344 tpcw W 145 10 INSERT INTO NEW_ORDER (no_o_id, no_d_id,
no_w_id) VALUES ( ?, ?, ?)/<!%I|3001|!%><!%I|9|!%><!%I|3|!%>
06:41:24,396 tpcw S 146 0 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|1321|!%><!%I|2|!%>
06:41:24,545 tpcw S 147 0 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|62727|!%>
06:41:24,628 tpcw W 148 5 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|35|!%><!%I|4|!%><!%I|0|!%><!%I|91839|!%><!%I|1|!%>
06:41:24,940 tpcw W 149 5 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|14|!%><!%I|9|!%><!%I|1|!%><!%I|69174|!%><!%I|3|!%>
06:41:25,191 tpcw S 150 0 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|62727|!%><!%I|2|!%>
06:41:25,261 tpcw W 151 5 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|23|!%><!%I|5|!%><!%I|0|!%><!%I|74595|!%><!%I|1|!%>
06:41:25,352 tpcw W 152 0 INSERT INTO order_line (ol_o_id, ol_d_id,
ol_w_id, ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount,
ol_dist_info) VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|8|!%><!%I|2|!%><!%I|1|!%><!%I|72586|!%><!%I|2|!%><!%I|9|!%><!%F|694.71|!%><!%S|igDaNrjkeoNInuCZKxVsObX
|!%>
06:41:25,556 tpcw W 153 0 INSERT INTO order_line (ol_o_id, ol_d_id,
ol_w_id, ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount,
ol_dist_info) VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|8|!%><!%I|2|!%><!%I|2|!%><!%I|92253|!%><!%I|2|!%><!%I|2|!%><!%F|159.6|!%><!%S|gQpOtFaWyBQMJjmFmbCqFzD
|!%>
06:41:25,564 tpcw W 154 5 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|49|!%><!%I|8|!%><!%I|0|!%><!%I|29433|!%><!%I|1|!%>
06:41:25,565 tpcw S 155 8 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|61982|!%>
06:41:25,566 tpcw S 156 9 SELECT d_street_1, d_street_2, d_city, d_state,
d_zip, d_name FROM district WHERE d_w_id = ? AND d_id =
?/<!%I|1|!%><!%I|9|!%>
06:41:25,566 tpcw W 157 10 UPDATE district SET d_next_o_id = d_next_o_id +
1  WHERE d_id = ? AND d_w_id = ?/<!%I|9|!%><!%I|3|!%>
06:41:25,568 tpcw S 158 9 SELECT c_first, c_middle, c_last, c_street_1,
c_street_2, c_city, c_state, c_zip,       c_phone, c_credit, c_credit_lim,
c_discount, c_balance, c_since   FROM customer WHERE c_w_id = ? AND c_d_id
= ? AND c_id = ?/<!%I|1|!%><!%I|9|!%><!%I|1468|!%>
06:41:25,603 tpcw W 159 0 INSERT INTO order_line (ol_o_id, ol_d_id,
ol_w_id, ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount,
ol_dist_info) VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|8|!%><!%I|2|!%><!%I|3|!%><!%I|49995|!%><!%I|2|!%><!%I|2|!%><!%F|30.58|!%><!%S|ePjOMHXSqKkFqNgIHGyVjqr
|!%>
06:41:25,612 tpcw S 160 8 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|61982|!%><!%I|2|!%>
06:41:25,737 tpcw W 161 9 UPDATE customer SET c_balance = ? WHERE c_w_id =
? AND c_d_id = ? AND c_id =
?/<!%F|1802.77|!%><!%I|1|!%><!%I|9|!%><!%I|1468|!%>
06:41:25,913 tpcw W 162 9 INSERT INTO history (h_c_d_id, h_c_w_id, h_c_id,
h_d_id, h_w_id, h_date, h_amount, h_data)  VALUES
(?,?,?,?,?,?,?,?)/<!%I|9|!%><!%I|1|!%><!%I|1468|!%><!%I|9|!%><!%I|1|!%><!%T|2011-11-23
06:41:25.912|!%><!%F|1812.77|!%><!%S|GKSrRrF    AfKRvpkG|!%>
06:41:25,922 tpcw S 163 8 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|99656|!%>
06:41:25,928 tpcw C 9
06:41:25,943 tpcw W 164 0 INSERT INTO order_line (ol_o_id, ol_d_id,
ol_w_id, ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount,
ol_dist_info) VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|8|!%><!%I|2|!%><!%I|4|!%><!%I|1321|!%><!%I|2|!%><!%I|4|!%><!%F|364.64|!%><!%S|ldbeTSMMSfNFyPILvVlCLvY
|!%>
06:41:25,951 tpcw W 165 5 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|61|!%><!%I|10|!%><!%I|0|!%><!%I|56570|!%><!%I|1|!%>
06:41:25,953 tpcw W 166 10 INSERT INTO OORDER  (o_id, o_d_id, o_w_id,
o_c_id, o_entry_d, o_ol_cnt, o_all_local) VALUES (?, ?, ?, ?, ?, ?,
?)/<!%I|3001|!%><!%I|9|!%><!%I|3|!%><!%I|1667|!%><!%T|2011-11-23
06:41:25.952|!%><!%I|6|!%><!%I|1|!%>
06:41:25,958 tpcw W 167 0 INSERT INTO order_line (ol_o_id, ol_d_id,
ol_w_id, ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount,
ol_dist_info) VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|8|!%><!%I|2|!%><!%I|5|!%><!%I|62727|!%><!%I|2|!%><!%I|6|!%><!%F|228.54001|!%><!%S|BrXsDVZCNXYVZkkCKkiwHvm
|!%>
06:41:25,959 tpcw S 168 10 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|1349|!%>
06:41:25,962 tpcw B 11
06:41:25,962 tpcw S 169 11 SELECT d_next_o_id FROM district WHERE d_w_id =
? AND d_id = ?/<!%I|1|!%><!%I|7|!%>
06:41:25,969 tpcw S 170 11 SELECT COUNT(DISTINCT (s_i_id)) AS stock_count
FROM order_line, stock WHERE ol_w_id = ? AND ol_d_id = ? AND ol_o_id < ?
AND ol_o_id >= ? - 20 AND s_w_id = ? AND s_i_id = ol_i_id AND s_quantity <
?/<!%I|1|!%><!%I|7|!%><!%I|3001|!%><!%I|3001|!%><!%I|1|!%><!%I|12|!%>
06:41:26,003 tpcw S 171 10 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|1349|!%><!%I|3|!%>
06:41:26,081 tpcw S 172 8 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|99656|!%><!%I|2|!%>
06:41:26,390 tpcw W 173 0 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|91|!%><!%I|9|!%><!%I|0|!%><!%I|72586|!%><!%I|2|!%>
06:41:26,403 tpcw C 5
06:41:26,412 tpcw S 174 10 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|13580|!%>
06:41:26,450 tpcw B 12
06:41:26,450 tpcw S 175 12 SELECT c_discount, c_last, c_credit, w_tax  FROM
customer, warehouse WHERE w_id = ? AND w_id = c_w_id AND c_d_id = ? AND
c_id = ?/<!%I|1|!%><!%I|4|!%><!%I|1258|!%>
06:41:26,524 tpcw S 176 8 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|13675|!%>
06:41:26,533 tpcw S 177 10 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|13580|!%><!%I|3|!%>
06:41:26,664 tpcw S 178 12 SELECT d_next_o_id, d_tax FROM district WHERE
d_id = ? AND d_w_id = ? FOR UPDATE/<!%I|4|!%><!%I|1|!%>
06:41:26,673 tpcw W 179 12 INSERT INTO NEW_ORDER (no_o_id, no_d_id,
no_w_id) VALUES ( ?, ?, ?)/<!%I|3001|!%><!%I|4|!%><!%I|1|!%>
06:41:26,711 tpcw S 180 8 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|13675|!%><!%I|2|!%>
06:41:26,917 tpcw W 181 0 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|71|!%><!%I|2|!%><!%I|0|!%><!%I|92253|!%><!%I|2|!%>
06:41:26,968 tpcw S 182 10 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|92047|!%>
06:41:27,080 tpcw S 183 10 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|92047|!%><!%I|3|!%>
06:41:27,152 tpcw S 184 8 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|77550|!%>
06:41:27,272 tpcw S 185 8 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|77550|!%><!%I|2|!%>
06:41:27,380 tpcw W 186 0 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|21|!%><!%I|2|!%><!%I|0|!%><!%I|49995|!%><!%I|2|!%>
06:41:27,552 tpcw S 187 10 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|53370|!%>
06:41:27,600 tpcw C 11
06:41:27,633 tpcw B 13
06:41:27,633 tpcw W 188 13 UPDATE warehouse SET w_ytd = w_ytd + ?  WHERE
w_id = ?/<!%F|56.68|!%><!%I|1|!%>
06:41:27,679 tpcw S 189 10 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|53370|!%><!%I|3|!%>
06:41:27,680 tpcw S 190 13 SELECT w_street_1, w_street_2, w_city, w_state,
w_zip, w_name FROM warehouse WHERE w_id = ?/<!%I|1|!%>
06:41:27,681 tpcw W 191 13 UPDATE district SET d_ytd = d_ytd + ? WHERE
d_w_id = ? AND d_id = ?/<!%F|56.68|!%><!%I|1|!%><!%I|4|!%>
06:41:27,703 tpcw S 192 8 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|32582|!%>
06:41:27,801 tpcw S 193 8 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|32582|!%><!%I|2|!%>
06:41:27,802 tpcw W 194 0 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|82|!%><!%I|4|!%><!%I|0|!%><!%I|1321|!%><!%I|2|!%>
06:41:28,004 tpcw S 195 10 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|78070|!%>
06:41:28,104 tpcw S 196 8 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|31606|!%>
06:41:28,132 tpcw S 197 8 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|31606|!%><!%I|2|!%>
06:41:28,204 tpcw S 198 10 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|78070|!%><!%I|3|!%>
06:41:28,224 tpcw W 199 0 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|56|!%><!%I|6|!%><!%I|0|!%><!%I|62727|!%><!%I|2|!%>
06:41:28,308 tpcw S 200 8 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|91812|!%>
06:41:28,464 tpcw S 201 10 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|51823|!%>
06:41:28,491 tpcw S 202 10 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|51823|!%><!%I|3|!%>
06:41:28,586 tpcw C 0
06:41:28,628 tpcw W 203 10 INSERT INTO order_line (ol_o_id, ol_d_id,
ol_w_id, ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount,
ol_dist_info) VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|9|!%><!%I|3|!%><!%I|1|!%><!%I|1349|!%><!%I|3|!%><!%I|4|!%><!%F|98.72|!%><!%S|sevNRneweZgcwvXQwFwaqdS
|!%>
06:41:28,664 tpcw B 14
06:41:28,664 tpcw W 204 14 UPDATE warehouse SET w_ytd = w_ytd + ?  WHERE
w_id = ?/<!%F|4539.02|!%><!%I|2|!%>
06:41:28,675 tpcw S 205 8 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|91812|!%><!%I|2|!%>
06:41:28,808 tpcw S 206 8 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|59456|!%>
06:41:28,909 tpcw W 207 10 INSERT INTO order_line (ol_o_id, ol_d_id,
ol_w_id, ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount,
ol_dist_info) VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|9|!%><!%I|3|!%><!%I|2|!%><!%I|13580|!%><!%I|3|!%><!%I|5|!%><!%F|304.55|!%><!%S|sVqkDqmGOQjkwAwGjxmvoeL
|!%>
06:41:28,912 tpcw W 208 10 INSERT INTO order_line (ol_o_id, ol_d_id,
ol_w_id, ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount,
ol_dist_info) VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|9|!%><!%I|3|!%><!%I|3|!%><!%I|92047|!%><!%I|3|!%><!%I|1|!%><!%F|22.47|!%><!%S|RjKFPtkJltyRDmvXImLCrgq
|!%>
06:41:28,941 tpcw W 209 12 UPDATE district SET d_next_o_id = d_next_o_id +
1  WHERE d_id = ? AND d_w_id = ?/<!%I|4|!%><!%I|1|!%>
06:41:28,942 tpcw W 210 10 INSERT INTO order_line (ol_o_id, ol_d_id,
ol_w_id, ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount,
ol_dist_info) VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|9|!%><!%I|3|!%><!%I|4|!%><!%I|53370|!%><!%I|3|!%><!%I|7|!%><!%F|295.12|!%><!%S|umNbLolmLjPAgWBVpYwlJAG
|!%>
06:41:28,956 tpcw W 211 10 INSERT INTO order_line (ol_o_id, ol_d_id,
ol_w_id, ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount,
ol_dist_info) VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|9|!%><!%I|3|!%><!%I|5|!%><!%I|78070|!%><!%I|3|!%><!%I|1|!%><!%F|4.32|!%><!%S|dcqflZPdKXeMPGUWROCmARG
|!%>
06:41:28,968 tpcw W 212 10 INSERT INTO order_line (ol_o_id, ol_d_id,
ol_w_id, ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount,
ol_dist_info) VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|9|!%><!%I|3|!%><!%I|6|!%><!%I|51823|!%><!%I|3|!%><!%I|9|!%><!%F|288.27|!%><!%S|qekRXBGXlonhrWsRHImUEIb
|!%>
06:41:28,972 tpcw W 213 10 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd
+ ?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|91|!%><!%I|4|!%><!%I|0|!%><!%I|1349|!%><!%I|3|!%>
06:41:29,010 tpcw S 214 8 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|59456|!%><!%I|2|!%>
06:41:29,240 tpcw S 215 8 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|64935|!%>
06:41:29,268 tpcw S 216 8 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|64935|!%><!%I|2|!%>
06:41:29,318 tpcw W 217 10 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd
+ ?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|76|!%><!%I|5|!%><!%I|0|!%><!%I|13580|!%><!%I|3|!%>
06:41:29,471 tpcw S 218 8 SELECT i_price, i_name , i_data FROM item WHERE
i_id = ?/<!%I|26020|!%>
06:41:29,571 tpcw W 219 10 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd
+ ?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|84|!%><!%I|1|!%><!%I|0|!%><!%I|92047|!%><!%I|3|!%>
06:41:29,644 tpcw S 220 8 SELECT s_quantity, s_data, s_dist_01, s_dist_02,
s_dist_03, s_dist_04, s_dist_05,        s_dist_06, s_dist_07, s_dist_08,
s_dist_09, s_dist_10 FROM stock WHERE s_i_id = ? AND s_w_id = ? FOR
UPDATE/<!%I|26020|!%><!%I|2|!%>
06:41:29,820 tpcw W 221 8 INSERT INTO order_line (ol_o_id, ol_d_id,
ol_w_id, ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount,
ol_dist_info) VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|5|!%><!%I|2|!%><!%I|1|!%><!%I|61982|!%><!%I|2|!%><!%I|7|!%><!%F|653.94|!%><!%S|tYvrZXhwISlEvrvhFbvHYou
|!%>
06:41:29,899 tpcw W 222 10 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd
+ ?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|47|!%><!%I|7|!%><!%I|0|!%><!%I|53370|!%><!%I|3|!%>
06:41:30,101 tpcw W 223 10 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd
+ ?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|70|!%><!%I|1|!%><!%I|0|!%><!%I|78070|!%><!%I|3|!%>
06:41:30,275 tpcw W 224 10 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd
+ ?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|76|!%><!%I|9|!%><!%I|0|!%><!%I|51823|!%><!%I|3|!%>
06:41:30,418 tpcw C 10
06:41:30,432 tpcw W 225 8 INSERT INTO order_line (ol_o_id, ol_d_id,
ol_w_id, ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount,
ol_dist_info) VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|5|!%><!%I|2|!%><!%I|2|!%><!%I|99656|!%><!%I|2|!%><!%I|2|!%><!%F|132.56|!%><!%S|vHfWLTJHoLolyupcuTAOTnI
|!%>
06:41:30,433 tpcw B 15
06:41:30,433 tpcw S 226 15 SELECT c_discount, c_last, c_credit, w_tax  FROM
customer, warehouse WHERE w_id = ? AND w_id = c_w_id AND c_d_id = ? AND
c_id = ?/<!%I|3|!%><!%I|2|!%><!%I|2751|!%>
06:41:30,447 tpcw W 227 8 INSERT INTO order_line (ol_o_id, ol_d_id,
ol_w_id, ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount,
ol_dist_info) VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|5|!%><!%I|2|!%><!%I|3|!%><!%I|13675|!%><!%I|2|!%><!%I|5|!%><!%F|106.95|!%><!%S|sZsDKLyxyqhIEYVIfwhinqV
|!%>
06:41:30,453 tpcw W 228 8 INSERT INTO order_line (ol_o_id, ol_d_id,
ol_w_id, ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount,
ol_dist_info) VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|5|!%><!%I|2|!%><!%I|4|!%><!%I|77550|!%><!%I|2|!%><!%I|9|!%><!%F|540.36|!%><!%S|iABrztaqeNsOWamhrfcrfyr
|!%>
06:41:30,460 tpcw W 229 8 INSERT INTO order_line (ol_o_id, ol_d_id,
ol_w_id, ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount,
ol_dist_info) VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|5|!%><!%I|2|!%><!%I|5|!%><!%I|32582|!%><!%I|2|!%><!%I|7|!%><!%F|488.60004|!%><!%S|KdiLjjxccjHrSQjNAUtZNBn
|!%>
06:41:30,489 tpcw W 230 8 INSERT INTO order_line (ol_o_id, ol_d_id,
ol_w_id, ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount,
ol_dist_info) VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|5|!%><!%I|2|!%><!%I|6|!%><!%I|31606|!%><!%I|2|!%><!%I|1|!%><!%F|48.08|!%><!%S|BKlOYSFUoUAfSRVixsDNxMS
|!%>
06:41:30,500 tpcw S 231 15 SELECT d_next_o_id, d_tax FROM district WHERE
d_id = ? AND d_w_id = ? FOR UPDATE/<!%I|2|!%><!%I|3|!%>
06:41:30,501 tpcw W 232 8 INSERT INTO order_line (ol_o_id, ol_d_id,
ol_w_id, ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount,
ol_dist_info) VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|5|!%><!%I|2|!%><!%I|7|!%><!%I|91812|!%><!%I|2|!%><!%I|10|!%><!%F|515.4|!%><!%S|bzRngWVKpGKAOkImHPHzGan
|!%>
06:41:30,512 tpcw W 233 15 INSERT INTO NEW_ORDER (no_o_id, no_d_id,
no_w_id) VALUES ( ?, ?, ?)/<!%I|3001|!%><!%I|2|!%><!%I|3|!%>
06:41:30,517 tpcw W 234 8 INSERT INTO order_line (ol_o_id, ol_d_id,
ol_w_id, ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount,
ol_dist_info) VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|5|!%><!%I|2|!%><!%I|8|!%><!%I|59456|!%><!%I|2|!%><!%I|10|!%><!%F|274.8|!%><!%S|qKRBoYrEBVokJIufYReGJKA
|!%>
06:41:30,519 tpcw W 235 8 INSERT INTO order_line (ol_o_id, ol_d_id,
ol_w_id, ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount,
ol_dist_info) VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|5|!%><!%I|2|!%><!%I|9|!%><!%I|64935|!%><!%I|2|!%><!%I|4|!%><!%F|346.8|!%><!%S|IusEFfalAzThjupMOvhMdrY
|!%>
06:41:30,522 tpcw W 236 8 INSERT INTO order_line (ol_o_id, ol_d_id,
ol_w_id, ol_number, ol_i_id, ol_supply_w_id,  ol_quantity, ol_amount,
ol_dist_info) VALUES
(?,?,?,?,?,?,?,?,?)/<!%I|3001|!%><!%I|5|!%><!%I|2|!%><!%I|10|!%><!%I|26020|!%><!%I|2|!%><!%I|6|!%><!%F|558.24|!%><!%S|AVzcvSzbfnSZaVxldoJEJIb
|!%>
06:41:30,524 tpcw W 237 8 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|45|!%><!%I|7|!%><!%I|0|!%><!%I|61982|!%><!%I|2|!%>
06:41:30,681 tpcw W 238 8 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|81|!%><!%I|2|!%><!%I|0|!%><!%I|99656|!%><!%I|2|!%>
06:41:30,824 tpcw W 239 8 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|63|!%><!%I|5|!%><!%I|0|!%><!%I|13675|!%><!%I|2|!%>
06:41:30,969 tpcw W 240 8 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|78|!%><!%I|9|!%><!%I|0|!%><!%I|77550|!%><!%I|2|!%>
06:41:31,116 tpcw W 241 8 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|37|!%><!%I|7|!%><!%I|0|!%><!%I|32582|!%><!%I|2|!%>
06:41:31,289 tpcw W 242 8 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|59|!%><!%I|1|!%><!%I|0|!%><!%I|31606|!%><!%I|2|!%>
06:41:31,433 tpcw W 243 8 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|45|!%><!%I|10|!%><!%I|0|!%><!%I|91812|!%><!%I|2|!%>
06:41:31,576 tpcw W 244 8 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|83|!%><!%I|10|!%><!%I|0|!%><!%I|59456|!%><!%I|2|!%>
06:41:31,720 tpcw W 245 8 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|39|!%><!%I|4|!%><!%I|0|!%><!%I|64935|!%><!%I|2|!%>
06:41:31,864 tpcw W 246 8 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd +
?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
?/<!%I|69|!%><!%I|6|!%><!%I|0|!%><!%I|26020|!%><!%I|2|!%>
06:41:32,008 tpcw C 8
06:41:32,018 tpcw B 16
06:41:32,018 tpcw S 247 16 SELECT d_next_o_id FROM district WHERE d_w_id =
? AND d_id = ?/<!%I|2|!%><!%I|3|!%>
06:41:32,019 tpcw S 248 16 SELECT COUNT(DISTINCT (s_i_id)) AS stock_count
FROM order_line, stock WHERE ol_w_id = ? AND ol_d_id = ? AND ol_o_id < ?
AND ol_o_id >= ? - 20 AND s_w_id = ? AND s_i_id = ol_i_id AND s_quantity <
?/<!%I|2|!%><!%I|3|!%><!%I|3001|!%><!%I|3001|!%><!%I|2|!%><!%I|12|!%>
06:41:32,421 tpcw C 16
06:41:32,424 tpcw B 17
06:41:32,424 tpcw S 249 17 SELECT c_discount, c_last, c_credit, w_tax  FROM
customer, warehouse WHERE w_id = ? AND w_id = c_w_id AND c_d_id = ? AND
c_id = ?/<!%I|2|!%><!%I|2|!%><!%I|1676|!%>
06:41:32,487 tpcw S 250 17 SELECT d_next_o_id, d_tax FROM district WHERE
d_id = ? AND d_w_id = ? FOR UPDATE/<!%I|2|!%><!%I|2|!%>
06:41:32,489 tpcw W 251 17 INSERT INTO NEW_ORDER (no_o_id, no_d_id,
no_w_id) VALUES ( ?, ?, ?)/<!%I|3001|!%><!%I|2|!%><!%I|2|!%>

On Wed, Nov 23, 2011 at 3:09 PM, Emmanuel Cecchet <ce...@gm...> wrote:

>  Hi,
>
> From your log it looks like everyone is waiting for that transaction 65 to
> either commit or rollback.
> If your thread has crashed and there is no rollback or connection closing
> in a catch block, all the locks are going to be retained forever (thought
> there is a possibility to set timeout on transactions in the load balancer
> settings if I recall).
> Without the log of the exact requests, it's hard to tell you more than
> that.
>
> Keep us posted with your findings,
> Emmanuel
>
>
> On 11/23/2011 06:30, rohit dhamane wrote:
>
> Hi,
>
>  I have been facing some problem with sequoia. I am trying to run
> BenchmarkSql-2.3 (http://sourceforge.net/projects/benchmarksql/) with
> sequoia over two postgresql-7.3 servers but it seems to get stuck
> indefinitely at the same point. I think it's happening because of the
> SELECT...FOR UPDATE but not really sure how :( It seems that the
> transactions are getting into a deadlock. Here's the out put when I turned
> on the debug mode.
>
>  02:56:49,388 DEBUG controller.core.PingResponder Received ping data from
> /127.0.0.1
> 02:56:49,388 DEBUG controller.core.PingResponder Response to ping sent to /
> 127.0.0.1
> 02:56:49,775 DEBUG sequoia.controller.loadbalancer Building wait-for
> graph...
> 02:56:49,776 DEBUG sequoia.controller.loadbalancer new_order locked by 64
> 02:56:49,777 DEBUG sequoia.controller.loadbalancer district locked by 65
> 02:56:49,777 DEBUG sequoia.controller.loadbalancer warehouse locked by 65
> 02:56:49,777 DEBUG sequoia.controller.loadbalancer Walking wait-for
> graph...
> 02:56:49,778 DEBUG sequoia.controller.loadbalancer 64 waits for district
> locked by 65
> 02:56:49,779 DEBUG sequoia.controller.loadbalancer 68 waits for new_order
> locked by 64
> 02:56:49,779 DEBUG sequoia.controller.loadbalancer     64 waits for
> district locked by 65
> 02:56:49,779 DEBUG sequoia.controller.loadbalancer 67 waits for warehouse
> locked by 65
> 02:56:49,779 DEBUG sequoia.controller.loadbalancer 66 waits for new_order
> locked by 64
> 02:56:49,779 DEBUG sequoia.controller.loadbalancer     64 waits for
> district locked by 65
> 02:56:49,779 DEBUG sequoia.controller.loadbalancer Choosing victim node...
> 02:56:49,779 DEBUG sequoia.controller.loadbalancer 0 cycles detected
> 02:56:49,779 DEBUG sequoia.controller.loadbalancer No victim
> 02:56:50,389 DEBUG controller.core.PingResponder Received ping data from /
> 127.0.0.1
> 02:56:50,389 DEBUG controller.core.PingResponder Response to ping sent to /
> 127.0.0.1
>
>
>
>  Here's my configuration file..
>
>  <?xml version="1.0" encoding="UTF-8"?>^M
> <!DOCTYPE SEQUOIA PUBLIC "-//Continuent//DTD SEQUOIA @VERSION@//EN" "
> http://sequoia.continuent.org/dtds/sequoia-@VERSION@.dtd">^M
> ^M
> <SEQUOIA>^M
> ^M
>   <VirtualDatabase name="tpcw">^M
> ^M
>     <AuthenticationManager>^M
>       <Admin>^M
>         <User username="postgres" password=""/>^M
>       </Admin> ^M
>       <VirtualUsers>^M
>         <VirtualLogin vLogin="postgres" vPassword=""/>^M
>       </VirtualUsers>^M
>     </AuthenticationManager>^M
> ^M
>     <DatabaseBackend name="localhost" driver="org.postgresql.Driver"
> driverPath="/home/rohit/Software/CJDBC/sequoia-2.10.10-bin/drivers/postgresql7.3.jar"
> url="jdbc:postgresql://localhost:6551/tpcw" connectionTestStatement="select
> now()">^M
>
>        <ConnectionManager vLogin="postgres" rLogin="postgres"
> rPassword="">^M
>         <VariablePoolConnectionManager initPoolSize="20" minPoolSize="5"
> maxPoolSize="0" idleTimeout="180" waitTimeout="0"/>^M
>       </ConnectionManager>^M
>     </DatabaseBackend>^M
> ^M
>     <DatabaseBackend name="Remote" driver="org.postgresql.Driver"
> driverPath="/home/rohit/Software/CJDBC/sequoia-2.10.10-bin/drivers/postgresql7.3.jar"
> url="jdbc:postgresql://192.168.164.136:6552/tpcw"
> connectionTestStatement="select now()">^M
>       <ConnectionManager vLogin="postgres" rLogin="postgres"
> rPassword="">^M
>         <VariablePoolConnectionManager initPoolSize="20" minPoolSize="5"
> maxPoolSize="0" idleTimeout="180" waitTimeout="0"/>^M
>       </ConnectionManager>^M
>     </DatabaseBackend>^M
>      <RequestManager>^M
>       <RequestScheduler>^M
>          <RAIDb-1Scheduler level="passThrough"/>^M
>       </RequestScheduler>^M
> ^M
>       <RequestCache>^M
>          <MetadataCache/>^M
>          <ParsingCache/>                 ^M
>          <ResultCache granularity="table" />^M
>       </RequestCache>^M
> ^M
>       <LoadBalancer transactionIsolation="serializable">^M
>          <RAIDb-1>^M
>             <WaitForCompletion policy="all"
>             deadlockTimeoutInMs="30000"/>^M
>             <RAIDb-1-RoundRobin/>^M
>          </RAIDb-1>^M
>       </LoadBalancer>^M
>      </RequestManager>^M
> ^M
>   </VirtualDatabase>^M
> ^M
> </SEQUOIA>^M
>
>  If anybody has anu idea why this happens please let me know. I would
> appreciate it a lot. Thanks in advance.
>
>  Regards,
> Rohit
>
>
> ------------------------------------------------------------------------------
> All the data continuously generated in your IT infrastructure
> contains a definitive record of customers, application performance,
> security threats, fraudulent activity, and more. Splunk takes this
> data and makes sense of it. IT sense. And common sense.http://p.sf.net/sfu/splunk-novd2d
>
>
>
> _______________________________________________
> Sequoiadb-discuss mailing lis...@li...https://lists.sourceforge.net/lists/listinfo/sequoiadb-discuss
>
>
>

Re: [Sequoiadb-discuss] Sequoia gets stuck (probably) because of SELECT...FOR UPDATE

[Emmanuel C. <ce...@gm...>]

Hi,

 From your log it looks like everyone is waiting for that transaction 65 
to either commit or rollback.
If your thread has crashed and there is no rollback or connection 
closing in a catch block, all the locks are going to be retained forever 
(thought there is a possibility to set timeout on transactions in the 
load balancer settings if I recall).
Without the log of the exact requests, it's hard to tell you more than that.

Keep us posted with your findings,
Emmanuel

On 11/23/2011 06:30, rohit dhamane wrote:
> Hi,
>
> I have been facing some problem with sequoia. I am trying to run 
> BenchmarkSql-2.3 (http://sourceforge.net/projects/benchmarksql/) with 
> sequoia over two postgresql-7.3 servers but it seems to get stuck 
> indefinitely at the same point. I think it's happening because of the 
> SELECT...FOR UPDATE but not really sure how :( It seems that the 
> transactions are getting into a deadlock. Here's the out put when I 
> turned on the debug mode.
>
> 02:56:49,388 DEBUG controller.core.PingResponder Received ping data 
> from /127.0.0.1 <http://127.0.0.1>
> 02:56:49,388 DEBUG controller.core.PingResponder Response to ping sent 
> to /127.0.0.1 <http://127.0.0.1>
> 02:56:49,775 DEBUG sequoia.controller.loadbalancer Building wait-for 
> graph...
> 02:56:49,776 DEBUG sequoia.controller.loadbalancer new_order locked by 64
> 02:56:49,777 DEBUG sequoia.controller.loadbalancer district locked by 65
> 02:56:49,777 DEBUG sequoia.controller.loadbalancer warehouse locked by 65
> 02:56:49,777 DEBUG sequoia.controller.loadbalancer Walking wait-for 
> graph...
> 02:56:49,778 DEBUG sequoia.controller.loadbalancer 64 waits for 
> district locked by 65
> 02:56:49,779 DEBUG sequoia.controller.loadbalancer 68 waits for 
> new_order locked by 64
> 02:56:49,779 DEBUG sequoia.controller.loadbalancer     64 waits for 
> district locked by 65
> 02:56:49,779 DEBUG sequoia.controller.loadbalancer 67 waits for 
> warehouse locked by 65
> 02:56:49,779 DEBUG sequoia.controller.loadbalancer 66 waits for 
> new_order locked by 64
> 02:56:49,779 DEBUG sequoia.controller.loadbalancer     64 waits for 
> district locked by 65
> 02:56:49,779 DEBUG sequoia.controller.loadbalancer Choosing victim node...
> 02:56:49,779 DEBUG sequoia.controller.loadbalancer 0 cycles detected
> 02:56:49,779 DEBUG sequoia.controller.loadbalancer No victim
> 02:56:50,389 DEBUG controller.core.PingResponder Received ping data 
> from /127.0.0.1 <http://127.0.0.1>
> 02:56:50,389 DEBUG controller.core.PingResponder Response to ping sent 
> to /127.0.0.1 <http://127.0.0.1>
>
>
>
> Here's my configuration file..
>
> <?xml version="1.0" encoding="UTF-8"?>^M
> <!DOCTYPE SEQUOIA PUBLIC "-//Continuent//DTD SEQUOIA @VERSION@//EN" 
> "http://sequoia.continuent.org/dtds/sequoia-@VERSION@.dtd">^M
> ^M
> <SEQUOIA>^M
> ^M
> <VirtualDatabase name="tpcw">^M
> ^M
> <AuthenticationManager>^M
> <Admin>^M
> <User username="postgres" password=""/>^M
> </Admin> ^M
> <VirtualUsers>^M
> <VirtualLogin vLogin="postgres" vPassword=""/>^M
> </VirtualUsers>^M
> </AuthenticationManager>^M
> ^M
> <DatabaseBackend name="localhost" driver="org.postgresql.Driver" 
> driverPath="/home/rohit/Software/CJDBC/sequoia-2.10.10-bin/drivers/postgresql7.3.jar" 
> url="jdbc:postgresql://localhost:6551/tpcw" 
> connectionTestStatement="select now()">^M
>
> <ConnectionManager vLogin="postgres" rLogin="postgres" rPassword="">^M
> <VariablePoolConnectionManager initPoolSize="20" minPoolSize="5" 
> maxPoolSize="0" idleTimeout="180" waitTimeout="0"/>^M
> </ConnectionManager>^M
> </DatabaseBackend>^M
> ^M
> <DatabaseBackend name="Remote" driver="org.postgresql.Driver" 
> driverPath="/home/rohit/Software/CJDBC/sequoia-2.10.10-bin/drivers/postgresql7.3.jar" 
> url="jdbc:postgresql://192.168.164.136:6552/tpcw 
> <http://192.168.164.136:6552/tpcw>" connectionTestStatement="select 
> now()">^M
> <ConnectionManager vLogin="postgres" rLogin="postgres" rPassword="">^M
> <VariablePoolConnectionManager initPoolSize="20" minPoolSize="5" 
> maxPoolSize="0" idleTimeout="180" waitTimeout="0"/>^M
> </ConnectionManager>^M
> </DatabaseBackend>^M
> <RequestManager>^M
> <RequestScheduler>^M
> <RAIDb-1Scheduler level="passThrough"/>^M
> </RequestScheduler>^M
> ^M
> <RequestCache>^M
> <MetadataCache/>^M
> <ParsingCache/>                 ^M
> <ResultCache granularity="table" />^M
> </RequestCache>^M
> ^M
> <LoadBalancer transactionIsolation="serializable">^M
> <RAIDb-1>^M
> <WaitForCompletion policy="all"
>             deadlockTimeoutInMs="30000"/>^M
> <RAIDb-1-RoundRobin/>^M
> </RAIDb-1>^M
> </LoadBalancer>^M
> </RequestManager>^M
> ^M
> </VirtualDatabase>^M
> ^M
> </SEQUOIA>^M
>
> If anybody has anu idea why this happens please let me know. I would 
> appreciate it a lot. Thanks in advance.
>
> Regards,
> Rohit
>
>
> ------------------------------------------------------------------------------
> All the data continuously generated in your IT infrastructure
> contains a definitive record of customers, application performance,
> security threats, fraudulent activity, and more. Splunk takes this
> data and makes sense of it. IT sense. And common sense.
> http://p.sf.net/sfu/splunk-novd2d
>
>
> _______________________________________________
> Sequoiadb-discuss mailing list
> Seq...@li...
> https://lists.sourceforge.net/lists/listinfo/sequoiadb-discuss

Re: [Sequoiadb-discuss] Sequoia gets stuck (probably) because of SELECT...FOR UPDATE

[Emmanuel C. <ce...@gm...>]

Hi,

 From your log it looks like everyone is waiting for that transaction 65 
to either commit or rollback.
If your thread has crashed and there is no rollback or connection 
closing in a catch block, all the locks are going to be retained forever 
(thought there is a possibility to set timeout on transactions in the 
load balancer settings if I recall).
Without the log of the exact requests, it's hard to tell you more than that.

Keep us posted with your findings,
Emmanuel

On 11/23/2011 06:30, rohit dhamane wrote:
> Hi,
>
> I have been facing some problem with sequoia. I am trying to run 
> BenchmarkSql-2.3 (http://sourceforge.net/projects/benchmarksql/) with 
> sequoia over two postgresql-7.3 servers but it seems to get stuck 
> indefinitely at the same point. I think it's happening because of the 
> SELECT...FOR UPDATE but not really sure how :( It seems that the 
> transactions are getting into a deadlock. Here's the out put when I 
> turned on the debug mode.
>
> 02:56:49,388 DEBUG controller.core.PingResponder Received ping data 
> from /127.0.0.1 <http://127.0.0.1>
> 02:56:49,388 DEBUG controller.core.PingResponder Response to ping sent 
> to /127.0.0.1 <http://127.0.0.1>
> 02:56:49,775 DEBUG sequoia.controller.loadbalancer Building wait-for 
> graph...
> 02:56:49,776 DEBUG sequoia.controller.loadbalancer new_order locked by 64
> 02:56:49,777 DEBUG sequoia.controller.loadbalancer district locked by 65
> 02:56:49,777 DEBUG sequoia.controller.loadbalancer warehouse locked by 65
> 02:56:49,777 DEBUG sequoia.controller.loadbalancer Walking wait-for 
> graph...
> 02:56:49,778 DEBUG sequoia.controller.loadbalancer 64 waits for 
> district locked by 65
> 02:56:49,779 DEBUG sequoia.controller.loadbalancer 68 waits for 
> new_order locked by 64
> 02:56:49,779 DEBUG sequoia.controller.loadbalancer     64 waits for 
> district locked by 65
> 02:56:49,779 DEBUG sequoia.controller.loadbalancer 67 waits for 
> warehouse locked by 65
> 02:56:49,779 DEBUG sequoia.controller.loadbalancer 66 waits for 
> new_order locked by 64
> 02:56:49,779 DEBUG sequoia.controller.loadbalancer     64 waits for 
> district locked by 65
> 02:56:49,779 DEBUG sequoia.controller.loadbalancer Choosing victim node...
> 02:56:49,779 DEBUG sequoia.controller.loadbalancer 0 cycles detected
> 02:56:49,779 DEBUG sequoia.controller.loadbalancer No victim
> 02:56:50,389 DEBUG controller.core.PingResponder Received ping data 
> from /127.0.0.1 <http://127.0.0.1>
> 02:56:50,389 DEBUG controller.core.PingResponder Response to ping sent 
> to /127.0.0.1 <http://127.0.0.1>
>
>
>
> Here's my configuration file..
>
> <?xml version="1.0" encoding="UTF-8"?>^M
> <!DOCTYPE SEQUOIA PUBLIC "-//Continuent//DTD SEQUOIA @VERSION@//EN" 
> "http://sequoia.continuent.org/dtds/sequoia-@VERSION@.dtd">^M
> ^M
> <SEQUOIA>^M
> ^M
> <VirtualDatabase name="tpcw">^M
> ^M
> <AuthenticationManager>^M
> <Admin>^M
> <User username="postgres" password=""/>^M
> </Admin> ^M
> <VirtualUsers>^M
> <VirtualLogin vLogin="postgres" vPassword=""/>^M
> </VirtualUsers>^M
> </AuthenticationManager>^M
> ^M
> <DatabaseBackend name="localhost" driver="org.postgresql.Driver" 
> driverPath="/home/rohit/Software/CJDBC/sequoia-2.10.10-bin/drivers/postgresql7.3.jar" 
> url="jdbc:postgresql://localhost:6551/tpcw" 
> connectionTestStatement="select now()">^M
>
> <ConnectionManager vLogin="postgres" rLogin="postgres" rPassword="">^M
> <VariablePoolConnectionManager initPoolSize="20" minPoolSize="5" 
> maxPoolSize="0" idleTimeout="180" waitTimeout="0"/>^M
> </ConnectionManager>^M
> </DatabaseBackend>^M
> ^M
> <DatabaseBackend name="Remote" driver="org.postgresql.Driver" 
> driverPath="/home/rohit/Software/CJDBC/sequoia-2.10.10-bin/drivers/postgresql7.3.jar" 
> url="jdbc:postgresql://192.168.164.136:6552/tpcw 
> <http://192.168.164.136:6552/tpcw>" connectionTestStatement="select 
> now()">^M
> <ConnectionManager vLogin="postgres" rLogin="postgres" rPassword="">^M
> <VariablePoolConnectionManager initPoolSize="20" minPoolSize="5" 
> maxPoolSize="0" idleTimeout="180" waitTimeout="0"/>^M
> </ConnectionManager>^M
> </DatabaseBackend>^M
> <RequestManager>^M
> <RequestScheduler>^M
> <RAIDb-1Scheduler level="passThrough"/>^M
> </RequestScheduler>^M
> ^M
> <RequestCache>^M
> <MetadataCache/>^M
> <ParsingCache/>                 ^M
> <ResultCache granularity="table" />^M
> </RequestCache>^M
> ^M
> <LoadBalancer transactionIsolation="serializable">^M
> <RAIDb-1>^M
> <WaitForCompletion policy="all"
>             deadlockTimeoutInMs="30000"/>^M
> <RAIDb-1-RoundRobin/>^M
> </RAIDb-1>^M
> </LoadBalancer>^M
> </RequestManager>^M
> ^M
> </VirtualDatabase>^M
> ^M
> </SEQUOIA>^M
>
> If anybody has anu idea why this happens please let me know. I would 
> appreciate it a lot. Thanks in advance.
>
> Regards,
> Rohit
>
>
> ------------------------------------------------------------------------------
> All the data continuously generated in your IT infrastructure
> contains a definitive record of customers, application performance,
> security threats, fraudulent activity, and more. Splunk takes this
> data and makes sense of it. IT sense. And common sense.
> http://p.sf.net/sfu/splunk-novd2d
>
>
> _______________________________________________
> Sequoiadb-discuss mailing list
> Seq...@li...
> https://lists.sourceforge.net/lists/listinfo/sequoiadb-discuss

Re: [Sequoiadb-discuss] Sequoia gets stuck (probably) because of SELECT...FOR UPDATE

[Emmanuel C. <ce...@gm...>]

Hi,
> Thank you very much for your quick reply emmanuel.  I have already 
> tried setting the timeout in load balancer but it doesn't work for me 
> I guess :(
> I have been facing this problem with the SELECT.. FOR UPDATE 
> statements. While going through the source code of sequoia I found 
> this in
> sequoia-2.10.10-src/src/org/continuent/sequoia/controller/requests/SelectRequest.java 
>
>
> public class SelectRequest extends AbstractRequest implements Serializable
> {
>   private static final long      serialVersionUID = 6498520472410320514L;
>
> /**
>    * Set to true if this SelectRequest must be broadcasted on the cluster
>    * (useful for queries like SELECT FOR UPDATE
>    */
>   private boolean                mustBroadcast    =false; <Line 76>
>
> Do I have to change mustBroadcast to true and recompile the sequoia to 
> enable it to do SELECT...FOR UPDATE ?
No this value is automatically set by the parser. When the select 
statement is parsed, it is considered as a write on the table and is 
broadcast to all databases to acquire a write lock.
>
> Also, here's the request log from a similar test (it again got stuck 
> at same point) .
> I apologize for copy pasting the entire log here.
>
> 06:42:10,221 DEBUG controller.core.PingResponder Response to ping sent 
> to /127.0.0.1 <http://127.0.0.1>
> 06:42:11,207 DEBUG controller.core.PingResponder Received ping data 
> from /127.0.0.1 <http://127.0.0.1>
> 06:42:11,207 DEBUG controller.core.PingResponder Response to ping sent 
> to /127.0.0.1 <http://127.0.0.1>
> 06:42:12,351 DEBUG sequoia.controller.loadbalancer Building wait-for 
> graph...
> 06:42:12,352 DEBUG sequoia.controller.loadbalancer warehouse locked by 13
> 06:42:12,352 DEBUG sequoia.controller.loadbalancer new_order locked by 12
> 06:42:12,352 DEBUG sequoia.controller.loadbalancer district locked by 13
> 06:42:12,352 DEBUG sequoia.controller.loadbalancer Walking wait-for 
> graph...
> 06:42:12,352 DEBUG sequoia.controller.loadbalancer 17 waits for 
> new_order locked by 12
> 06:42:12,352 DEBUG sequoia.controller.loadbalancer     12 waits for 
> district locked by 13
> 06:42:12,352 DEBUG sequoia.controller.loadbalancer 15 waits for 
> new_order locked by 12
> 06:42:12,352 DEBUG sequoia.controller.loadbalancer     12 waits for 
> district locked by 13
> 06:42:12,352 DEBUG sequoia.controller.loadbalancer 14 waits for 
> warehouse locked by 13
> 06:42:12,352 DEBUG sequoia.controller.loadbalancer Choosing victim node...
> 06:42:12,352 DEBUG sequoia.controller.loadbalancer 0 cycles detected
> 06:42:12,352 DEBUG sequoia.controller.loadbalancer No victim
Looks like transaction 13 is not completing. I have reduced your log to 
the incriminating transactions below:
>
> *_Request.log_*
>
> 06:41:26,450 tpcw B 12
> 06:41:26,450 tpcw S 175 12 SELECT c_discount, c_last, c_credit, w_tax 
>  FROM customer, warehouse WHERE w_id = ? AND w_id = c_w_id AND c_d_id 
> = ? AND c_id = ?/<!%I|1|!%><!%I|4|!%><!%I|1258|!%>
> 06:41:26,664 tpcw S 178 12 SELECT d_next_o_id, d_tax FROM district 
> WHERE d_id = ? AND d_w_id = ? FOR UPDATE/<!%I|4|!%><!%I|1|!%>
> 06:41:26,673 tpcw W 179 12 INSERT INTO NEW_ORDER (no_o_id, no_d_id, 
> no_w_id) VALUES ( ?, ?, ?)/<!%I|3001|!%><!%I|4|!%><!%I|1|!%>
> 06:41:26,917 tpcw W 181 0 UPDATE stock SET s_quantity = ? , s_ytd = 
> s_ytd + ?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND 
> s_w_id = ?/<!%I|71|!%><!%I|2|!%><!%I|0|!%><!%I|92253|!%><!%I|2|!%>
> 06:41:27,633 tpcw B 13
> 06:41:27,633 tpcw W 188 13 UPDATE warehouse SET w_ytd = w_ytd + ? 
>  WHERE w_id = ?/<!%F|56.68|!%><!%I|1|!%>
> 06:41:27,680 tpcw S 190 13 SELECT w_street_1, w_street_2, w_city, 
> w_state, w_zip, w_name FROM warehouse WHERE w_id = ?/<!%I|1|!%>
> 06:41:27,681 tpcw W 191 13 UPDATE district SET d_ytd = d_ytd + ? WHERE 
> d_w_id = ? AND d_id = ?/<!%F|56.68|!%><!%I|1|!%><!%I|4|!%>
> 06:41:28,664 tpcw B 14
> 06:41:28,664 tpcw W 204 14 UPDATE warehouse SET w_ytd = w_ytd + ? 
>  WHERE w_id = ?/<!%F|4539.02|!%><!%I|2|!%>
> 06:41:30,433 tpcw B 15
> 06:41:30,433 tpcw S 226 15 SELECT c_discount, c_last, c_credit, w_tax 
>  FROM customer, warehouse WHERE w_id = ? AND w_id = c_w_id AND c_d_id 
> = ? AND c_id = ?/<!%I|3|!%><!%I|2|!%><!%I|2751|!%>
> 06:41:30,500 tpcw S 231 15 SELECT d_next_o_id, d_tax FROM district 
> WHERE d_id = ? AND d_w_id = ? FOR UPDATE/<!%I|2|!%><!%I|3|!%>
> 06:41:30,512 tpcw W 233 15 INSERT INTO NEW_ORDER (no_o_id, no_d_id, 
> no_w_id) VALUES ( ?, ?, ?)/<!%I|3001|!%><!%I|2|!%><!%I|3|!%>
> 06:41:32,424 tpcw B 17
> 06:41:32,424 tpcw S 249 17 SELECT c_discount, c_last, c_credit, w_tax 
>  FROM customer, warehouse WHERE w_id = ? AND w_id = c_w_id AND c_d_id 
> = ? AND c_id = ?/<!%I|2|!%><!%I|2|!%><!%I|1676|!%>
> 06:41:32,487 tpcw S 250 17 SELECT d_next_o_id, d_tax FROM district 
> WHERE d_id = ? AND d_w_id = ? FOR UPDATE/<!%I|2|!%><!%I|2|!%>
> 06:41:32,489 tpcw W 251 17 INSERT INTO NEW_ORDER (no_o_id, no_d_id, 
> no_w_id) VALUES ( ?, ?, ?)/<!%I|3001|!%><!%I|2|!%><!%I|2|!%>

I found the problem. The lock that transaction 12 acquired on the 
district table (in its select for update) has not been properly added 
and the deadlock has not been detected.
So on one side, Sequoia has a bug with not properly updating its lock 
table on this select for update (the query parsing code might have an 
issue).
On the other side, your transactions are not serializable and they 
deadlock (the application should be fixed). By serialiazing writes per 
table, Sequoia exposes these bugs faster than if you were running 
directly on top of the database (but you should be able to obtain the 
same deadlock directly on the database). Actually is stuck on the 
database deadlock. I don't remember if the version of Postgres you are 
using has a global transaction timeout that you can set so that Postgres 
would kill the deadlocked transactions itself (quick fix).

Hope this helps
Emmanuel

>
> On Wed, Nov 23, 2011 at 3:09 PM, Emmanuel Cecchet <ce...@gm... 
> <mailto:ce...@gm...>> wrote:
>
>     Hi,
>
>     From your log it looks like everyone is waiting for that
>     transaction 65 to either commit or rollback.
>     If your thread has crashed and there is no rollback or connection
>     closing in a catch block, all the locks are going to be retained
>     forever (thought there is a possibility to set timeout on
>     transactions in the load balancer settings if I recall).
>     Without the log of the exact requests, it's hard to tell you more
>     than that.
>
>     Keep us posted with your findings,
>     Emmanuel
>
>
>     On 11/23/2011 06:30, rohit dhamane wrote:
>>     Hi,
>>
>>     I have been facing some problem with sequoia. I am trying to run
>>     BenchmarkSql-2.3
>>     (http://sourceforge.net/projects/benchmarksql/) with sequoia over
>>     two postgresql-7.3 servers but it seems to get stuck indefinitely
>>     at the same point. I think it's happening because of the
>>     SELECT...FOR UPDATE but not really sure how :( It seems that the
>>     transactions are getting into a deadlock. Here's the out put when
>>     I turned on the debug mode.
>>
>>     02:56:49,388 DEBUG controller.core.PingResponder Received ping
>>     data from /127.0.0.1 <http://127.0.0.1>
>>     02:56:49,388 DEBUG controller.core.PingResponder Response to ping
>>     sent to /127.0.0.1 <http://127.0.0.1>
>>     02:56:49,775 DEBUG sequoia.controller.loadbalancer Building
>>     wait-for graph...
>>     02:56:49,776 DEBUG sequoia.controller.loadbalancer new_order
>>     locked by 64
>>     02:56:49,777 DEBUG sequoia.controller.loadbalancer district
>>     locked by 65
>>     02:56:49,777 DEBUG sequoia.controller.loadbalancer warehouse
>>     locked by 65
>>     02:56:49,777 DEBUG sequoia.controller.loadbalancer Walking
>>     wait-for graph...
>>     02:56:49,778 DEBUG sequoia.controller.loadbalancer 64 waits for
>>     district locked by 65
>>     02:56:49,779 DEBUG sequoia.controller.loadbalancer 68 waits for
>>     new_order locked by 64
>>     02:56:49,779 DEBUG sequoia.controller.loadbalancer     64 waits
>>     for district locked by 65
>>     02:56:49,779 DEBUG sequoia.controller.loadbalancer 67 waits for
>>     warehouse locked by 65
>>     02:56:49,779 DEBUG sequoia.controller.loadbalancer 66 waits for
>>     new_order locked by 64
>>     02:56:49,779 DEBUG sequoia.controller.loadbalancer     64 waits
>>     for district locked by 65
>>     02:56:49,779 DEBUG sequoia.controller.loadbalancer Choosing
>>     victim node...
>>     02:56:49,779 DEBUG sequoia.controller.loadbalancer 0 cycles detected
>>     02:56:49,779 DEBUG sequoia.controller.loadbalancer No victim
>>     02:56:50,389 DEBUG controller.core.PingResponder Received ping
>>     data from /127.0.0.1 <http://127.0.0.1>
>>     02:56:50,389 DEBUG controller.core.PingResponder Response to ping
>>     sent to /127.0.0.1 <http://127.0.0.1>
>>
>>
>>
>>     Here's my configuration file..
>>
>>     <?xml version="1.0" encoding="UTF-8"?>^M
>>     <!DOCTYPE SEQUOIA PUBLIC "-//Continuent//DTD SEQUOIA
>>     @VERSION@//EN"
>>     "http://sequoia.continuent.org/dtds/sequoia-@VERSION@.dtd">^M
>>     ^M
>>     <SEQUOIA>^M
>>     ^M
>>     <VirtualDatabase name="tpcw">^M
>>     ^M
>>     <AuthenticationManager>^M
>>     <Admin>^M
>>     <User username="postgres" password=""/>^M
>>     </Admin> ^M
>>     <VirtualUsers>^M
>>     <VirtualLogin vLogin="postgres" vPassword=""/>^M
>>     </VirtualUsers>^M
>>     </AuthenticationManager>^M
>>     ^M
>>     <DatabaseBackend name="localhost" driver="org.postgresql.Driver"
>>     driverPath="/home/rohit/Software/CJDBC/sequoia-2.10.10-bin/drivers/postgresql7.3.jar"
>>     url="jdbc:postgresql://localhost:6551/tpcw"
>>     connectionTestStatement="select now()">^M
>>
>>     <ConnectionManager vLogin="postgres" rLogin="postgres"
>>     rPassword="">^M
>>     <VariablePoolConnectionManager initPoolSize="20" minPoolSize="5"
>>     maxPoolSize="0" idleTimeout="180" waitTimeout="0"/>^M
>>     </ConnectionManager>^M
>>     </DatabaseBackend>^M
>>     ^M
>>     <DatabaseBackend name="Remote" driver="org.postgresql.Driver"
>>     driverPath="/home/rohit/Software/CJDBC/sequoia-2.10.10-bin/drivers/postgresql7.3.jar"
>>     url="jdbc:postgresql://192.168.164.136:6552/tpcw
>>     <http://192.168.164.136:6552/tpcw>"
>>     connectionTestStatement="select now()">^M
>>     <ConnectionManager vLogin="postgres" rLogin="postgres"
>>     rPassword="">^M
>>     <VariablePoolConnectionManager initPoolSize="20" minPoolSize="5"
>>     maxPoolSize="0" idleTimeout="180" waitTimeout="0"/>^M
>>     </ConnectionManager>^M
>>     </DatabaseBackend>^M
>>     <RequestManager>^M
>>     <RequestScheduler>^M
>>     <RAIDb-1Scheduler level="passThrough"/>^M
>>     </RequestScheduler>^M
>>     ^M
>>     <RequestCache>^M
>>     <MetadataCache/>^M
>>     <ParsingCache/>                 ^M
>>     <ResultCache granularity="table" />^M
>>     </RequestCache>^M
>>     ^M
>>     <LoadBalancer transactionIsolation="serializable">^M
>>     <RAIDb-1>^M
>>     <WaitForCompletion policy="all"
>>                 deadlockTimeoutInMs="30000"/>^M
>>     <RAIDb-1-RoundRobin/>^M
>>     </RAIDb-1>^M
>>     </LoadBalancer>^M
>>     </RequestManager>^M
>>     ^M
>>     </VirtualDatabase>^M
>>     ^M
>>     </SEQUOIA>^M
>>
>>     If anybody has anu idea why this happens please let me know. I
>>     would appreciate it a lot. Thanks in advance.
>>
>>     Regards,
>>     Rohit
>>
>>
>>     ------------------------------------------------------------------------------
>>     All the data continuously generated in your IT infrastructure
>>     contains a definitive record of customers, application performance,
>>     security threats, fraudulent activity, and more. Splunk takes this
>>     data and makes sense of it. IT sense. And common sense.
>>     http://p.sf.net/sfu/splunk-novd2d
>>
>>
>>     _______________________________________________
>>     Sequoiadb-discuss mailing list
>>     Seq...@li...  <mailto:Seq...@li...>
>>     https://lists.sourceforge.net/lists/listinfo/sequoiadb-discuss
>
>

Re: [Sequoiadb-discuss] Sequoia gets stuck (probably) because of SELECT...FOR UPDATE

[rohit d. <roh...@gm...>]

Hi Emmanuel,
Thanks a lot. That was really helpful reply. I will try to fix the issue
with my client application  and see is it works.

Regards,
Rohit

On Wed, Nov 23, 2011 at 5:21 PM, Emmanuel Cecchet <ce...@gm...> wrote:

>  Hi,
>
> Thank you very much for your quick reply emmanuel.  I have already tried
> setting the timeout in load balancer but it doesn't work for me I guess :(
> I have been facing this problem with the SELECT.. FOR UPDATE statements.
> While going through the source code of sequoia I found this in
>
> sequoia-2.10.10-src/src/org/continuent/sequoia/controller/requests/SelectRequest.java
>
>  public class SelectRequest extends AbstractRequest implements
> Serializable
> {
>   private static final long      serialVersionUID = 6498520472410320514L;
>
>    /**
>    * Set to true if this SelectRequest must be broadcasted on the cluster
>    * (useful for queries like SELECT FOR UPDATE
>    */
>   private boolean                mustBroadcast    = false;
>             <Line 76>
>
>  Do I have to change mustBroadcast to true and recompile the sequoia to
> enable it to do SELECT...FOR UPDATE ?
>
> No this value is automatically set by the parser. When the select
> statement is parsed, it is considered as a write on the table and is
> broadcast to all databases to acquire a write lock.
>
>
>  Also, here's the request log from a similar test (it again got stuck at
> same point) .
> I apologize for copy pasting the entire log here.
>
>  06:42:10,221 DEBUG controller.core.PingResponder Response to ping sent
> to /127.0.0.1
> 06:42:11,207 DEBUG controller.core.PingResponder Received ping data from /
> 127.0.0.1
> 06:42:11,207 DEBUG controller.core.PingResponder Response to ping sent to /
> 127.0.0.1
> 06:42:12,351 DEBUG sequoia.controller.loadbalancer Building wait-for
> graph...
> 06:42:12,352 DEBUG sequoia.controller.loadbalancer warehouse locked by 13
> 06:42:12,352 DEBUG sequoia.controller.loadbalancer new_order locked by 12
> 06:42:12,352 DEBUG sequoia.controller.loadbalancer district locked by 13
> 06:42:12,352 DEBUG sequoia.controller.loadbalancer Walking wait-for
> graph...
> 06:42:12,352 DEBUG sequoia.controller.loadbalancer 17 waits for new_order
> locked by 12
> 06:42:12,352 DEBUG sequoia.controller.loadbalancer     12 waits for
> district locked by 13
> 06:42:12,352 DEBUG sequoia.controller.loadbalancer 15 waits for new_order
> locked by 12
> 06:42:12,352 DEBUG sequoia.controller.loadbalancer     12 waits for
> district locked by 13
> 06:42:12,352 DEBUG sequoia.controller.loadbalancer 14 waits for warehouse
> locked by 13
> 06:42:12,352 DEBUG sequoia.controller.loadbalancer Choosing victim node...
> 06:42:12,352 DEBUG sequoia.controller.loadbalancer 0 cycles detected
> 06:42:12,352 DEBUG sequoia.controller.loadbalancer No victim
>
> Looks like transaction 13 is not completing. I have reduced your log to
> the incriminating transactions below:
>
>
>  *Request.log*
>
> 06:41:26,450 tpcw B 12
> 06:41:26,450 tpcw S 175 12 SELECT c_discount, c_last, c_credit, w_tax
>  FROM customer, warehouse WHERE w_id = ? AND w_id = c_w_id AND c_d_id = ?
> AND c_id = ?/<!%I|1|!%><!%I|4|!%><!%I|1258|!%>
> 06:41:26,664 tpcw S 178 12 SELECT d_next_o_id, d_tax FROM district WHERE
> d_id = ? AND d_w_id = ? FOR UPDATE/<!%I|4|!%><!%I|1|!%>
> 06:41:26,673 tpcw W 179 12 INSERT INTO NEW_ORDER (no_o_id, no_d_id,
> no_w_id) VALUES ( ?, ?, ?)/<!%I|3001|!%><!%I|4|!%><!%I|1|!%>
> 06:41:26,917 tpcw W 181 0 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd
> + ?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
> ?/<!%I|71|!%><!%I|2|!%><!%I|0|!%><!%I|92253|!%><!%I|2|!%>
> 06:41:27,633 tpcw B 13
> 06:41:27,633 tpcw W 188 13 UPDATE warehouse SET w_ytd = w_ytd + ?  WHERE
> w_id = ?/<!%F|56.68|!%><!%I|1|!%>
> 06:41:27,680 tpcw S 190 13 SELECT w_street_1, w_street_2, w_city, w_state,
> w_zip, w_name FROM warehouse WHERE w_id = ?/<!%I|1|!%>
> 06:41:27,681 tpcw W 191 13 UPDATE district SET d_ytd = d_ytd + ? WHERE
> d_w_id = ? AND d_id = ?/<!%F|56.68|!%><!%I|1|!%><!%I|4|!%>
> 06:41:28,664 tpcw B 14
> 06:41:28,664 tpcw W 204 14 UPDATE warehouse SET w_ytd = w_ytd + ?  WHERE
> w_id = ?/<!%F|4539.02|!%><!%I|2|!%>
> 06:41:30,433 tpcw B 15
> 06:41:30,433 tpcw S 226 15 SELECT c_discount, c_last, c_credit, w_tax
>  FROM customer, warehouse WHERE w_id = ? AND w_id = c_w_id AND c_d_id = ?
> AND c_id = ?/<!%I|3|!%><!%I|2|!%><!%I|2751|!%>
> 06:41:30,500 tpcw S 231 15 SELECT d_next_o_id, d_tax FROM district WHERE
> d_id = ? AND d_w_id = ? FOR UPDATE/<!%I|2|!%><!%I|3|!%>
> 06:41:30,512 tpcw W 233 15 INSERT INTO NEW_ORDER (no_o_id, no_d_id,
> no_w_id) VALUES ( ?, ?, ?)/<!%I|3001|!%><!%I|2|!%><!%I|3|!%>
> 06:41:32,424 tpcw B 17
> 06:41:32,424 tpcw S 249 17 SELECT c_discount, c_last, c_credit, w_tax
>  FROM customer, warehouse WHERE w_id = ? AND w_id = c_w_id AND c_d_id = ?
> AND c_id = ?/<!%I|2|!%><!%I|2|!%><!%I|1676|!%>
> 06:41:32,487 tpcw S 250 17 SELECT d_next_o_id, d_tax FROM district WHERE
> d_id = ? AND d_w_id = ? FOR UPDATE/<!%I|2|!%><!%I|2|!%>
> 06:41:32,489 tpcw W 251 17 INSERT INTO NEW_ORDER (no_o_id, no_d_id,
> no_w_id) VALUES ( ?, ?, ?)/<!%I|3001|!%><!%I|2|!%><!%I|2|!%>
>
>
> I found the problem. The lock that transaction 12 acquired on the district
> table (in its select for update) has not been properly added and the
> deadlock has not been detected.
> So on one side, Sequoia has a bug with not properly updating its lock
> table on this select for update (the query parsing code might have an
> issue).
> On the other side, your transactions are not serializable and they
> deadlock (the application should be fixed). By serialiazing writes per
> table, Sequoia exposes these bugs faster than if you were running directly
> on top of the database (but you should be able to obtain the same deadlock
> directly on the database). Actually is stuck on the database deadlock. I
> don't remember if the version of Postgres you are using has a global
> transaction timeout that you can set so that Postgres would kill the
> deadlocked transactions itself (quick fix).
>
> Hope this helps
> Emmanuel
>
>
>
> On Wed, Nov 23, 2011 at 3:09 PM, Emmanuel Cecchet <ce...@gm...>wrote:
>
>>  Hi,
>>
>> From your log it looks like everyone is waiting for that transaction 65
>> to either commit or rollback.
>> If your thread has crashed and there is no rollback or connection closing
>> in a catch block, all the locks are going to be retained forever (thought
>> there is a possibility to set timeout on transactions in the load balancer
>> settings if I recall).
>> Without the log of the exact requests, it's hard to tell you more than
>> that.
>>
>> Keep us posted with your findings,
>> Emmanuel
>>
>>
>> On 11/23/2011 06:30, rohit dhamane wrote:
>>
>>  Hi,
>>
>>  I have been facing some problem with sequoia. I am trying to run
>> BenchmarkSql-2.3 (http://sourceforge.net/projects/benchmarksql/) with
>> sequoia over two postgresql-7.3 servers but it seems to get stuck
>> indefinitely at the same point. I think it's happening because of the
>> SELECT...FOR UPDATE but not really sure how :( It seems that the
>> transactions are getting into a deadlock. Here's the out put when I turned
>> on the debug mode.
>>
>>  02:56:49,388 DEBUG controller.core.PingResponder Received ping data
>> from /127.0.0.1
>> 02:56:49,388 DEBUG controller.core.PingResponder Response to ping sent to
>> /127.0.0.1
>> 02:56:49,775 DEBUG sequoia.controller.loadbalancer Building wait-for
>> graph...
>> 02:56:49,776 DEBUG sequoia.controller.loadbalancer new_order locked by 64
>> 02:56:49,777 DEBUG sequoia.controller.loadbalancer district locked by 65
>> 02:56:49,777 DEBUG sequoia.controller.loadbalancer warehouse locked by 65
>> 02:56:49,777 DEBUG sequoia.controller.loadbalancer Walking wait-for
>> graph...
>> 02:56:49,778 DEBUG sequoia.controller.loadbalancer 64 waits for district
>> locked by 65
>> 02:56:49,779 DEBUG sequoia.controller.loadbalancer 68 waits for new_order
>> locked by 64
>> 02:56:49,779 DEBUG sequoia.controller.loadbalancer     64 waits for
>> district locked by 65
>> 02:56:49,779 DEBUG sequoia.controller.loadbalancer 67 waits for warehouse
>> locked by 65
>> 02:56:49,779 DEBUG sequoia.controller.loadbalancer 66 waits for new_order
>> locked by 64
>> 02:56:49,779 DEBUG sequoia.controller.loadbalancer     64 waits for
>> district locked by 65
>> 02:56:49,779 DEBUG sequoia.controller.loadbalancer Choosing victim node...
>> 02:56:49,779 DEBUG sequoia.controller.loadbalancer 0 cycles detected
>> 02:56:49,779 DEBUG sequoia.controller.loadbalancer No victim
>> 02:56:50,389 DEBUG controller.core.PingResponder Received ping data from /
>> 127.0.0.1
>> 02:56:50,389 DEBUG controller.core.PingResponder Response to ping sent to
>> /127.0.0.1
>>
>>
>>
>>  Here's my configuration file..
>>
>>  <?xml version="1.0" encoding="UTF-8"?>^M
>> <!DOCTYPE SEQUOIA PUBLIC "-//Continuent//DTD SEQUOIA @VERSION@//EN" "
>> http://sequoia.continuent.org/dtds/sequoia-@VERSION@.dtd">^M
>> ^M
>> <SEQUOIA>^M
>> ^M
>>   <VirtualDatabase name="tpcw">^M
>> ^M
>>     <AuthenticationManager>^M
>>       <Admin>^M
>>         <User username="postgres" password=""/>^M
>>       </Admin> ^M
>>       <VirtualUsers>^M
>>         <VirtualLogin vLogin="postgres" vPassword=""/>^M
>>       </VirtualUsers>^M
>>     </AuthenticationManager>^M
>> ^M
>>     <DatabaseBackend name="localhost" driver="org.postgresql.Driver"
>> driverPath="/home/rohit/Software/CJDBC/sequoia-2.10.10-bin/drivers/postgresql7.3.jar"
>> url="jdbc:postgresql://localhost:6551/tpcw" connectionTestStatement="select
>> now()">^M
>>
>>        <ConnectionManager vLogin="postgres" rLogin="postgres"
>> rPassword="">^M
>>         <VariablePoolConnectionManager initPoolSize="20" minPoolSize="5"
>> maxPoolSize="0" idleTimeout="180" waitTimeout="0"/>^M
>>       </ConnectionManager>^M
>>     </DatabaseBackend>^M
>> ^M
>>     <DatabaseBackend name="Remote" driver="org.postgresql.Driver"
>> driverPath="/home/rohit/Software/CJDBC/sequoia-2.10.10-bin/drivers/postgresql7.3.jar"
>> url="jdbc:postgresql://192.168.164.136:6552/tpcw"
>> connectionTestStatement="select now()">^M
>>       <ConnectionManager vLogin="postgres" rLogin="postgres"
>> rPassword="">^M
>>         <VariablePoolConnectionManager initPoolSize="20" minPoolSize="5"
>> maxPoolSize="0" idleTimeout="180" waitTimeout="0"/>^M
>>       </ConnectionManager>^M
>>     </DatabaseBackend>^M
>>      <RequestManager>^M
>>       <RequestScheduler>^M
>>          <RAIDb-1Scheduler level="passThrough"/>^M
>>       </RequestScheduler>^M
>> ^M
>>       <RequestCache>^M
>>          <MetadataCache/>^M
>>          <ParsingCache/>                 ^M
>>          <ResultCache granularity="table" />^M
>>       </RequestCache>^M
>> ^M
>>       <LoadBalancer transactionIsolation="serializable">^M
>>          <RAIDb-1>^M
>>             <WaitForCompletion policy="all"
>>             deadlockTimeoutInMs="30000"/>^M
>>             <RAIDb-1-RoundRobin/>^M
>>          </RAIDb-1>^M
>>       </LoadBalancer>^M
>>      </RequestManager>^M
>> ^M
>>   </VirtualDatabase>^M
>> ^M
>> </SEQUOIA>^M
>>
>>  If anybody has anu idea why this happens please let me know. I would
>> appreciate it a lot. Thanks in advance.
>>
>>  Regards,
>> Rohit
>>
>>
>>  ------------------------------------------------------------------------------
>> All the data continuously generated in your IT infrastructure
>> contains a definitive record of customers, application performance,
>> security threats, fraudulent activity, and more. Splunk takes this
>> data and makes sense of it. IT sense. And common sense.http://p.sf.net/sfu/splunk-novd2d
>>
>>
>>
>> _______________________________________________
>> Sequoiadb-discuss mailing lis...@li...https://lists.sourceforge.net/lists/listinfo/sequoiadb-discuss
>>
>>
>>
>
>

Re: [Sequoiadb-discuss] Sequoia gets stuck (probably) because of SELECT...FOR UPDATE

[rohit d. <roh...@gm...>]

Hi,

I tried to make changes to my client code and also tried running the
transactions in serializable isolation level. Although some of the
transaction were getting aborted whenever there were conflicts, but in the
end it still got stuck again.
I have set up the deadlock timeout in postgres but still it doesn't seem to
work. I tried running this with different versions of postgres (postgres
7.2, 7.3, 8.0 and 9.0) but no use.
So I guess it's probably because of the bug in Sequoia. It can not handle
the SELECT...FOR UPDATE statements properly and it needs to be taken care
of. Does anyone know how to report the bug for sequoia?
You can check this problem by running BenchmarkSql-2.3 (
http://sourceforge.net/projects/benchmarksql/) with Sequoia and two
postgres servers. Please let me know if there is any progress in this
regard. thank you very much for all the help.

Regards,
Rohit

On Wed, Nov 23, 2011 at 5:28 PM, rohit dhamane <roh...@gm...>wrote:

> Hi Emmanuel,
> Thanks a lot. That was really helpful reply. I will try to fix the issue
> with my client application  and see is it works.
>
> Regards,
> Rohit
>
>
> On Wed, Nov 23, 2011 at 5:21 PM, Emmanuel Cecchet <ce...@gm...>wrote:
>
>>  Hi,
>>
>> Thank you very much for your quick reply emmanuel.  I have already tried
>> setting the timeout in load balancer but it doesn't work for me I guess :(
>> I have been facing this problem with the SELECT.. FOR UPDATE statements.
>> While going through the source code of sequoia I found this in
>>
>> sequoia-2.10.10-src/src/org/continuent/sequoia/controller/requests/SelectRequest.java
>>
>>  public class SelectRequest extends AbstractRequest implements
>> Serializable
>> {
>>   private static final long      serialVersionUID = 6498520472410320514L;
>>
>>    /**
>>    * Set to true if this SelectRequest must be broadcasted on the cluster
>>    * (useful for queries like SELECT FOR UPDATE
>>    */
>>   private boolean                mustBroadcast    = false;
>>             <Line 76>
>>
>>  Do I have to change mustBroadcast to true and recompile the sequoia to
>> enable it to do SELECT...FOR UPDATE ?
>>
>> No this value is automatically set by the parser. When the select
>> statement is parsed, it is considered as a write on the table and is
>> broadcast to all databases to acquire a write lock.
>>
>>
>>  Also, here's the request log from a similar test (it again got stuck at
>> same point) .
>> I apologize for copy pasting the entire log here.
>>
>>  06:42:10,221 DEBUG controller.core.PingResponder Response to ping sent
>> to /127.0.0.1
>> 06:42:11,207 DEBUG controller.core.PingResponder Received ping data from /
>> 127.0.0.1
>> 06:42:11,207 DEBUG controller.core.PingResponder Response to ping sent to
>> /127.0.0.1
>> 06:42:12,351 DEBUG sequoia.controller.loadbalancer Building wait-for
>> graph...
>> 06:42:12,352 DEBUG sequoia.controller.loadbalancer warehouse locked by 13
>> 06:42:12,352 DEBUG sequoia.controller.loadbalancer new_order locked by 12
>> 06:42:12,352 DEBUG sequoia.controller.loadbalancer district locked by 13
>> 06:42:12,352 DEBUG sequoia.controller.loadbalancer Walking wait-for
>> graph...
>> 06:42:12,352 DEBUG sequoia.controller.loadbalancer 17 waits for new_order
>> locked by 12
>> 06:42:12,352 DEBUG sequoia.controller.loadbalancer     12 waits for
>> district locked by 13
>> 06:42:12,352 DEBUG sequoia.controller.loadbalancer 15 waits for new_order
>> locked by 12
>> 06:42:12,352 DEBUG sequoia.controller.loadbalancer     12 waits for
>> district locked by 13
>> 06:42:12,352 DEBUG sequoia.controller.loadbalancer 14 waits for warehouse
>> locked by 13
>> 06:42:12,352 DEBUG sequoia.controller.loadbalancer Choosing victim node...
>> 06:42:12,352 DEBUG sequoia.controller.loadbalancer 0 cycles detected
>> 06:42:12,352 DEBUG sequoia.controller.loadbalancer No victim
>>
>> Looks like transaction 13 is not completing. I have reduced your log to
>> the incriminating transactions below:
>>
>>
>>  *Request.log*
>>
>> 06:41:26,450 tpcw B 12
>> 06:41:26,450 tpcw S 175 12 SELECT c_discount, c_last, c_credit, w_tax
>>  FROM customer, warehouse WHERE w_id = ? AND w_id = c_w_id AND c_d_id = ?
>> AND c_id = ?/<!%I|1|!%><!%I|4|!%><!%I|1258|!%>
>> 06:41:26,664 tpcw S 178 12 SELECT d_next_o_id, d_tax FROM district WHERE
>> d_id = ? AND d_w_id = ? FOR UPDATE/<!%I|4|!%><!%I|1|!%>
>> 06:41:26,673 tpcw W 179 12 INSERT INTO NEW_ORDER (no_o_id, no_d_id,
>> no_w_id) VALUES ( ?, ?, ?)/<!%I|3001|!%><!%I|4|!%><!%I|1|!%>
>> 06:41:26,917 tpcw W 181 0 UPDATE stock SET s_quantity = ? , s_ytd = s_ytd
>> + ?, s_remote_cnt = s_remote_cnt + ?  WHERE s_i_id = ? AND s_w_id =
>> ?/<!%I|71|!%><!%I|2|!%><!%I|0|!%><!%I|92253|!%><!%I|2|!%>
>> 06:41:27,633 tpcw B 13
>> 06:41:27,633 tpcw W 188 13 UPDATE warehouse SET w_ytd = w_ytd + ?  WHERE
>> w_id = ?/<!%F|56.68|!%><!%I|1|!%>
>> 06:41:27,680 tpcw S 190 13 SELECT w_street_1, w_street_2, w_city,
>> w_state, w_zip, w_name FROM warehouse WHERE w_id = ?/<!%I|1|!%>
>> 06:41:27,681 tpcw W 191 13 UPDATE district SET d_ytd = d_ytd + ? WHERE
>> d_w_id = ? AND d_id = ?/<!%F|56.68|!%><!%I|1|!%><!%I|4|!%>
>> 06:41:28,664 tpcw B 14
>> 06:41:28,664 tpcw W 204 14 UPDATE warehouse SET w_ytd = w_ytd + ?  WHERE
>> w_id = ?/<!%F|4539.02|!%><!%I|2|!%>
>> 06:41:30,433 tpcw B 15
>> 06:41:30,433 tpcw S 226 15 SELECT c_discount, c_last, c_credit, w_tax
>>  FROM customer, warehouse WHERE w_id = ? AND w_id = c_w_id AND c_d_id = ?
>> AND c_id = ?/<!%I|3|!%><!%I|2|!%><!%I|2751|!%>
>> 06:41:30,500 tpcw S 231 15 SELECT d_next_o_id, d_tax FROM district WHERE
>> d_id = ? AND d_w_id = ? FOR UPDATE/<!%I|2|!%><!%I|3|!%>
>> 06:41:30,512 tpcw W 233 15 INSERT INTO NEW_ORDER (no_o_id, no_d_id,
>> no_w_id) VALUES ( ?, ?, ?)/<!%I|3001|!%><!%I|2|!%><!%I|3|!%>
>> 06:41:32,424 tpcw B 17
>> 06:41:32,424 tpcw S 249 17 SELECT c_discount, c_last, c_credit, w_tax
>>  FROM customer, warehouse WHERE w_id = ? AND w_id = c_w_id AND c_d_id = ?
>> AND c_id = ?/<!%I|2|!%><!%I|2|!%><!%I|1676|!%>
>> 06:41:32,487 tpcw S 250 17 SELECT d_next_o_id, d_tax FROM district WHERE
>> d_id = ? AND d_w_id = ? FOR UPDATE/<!%I|2|!%><!%I|2|!%>
>> 06:41:32,489 tpcw W 251 17 INSERT INTO NEW_ORDER (no_o_id, no_d_id,
>> no_w_id) VALUES ( ?, ?, ?)/<!%I|3001|!%><!%I|2|!%><!%I|2|!%>
>>
>>
>> I found the problem. The lock that transaction 12 acquired on the
>> district table (in its select for update) has not been properly added and
>> the deadlock has not been detected.
>> So on one side, Sequoia has a bug with not properly updating its lock
>> table on this select for update (the query parsing code might have an
>> issue).
>> On the other side, your transactions are not serializable and they
>> deadlock (the application should be fixed). By serialiazing writes per
>> table, Sequoia exposes these bugs faster than if you were running directly
>> on top of the database (but you should be able to obtain the same deadlock
>> directly on the database). Actually is stuck on the database deadlock. I
>> don't remember if the version of Postgres you are using has a global
>> transaction timeout that you can set so that Postgres would kill the
>> deadlocked transactions itself (quick fix).
>>
>> Hope this helps
>> Emmanuel
>>
>>
>>
>> On Wed, Nov 23, 2011 at 3:09 PM, Emmanuel Cecchet <ce...@gm...>wrote:
>>
>>>  Hi,
>>>
>>> From your log it looks like everyone is waiting for that transaction 65
>>> to either commit or rollback.
>>> If your thread has crashed and there is no rollback or connection
>>> closing in a catch block, all the locks are going to be retained forever
>>> (thought there is a possibility to set timeout on transactions in the load
>>> balancer settings if I recall).
>>> Without the log of the exact requests, it's hard to tell you more than
>>> that.
>>>
>>> Keep us posted with your findings,
>>> Emmanuel
>>>
>>>
>>> On 11/23/2011 06:30, rohit dhamane wrote:
>>>
>>>  Hi,
>>>
>>>  I have been facing some problem with sequoia. I am trying to run
>>> BenchmarkSql-2.3 (http://sourceforge.net/projects/benchmarksql/) with
>>> sequoia over two postgresql-7.3 servers but it seems to get stuck
>>> indefinitely at the same point. I think it's happening because of the
>>> SELECT...FOR UPDATE but not really sure how :( It seems that the
>>> transactions are getting into a deadlock. Here's the out put when I turned
>>> on the debug mode.
>>>
>>>  02:56:49,388 DEBUG controller.core.PingResponder Received ping data
>>> from /127.0.0.1
>>> 02:56:49,388 DEBUG controller.core.PingResponder Response to ping sent
>>> to /127.0.0.1
>>> 02:56:49,775 DEBUG sequoia.controller.loadbalancer Building wait-for
>>> graph...
>>> 02:56:49,776 DEBUG sequoia.controller.loadbalancer new_order locked by 64
>>> 02:56:49,777 DEBUG sequoia.controller.loadbalancer district locked by 65
>>> 02:56:49,777 DEBUG sequoia.controller.loadbalancer warehouse locked by 65
>>> 02:56:49,777 DEBUG sequoia.controller.loadbalancer Walking wait-for
>>> graph...
>>> 02:56:49,778 DEBUG sequoia.controller.loadbalancer 64 waits for district
>>> locked by 65
>>> 02:56:49,779 DEBUG sequoia.controller.loadbalancer 68 waits for
>>> new_order locked by 64
>>> 02:56:49,779 DEBUG sequoia.controller.loadbalancer     64 waits for
>>> district locked by 65
>>> 02:56:49,779 DEBUG sequoia.controller.loadbalancer 67 waits for
>>> warehouse locked by 65
>>> 02:56:49,779 DEBUG sequoia.controller.loadbalancer 66 waits for
>>> new_order locked by 64
>>> 02:56:49,779 DEBUG sequoia.controller.loadbalancer     64 waits for
>>> district locked by 65
>>> 02:56:49,779 DEBUG sequoia.controller.loadbalancer Choosing victim
>>> node...
>>> 02:56:49,779 DEBUG sequoia.controller.loadbalancer 0 cycles detected
>>> 02:56:49,779 DEBUG sequoia.controller.loadbalancer No victim
>>> 02:56:50,389 DEBUG controller.core.PingResponder Received ping data from
>>> /127.0.0.1
>>> 02:56:50,389 DEBUG controller.core.PingResponder Response to ping sent
>>> to /127.0.0.1
>>>
>>>
>>>
>>>  Here's my configuration file..
>>>
>>>  <?xml version="1.0" encoding="UTF-8"?>^M
>>> <!DOCTYPE SEQUOIA PUBLIC "-//Continuent//DTD SEQUOIA @VERSION@//EN" "
>>> http://sequoia.continuent.org/dtds/sequoia-@VERSION@.dtd">^M
>>> ^M
>>> <SEQUOIA>^M
>>> ^M
>>>   <VirtualDatabase name="tpcw">^M
>>> ^M
>>>     <AuthenticationManager>^M
>>>       <Admin>^M
>>>         <User username="postgres" password=""/>^M
>>>       </Admin> ^M
>>>       <VirtualUsers>^M
>>>         <VirtualLogin vLogin="postgres" vPassword=""/>^M
>>>       </VirtualUsers>^M
>>>     </AuthenticationManager>^M
>>> ^M
>>>     <DatabaseBackend name="localhost" driver="org.postgresql.Driver"
>>> driverPath="/home/rohit/Software/CJDBC/sequoia-2.10.10-bin/drivers/postgresql7.3.jar"
>>> url="jdbc:postgresql://localhost:6551/tpcw" connectionTestStatement="select
>>> now()">^M
>>>
>>>        <ConnectionManager vLogin="postgres" rLogin="postgres"
>>> rPassword="">^M
>>>         <VariablePoolConnectionManager initPoolSize="20" minPoolSize="5"
>>> maxPoolSize="0" idleTimeout="180" waitTimeout="0"/>^M
>>>       </ConnectionManager>^M
>>>     </DatabaseBackend>^M
>>> ^M
>>>     <DatabaseBackend name="Remote" driver="org.postgresql.Driver"
>>> driverPath="/home/rohit/Software/CJDBC/sequoia-2.10.10-bin/drivers/postgresql7.3.jar"
>>> url="jdbc:postgresql://192.168.164.136:6552/tpcw"
>>> connectionTestStatement="select now()">^M
>>>       <ConnectionManager vLogin="postgres" rLogin="postgres"
>>> rPassword="">^M
>>>         <VariablePoolConnectionManager initPoolSize="20" minPoolSize="5"
>>> maxPoolSize="0" idleTimeout="180" waitTimeout="0"/>^M
>>>       </ConnectionManager>^M
>>>     </DatabaseBackend>^M
>>>      <RequestManager>^M
>>>       <RequestScheduler>^M
>>>          <RAIDb-1Scheduler level="passThrough"/>^M
>>>       </RequestScheduler>^M
>>> ^M
>>>       <RequestCache>^M
>>>          <MetadataCache/>^M
>>>          <ParsingCache/>                 ^M
>>>          <ResultCache granularity="table" />^M
>>>       </RequestCache>^M
>>> ^M
>>>       <LoadBalancer transactionIsolation="serializable">^M
>>>          <RAIDb-1>^M
>>>             <WaitForCompletion policy="all"
>>>             deadlockTimeoutInMs="30000"/>^M
>>>             <RAIDb-1-RoundRobin/>^M
>>>          </RAIDb-1>^M
>>>       </LoadBalancer>^M
>>>      </RequestManager>^M
>>> ^M
>>>   </VirtualDatabase>^M
>>> ^M
>>> </SEQUOIA>^M
>>>
>>>  If anybody has anu idea why this happens please let me know. I would
>>> appreciate it a lot. Thanks in advance.
>>>
>>>  Regards,
>>> Rohit
>>>
>>>
>>>  ------------------------------------------------------------------------------
>>> All the data continuously generated in your IT infrastructure
>>> contains a definitive record of customers, application performance,
>>> security threats, fraudulent activity, and more. Splunk takes this
>>> data and makes sense of it. IT sense. And common sense.http://p.sf.net/sfu/splunk-novd2d
>>>
>>>
>>>
>>> _______________________________________________
>>> Sequoiadb-discuss mailing lis...@li...https://lists.sourceforge.net/lists/listinfo/sequoiadb-discuss
>>>
>>>
>>>
>>
>>
>