[Postgres-xl-general] Not able to run pgxc_ctl

Ramanuj Hari hari.ramanuj at gmail.com
Mon Sep 22 10:51:07 PDT 2014


Hi,

Finally given up to run postgresql-xl on FreeBSD.

Doing POC on CentOS 7. Manual mode is having issue, however it's nice to
see pgxc_ctl is taking care of initialization and all other start/stop
part.

In our Company, we wanted to provide DB Cluster Solution for Analytics
product, and evaluating postgresql-xl as best contender than that of
MongoDB, given that MPP support available in XL.

Thanks,
Ramanuj


On Fri, Sep 19, 2014 at 12:21 PM, Ramanuj Hari <hari.ramanuj at gmail.com>
wrote:

> Hi Pavan,
>
> Thanks for your response.
>
> Finally, was able to run pgxc_ctl on freebsd. But the last step of
> pgxc_ctl init all, failed with command "execute direct on..."
>
> -----Below is log of pgxc_ctl for it ---
> do_shell.c:dump_cmdList(700) *** cmdList Dump
> *******************************
> allocated = 2, used = 1
> do_shell.c:dump_cmdList(710) === CMD: 0 ===
> do_shell.c:dump_cmdList(714)    --- CMD-EL: 0:host="NULL", command="psql
> -p 11921 -h 10.102.103.83 -a postgres pgxl",
> localStdin="/tmp/STDIN_40163_34", localStdout="NULL"
> EXECUTE DIRECT ON (datanode1) 'CREATE NODE coord1 WITH
> (TYPE=''coordinator'', HOST=''10.102.103.83'', PORT=11921)';
> EXECUTE DIRECT ON (datanode1) 'ALTER NODE datanode1 WITH
> (TYPE=''datanode'', HOST=''10.102.103.83'', PORT=12921, PRIMARY,
> PREFERRED)';
> do_shell.c:dump_cmdList(724)    ----------
> do_shell.c:doCmdEl(358) Local command: "psql -p 11921 -h 10.102.103.83 -a
> postgres pgxl", actual: "( psql -p 11921 -h 10.102.103.83 -a postgres pgxl
> ) > /tmp/STDOUT_40163_35 2>&1 < /tmp/STDIN_40163_34"
> DEBUG:  CommitTransaction
> DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR,
> xid/subid/cid: 0/1/0, nestlvl: 1, children:
> DEBUG:  [re]setting xid = 0, old_value = 0
> DEBUG:  StartTransactionCommand
> DEBUG:  StartTransaction
> DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR,
> xid/subid/cid: 0/1/0, nestlvl: 1, children:
> DEBUG:  Done pgxc_nodes scan: 1 coordinators and 1 datanodes
> DEBUG:  Get OIDs from table: 1 coordinators and 1 datanodes
> DEBUG:  CommitTransactionCommand
> DEBUG:  CommitTransaction
> DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR,
> xid/subid/cid: 0/1/0, nestlvl: 1, children:
> DEBUG:  [re]setting xid = 0, old_value = 0
> EXECUTE DIRECT ON (datanode1) 'CREATE NODE coord1 WITH
> (TYPE=''coordinator'', HOST=''10.102.103.83'', PORT=11921)';
> DEBUG:  StartTransactionCommand
> DEBUG:  StartTransaction
> DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR,
> xid/subid/cid: 0/1/0, nestlvl: 1, children:
> LOG:  statement: EXECUTE DIRECT ON (datanode1) 'CREATE NODE coord1 WITH
> (TYPE=''coordinator'', HOST=''10.102.103.83'', PORT=11921)';
> DEBUG:  Postmaster child: connection established to GTM with string
> host=10.102.103.83 port=14921 node_name=coord1
> DEBUG:  Assigned new transaction ID from GTM = 3004
> DEBUG:  Getting snapshot. Current XID = 3004
> DEBUG:  from GTM: xmin = 3004, xmax = 3004, xcnt = 0, RecGlobXmin = 3004
> LOG:  parse tree:
> DETAIL:     {QUERY
>    :commandType 5
>    :querySource 0
>    :canSetTag true
>    :utilityStmt ?
>    :resultRelation 0
>    :hasAggs false
>    :hasWindowFuncs false
>    :hasSubLinks false
>    :hasDistinctOn false
>    :hasRecursive false
>    :hasModifyingCTE false
>    :hasForUpdate false
>    :cteList <>
>    :rtable <>
>    :jointree <>
>    :targetList <>
>    :returningList <>
>    :groupClause <>
>    :havingQual <>
>    :windowClause <>
>    :distinctClause <>
>    :sortClause <>
>    :limitOffset <>
>    :limitCount <>
>    :rowMarks <>
>    :setOperations <>
>    :constraintDeps <>
>    }
>
> LOG:  rewritten parse tree:
> DETAIL:  (
>    {QUERY
>    :commandType 5
>    :querySource 0
>    :canSetTag true
>    :utilityStmt ?
>    :resultRelation 0
>    :hasAggs false
>    :hasWindowFuncs false
>    :hasSubLinks false
>    :hasDistinctOn false
>    :hasRecursive false
>    :hasModifyingCTE false
>    :hasForUpdate false
>    :cteList <>
>    :rtable <>
>    :jointree <>
>    :targetList <>
>    :returningList <>
>    :groupClause <>
>    :havingQual <>
>    :windowClause <>
>    :distinctClause <>
>    :sortClause <>
>    :limitOffset <>
>    :limitCount <>
>    :rowMarks <>
>    :setOperations <>
>    :constraintDeps <>
>    }
> )
>
> DEBUG:  ProcessUtility
> DEBUG:  Getting snapshot for autovacuum. Current XID = 3004
> DEBUG:  for autovacuum from GTM: xmin = 3004, xmax = 3004, xcnt = 0,
> RecGlobXmin = 3004
> LOG:  Connection error could not send data to server
> LOG:  Connection error failed to send data to datanode
> connection to server was lost
> coord_cmd.c:configure_datanodes(414) Done.
> PGXC$ 1
> 1: not found
> PGXC$
>
> ------
>
> Next, when I enabled all the logging on datanode, and try to execute
> direct command while connecting from co-ordinator, it fails.
> --command prompt log---
> pgxl at Freebsd_103_83 ~-> psql -h 127.0.0.1 -p 11921 -U  pgxl postgres
> DEBUG:  CommitTransaction
> DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR,
> xid/subid/cid: 0/1/0, nestlvl: 1, children:
> DEBUG:  [re]setting xid = 0, old_value = 0
> DEBUG:  StartTransactionCommand
> DEBUG:  StartTransaction
> DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR,
> xid/subid/cid: 0/1/0, nestlvl: 1, children:
> DEBUG:  Done pgxc_nodes scan: 1 coordinators and 1 datanodes
> DEBUG:  Get OIDs from table: 1 coordinators and 1 datanodes
> DEBUG:  CommitTransactionCommand
> DEBUG:  CommitTransaction
> DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR,
> xid/subid/cid: 0/1/0, nestlvl: 1, children:
> DEBUG:  [re]setting xid = 0, old_value = 0
> psql (PGXL 9.2.0, based on PG 9.2.4 (Postgres-XL 9.2.0))
> Type "help" for help.
>
> postgres=# execute direct on (datanode1) 'select * from pgxc_node';
> DEBUG:  StartTransactionCommand
> DEBUG:  StartTransaction
> DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR,
> xid/subid/cid: 0/1/0, nestlvl: 1, children:
> LOG:  statement: execute direct on (datanode1) 'select * from pgxc_node';
> DEBUG:  Postmaster child: connection established to GTM with string
> host=10.102.103.83 port=14921 node_name=coord1
> DEBUG:  Assigned new transaction ID from GTM = 4137
> DEBUG:  Getting snapshot. Current XID = 4137
> DEBUG:  from GTM: xmin = 4137, xmax = 4137, xcnt = 0, RecGlobXmin = 4137
> LOG:  parse tree:
> DETAIL:     {QUERY
>    :commandType 1
>    :querySource 0
>    :canSetTag true
>    :utilityStmt ?
>    :resultRelation 0
>    :hasAggs false
>    :hasWindowFuncs false
>    :hasSubLinks false
>    :hasDistinctOn false
>    :hasRecursive false
>    :hasModifyingCTE false
>    :hasForUpdate false
>    :cteList <>
>    :rtable (
>       {RTE
>       :alias <>
>       :eref
>          {ALIAS
>          :aliasname pgxc_node
>          :colnames ("node_name" "node_type" "node_port" "node_host"
> "nodeis_pr
>          imary" "nodeis_preferred" "node_id")
>          }
>       :rtekind 0
>       :relid 9015
>       :relkind r
>       :inh true
>       :inFromCl true
>       :requiredPerms 2
>       :checkAsUser 0
>       :selectedCols (b 10 11 12 13 14 15 16)
>       :modifiedCols (b)
>       }
>    )
>    :jointree
>       {FROMEXPR
>       :fromlist (
>          {RANGETBLREF
>          :rtindex 1
>          }
>       )
>       :quals <>
>       }
>    :targetList (
>       {TARGETENTRY
>       :expr
>          {VAR
>          :varno 1
>          :varattno 1
>          :vartype 19
>          :vartypmod -1
>          :varcollid 0
>          :varlevelsup 0
>          :varnoold 1
>          :varoattno 1
>          :location 7
>          }
>       :resno 1
>       :resname node_name
>       :ressortgroupref 0
>       :resorigtbl 9015
>       :resorigcol 1
>       :resjunk false
>       }
>       {TARGETENTRY
>       :expr
>          {VAR
>          :varno 1
>          :varattno 2
>          :vartype 18
>          :vartypmod -1
>          :varcollid 0
>          :varlevelsup 0
>          :varnoold 1
>          :varoattno 2
>          :location 7
>          }
>       :resno 2
>       :resname node_type
>       :ressortgroupref 0
>       :resorigtbl 9015
>       :resorigcol 2
>       :resjunk false
>       }
>       {TARGETENTRY
>       :expr
>          {VAR
>          :varno 1
>          :varattno 3
>          :vartype 23
>          :vartypmod -1
>          :varcollid 0
>          :varlevelsup 0
>          :varnoold 1
>          :varoattno 3
>          :location 7
>          }
>       :resno 3
>       :resname node_port
>       :ressortgroupref 0
>       :resorigtbl 9015
>       :resorigcol 3
>       :resjunk false
>       }
>       {TARGETENTRY
>       :expr
>          {VAR
>          :varno 1
>          :varattno 4
>          :vartype 19
>          :vartypmod -1
>          :varcollid 0
>          :varlevelsup 0
>          :varnoold 1
>          :varoattno 4
>          :location 7
>          }
>       :resno 4
>       :resname node_host
>       :ressortgroupref 0
>       :resorigtbl 9015
>       :resorigcol 4
>       :resjunk false
>       }
>       {TARGETENTRY
>       :expr
>          {VAR
>          :varno 1
>          :varattno 5
>          :vartype 16
>          :vartypmod -1
>          :varcollid 0
>          :varlevelsup 0
>          :varnoold 1
>          :varoattno 5
>          :location 7
>          }
>       :resno 5
>       :resname nodeis_primary
>       :ressortgroupref 0
>       :resorigtbl 9015
>       :resorigcol 5
>       :resjunk false
>       }
>       {TARGETENTRY
>       :expr
>          {VAR
>          :varno 1
>          :varattno 6
>          :vartype 16
>          :vartypmod -1
>          :varcollid 0
>          :varlevelsup 0
>          :varnoold 1
>          :varoattno 6
>          :location 7
>          }
>       :resno 6
>       :resname nodeis_preferred
>       :ressortgroupref 0
>       :resorigtbl 9015
>       :resorigcol 6
>       :resjunk false
>       }
>       {TARGETENTRY
>       :expr
>          {VAR
>          :varno 1
>          :varattno 7
>          :vartype 23
>          :vartypmod -1
>          :varcollid 0
>          :varlevelsup 0
>          :varnoold 1
>          :varoattno 7
>          :location 7
>          }
>       :resno 7
>       :resname node_id
>       :ressortgroupref 0
>       :resorigtbl 9015
>       :resorigcol 7
>       :resjunk false
>       }
>    )
>    :returningList <>
>    :groupClause <>
>    :havingQual <>
>    :windowClause <>
>    :distinctClause <>
>    :sortClause <>
>    :limitOffset <>
>    :limitCount <>
>    :rowMarks <>
>    :setOperations <>
>    :constraintDeps <>
>    }
>
> LOG:  rewritten parse tree:
> DETAIL:  (
>    {QUERY
>    :commandType 1
>    :querySource 0
>    :canSetTag true
>    :utilityStmt ?
>    :resultRelation 0
>    :hasAggs false
>    :hasWindowFuncs false
>    :hasSubLinks false
>    :hasDistinctOn false
>    :hasRecursive false
>    :hasModifyingCTE false
>    :hasForUpdate false
>    :cteList <>
>    :rtable (
>       {RTE
>       :alias <>
>       :eref
>          {ALIAS
>          :aliasname pgxc_node
>          :colnames ("node_name" "node_type" "node_port" "node_host"
> "nodeis_pr
>          imary" "nodeis_preferred" "node_id")
>          }
>       :rtekind 0
>       :relid 9015
>       :relkind r
>       :inh true
>       :inFromCl true
>       :requiredPerms 2
>       :checkAsUser 0
>       :selectedCols (b 10 11 12 13 14 15 16)
>       :modifiedCols (b)
>       }
>    )
>    :jointree
>       {FROMEXPR
>       :fromlist (
>          {RANGETBLREF
>          :rtindex 1
>          }
>       )
>       :quals <>
>       }
>    :targetList (
>       {TARGETENTRY
>       :expr
>          {VAR
>          :varno 1
>          :varattno 1
>          :vartype 19
>          :vartypmod -1
>          :varcollid 0
>          :varlevelsup 0
>          :varnoold 1
>          :varoattno 1
>          :location 7
>          }
>       :resno 1
>       :resname node_name
>       :ressortgroupref 0
>       :resorigtbl 9015
>       :resorigcol 1
>       :resjunk false
>       }
>       {TARGETENTRY
>       :expr
>          {VAR
>          :varno 1
>          :varattno 2
>          :vartype 18
>          :vartypmod -1
>          :varcollid 0
>          :varlevelsup 0
>          :varnoold 1
>          :varoattno 2
>          :location 7
>          }
>       :resno 2
>       :resname node_type
>       :ressortgroupref 0
>       :resorigtbl 9015
>       :resorigcol 2
>       :resjunk false
>       }
>       {TARGETENTRY
>       :expr
>          {VAR
>          :varno 1
>          :varattno 3
>          :vartype 23
>          :vartypmod -1
>          :varcollid 0
>          :varlevelsup 0
>          :varnoold 1
>          :varoattno 3
>          :location 7
>          }
>       :resno 3
>       :resname node_port
>       :ressortgroupref 0
>       :resorigtbl 9015
>       :resorigcol 3
>       :resjunk false
>       }
>       {TARGETENTRY
>       :expr
>          {VAR
>          :varno 1
>          :varattno 4
>          :vartype 19
>          :vartypmod -1
>          :varcollid 0
>          :varlevelsup 0
>          :varnoold 1
>          :varoattno 4
>          :location 7
>          }
>       :resno 4
>       :resname node_host
>       :ressortgroupref 0
>       :resorigtbl 9015
>       :resorigcol 4
>       :resjunk false
>       }
>       {TARGETENTRY
>       :expr
>          {VAR
>          :varno 1
>          :varattno 5
>          :vartype 16
>          :vartypmod -1
>          :varcollid 0
>          :varlevelsup 0
>          :varnoold 1
>          :varoattno 5
>          :location 7
>          }
>       :resno 5
>       :resname nodeis_primary
>       :ressortgroupref 0
>       :resorigtbl 9015
>       :resorigcol 5
>       :resjunk false
>       }
>       {TARGETENTRY
>       :expr
>          {VAR
>          :varno 1
>          :varattno 6
>          :vartype 16
>          :vartypmod -1
>          :varcollid 0
>          :varlevelsup 0
>          :varnoold 1
>          :varoattno 6
>          :location 7
>          }
>       :resno 6
>       :resname nodeis_preferred
>       :ressortgroupref 0
>       :resorigtbl 9015
>       :resorigcol 6
>       :resjunk false
>       }
>       {TARGETENTRY
>       :expr
>          {VAR
>          :varno 1
>          :varattno 7
>          :vartype 23
>          :vartypmod -1
>          :varcollid 0
>          :varlevelsup 0
>          :varnoold 1
>          :varoattno 7
>          :location 7
>          }
>       :resno 7
>       :resname node_id
>       :ressortgroupref 0
>       :resorigtbl 9015
>       :resorigcol 7
>       :resjunk false
>       }
>    )
>    :returningList <>
>    :groupClause <>
>    :havingQual <>
>    :windowClause <>
>    :distinctClause <>
>    :sortClause <>
>    :limitOffset <>
>    :limitCount <>
>    :rowMarks <>
>    :setOperations <>
>    :constraintDeps <>
>    }
> )
>
> LOG:  plan:
> DETAIL:     {PLANNEDSTMT
>    :commandType 1
>    :queryId 0
>    :hasReturning false
>    :hasModifyingCTE false
>    :canSetTag true
>    :transientPlan false
>    :planTree
>       {REMOTEQUERY
>       :startup_cost 0.00
>       :total_cost 0.00
>       :plan_rows 0
>       :plan_width 0
>       :targetlist (
>          {TARGETENTRY
>          :expr
>             {VAR
>             :varno 1
>             :varattno 1
>             :vartype 19
>             :vartypmod -1
>             :varcollid 0
>             :varlevelsup 0
>             :varnoold 1
>             :varoattno 1
>             :location 7
>             }
>          :resno 1
>          :resname node_name
>          :ressortgroupref 0
>          :resorigtbl 9015
>          :resorigcol 1
>          :resjunk false
>          }
>          {TARGETENTRY
>          :expr
>             {VAR
>             :varno 1
>             :varattno 2
>             :vartype 18
>             :vartypmod -1
>             :varcollid 0
>             :varlevelsup 0
>             :varnoold 1
>             :varoattno 2
>             :location 7
>             }
>          :resno 2
>          :resname node_type
>          :ressortgroupref 0
>          :resorigtbl 9015
>          :resorigcol 2
>          :resjunk false
>          }
>          {TARGETENTRY
>          :expr
>             {VAR
>             :varno 1
>             :varattno 3
>             :vartype 23
>             :vartypmod -1
>             :varcollid 0
>             :varlevelsup 0
>             :varnoold 1
>             :varoattno 3
>             :location 7
>             }
>          :resno 3
>          :resname node_port
>          :ressortgroupref 0
>          :resorigtbl 9015
>          :resorigcol 3
>          :resjunk false
>          }
>          {TARGETENTRY
>          :expr
>             {VAR
>             :varno 1
>             :varattno 4
>             :vartype 19
>             :vartypmod -1
>             :varcollid 0
>             :varlevelsup 0
>             :varnoold 1
>             :varoattno 4
>             :location 7
>             }
>          :resno 4
>          :resname node_host
>          :ressortgroupref 0
>          :resorigtbl 9015
>          :resorigcol 4
>          :resjunk false
>          }
>          {TARGETENTRY
>          :expr
>             {VAR
>             :varno 1
>             :varattno 5
>             :vartype 16
>             :vartypmod -1
>             :varcollid 0
>             :varlevelsup 0
>             :varnoold 1
>             :varoattno 5
>             :location 7
>             }
>          :resno 5
>          :resname nodeis_primary
>          :ressortgroupref 0
>          :resorigtbl 9015
>          :resorigcol 5
>          :resjunk false
>          }
>          {TARGETENTRY
>          :expr
>             {VAR
>             :varno 1
>             :varattno 6
>             :vartype 16
>             :vartypmod -1
>             :varcollid 0
>             :varlevelsup 0
>             :varnoold 1
>             :varoattno 6
>             :location 7
>             }
>          :resno 6
>          :resname nodeis_preferred
>          :ressortgroupref 0
>          :resorigtbl 9015
>          :resorigcol 6
>          :resjunk false
>          }
>          {TARGETENTRY
>          :expr
>             {VAR
>             :varno 1
>             :varattno 7
>             :vartype 23
>             :vartypmod -1
>             :varcollid 0
>             :varlevelsup 0
>             :varnoold 1
>             :varoattno 7
>             :location 7
>             }
>          :resno 7
>          :resname node_id
>          :ressortgroupref 0
>          :resorigtbl 9015
>          :resorigcol 7
>          :resjunk false
>          }
>       )
>       :qual <>
>       :lefttree <>
>       :righttree <>
>       :initPlan <>
>       :extParam (b)
>       :allParam (b)
>       :scanrelid 0
>       :exec_direct_type 4
>       :sql_statement select\ *\ from\ pgxc_node
>       :exec_nodes
>          {EXEC_NODES
>          :primarynodelist <>
>          :nodeList (i 0)
>          :baselocatortype
>
> DEBUG:  Getting snapshot for autovacuum. Current XID = 4137
> DEBUG:  for autovacuum from GTM: xmin = 4137, xmax = 4137, xcnt = 0,
> RecGlobXmin = 4137
> LOG:  Connection error could not send data to server
> LOG:  Connection error failed to send data to datanode
> LOG:  Connection error failed to send ROLLBACK TRANSACTION command
> DEBUG:  Connection to Datanode 16384 has unexpected state 3 and will be
> dropped
> DEBUG:  Record transaction abort 4137
> DEBUG:  [re]setting xid = 0, old_value = 0
> ERROR:  Could not begin transaction on data node.
> postgres=#
> --------
>
>
> ===== tail -f of coordinator and datanode log file while executing above
> command ====
> ==> coord/pg_log/postgresql-2014-09-19_073943.log <==
> <407742014-09-19 07:44:43 PDT%LOG:  00000: checkpoint starting: time
> <407742014-09-19 07:44:43 PDT%LOCATION:  LogCheckpointStart, xlog.c:7885
> <407742014-09-19 07:44:43 PDT%DEBUG:  00000: SlruScanDirectory invoking
> callback on pg_multixact/offsets/0000
> <407742014-09-19 07:44:43 PDT%LOCATION:  SlruScanDirectory, slru.c:1267
> <407742014-09-19 07:44:43 PDT%DEBUG:  00000: SlruScanDirectory invoking
> callback on pg_multixact/members/0000
> <407742014-09-19 07:44:43 PDT%LOCATION:  SlruScanDirectory, slru.c:1267
> <407742014-09-19 07:44:43 PDT%DEBUG:  00000: checkpoint sync: number=1
> file=global/11977 time=0.932 msec
> <407742014-09-19 07:44:43 PDT%LOCATION:  mdsync, md.c:1161
> <407742014-09-19 07:44:43 PDT%DEBUG:  00000: attempting to remove WAL
> segments older than log file 000000010000000000000000
> <407742014-09-19 07:44:43 PDT%LOCATION:  RemoveOldXlogFiles, xlog.c:3555
> <407742014-09-19 07:44:43 PDT%DEBUG:  00000: SlruScanDirectory invoking
> callback on pg_subtrans/0000
> <407742014-09-19 07:44:43 PDT%LOCATION:  SlruScanDirectory, slru.c:1267
> <407742014-09-19 07:44:43 PDT%LOG:  00000: checkpoint complete: wrote 1
> buffers (0.0%); 0 transaction log file(s) added, 0 removed, 0 recycled;
> write=0.000 s, sync=0.001 s, total=0.006 s; sync files=1, longest=0.000 s,
> average=0.000 s
> <407742014-09-19 07:44:43 PDT%LOCATION:  LogCheckpointEnd, xlog.c:7973
> <407732014-09-19 07:44:43 PDT%DEBUG:  00000: Pool maintenance, done in
> 0.000000 seconds, removed 0 pools
> <407732014-09-19 07:44:43 PDT%LOCATION:  pools_maintenance, poolmgr.c:3142
> <407772014-09-19 07:44:43 PDT%DEBUG:  00000: StartTransaction
> <407772014-09-19 07:44:43 PDT%LOCATION:  ShowTransactionState, xact.c:5317
> <407772014-09-19 07:44:43 PDT%DEBUG:  00000: name: unnamed; blockState:
>     DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children:
> <407772014-09-19 07:44:43 PDT%LOCATION:  ShowTransactionStateRec,
> xact.c:5355
> <407772014-09-19 07:44:43 PDT%DEBUG:  00000: Autovacuum launcher:
> connection established to GTM with string host=10.102.103.83 port=14921
> node_name=coord1
> <407772014-09-19 07:44:43 PDT%LOCATION:  InitGTM, gtm.c:96
> <407772014-09-19 07:44:43 PDT%DEBUG:  00000: Assigned new transaction ID
> from GTM = 4134
> <407772014-09-19 07:44:43 PDT%LOCATION:  GetNewTransactionId, varsup.c:179
> <407772014-09-19 07:44:43 PDT%DEBUG:  00000: Getting snapshot for
> autovacuum. Current XID = 4134
> <407772014-09-19 07:44:43 PDT%LOCATION:  GetSnapshotDataDataNode,
> procarray.c:2824
> <407772014-09-19 07:44:43 PDT%DEBUG:  00000: for autovacuum from GTM: xmin
> = 4134, xmax = 4134, xcnt = 0, RecGlobXmin = 4134
> <407772014-09-19 07:44:43 PDT%LOCATION:  GetSnapshotDataDataNode,
> procarray.c:2855
> <407772014-09-19 07:44:43 PDT%DEBUG:  00000: CommitTransaction
> <407772014-09-19 07:44:43 PDT%LOCATION:  ShowTransactionState, xact.c:5317
> <407772014-09-19 07:44:43 PDT%DEBUG:  00000: name: unnamed; blockState:
>     STARTED; state: INPROGR, xid/subid/cid: 4134/1/0, nestlvl: 1, children:
> <407772014-09-19 07:44:43 PDT%LOCATION:  ShowTransactionStateRec,
> xact.c:5355
> <407772014-09-19 07:44:43 PDT%DEBUG:  00000: Record transaction commit 4134
> <407772014-09-19 07:44:43 PDT%LOCATION:  TransactionIdSetTreeStatus,
> clog.c:166
> <407772014-09-19 07:44:43 PDT%DEBUG:  00000: Autovacuum launcher:
> connection to GTM closed
> <407772014-09-19 07:44:43 PDT%LOCATION:  CloseGTM, gtm.c:133
> <407772014-09-19 07:44:43 PDT%DEBUG:  00000: [re]setting xid = 0,
> old_value = 0
> <407772014-09-19 07:44:43 PDT%LOCATION:  SetNextTransactionId, varsup.c:55
> <407772014-09-19 07:44:43 PDT%DEBUG:  00000: StartTransaction
> <407772014-09-19 07:44:43 PDT%LOCATION:  ShowTransactionState, xact.c:5317
> <407772014-09-19 07:44:43 PDT%DEBUG:  00000: name: unnamed; blockState:
>     DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children:
> <407772014-09-19 07:44:43 PDT%LOCATION:  ShowTransactionStateRec,
> xact.c:5355
> <407772014-09-19 07:44:43 PDT%DEBUG:  00000: Autovacuum launcher:
> connection established to GTM with string host=10.102.103.83 port=14921
> node_name=coord1
> <407772014-09-19 07:44:43 PDT%LOCATION:  InitGTM, gtm.c:96
> <407772014-09-19 07:44:43 PDT%DEBUG:  00000: Assigned new transaction ID
> from GTM = 4135
> <407772014-09-19 07:44:43 PDT%LOCATION:  GetNewTransactionId, varsup.c:179
> <407772014-09-19 07:44:43 PDT%DEBUG:  00000: Getting snapshot for
> autovacuum. Current XID = 4135
> <407772014-09-19 07:44:43 PDT%LOCATION:  GetSnapshotDataDataNode,
> procarray.c:2824
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: InitPostgres
> <408322014-09-19 07:44:43 PDT%LOCATION:  InitPostgres, postinit.c:482
> <407772014-09-19 07:44:43 PDT%DEBUG:  00000: for autovacuum from GTM: xmin
> = 4135, xmax = 4135, xcnt = 0, RecGlobXmin = 4135
> <407772014-09-19 07:44:43 PDT%LOCATION:  GetSnapshotDataDataNode,
> procarray.c:2855
> <407772014-09-19 07:44:43 PDT%DEBUG:  00000: CommitTransaction
> <407772014-09-19 07:44:43 PDT%LOCATION:  ShowTransactionState, xact.c:5317
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: my backend ID is 3
> <408322014-09-19 07:44:43 PDT%LOCATION:  SharedInvalBackendInit,
> sinvaladt.c:330
> <407772014-09-19 07:44:43 PDT%DEBUG:  00000: name: unnamed; blockState:
>     STARTED; state: INPROGR, xid/subid/cid: 4135/1/0, nestlvl: 1, children:
> <407772014-09-19 07:44:43 PDT%LOCATION:  ShowTransactionStateRec,
> xact.c:5355
> <407772014-09-19 07:44:43 PDT%DEBUG:  00000: Record transaction commit 4135
> <407772014-09-19 07:44:43 PDT%LOCATION:  TransactionIdSetTreeStatus,
> clog.c:166
> <407772014-09-19 07:44:43 PDT%DEBUG:  00000: Autovacuum launcher:
> connection to GTM closed
> <407772014-09-19 07:44:43 PDT%LOCATION:  CloseGTM, gtm.c:133
> <407772014-09-19 07:44:43 PDT%DEBUG:  00000: [re]setting xid = 0,
> old_value = 0
> <407772014-09-19 07:44:43 PDT%LOCATION:  SetNextTransactionId, varsup.c:55
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: StartTransaction
> <408322014-09-19 07:44:43 PDT%LOCATION:  ShowTransactionState, xact.c:5317
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: name: unnamed; blockState:
>     DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children:
> <408322014-09-19 07:44:43 PDT%LOCATION:  ShowTransactionStateRec,
> xact.c:5355
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: Autovacuum worker: connection
> established to GTM with string host=10.102.103.83 port=14921
> node_name=coord1
> <408322014-09-19 07:44:43 PDT%LOCATION:  InitGTM, gtm.c:94
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: Assigned new transaction ID
> from GTM = 4136
> <408322014-09-19 07:44:43 PDT%LOCATION:  GetNewTransactionId, varsup.c:179
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: Getting snapshot for
> autovacuum. Current XID = 4136
> <408322014-09-19 07:44:43 PDT%LOCATION:  GetSnapshotDataDataNode,
> procarray.c:2824
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: for autovacuum from GTM: xmin
> = 4136, xmax = 4136, xcnt = 0, RecGlobXmin = 4136
> <408322014-09-19 07:44:43 PDT%LOCATION:  GetSnapshotDataDataNode,
> procarray.c:2855
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: CommitTransaction
> <408322014-09-19 07:44:43 PDT%LOCATION:  ShowTransactionState, xact.c:5317
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: name: unnamed; blockState:
>     STARTED; state: INPROGR, xid/subid/cid: 4136/1/0, nestlvl: 1, children:
> <408322014-09-19 07:44:43 PDT%LOCATION:  ShowTransactionStateRec,
> xact.c:5355
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: Record transaction commit 4136
> <408322014-09-19 07:44:43 PDT%LOCATION:  TransactionIdSetTreeStatus,
> clog.c:166
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: Autovacuum worker: connection
> to GTM closed
> <408322014-09-19 07:44:43 PDT%LOCATION:  CloseGTM, gtm.c:131
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: [re]setting xid = 0,
> old_value = 0
> <408322014-09-19 07:44:43 PDT%LOCATION:  SetNextTransactionId, varsup.c:55
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: autovacuum: processing
> database "postgres"
> <408322014-09-19 07:44:43 PDT%LOCATION:  AutoVacWorkerMain,
> autovacuum.c:1647
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: StartTransaction
> <408322014-09-19 07:44:43 PDT%LOCATION:  ShowTransactionState, xact.c:5317
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: name: unnamed; blockState:
>     DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children:
> <408322014-09-19 07:44:43 PDT%LOCATION:  ShowTransactionStateRec,
> xact.c:5355
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: pg_authid: vac: 0 (threshold
> 50), anl: 0 (threshold 50)
> <408322014-09-19 07:44:43 PDT%LOCATION:  relation_needs_vacanalyze,
> autovacuum.c:2703
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: pg_attribute: vac: 0
> (threshold 554), anl: 0 (threshold 302)
> <408322014-09-19 07:44:43 PDT%LOCATION:  relation_needs_vacanalyze,
> autovacuum.c:2703
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: pg_class: vac: 0 (threshold
> 113), anl: 0 (threshold 82)
> <408322014-09-19 07:44:43 PDT%LOCATION:  relation_needs_vacanalyze,
> autovacuum.c:2703
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: pg_index: vac: 0 (threshold
> 73), anl: 0 (threshold 62)
> <408322014-09-19 07:44:43 PDT%LOCATION:  relation_needs_vacanalyze,
> autovacuum.c:2703
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: pg_opclass: vac: 0 (threshold
> 74), anl: 0 (threshold 62)
> <408322014-09-19 07:44:43 PDT%LOCATION:  relation_needs_vacanalyze,
> autovacuum.c:2703
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: pg_am: vac: 0 (threshold 51),
> anl: 0 (threshold 50)
> <408322014-09-19 07:44:43 PDT%LOCATION:  relation_needs_vacanalyze,
> autovacuum.c:2703
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: pg_amproc: vac: 0 (threshold
> 107), anl: 0 (threshold 79)
> <408322014-09-19 07:44:43 PDT%LOCATION:  relation_needs_vacanalyze,
> autovacuum.c:2703
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: pgxc_node: vac: 0 (threshold
> 50), anl: 0 (threshold 50)
> <408322014-09-19 07:44:43 PDT%LOCATION:  relation_needs_vacanalyze,
> autovacuum.c:2703
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: pg_database: vac: 0
> (threshold 51), anl: 0 (threshold 50)
> <408322014-09-19 07:44:43 PDT%LOCATION:  relation_needs_vacanalyze,
> autovacuum.c:2703
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: Done pgxc_nodes scan: 1
> coordinators and 1 datanodes
> <408322014-09-19 07:44:43 PDT%LOCATION:  PgxcNodeListAndCount,
> nodemgr.c:359
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: Get OIDs from table: 1
> coordinators and 1 datanodes
> <408322014-09-19 07:44:43 PDT%LOCATION:  PgxcNodeGetOids, nodemgr.c:387
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: CommitTransaction
> <408322014-09-19 07:44:43 PDT%LOCATION:  ShowTransactionState, xact.c:5317
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: name: unnamed; blockState:
>     STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children:
> <408322014-09-19 07:44:43 PDT%LOCATION:  ShowTransactionStateRec,
> xact.c:5355
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: [re]setting xid = 0,
> old_value = 0
> <408322014-09-19 07:44:43 PDT%LOCATION:  SetNextTransactionId, varsup.c:55
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: shmem_exit(0): 8 callbacks to
> make
> <408322014-09-19 07:44:43 PDT%LOCATION:  shmem_exit, ipc.c:211
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: proc_exit(0): 2 callbacks to
> make
> <408322014-09-19 07:44:43 PDT%LOCATION:  proc_exit_prepare, ipc.c:183
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: exit(0)
> <408322014-09-19 07:44:43 PDT%LOCATION:  proc_exit, ipc.c:135
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: shmem_exit(-1): 0 callbacks
> to make
> <408322014-09-19 07:44:43 PDT%LOCATION:  shmem_exit, ipc.c:211
> <408322014-09-19 07:44:43 PDT%DEBUG:  00000: proc_exit(-1): 0 callbacks to
> make
> <408322014-09-19 07:44:43 PDT%LOCATION:  proc_exit_prepare, ipc.c:183
> <407702014-09-19 07:44:43 PDT%DEBUG:  00000: reaping dead processes
> <407702014-09-19 07:44:43 PDT%LOCATION:  reaper, postmaster.c:2501
> <407702014-09-19 07:44:43 PDT%DEBUG:  00000: server process (PID 40832)
> exited with exit code 0
> <407702014-09-19 07:44:43 PDT%LOCATION:  LogChildExit, postmaster.c:3133
>
> ========
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%DEBUG:  00000:
> StartTransactionCommand
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%LOCATION:
>  start_xact_command, postgres.c:2797
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%STATEMENT:
>  execute direct on (datanode1) 'select * from pgxc_node';
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%DEBUG:  00000:
> StartTransaction
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%LOCATION:
>  ShowTransactionState, xact.c:5317
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%STATEMENT:
>  execute direct on (datanode1) 'select * from pgxc_node';
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%DEBUG:  00000:
> name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid:
> 0/1/0, nestlvl: 1, children:
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%LOCATION:
>  ShowTransactionStateRec, xact.c:5355
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%STATEMENT:
>  execute direct on (datanode1) 'select * from pgxc_node';
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%LOG:  00000:
> statement: execute direct on (datanode1) 'select * from pgxc_node';
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%LOCATION:
>  exec_simple_query, postgres.c:1105
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%DEBUG:  00000:
> Postmaster child: connection established to GTM with string
> host=10.102.103.83 port=14921 node_name=coord1
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%LOCATION:
>  InitGTM, gtm.c:98
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%STATEMENT:
>  execute direct on (datanode1) 'select * from pgxc_node';
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%DEBUG:  00000:
> Assigned new transaction ID from GTM = 4137
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%LOCATION:
>  GetNewTransactionId, varsup.c:179
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%STATEMENT:
>  execute direct on (datanode1) 'select * from pgxc_node';
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%DEBUG:  00000:
> Getting snapshot. Current XID = 4137
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%LOCATION:
>  GetSnapshotDataCoordinator, procarray.c:3034
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%STATEMENT:
>  execute direct on (datanode1) 'select * from pgxc_node';
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%DEBUG:  00000:
> from GTM: xmin = 4137, xmax = 4137, xcnt = 0, RecGlobXmin = 4137
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%LOCATION:
>  GetSnapshotDataCoordinator, procarray.c:3049
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%STATEMENT:
>  execute direct on (datanode1) 'select * from pgxc_node';
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%LOG:  00000:
> parse tree:
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%DETAIL:
> {QUERY
>    :commandType 1
>    :querySource 0
>    :canSetTag true
>    :utilityStmt ?
>    :resultRelation 0
>    :hasAggs false
>    :hasWindowFuncs false
>    :hasSubLinks false
>    :hasDistinctOn false
>    :hasRecursive false
>    :hasModifyingCTE false
>    :hasForUpdate false
>    :cteList <>
>    :rtable (
>       {RTE
>       :alias <>
>       :eref
>          {ALIAS
>          :aliasname pgxc_node
>          :colnames ("node_name" "node_type" "node_port" "node_host"
> "nodeis_pr
>          imary" "nodeis_preferred" "node_id")
>          }
>       :rtekind 0
>       :relid 9015
>       :relkind r
>       :inh true
>       :inFromCl true
>       :requiredPerms 2
>       :checkAsUser 0
>       :selectedCols (b 10 11 12 13 14 15 16)
>       :modifiedCols (b)
>       }
>    )
>    :jointree
>       {FROMEXPR
>       :fromlist (
>          {RANGETBLREF
>          :rtindex 1
>          }
>       )
>       :quals <>
>       }
>    :targetList (
>       {TARGETENTRY
>       :expr
>          {VAR
>          :varno 1
>          :varattno 1
>          :vartype 19
>          :vartypmod -1
>          :varcollid 0
>          :varlevelsup 0
>          :varnoold 1
>          :varoattno 1
>          :location 7
>          }
>       :resno 1
>       :resname node_name
>       :ressortgroupref 0
>       :resorigtbl 9015
>       :resorigcol 1
>       :resjunk false
>       }
>       {TARGETENTRY
>       :expr
>          {VAR
>          :varno 1
>          :varattno 2
>          :vartype 18
>          :vartypmod -1
>          :varcollid 0
>          :varlevelsup 0
>          :varnoold 1
>          :varoattno 2
>          :location 7
>          }
>       :resno 2
>       :resname node_type
>       :ressortgroupref 0
>       :resorigtbl 9015
>       :resorigcol 2
>       :resjunk false
>       }
>       {TARGETENTRY
>       :expr
>          {VAR
>          :varno 1
>          :varattno 3
>          :vartype 23
>          :vartypmod -1
>          :varcollid 0
>          :varlevelsup 0
>          :varnoold 1
>          :varoattno 3
>          :location 7
>          }
>       :resno 3
>       :resname node_port
>       :ressortgroupref 0
>       :resorigtbl 9015
>       :resorigcol 3
>       :resjunk false
>       }
>       {TARGETENTRY
>       :expr
>          {VAR
>          :varno 1
>          :varattno 4
>          :vartype 19
>          :vartypmod -1
>          :varcollid 0
>          :varlevelsup 0
>          :varnoold 1
>          :varoattno 4
>          :location 7
>          }
>       :resno 4
>       :resname node_host
>       :ressortgroupref 0
>       :resorigtbl 9015
>       :resorigcol 4
>       :resjunk false
>       }
>       {TARGETENTRY
>       :expr
>          {VAR
>          :varno 1
>          :varattno 5
>          :vartype 16
>          :vartypmod -1
>          :varcollid 0
>          :varlevelsup 0
>          :varnoold 1
>          :varoattno 5
>          :location 7
>          }
>       :resno 5
>       :resname nodeis_primary
>       :ressortgroupref 0
>       :resorigtbl 9015
>       :resorigcol 5
>       :resjunk false
>       }
>       {TARGETENTRY
>       :expr
>          {VAR
>          :varno 1
>          :varattno 6
>          :vartype 16
>          :vartypmod -1
>          :varcollid 0
>          :varlevelsup 0
>          :varnoold 1
>          :varoattno 6
>          :location 7
>          }
>       :resno 6
>       :resname nodeis_preferred
>       :ressortgroupref 0
>       :resorigtbl 9015
>       :resorigcol 6
>       :resjunk false
>       }
>       {TARGETENTRY
>       :expr
>          {VAR
>          :varno 1
>          :varattno 7
>          :vartype 23
>          :vartypmod -1
>          :varcollid 0
>          :varlevelsup 0
>          :varnoold 1
>          :varoattno 7
>          :location 7
>          }
>       :resno 7
>       :resname node_id
>       :ressortgroupref 0
>       :resorigtbl 9015
>       :resorigcol 7
>       :resjunk false
>       }
>    )
>    :returningList <>
>    :groupClause <>
>    :havingQual <>
>    :windowClause <>
>    :distinctClause <>
>    :sortClause <>
>    :limitOffset <>
>    :limitCount <>
>    :rowMarks <>
>    :setOperations <>
>    :constraintDeps <>
>    }
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%LOCATION:
>  elog_node_display, print.c:83
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%STATEMENT:
>  execute direct on (datanode1) 'select * from pgxc_node';
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%LOG:  00000:
> rewritten parse tree:
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%DETAIL:  (
>    {QUERY
>    :commandType 1
>    :querySource 0
>    :canSetTag true
>    :utilityStmt ?
>    :resultRelation 0
>    :hasAggs false
>    :hasWindowFuncs false
>    :hasSubLinks false
>    :hasDistinctOn false
>    :hasRecursive false
>    :hasModifyingCTE false
>    :hasForUpdate false
>    :cteList <>
>    :rtable (
>       {RTE
>       :alias <>
>       :eref
>          {ALIAS
>          :aliasname pgxc_node
>          :colnames ("node_name" "node_type" "node_port" "node_host"
> "nodeis_pr
>          imary" "nodeis_preferred" "node_id")
>          }
>       :rtekind 0
>       :relid 9015
>       :relkind r
>       :inh true
>       :inFromCl true
>       :requiredPerms 2
>       :checkAsUser 0
>       :selectedCols (b 10 11 12 13 14 15 16)
>       :modifiedCols (b)
>       }
>    )
>    :jointree
>       {FROMEXPR
>       :fromlist (
>          {RANGETBLREF
>          :rtindex 1
>          }
>       )
>       :quals <>
>       }
>    :targetList (
>       {TARGETENTRY
>       :expr
>          {VAR
>          :varno 1
>          :varattno 1
>          :vartype 19
>          :vartypmod -1
>          :varcollid 0
>          :varlevelsup 0
>          :varnoold 1
>          :varoattno 1
>          :location 7
>          }
>       :resno 1
>       :resname node_name
>       :ressortgroupref 0
>       :resorigtbl 9015
>       :resorigcol 1
>       :resjunk false
>       }
>       {TARGETENTRY
>       :expr
>          {VAR
>          :varno 1
>          :varattno 2
>          :vartype 18
>          :vartypmod -1
>          :varcollid 0
>          :varlevelsup 0
>          :varnoold 1
>          :varoattno 2
>          :location 7
>          }
>       :resno 2
>       :resname node_type
>       :ressortgroupref 0
>       :resorigtbl 9015
>       :resorigcol 2
>       :resjunk false
>       }
>       {TARGETENTRY
>       :expr
>          {VAR
>          :varno 1
>          :varattno 3
>          :vartype 23
>          :vartypmod -1
>          :varcollid 0
>          :varlevelsup 0
>          :varnoold 1
>          :varoattno 3
>          :location 7
>          }
>       :resno 3
>       :resname node_port
>       :ressortgroupref 0
>       :resorigtbl 9015
>       :resorigcol 3
>       :resjunk false
>       }
>       {TARGETENTRY
>       :expr
>          {VAR
>          :varno 1
>          :varattno 4
>          :vartype 19
>          :vartypmod -1
>          :varcollid 0
>          :varlevelsup 0
>          :varnoold 1
>          :varoattno 4
>          :location 7
>          }
>       :resno 4
>       :resname node_host
>       :ressortgroupref 0
>       :resorigtbl 9015
>       :resorigcol 4
>       :resjunk false
>       }
>       {TARGETENTRY
>       :expr
>          {VAR
>          :varno 1
>          :varattno 5
>          :vartype 16
>          :vartypmod -1
>          :varcollid 0
>          :varlevelsup 0
>          :varnoold 1
>          :varoattno 5
>          :location 7
>          }
>       :resno 5
>       :resname nodeis_primary
>       :ressortgroupref 0
>       :resorigtbl 9015
>       :resorigcol 5
>       :resjunk false
>       }
>       {TARGETENTRY
>       :expr
>          {VAR
>          :varno 1
>          :varattno 6
>          :vartype 16
>          :vartypmod -1
>          :varcollid 0
>          :varlevelsup 0
>          :varnoold 1
>          :varoattno 6
>          :location 7
>          }
>       :resno 6
>       :resname nodeis_preferred
>       :ressortgroupref 0
>       :resorigtbl 9015
>       :resorigcol 6
>       :resjunk false
>       }
>       {TARGETENTRY
>       :expr
>          {VAR
>          :varno 1
>          :varattno 7
>          :vartype 23
>          :vartypmod -1
>          :varcollid 0
>          :varlevelsup 0
>          :varnoold 1
>          :varoattno 7
>          :location 7
>          }
>       :resno 7
>       :resname node_id
>       :ressortgroupref 0
>       :resorigtbl 9015
>       :resorigcol 7
>       :resjunk false
>       }
>    )
>    :returningList <>
>    :groupClause <>
>    :havingQual <>
>    :windowClause <>
>    :distinctClause <>
>    :sortClause <>
>    :limitOffset <>
>    :limitCount <>
>    :rowMarks <>
>    :setOperations <>
>    :constraintDeps <>
>    }
> )
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%LOCATION:
>  elog_node_display, print.c:83
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%STATEMENT:
>  execute direct on (datanode1) 'select * from pgxc_node';
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%LOG:  00000:
> plan:
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%DETAIL:
> {PLANNEDSTMT
>    :commandType 1
>    :queryId 0
>    :hasReturning false
>    :hasModifyingCTE false
>    :canSetTag true
>    :transientPlan false
>    :planTree
>       {REMOTEQUERY
>       :startup_cost 0.00
>       :total_cost 0.00
>       :plan_rows 0
>       :plan_width 0
>       :targetlist (
>          {TARGETENTRY
>          :expr
>             {VAR
>             :varno 1
>             :varattno 1
>             :vartype 19
>             :vartypmod -1
>             :varcollid 0
>             :varlevelsup 0
>             :varnoold 1
>             :varoattno 1
>             :location 7
>             }
>          :resno 1
>          :resname node_name
>          :ressortgroupref 0
>          :resorigtbl 9015
>          :resorigcol 1
>          :resjunk false
>          }
>          {TARGETENTRY
>          :expr
>             {VAR
>             :varno 1
>             :varattno 2
>             :vartype 18
>             :vartypmod -1
>             :varcollid 0
>             :varlevelsup 0
>             :varnoold 1
>             :varoattno 2
>             :location 7
>             }
>          :resno 2
>          :resname node_type
>          :ressortgroupref 0
>          :resorigtbl 9015
>          :resorigcol 2
>          :resjunk false
>          }
>          {TARGETENTRY
>          :expr
>             {VAR
>             :varno 1
>             :varattno 3
>             :vartype 23
>             :vartypmod -1
>             :varcollid 0
>             :varlevelsup 0
>             :varnoold 1
>             :varoattno 3
>             :location 7
>             }
>          :resno 3
>          :resname node_port
>          :ressortgroupref 0
>          :resorigtbl 9015
>          :resorigcol 3
>          :resjunk false
>          }
>          {TARGETENTRY
>          :expr
>             {VAR
>             :varno 1
>             :varattno 4
>             :vartype 19
>             :vartypmod -1
>             :varcollid 0
>             :varlevelsup 0
>             :varnoold 1
>             :varoattno 4
>             :location 7
>             }
>          :resno 4
>          :resname node_host
>          :ressortgroupref 0
>          :resorigtbl 9015
>          :resorigcol 4
>          :resjunk false
>          }
>          {TARGETENTRY
>          :expr
>             {VAR
>             :varno 1
>             :varattno 5
>             :vartype 16
>             :vartypmod -1
>             :varcollid 0
>             :varlevelsup 0
>             :varnoold 1
>             :varoattno 5
>             :location 7
>             }
>          :resno 5
>          :resname nodeis_primary
>          :ressortgroupref 0
>          :resorigtbl 9015
>          :resorigcol 5
>          :resjunk false
>          }
>          {TARGETENTRY
>          :expr
>             {VAR
>             :varno 1
>             :varattno 6
>             :vartype 16
>             :vartypmod -1
>             :varcollid 0
>             :varlevelsup 0
>             :varnoold 1
>             :varoattno 6
>             :location 7
>             }
>          :resno 6
>          :resname nodeis_preferred
>          :ressortgroupref 0
>          :resorigtbl 9015
>          :resorigcol 6
>          :resjunk false
>          }
>          {TARGETENTRY
>          :expr
>             {VAR
>             :varno 1
>             :varattno 7
>             :vartype 23
>             :vartypmod -1
>             :varcollid 0
>             :varlevelsup 0
>             :varnoold 1
>             :varoattno 7
>             :location 7
>             }
>          :resno 7
>          :resname node_id
>          :ressortgroupref 0
>          :resorigtbl 9015
>          :resorigcol 7
>          :resjunk false
>          }
>       )
>       :qual <>
>       :lefttree <>
>       :righttree <>
>       :initPlan <>
>       :extParam (b)
>       :allParam (b)
>       :scanrelid 0
>       :exec_direct_type 4
>       :sql_statement select\ *\ from\ pgxc_node
>       :exec_nodes
>          {EXEC_NODES
>          :primarynodelist <>
>          :nodeList (i 0)
>          :baselocatortype
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%LOCATION:
>  elog_node_display, print.c:83
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%STATEMENT:
>  execute direct on (datanode1) 'select * from pgxc_node';
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%DEBUG:  00000:
> Getting snapshot for autovacuum. Current XID = 4137
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%LOCATION:
>  GetSnapshotDataDataNode, procarray.c:2824
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%STATEMENT:
>  execute direct on (datanode1) 'select * from pgxc_node';
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%DEBUG:  00000:
> for autovacuum from GTM: xmin = 4137, xmax = 4137, xcnt = 0, RecGlobXmin =
> 4137
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%LOCATION:
>  GetSnapshotDataDataNode, procarray.c:2855
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%STATEMENT:
>  execute direct on (datanode1) 'select * from pgxc_node';
> <407732014-09-19 07:44:50 PDT%DEBUG:  00000: Pooler is handling command c
> from 0
> <407732014-09-19 07:44:50 PDT%LOCATION:  agent_handle_input, poolmgr.c:1318
> <407732014-09-19 07:44:50 PDT%DEBUG:  00000: Get OIDs from table: 1
> coordinators and 1 datanodes
> <407732014-09-19 07:44:50 PDT%LOCATION:  PgxcNodeGetOids, nodemgr.c:387
> <407732014-09-19 07:44:50 PDT%DEBUG:  00000: Pooler is handling command g
> from 40819
> <407732014-09-19 07:44:50 PDT%LOCATION:  agent_handle_input, poolmgr.c:1318
>
> ==> dn_master/pg_log/postgresql-2014-09-19_074025.log <==
> <407892014-09-19 07:44:50 PDT%DEBUG:  forked new backend, pid=40833
> socket=10
> <[unknown]408332014-09-19 07:44:50 PDT[unknown]%LOG:  connection received:
> host=10.102.103.83 port=26425
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
>  postgres child[40833]: starting with (
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
> postgres
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:  )
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
>  InitPostgres
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:  my
> backend ID is 2
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
>  StartTransaction
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
>  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid:
> 0/1/0, nestlvl: 1, children:
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
>  Postmaster child: connection established to GTM with string
> host=10.102.103.83 port=14921 node_name=datanode1
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
>  TransactionId = 4138
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%LOG:  Will
> fall back to local snapshot for XID = 4138, source = 0, gxmin = 0, autovac
> launch = 0, autovac = 0, normProcMode = 0, postEnv = 1
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
>  Local snapshot is built, xmin: 4134, xmax: 4134, xcnt: 0,
> RecentGlobalXmin: 4134
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%LOG:
>  connection authorized: user=pgxl database=postgres
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
>  CommitTransaction
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
>  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid:
> 4138/1/0, nestlvl: 1, children:
>
> ==> coord/pg_log/postgresql-2014-09-19_073943.log <==
> DEBUG:  CommitTransaction
> DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR,
> xid/subid/cid: 4138/1/0, nestlvl: 1, children:
> DEBUG:  Record transaction commit 4138
>
> ==> dn_master/pg_log/postgresql-2014-09-19_074025.log <==
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
>  Record transaction commit 4138
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
>  [re]setting xid = 0, old_value = 0
>
> ==> coord/pg_log/postgresql-2014-09-19_073943.log <==
> DEBUG:  [re]setting xid = 0, old_value = 0
> DEBUG:  StartTransactionCommand
> DEBUG:  StartTransaction
>
> ==> dn_master/pg_log/postgresql-2014-09-19_074025.log <==
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
>  StartTransactionCommand
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
>  StartTransaction
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
>  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid:
> 0/1/0, nestlvl: 1, children:
>
> ==> coord/pg_log/postgresql-2014-09-19_073943.log <==
> DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR,
> xid/subid/cid: 0/1/0, nestlvl: 1, children:
>
> ==> dn_master/pg_log/postgresql-2014-09-19_074025.log <==
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:  Done
> pgxc_nodes scan: 1 coordinators and 1 datanodes
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:  Get
> OIDs from table: 1 coordinators and 1 datanodes
>
> ==> coord/pg_log/postgresql-2014-09-19_073943.log <==
> DEBUG:  Done pgxc_nodes scan: 1 coordinators and 1 datanodes
> DEBUG:  Get OIDs from table: 1 coordinators and 1 datanodes
>
> ==> dn_master/pg_log/postgresql-2014-09-19_074025.log <==
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
>  CommitTransactionCommand
>
> ==> coord/pg_log/postgresql-2014-09-19_073943.log <==
> DEBUG:  CommitTransactionCommand
> DEBUG:  CommitTransaction
>
> ==> dn_master/pg_log/postgresql-2014-09-19_074025.log <==
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
>  CommitTransaction
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
>  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid:
> 0/1/0, nestlvl: 1, children:
>
> ==> coord/pg_log/postgresql-2014-09-19_073943.log <==
> DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR,
> xid/subid/cid: 0/1/0, nestlvl: 1, children:
>
> ==> dn_master/pg_log/postgresql-2014-09-19_074025.log <==
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
>  [re]setting xid = 0, old_value = 0
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
>  unset snapshot info
>
> ==> coord/pg_log/postgresql-2014-09-19_073943.log <==
> DEBUG:  [re]setting xid = 0, old_value = 0
> <407732014-09-19 07:44:50 PDT%DEBUG:  00000: Pooler: increased pool size
> to 1 for pool host=10.102.103.83 port=12921 dbname=postgres user=pgxl
> application_name=pgxc sslmode=disable options='-c remotetype=coordinator -c
> parentnode=coord1'
> <407732014-09-19 07:44:50 PDT%LOCATION:  grow_pool, poolmgr.c:2647
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%LOG:  00000:
> Connection error could not send data to server
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%LOCATION:
>  add_error_message, pgxcnode.c:2025
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%STATEMENT:
>  execute direct on (datanode1) 'select * from pgxc_node';
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%LOG:  00000:
> Connection error failed to send data to datanode
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%LOCATION:
>  add_error_message, pgxcnode.c:2025
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%STATEMENT:
>  execute direct on (datanode1) 'select * from pgxc_node';
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%ERROR:  XX000:
> Could not begin transaction on data node.
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%LOCATION:
>  ExecRemoteQuery, execRemote.c:7452
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%STATEMENT:
>  execute direct on (datanode1) 'select * from pgxc_node';
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%LOG:  00000:
> Connection error failed to send ROLLBACK TRANSACTION command
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%LOCATION:
>  add_error_message, pgxcnode.c:2025
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%DEBUG:  00000:
> Connection to Datanode 16384 has unexpected state 3 and will be dropped
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%LOCATION:
>  release_handles, pgxcnode.c:902
> <407732014-09-19 07:44:50 PDT%DEBUG:  00000: Pooler is handling command r
> from 40819
> <407732014-09-19 07:44:50 PDT%LOCATION:  agent_handle_input, poolmgr.c:1318
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%DEBUG:  00000:
> Record transaction abort 4137
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%LOCATION:
>  TransactionIdSetTreeStatus, clog.c:168
> <407732014-09-19 07:44:50 PDT%DEBUG:  00000: Cleaning up connection from
> pool host=10.102.103.83 port=12921 dbname=postgres user=pgxl
> application_name=pgxc sslmode=disable options='-c remotetype=coordinator -c
> parentnode=coord1', closing
> <407732014-09-19 07:44:50 PDT%LOCATION:  release_connection, poolmgr.c:2538
>
> ==> dn_master/pg_log/postgresql-2014-09-19_074025.log <==
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
>  shmem_exit(0): 9 callbacks to make
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
>  proc_exit(0): 6 callbacks to make
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
>  Postmaster child: connection to GTM closed
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
>  Postmaster child: connection to GTM closed
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
>  Total Transactions: 2 Total Statements: 0
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
>  Autocommit: 0 2PC for Autocommit: 0 2PC for non-Autocommit: 0
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:  0
> Statements per Transaction: 2 (100%)
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:  1
> Statements per Transaction: 0 (0%)
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:  2
> Statements per Transaction: 0 (0%)
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:  3
> Statements per Transaction: 0 (0%)
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:  4
> Statements per Transaction: 0 (0%)
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:  5
> Statements per Transaction: 0 (0%)
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:  6
> Statements per Transaction: 0 (0%)
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:  7
> Statements per Transaction: 0 (0%)
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:  8
> Statements per Transaction: 0 (0%)
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:  9
> Statements per Transaction: 0 (0%)
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:  10+
> Statements per Transaction: 0 (0%)
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%LOG:
>  disconnection: session time: 0:00:00.011 user=pgxl database=postgres
> host=10.102.103.83 port=26425
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
>  exit(0)
> <407892014-09-19 07:44:50 PDT%DEBUG:  forked new backend, pid=40834
> socket=10
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
>  shmem_exit(-1): 0 callbacks to make
> <10.102.103.83(26425)pgxl408332014-09-19 07:44:50 PDTpostgres%DEBUG:
>  proc_exit(-1): 0 callbacks to make
>
> ==> coord/pg_log/postgresql-2014-09-19_073943.log <==
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%DEBUG:  00000:
> [re]setting xid = 0, old_value = 0
> <localhost(32717)pgxl408192014-09-19 07:44:50 PDTpostgres%LOCATION:
>  SetNextTransactionId, varsup.c:55
>
> ==> dn_master/pg_log/postgresql-2014-09-19_074025.log <==
> <407892014-09-19 07:44:50 PDT%DEBUG:  reaping dead processes
> <407892014-09-19 07:44:50 PDT%DEBUG:  server process (PID 40833) exited
> with exit code 0
> <[unknown]408342014-09-19 07:44:50 PDT[unknown]%LOG:  connection received:
> host=10.102.103.83 port=37817
> <10.102.103.83(37817)pgxl408342014-09-19 07:44:50 PDTpostgres%DEBUG:
>  postgres child[40834]: starting with (
> <10.102.103.83(37817)pgxl408342014-09-19 07:44:50 PDTpostgres%DEBUG:
> postgres
> <10.102.103.83(37817)pgxl408342014-09-19 07:44:50 PDTpostgres%DEBUG:  )
> <10.102.103.83(37817)pgxl408342014-09-19 07:44:50 PDTpostgres%DEBUG:
>  InitPostgres
> <10.102.103.83(37817)pgxl408342014-09-19 07:44:50 PDTpostgres%DEBUG:  my
> backend ID is 2
> <10.102.103.83(37817)pgxl408342014-09-19 07:44:50 PDTpostgres%DEBUG:
>  StartTransaction
> <10.102.103.83(37817)pgxl408342014-09-19 07:44:50 PDTpostgres%DEBUG:
>  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid:
> 0/1/0, nestlvl: 1, children:
> <10.102.103.83(37817)pgxl408342014-09-19 07:44:50 PDTpostgres%DEBUG:
>  Postmaster child: connection established to GTM with string
> host=10.102.103.83 port=14921 node_name=datanode1
> <10.102.103.83(37817)pgxl408342014-09-19 07:44:50 PDTpostgres%DEBUG:
>  TransactionId = 4139
> <10.102.103.83(37817)pgxl408342014-09-19 07:44:50 PDTpostgres%LOG:  Will
> fall back to local snapshot for XID = 4139, source = 0, gxmin = 0, autovac
> launch = 0, autovac = 0, normProcMode = 0, postEnv = 1
> <10.102.103.83(37817)pgxl408342014-09-19 07:44:50 PDTpostgres%DEBUG:
>  Local snapshot is built, xmin: 4139, xmax: 4139, xcnt: 0,
> RecentGlobalXmin: 4139
> <10.102.103.83(37817)pgxl408342014-09-19 07:44:50 PDTpostgres%LOG:
>  connection authorized: user=pgxl database=postgres
>
> ==> coord/pg_log/postgresql-2014-09-19_073943.log <==
> DEBUG:  CommitTransaction
> DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR,
> xid/subid/cid: 4139/1/0, nestlvl: 1, children:
> DEBUG:  Record transaction commit 4139
>
> ==> dn_master/pg_log/postgresql-2014-09-19_074025.log <==
> <10.102.103.83(37817)pgxl408342014-09-19 07:44:50 PDTpostgres%DEBUG:
>  CommitTransaction
> <10.102.103.83(37817)pgxl408342014-09-19 07:44:50 PDTpostgres%DEBUG:
>  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid:
> 4139/1/0, nestlvl: 1, children:
> <10.102.103.83(37817)pgxl408342014-09-19 07:44:50 PDTpostgres%DEBUG:
>  Record transaction commit 4139
> <10.102.103.83(37817)pgxl408342014-09-19 07:44:50 PDTpostgres%DEBUG:
>  [re]setting xid = 0, old_value = 0
>
> ==> coord/pg_log/postgresql-2014-09-19_073943.log <==
> DEBUG:  [re]setting xid = 0, old_value = 0
> DEBUG:  StartTransactionCommand
>
> ==> dn_master/pg_log/postgresql-2014-09-19_074025.log <==
> <10.102.103.83(37817)pgxl408342014-09-19 07:44:50 PDTpostgres%DEBUG:
>  StartTransactionCommand
> <10.102.103.83(37817)pgxl408342014-09-19 07:44:50 PDTpostgres%DEBUG:
>  StartTransaction
>
> ==> coord/pg_log/postgresql-2014-09-19_073943.log <==
> DEBUG:  StartTransaction
>
> ==> dn_master/pg_log/postgresql-2014-09-19_074025.log <==
> <10.102.103.83(37817)pgxl408342014-09-19 07:44:50 PDTpostgres%DEBUG:
>  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid:
> 0/1/0, nestlvl: 1, children:
>
> ==> coord/pg_log/postgresql-2014-09-19_073943.log <==
> DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR,
> xid/subid/cid: 0/1/0, nestlvl: 1, children:
> DEBUG:  Done pgxc_nodes scan: 1 coordinators and 1 datanodes
>
> ==> dn_master/pg_log/postgresql-2014-09-19_074025.log <==
> <10.102.103.83(37817)pgxl408342014-09-19 07:44:50 PDTpostgres%DEBUG:  Done
> pgxc_nodes scan: 1 coordinators and 1 datanodes
> <10.102.103.83(37817)pgxl408342014-09-19 07:44:50 PDTpostgres%DEBUG:  Get
> OIDs from table: 1 coordinators and 1 datanodes
>
> ==> coord/pg_log/postgresql-2014-09-19_073943.log <==
> DEBUG:  Get OIDs from table: 1 coordinators and 1 datanodes
> DEBUG:  CommitTransactionCommand
> DEBUG:  CommitTransaction
> DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR,
> xid/subid/cid: 0/1/0, nestlvl: 1, children:
>
> ==> dn_master/pg_log/postgresql-2014-09-19_074025.log <==
> <10.102.103.83(37817)pgxl408342014-09-19 07:44:50 PDTpostgres%DEBUG:
>  CommitTransactionCommand
> <10.102.103.83(37817)pgxl408342014-09-19 07:44:50 PDTpostgres%DEBUG:
>  CommitTransaction
> <10.102.103.83(37817)pgxl408342014-09-19 07:44:50 PDTpostgres%DEBUG:
>  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid:
> 0/1/0, nestlvl: 1, children:
>
> ==> coord/pg_log/postgresql-2014-09-19_073943.log <==
> DEBUG:  [re]setting xid = 0, old_value = 0
>
> ==> dn_master/pg_log/postgresql-2014-09-19_074025.log <==
> <10.102.103.83(37817)pgxl408342014-09-19 07:44:50 PDTpostgres%DEBUG:
>  [re]setting xid = 0, old_value = 0
>
> ==> coord/pg_log/postgresql-2014-09-19_073943.log <==
> <407732014-09-19 07:44:50 PDT%DEBUG:  00000: Pooler: increased pool size
> to 1 for pool host=10.102.103.83 port=12921 dbname=postgres user=pgxl
> application_name=pgxc sslmode=disable options='-c remotetype=coordinator -c
> parentnode=coord1'
> <407732014-09-19 07:44:50 PDT%LOCATION:  grow_pool, poolmgr.c:2647
>
> ==> dn_master/pg_log/postgresql-2014-09-19_074025.log <==
> <10.102.103.83(37817)pgxl408342014-09-19 07:44:50 PDTpostgres%DEBUG:
>  unset snapshot info
> ====
>
> On Fri, Sep 19, 2014 at 11:32 AM, Pavan Deolasee <pavan.deolasee at gmail.com
> > wrote:
>
>>
>>
>> On Wed, Sep 17, 2014 at 5:25 AM, Ramanuj Hari <hari.ramanuj at gmail.com>
>> wrote:
>>
>>> Hi,
>>>
>>> Just wondering if Postgresql-XL is supported on FreeBSD system. Have
>>> anyone tried that.
>>>
>>>
>> I haven't heard of anyone trying this out on FreeBSD yet.
>>
>> Your configuration looks OK. Do you see anything in the log messages of
>> coordinator/datanode or gtm? Could you set log_min_messages to DEBUG1 on
>> coordinator/datanode/gtm and see if that shows something helpful?
>>
>> Thanks,
>> Pavan
>>
>>
>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.postgres-xl.org/private.cgi/postgres-xl-general-postgres-xl.org/attachments/20140922/b802fedc/attachment.htm>


More information about the postgres-xl-general mailing list