Tue Nov 8 23:18:20 PST 2005
- Previous message: [Slony1-general] Circular replication problem
- Next message: [Slony1-general] CPU high when slony runs
- Messages sorted by: [ date ] [ thread ] [ subject ] [ author ]
Hi,
I am very new to Slony-I and fairly new to Postgresql, but am attempting
(successfully somewhat) to propogate data from 1 master to 2 remotes.
It is working as expected, although CPU runs high constantly due to the
rollbacks and commits happening constantly - Postgresql syslog follows -
Slony log shows no data other than normal connection info.
Is this expected behaviour? It happens every 3 seconds when NO DATA is
even being populated in the tables. This is with no apps even accessing
the databases while this is going on. Is there something I can do to
alleviate this? It makes our apps unusable since they are time
sensitive and the cpu is pegged. BTW - these are P4s with 2Gb ram
running on RH9 w/Postgres 7.4 if it matters.
TIA
-Greg
Nov 8 17:12:14 CCISD1500 postgres[14699]: [196-1] LOG: statement:
start transaction;set transaction isolation level serializable;select
last_value from
Nov 8 17:12:14 CCISD1500 postgres[14699]: [196-2]
"_cistera_cluster".sl_action_seq;
Nov 8 17:12:14 CCISD1500 postgres[14699]: [197-1] LOG: duration: 0.725
ms
Nov 8 17:12:14 CCISD1500 postgres[14699]: [198-1] LOG: statement:
rollback transaction;
Nov 8 17:12:14 CCISD1500 postgres[14699]: [199-1] LOG: duration: 0.214
ms
Nov 8 17:12:15 CCISD1500 postgres[14643]: [288-1] LOG: statement:
select ev_origin, ev_seqno, ev_timestamp, ev_minxid, ev_maxxid,
ev_xip, ev_type, ev_data1,
Nov 8 17:12:15 CCISD1500 postgres[14643]: [288-2] ev_data2,
ev_data3, ev_data4, ev_data5, ev_data6, ev_data7, ev_data8
from "_cistera_cluster".sl_event e
Nov 8 17:12:15 CCISD1500 postgres[14643]: [288-3] where (e.ev_origin =
'1' and e.ev_seqno > '1551') or (e.ev_origin = '3' and e.ev_seqno >
'1492') order by e.ev_origin,
Nov 8 17:12:15 CCISD1500 postgres[14643]: [288-4] e.ev_seqno
Nov 8 17:12:15 CCISD1500 postgres[14643]: [289-1] LOG: duration: 2.922
ms
Nov 8 17:12:15 CCISD1500 postgres[14644]: [288-1] LOG: statement:
select ev_origin, ev_seqno, ev_timestamp, ev_minxid, ev_maxxid,
ev_xip, ev_type, ev_data1,
Nov 8 17:12:15 CCISD1500 postgres[14644]: [288-2] ev_data2,
ev_data3, ev_data4, ev_data5, ev_data6, ev_data7, ev_data8
from "_cistera_cluster".sl_event e
Nov 8 17:12:15 CCISD1500 postgres[14644]: [288-3] where (e.ev_origin =
'1' and e.ev_seqno > '1551') or (e.ev_origin = '2' and e.ev_seqno >
'1924') order by e.ev_origin,
Nov 8 17:12:15 CCISD1500 postgres[14644]: [288-4] e.ev_seqno
Nov 8 17:12:15 CCISD1500 postgres[14644]: [289-1] LOG: duration: 2.707
ms
Nov 8 17:12:24 CCISD1500 postgres[14699]: [200-1] LOG: statement:
start transaction;set transaction isolation level serializable;select
last_value from
Nov 8 17:12:24 CCISD1500 postgres[14699]: [200-2]
"_cistera_cluster".sl_action_seq;
Nov 8 17:12:24 CCISD1500 postgres[14699]: [201-1] LOG: duration: 0.832
ms
Nov 8 17:12:24 CCISD1500 postgres[14699]: [202-1] LOG: statement:
rollback transaction;
Nov 8 17:12:24 CCISD1500 postgres[14699]: [203-1] LOG: duration: 0.225
ms
Nov 8 17:12:25 CCISD1500 postgres[14643]: [290-1] LOG: statement:
select ev_origin, ev_seqno, ev_timestamp, ev_minxid, ev_maxxid,
ev_xip, ev_type, ev_data1,
Nov 8 17:12:25 CCISD1500 postgres[14643]: [290-2] ev_data2,
ev_data3, ev_data4, ev_data5, ev_data6, ev_data7, ev_data8
from "_cistera_cluster".sl_event e
Nov 8 17:12:25 CCISD1500 postgres[14643]: [290-3] where (e.ev_origin =
'1' and e.ev_seqno > '1551') or (e.ev_origin = '3' and e.ev_seqno >
'1492') order by e.ev_origin,
Nov 8 17:12:25 CCISD1500 postgres[14643]: [290-4] e.ev_seqno
Nov 8 17:12:25 CCISD1500 postgres[14643]: [291-1] LOG: duration: 3.081
ms
Nov 8 17:12:25 CCISD1500 postgres[14644]: [290-1] LOG: statement:
select ev_origin, ev_seqno, ev_timestamp, ev_minxid, ev_maxxid,
ev_xip, ev_type, ev_data1,
Nov 8 17:12:25 CCISD1500 postgres[14644]: [290-2] ev_data2,
ev_data3, ev_data4, ev_data5, ev_data6, ev_data7, ev_data8
from "_cistera_cluster".sl_event e
Nov 8 17:12:25 CCISD1500 postgres[14644]: [290-3] where (e.ev_origin =
'1' and e.ev_seqno > '1551') or (e.ev_origin = '2' and e.ev_seqno >
'1924') order by e.ev_origin,
Nov 8 17:12:25 CCISD1500 postgres[14644]: [290-4] e.ev_seqno
Nov 8 17:12:25 CCISD1500 postgres[14644]: [291-1] LOG: duration: 2.892
ms
Nov 8 17:12:29 CCISD1500 postgres[14691]: [83-1] LOG: statement: begin
transaction; set transaction isolation level serializable;
Nov 8 17:12:29 CCISD1500 postgres[14691]: [84-1] LOG: duration: 0.398
ms
Nov 8 17:12:29 CCISD1500 postgres[14691]: [85-1] LOG: statement:
notify "_cistera_cluster_Event"; notify "_cistera_cluster_Confirm";
insert into "_cistera_cluster".sl_event
Nov 8 17:12:29 CCISD1500 postgres[14691]: [85-2] (ev_origin, ev_seqno,
ev_timestamp, ev_minxid, ev_maxxid, ev_xip, ev_type ) values
('3', '1493', '2005-11-08
Nov 8 17:12:29 CCISD1500 postgres[14691]: [85-3] 17:12:29.651485',
'3185951', '3203037', '''3185951''', 'SYNC'); insert into
"_cistera_cluster".sl_confirm ^I(con_origin,
Nov 8 17:12:29 CCISD1500 postgres[14691]: [85-4] con_received,
con_seqno, con_timestamp) values (3, 1, '1493', now()); commit
transaction;
Nov 8 17:12:29 CCISD1500 postgres[14691]: [86-1] LOG: duration: 6.234
ms
Nov 8 17:12:29 CCISD1500 postgres[14643]: [292-1] LOG: statement:
select ev_origin, ev_seqno, ev_timestamp, ev_minxid, ev_maxxid,
ev_xip, ev_type, ev_data1,
Nov 8 17:12:29 CCISD1500 postgres[14643]: [292-2] ev_data2,
ev_data3, ev_data4, ev_data5, ev_data6, ev_data7, ev_data8
from "_cistera_cluster".sl_event e
Nov 8 17:12:29 CCISD1500 postgres[14643]: [292-3] where (e.ev_origin =
'1' and e.ev_seqno > '1551') or (e.ev_origin = '3' and e.ev_seqno >
'1492') order by e.ev_origin,
Nov 8 17:12:29 CCISD1500 postgres[14643]: [292-4] e.ev_seqno
Nov 8 17:12:29 CCISD1500 postgres[14643]: [293-1] LOG: duration: 3.156
ms
Nov 8 17:12:29 CCISD1500 postgres[14643]: [294-1] LOG: statement:
select con_origin, con_received, max(con_seqno) as con_seqno,
max(con_timestamp) as con_timestamp from
Nov 8 17:12:29 CCISD1500 postgres[14643]: [294-2]
"_cistera_cluster".sl_confirm where con_received <> 2 group by
con_origin, con_received
Nov 8 17:12:29 CCISD1500 postgres[14643]: [295-1] LOG: duration: 1.865
ms
Nov 8 17:12:29 CCISD1500 postgres[14644]: [292-1] LOG: statement:
select ev_origin, ev_seqno, ev_timestamp, ev_minxid, ev_maxxid,
ev_xip, ev_type, ev_data1,
Nov 8 17:12:29 CCISD1500 postgres[14644]: [292-2] ev_data2,
ev_data3, ev_data4, ev_data5, ev_data6, ev_data7, ev_data8
from "_cistera_cluster".sl_event e
Nov 8 17:12:29 CCISD1500 postgres[14609]: [159-1] LOG: statement:
start transaction; set transaction isolation level serializable;
Nov 8 17:12:29 CCISD1500 postgres[14644]: [292-3] where (e.ev_origin =
'1' and e.ev_seqno > '1551') or (e.ev_origin = '2' and e.ev_seqno >
'1924') order by e.ev_origin,
Nov 8 17:12:29 CCISD1500 postgres[14609]: [160-1] LOG: duration: 1.796
ms
Nov 8 17:12:29 CCISD1500 postgres[14644]: [292-4] e.ev_seqno
Nov 8 17:12:29 CCISD1500 postgres[14609]: [161-1] LOG: statement:
select ev_seqno, ev_timestamp, ev_minxid, ev_maxxid, ev_xip,
ev_type, ev_data1, ev_data2,
Nov 8 17:12:29 CCISD1500 postgres[14644]: [293-1] LOG: duration: 8.536
ms
Nov 8 17:12:29 CCISD1500 postgres[14609]: [161-2] ev_data3, ev_data4,
ev_data5, ev_data6, ev_data7, ev_data8 from "_cistera_cluster".sl_event
where ev_origin = '1'
Nov 8 17:12:29 CCISD1500 postgres[14609]: [161-3] and ev_seqno >
'1551' order by ev_seqno
Nov 8 17:12:29 CCISD1500 postgres[14609]: [162-1] LOG: duration: 9.283
ms
Nov 8 17:12:29 CCISD1500 postgres[14644]: [294-1] LOG: statement:
select con_origin, con_received, max(con_seqno) as con_seqno,
max(con_timestamp) as con_timestamp from
Nov 8 17:12:29 CCISD1500 postgres[14609]: [163-1] LOG: statement:
rollback transaction;
Nov 8 17:12:29 CCISD1500 postgres[14644]: [294-2]
"_cistera_cluster".sl_confirm where con_received <> 3 group by
con_origin, con_received
Nov 8 17:12:29 CCISD1500 postgres[14609]: [164-1] LOG: duration: 1.848
ms
Nov 8 17:12:29 CCISD1500 postgres[14644]: [295-1] LOG: duration: 5.823
ms
Nov 8 17:12:29 CCISD1500 postgres[14679]: [83-1] LOG: statement:
select "_cistera_cluster".forwardConfirm(3, 2, '1493', '2005-11-08
17:12:29.839209');
Nov 8 17:12:29 CCISD1500 postgres[14679]: [84-1] LOG: duration: 6.953
ms
Nov 8 17:12:29 CCISD1500 postgres[14643]: [296-1] LOG: statement:
select ev_origin, ev_seqno, ev_timestamp, ev_minxid, ev_maxxid,
ev_xip, ev_type, ev_data1,
Nov 8 17:12:29 CCISD1500 postgres[14643]: [296-2] ev_data2,
ev_data3, ev_data4, ev_data5, ev_data6, ev_data7, ev_data8
from "_cistera_cluster".sl_event e
Nov 8 17:12:29 CCISD1500 postgres[14643]: [296-3] where (e.ev_origin =
'1' and e.ev_seqno > '1551') or (e.ev_origin = '3' and e.ev_seqno >
'1493') order by e.ev_origin,
Nov 8 17:12:29 CCISD1500 postgres[14643]: [296-4] e.ev_seqno
Nov 8 17:12:29 CCISD1500 postgres[14643]: [297-1] LOG: duration: 6.128
ms
Nov 8 17:12:29 CCISD1500 postgres[14644]: [296-1] LOG: statement:
select ev_origin, ev_seqno, ev_timestamp, ev_minxid, ev_maxxid,
ev_xip, ev_type, ev_data1,
Nov 8 17:12:29 CCISD1500 postgres[14644]: [296-2] ev_data2,
ev_data3, ev_data4, ev_data5, ev_data6, ev_data7, ev_data8
from "_cistera_cluster".sl_event e
Nov 8 17:12:29 CCISD1500 postgres[14644]: [296-3] where (e.ev_origin =
'1' and e.ev_seqno > '1551') or (e.ev_origin = '2' and e.ev_seqno >
'1924') order by e.ev_origin,
Nov 8 17:12:29 CCISD1500 postgres[14644]: [296-4] e.ev_seqno
Nov 8 17:12:29 CCISD1500 postgres[14643]: [298-1] LOG: statement:
select con_origin, con_received, max(con_seqno) as con_seqno,
max(con_timestamp) as con_timestamp from
Nov 8 17:12:29 CCISD1500 postgres[14644]: [297-1] LOG: duration: 6.703
ms
Nov 8 17:12:29 CCISD1500 postgres[14643]: [298-2]
"_cistera_cluster".sl_confirm where con_received <> 2 group by
con_origin, con_received
Nov 8 17:12:29 CCISD1500 postgres[14643]: [299-1] LOG: duration: 8.250
ms
Nov 8 17:12:29 CCISD1500 postgres[14644]: [298-1] LOG: statement:
select con_origin, con_received, max(con_seqno) as con_seqno,
max(con_timestamp) as con_timestamp from
Nov 8 17:12:29 CCISD1500 postgres[14644]: [298-2]
"_cistera_cluster".sl_confirm where con_received <> 3 group by
con_origin, con_received
Nov 8 17:12:29 CCISD1500 postgres[14644]: [299-1] LOG: duration: 4.395
ms
Nov 8 17:12:34 CCISD1500 postgres[14699]: [204-1] LOG: statement:
start transaction;set transaction isolation level serializable;select
last_value from
Nov 8 17:12:34 CCISD1500 postgres[14699]: [204-2]
"_cistera_cluster".sl_action_seq;
Nov 8 17:12:34 CCISD1500 postgres[14699]: [205-1] LOG: duration: 0.791
ms
Nov 8 17:12:34 CCISD1500 postgres[14699]: [206-1] LOG: statement:
rollback transaction;
Nov 8 17:12:34 CCISD1500 postgres[14699]: [207-1] LOG: duration: 0.258
ms
- Previous message: [Slony1-general] Circular replication problem
- Next message: [Slony1-general] CPU high when slony runs
- Messages sorted by: [ date ] [ thread ] [ subject ] [ author ]
More information about the Slony1-general mailing list