[Pgpool-general] pgpool shuts down master

Christopher Gorge Marges christophergorge at gmail.com
Thu Jan 5 03:48:43 GMT 2006


Hello,

I'm using pgpool 2.6.5, postgres 7.4.7, and RedHat 9.  We are
surprised that after a few minutes of using pgpool, it shuts the
master.  The pgpool.conf contains:
num_init_children = 20
max_pool = 2
replication_mode = true
replication_strict = true
replication_timeout = 5000
load_balance_mode = true
replication_stop_on_mismatch = true


The following is part of the logfile:


2006-01-04 22:20:52 DEBUG: pid 19424: read kind from backend pending
data Z len: 5 po: 44
2006-01-04 22:20:52 DEBUG: pid 19424: pool_process_query: kind from backend: Z
2006-01-04 22:20:52 DEBUG: pid 19424: pool_read_message_length: lenghth: 5
2006-01-04 22:20:52 DEBUG: pid 19424: ReadyForQuery: message length: 5
2006-01-04 22:20:52 DEBUG: pid 19424: ReadyForQuery: transaction state: T
2006-01-04 22:20:52 DEBUG: pid 19424: read kind from frontend Q(51)
2006-01-04 22:20:52 DEBUG: pid 19424: Query: INSERT INTO
archive_message_header values (
'2006-01-04T14:20:49.0319Z at scn1.scn.ph',
'http://www.panc.org.ph/party/1234567890999',
'http://www.panc.org.ph/party/1225821112808',
'urn:scn:cpa:1234567890999-1225821112808',
'1234567890999-2006-01-04T14:20:49.0319Z',
'urn:scn:service:ebxml-msg', 'ORDERS/XML/2.0.x',
'2006-01-04T14:20:49.0319Z', null)
2006-01-04 22:20:52 DEBUG: pid 19424: waiting for master completing the query
2006-01-04 22:20:52 DEBUG: pid 19424: read kind from backend C
2006-01-04 22:20:52 DEBUG: pid 19442: read kind from backend C
2006-01-04 22:20:52 DEBUG: pid 19424: pool_process_query: waiting for
secondary for data ready
2006-01-04 22:20:52 DEBUG: pid 19442: pool_process_query: waiting for
secondary for data ready
2006-01-04 22:20:52 DEBUG: pid 19424: pool_process_query: kind from backend: C
2006-01-04 22:20:52 DEBUG: pid 19442: pool_process_query: kind from backend: C
2006-01-04 22:20:52 DEBUG: pid 19424: read kind from backend pending
data Z len: 5 po: 22
2006-01-04 22:20:52 DEBUG: pid 19442: read kind from backend pending
data Z len: 5 po: 22
2006-01-04 22:20:52 DEBUG: pid 19424: pool_process_query: kind from backend: Z
2006-01-04 22:20:52 DEBUG: pid 19442: pool_process_query: kind from backend: Z
2006-01-04 22:20:52 DEBUG: pid 19424: pool_read_message_length: lenghth: 5
2006-01-04 22:20:52 DEBUG: pid 19442: pool_read_message_length: lenghth: 5
2006-01-04 22:20:52 DEBUG: pid 19424: ReadyForQuery: message length: 5
2006-01-04 22:20:52 DEBUG: pid 19442: ReadyForQuery: message length: 5
2006-01-04 22:20:52 DEBUG: pid 19424: ReadyForQuery: transaction state: T
2006-01-04 22:20:52 DEBUG: pid 19442: ReadyForQuery: transaction state: T
2006-01-04 22:20:52 DEBUG: pid 19424: read kind from frontend Q(51)
2006-01-04 22:20:52 DEBUG: pid 19424: Query: INSERT INTO
archive_message values ( '2006-01-04T14:20:49.0319Z at scn1.scn.ph',
'--17704280.1136384452305.JavaMail.root.scn1\\015\\012Content-Type:
text/xml\\015\\012\\015\\012<soap-env:Envelope
xmlns:soap-env="http://schemas.xmlsoap.org/soap/envelope/"><soap-env:Header><eb:MessageHeader
xmlns:eb="http://www.oasis-open.org/committees/ebxml-msg/schema/msg-header-2_0.xsd"
eb:version="2.0"
soap-env:mustUnderstand="1"><eb:From><eb:PartyId>http://www.panc.org.ph/party/1234567890999</eb:PartyId></eb:From><eb:To><eb:PartyId>http://www.panc.org.ph/party/1225821112808</eb:PartyId></eb:To><eb:CPAId>urn:scn:cpa:1234567890999-1225821112808</eb:CPAId><eb:ConversationId>1234567890999-2006-01-04T14:20:49.0319Z</eb:ConversationId><eb:Service>urn:scn:service:ebxml-msg</eb:Service><eb:Action>ORDERS/XML/2.0.x</eb:Action><eb:MessageData><eb:MessageId>2006-01-04T14:20:49.0319Z at scn1.scn.ph</eb:MessageId><eb:Timestamp>2006-01-04T14:20:49.0319Z</eb:Timestamp><eb:TimeToLive>2006-01-04T14:20:49.0319Z</eb:TimeToLive></eb:MessageData><eb:DuplicateElimination/></eb:MessageHeader></soap-env:Header><soap-env:Body/></soap-env:Envelope>\\015\\012--17704280.1136384452305.JavaMail.root.scn1\\015\\012Content-Type:
application/octet-stream;\\015\\012\\011name="orders_2.0.sample(v3.1SCN-TEST-500).csv"\\015\\012Content-Id:
cid:data\\015\\012\\015\\012PK\\003\\004\\024\\000\\010\\000\\010\\000\\320D#4\\000\\000\\000\\000\\000\\000\\000\\000\\000\\000\\000\\000\\004\\000\\000\\000data\\355\\230Mo\\233@\\020\\206\\357\\225\\372\\037V{\\307\\260\\213\\261q\\265&"\\016I6\\3026\\005\\247\\225z\\211\\010\\254]$>\\322e\\251\\312\\277\\357\\200\\355VM\\325\\264=T\\345\\300\\212\\003;\\274\\357\\3540\\317p\\201]|)r\\364Y\\310:\\253\\312%&\\023\\003#Q&U\\232\\225\\207%\\346\\321V\\263mk\\241\\021|\\341\\274~\\305*\\231\\202\\022\\251\\366I,q\\304\\327\\201\\357aT\\253X5\\365\\022oC~\\3037\\256\\217\\221\\024{!!\\013\\210\\202\\220\\257\\274\\007\\237G\\273\\207\\315\\375\\372\\322\\0131*\\233\\342Q\\310%\\266\\351t\\266\\260\\310\\33421\\312\\343\\362\\320\\304\\0070x\\033\\214\\322*i\\012Q*\\236.\\261I1J\\244\\210\\025\\324w\\025+PP\\303\\240\\2321\\327\\014\\202\\035\\366\\330\\264B:\\354\\220\\227\\016\\241\\324\\262)!\\204\\332\\206\\315\\364.\\304\\364\\323\\363Z\\344\\371\\213\\272\\263
\\025y\\006\\335h\\375*\\351\\217<Z\\246\\240\\204ePsJ\\311\\331\\362\\263\\364\\034\\351\\352t\\330^V\\005\\304\\272\\373c\\311\\266f\\202\\271\\0170\\225\\025\\002*yc\\030p1\\275\\3372\\375hQ\\325ol\\363g\\266\\316\\240\\377xx\\022C\\373s\\276\\337T\\352\\352\\370@\\244\\227\\355_\\346\\375U\\222\\262R\\242vBO\\013&\\333\\011\\012\\371\\007\\327G\\356;\\017\\301Z]EHC\\357\\335\\320\\273\\335\\336G}\\010\\241\\215\\027\\355|\\017\\005\\267\\334\\347A\\300a\\213N\\313\\230t\\307\\035\\363\\261<+\\005W\\242\\250\\321\\371ns\\032\\225\\216t\\006{\\236\\002\\017\\225\\001\\220\\231M\\347\\013bZtfO!C\\037d\\372Y\\223\\212:\\221\\331SOe\\265\\275\\276\\366\\320\\332\\335A\\001~\\264\\343+t\\347\\206\\210\\314\\215\\256e\\337eL\\212O\\215\\250\\225H\\3376q\\2512\\325\\242~\\332\\005\\314
1\\340\\253\\330K!n\\252*\\205I\\267\\260\\016M\\020*\\220Y"\\376p\\332a\\314a\\330\\247\\326\\314\\266\\272\\211ndgi\\301\\362\\361\\011^\\256\\250
],[\\267\\250\\232R9&\\261\\2403\\026\\323\\237\\305\\241U\\247S\\3771a\\375\\033\\213\\227\\260\\320\\021\\313\\020\\261\\230#\\226!b\\231\\216X\\206\\210\\305\\032\\261\\014\\021\\313l\\3042D,\\363\\021\\313\\020\\261\\330#\\226!bY\\214X\\206\\210\\205\\030#\\227\\377\\307E?\\376Er\\276\\002PK\\007\\010hf@\\307L\\002\\000\\000{\\022\\000\\000PK\\001\\002\\024\\000\\024\\000\\010\\000\\010\\000\\320D#4hf@\\307L\\002\\000\\000{\\022\\000\\000\\004\\000\\000\\000\\000\\000\\000\\000\\000\\000\\000\\000\\000\\000\\000\\000\\000\\000dataPK\\005\\006\\000\\000\\000\\000\\001\\000\\001\\0002\\000\\000\\000~\\002\\000\\000\\000\\000\\015\\012--17704280.1136384452305.JavaMail.root.scn1--\\015\\012')
2006-01-04 22:20:52 DEBUG: pid 19424: waiting for master completing the query
2006-01-04 22:20:52 DEBUG: pid 19442: read kind from frontend Q(51)
2006-01-04 22:20:52 DEBUG: pid 19442: Query: INSERT INTO
archive_message values ( '2006-01-04T14:20:48.3936Z at scn1.scn.ph',
'--23108627.1136384452636.JavaMail.root.scn2\\015\\012Content-Type:
text/xml\\015\\012\\015\\012<soap-env:Envelope
xmlns:soap-env="http://schemas.xmlsoap.org/soap/envelope/"><soap-env:Header><eb:MessageHeader
xmlns:eb="http://www.oasis-open.org/committees/ebxml-msg/schema/msg-header-2_0.xsd"
eb:version="2.0"
soap-env:mustUnderstand="1"><eb:From><eb:PartyId>http://www.panc.org.ph/party/1234567890999</eb:PartyId></eb:From><eb:To><eb:PartyId>http://www.panc.org.ph/party/1225821112808</eb:PartyId></eb:To><eb:CPAId>urn:scn:cpa:1234567890999-1225821112808</eb:CPAId><eb:ConversationId>1234567890999-2006-01-04T14:20:48.3936Z</eb:ConversationId><eb:Service>urn:scn:service:ebxml-msg</eb:Service><eb:Action>ORDERS/XML/2.0.x</eb:Action><eb:MessageData><eb:MessageId>2006-01-04T14:20:48.3936Z at scn1.scn.ph</eb:MessageId><eb:Timestamp>2006-01-04T14:20:48.3936Z</eb:Timestamp><eb:TimeToLive>2006-01-04T14:20:48.3936Z</eb:TimeToLive></eb:MessageData><eb:DuplicateElimination/></eb:MessageHeader></soap-env:Header><soap-env:Body/></soap-env:Envelope>\\015\\012--23108627.1136384452636.JavaMail.root.scn2\\015\\012Content-Type:
application/octet-stream;\\015\\012\\011name="orders_2.0.sample(v3.1SCN-TEST-500).csv"\\015\\012Content-Id:
cid:data\\015\\012\\015\\012PK\\003\\004\\024\\000\\010\\000\\010\\000\\320D#4\\000\\000\\000\\000\\000\\000\\000\\000\\000\\000\\000\\000\\004\\000\\000\\000data\\355\\230Mo\\233@\\020\\206\\357\\225\\372\\037V{\\307\\260\\213\\261q\\265&"\\016I6\\3026\\005\\247\\225z\\211\\010\\254]$>\\322e\\251\\312\\277\\357\\200\\355VM\\325\\264=T\\345\\300\\212\\003;\\274\\357\\3540\\317p\\201]|)r\\364Y\\310:\\253\\312%&\\023\\003#Q&U\\232\\225\\207%\\346\\321V\\263mk\\241\\021|\\341\\274~\\305*\\231\\202\\022\\251\\366I,q\\304\\327\\201\\357aT\\253X5\\365\\022oC~\\3037\\256\\217\\221\\024{!!\\013\\210\\202\\220\\257\\274\\007\\237G\\273\\207\\315\\375\\372\\322\\0131*\\233\\342Q\\310%\\266\\351t\\266\\260\\310\\33421\\312\\343\\362\\320\\304\\0070x\\033\\214\\322*i\\012Q*\\236.\\261I0J\\244\\210\\025\\324w\\025+PP\\303\\240\\2321\\327\\014\\202\\035\\366\\330\\264B:\\354\\220\\227\\016\\241\\324\\262)!\\204\\332\\206\\315\\364.\\304\\364\\323\\363Z\\344\\371\\213\\272\\263
\\025y\\006\\335h\\375*\\351\\217<Z\\246\\240\\204ePsJ\\311\\331\\362\\263\\364\\034\\351\\352t\\330^V\\005\\304\\272\\373c\\311\\266f\\202\\271\\0170\\225\\025\\002*yc\\030p1\\275\\3372\\375hQ\\325ol\\363g\\266\\316\\240\\377xx\\022C\\373s\\276\\337T\\352\\352\\370@\\244\\227\\355_\\346\\375U\\222\\262R\\242vBO\\013&\\333\\011\\012\\371\\007\\327G\\356;\\017\\301Z]EHC\\357\\335\\320\\273\\335\\336G}\\010\\241\\215\\027\\355|\\017\\005\\267\\334\\347A\\300a\\213N\\313\\230t\\307\\035\\363\\261<+\\005W\\242\\250\\321\\371ns\\032\\225\\216t\\006{\\236\\002\\017\\225\\001\\220\\231M\\347\\013bZtfO!C\\037d\\372Y\\223\\212:\\221\\331SOe\\265\\275\\276\\366\\320\\332\\335A\\001~\\264\\343+t\\347\\206\\210\\314\\215\\256e\\337eL\\212O\\215\\250\\225H\\3376q\\2512\\325\\242~\\332\\005\\314
1\\340\\253\\330K!n\\252*\\205I\\267\\260\\016M\\020*\\220Y"\\376p\\332a\\314a\\330\\247\\326\\314\\266(Lt#;K\\013\\226\\217O\\360rE\\005\\351b\\331\\272E\\325\\224\\3121\\211\\005\\235\\261\\230\\376,\\016\\255:\\235\\372\\217\\011\\353\\337X\\274\\204\\205\\216X\\206\\210\\305\\034\\261\\014\\021\\313t\\3042D,\\326\\210e\\210Xf#\\226!b\\231\\217X\\206\\210\\305\\036\\261\\014\\021\\313b\\3042D,\\304\\030\\271\\374?.\\372\\361/\\222\\363\\025PK\\007\\010\\262w\\327)L\\002\\000\\000{\\022\\000\\000PK\\001\\002\\024\\000\\024\\000\\010\\000\\010\\000\\320D#4\\262w\\327)L\\002\\000\\000{\\022\\000\\000\\004\\000\\000\\000\\000\\000\\000\\000\\000\\000\\000\\000\\000\\000\\000\\000\\000\\000dataPK\\005\\006\\000\\000\\000\\000\\001\\000\\001\\0002\\000\\000\\000~\\002\\000\\000\\000\\000\\015\\012--23108627.1136384452636.JavaMail.root.scn2--\\015\\012')
2006-01-04 22:20:52 DEBUG: pid 19442: waiting for master completing the query
2006-01-04 22:20:52 DEBUG: pid 19424: read kind from backend C
2006-01-04 22:20:52 DEBUG: pid 19424: pool_process_query: waiting for
secondary for data ready
2006-01-04 22:20:52 DEBUG: pid 19424: pool_process_query: kind from backend: C
2006-01-04 22:20:52 DEBUG: pid 19424: SimpleForwardToFrontend: length
does not match between backends master(21) secondary(33) kind:(C)
2006-01-04 22:20:52 ERROR: pid 19424: pool_process_query: kind does
not match between backends master(Z) secondary(C)
2006-01-04 22:20:52 DEBUG: pid 19442: read kind from backend C
2006-01-04 22:20:52 DEBUG: pid 19442: pool_process_query: waiting for
secondary for data ready
2006-01-04 22:20:52 DEBUG: pid 19442: pool_process_query: kind from backend: C
2006-01-04 22:20:52 DEBUG: pid 19442: read kind from backend pending
data Z len: 5 po: 22
2006-01-04 22:20:52 DEBUG: pid 19442: pool_process_query: kind from backend: Z
2006-01-04 22:20:52 DEBUG: pid 19442: pool_read_message_length: lenghth: 5
2006-01-04 22:20:52 DEBUG: pid 19442: ReadyForQuery: message length: 5
2006-01-04 22:20:52 DEBUG: pid 19442: ReadyForQuery: transaction state: T
2006-01-04 22:20:52 LOG:   pid 19424: notice_backend_error: master: 1
fail over request from pid 19424
2006-01-04 22:20:52 DEBUG: pid 19422: failover_handler called
2006-01-04 22:20:52 LOG:   pid 19422: starting degeneration. shutdown
master host scn1(10079)
2006-01-04 22:20:52 DEBUG: pid 19422: kill 19423
2006-01-04 22:20:52 DEBUG: pid 19422: kill 19424
2006-01-04 22:20:52 DEBUG: pid 19422: kill 19425
2006-01-04 22:20:52 DEBUG: pid 19422: kill 19426
2006-01-04 22:20:52 DEBUG: pid 19422: kill 19427
2006-01-04 22:20:52 DEBUG: pid 19422: kill 19428
2006-01-04 22:20:52 DEBUG: pid 19422: kill 19429
2006-01-04 22:20:52 DEBUG: pid 19422: kill 19430
2006-01-04 22:20:52 DEBUG: pid 19422: kill 19431
2006-01-04 22:20:52 DEBUG: pid 19422: kill 19432
2006-01-04 22:20:52 DEBUG: pid 19422: kill 19433
2006-01-04 22:20:52 DEBUG: pid 19422: kill 19434
2006-01-04 22:20:52 DEBUG: pid 19422: kill 19435
2006-01-04 22:20:52 DEBUG: pid 19423: child receives shutdown request signal 3
2006-01-04 22:20:52 DEBUG: pid 19425: child receives shutdown request signal 3
2006-01-04 22:20:52 DEBUG: pid 19426: child receives shutdown request signal 3
2006-01-04 22:20:52 DEBUG: pid 19427: child receives shutdown request signal 3
2006-01-04 22:20:52 DEBUG: pid 19428: child receives shutdown request signal 3
2006-01-04 22:20:52 DEBUG: pid 19429: child receives shutdown request signal 3
2006-01-04 22:20:52 DEBUG: pid 19430: child receives shutdown request signal 3
2006-01-04 22:20:52 DEBUG: pid 19422: kill 19436
2006-01-04 22:20:52 DEBUG: pid 19422: kill 19437
2006-01-04 22:20:52 DEBUG: pid 19422: kill 19438
2006-01-04 22:20:52 DEBUG: pid 19422: kill 19439
2006-01-04 22:20:52 DEBUG: pid 19422: kill 19440
2006-01-04 22:20:52 DEBUG: pid 19422: kill 19441
2006-01-04 22:20:52 DEBUG: pid 19422: kill 19442
2006-01-04 22:20:52 DEBUG: pid 19432: child receives shutdown request signal 3
2006-01-04 22:20:52 DEBUG: pid 19433: child receives shutdown request signal 3
2006-01-04 22:20:52 DEBUG: pid 19434: child receives shutdown request signal 3
2006-01-04 22:20:52 DEBUG: pid 19435: child receives shutdown request signal 3
2006-01-04 22:20:52 DEBUG: pid 19436: child receives shutdown request signal 3
2006-01-04 22:20:52 DEBUG: pid 19437: child receives shutdown request signal 3
2006-01-04 22:20:52 DEBUG: pid 19441: child receives shutdown request signal 3
2006-01-04 22:20:52 DEBUG: pid 19442: child receives shutdown request signal 3
2006-01-04 22:20:52 DEBUG: pid 19440: child receives shutdown request signal 3
2006-01-04 22:20:52 DEBUG: pid 19431: child receives shutdown request signal 3
2006-01-04 22:20:52 DEBUG: pid 19438: child receives shutdown request signal 3
2006-01-04 22:20:52 DEBUG: pid 19439: child receives shutdown request signal 3
2006-01-04 22:20:52 DEBUG: pid 19767: I am 19767
2006-01-04 22:20:52 DEBUG: pid 19768: I am 19768
2006-01-04 22:20:52 DEBUG: pid 19769: I am 19769
2006-01-04 22:20:52 DEBUG: pid 19770: I am 19770
2006-01-04 22:20:52 DEBUG: pid 19771: I am 19771
2006-01-04 22:20:52 DEBUG: pid 19772: I am 19772
2006-01-04 22:20:52 DEBUG: pid 19773: I am 19773
2006-01-04 22:20:52 DEBUG: pid 19774: I am 19774
2006-01-04 22:20:52 DEBUG: pid 19775: I am 19775
2006-01-04 22:20:52 DEBUG: pid 19776: I am 19776
2006-01-04 22:20:52 DEBUG: pid 19777: I am 19777
2006-01-04 22:20:52 DEBUG: pid 19778: I am 19778
2006-01-04 22:20:52 DEBUG: pid 19779: I am 19779
2006-01-04 22:20:52 DEBUG: pid 19780: I am 19780
2006-01-04 22:20:52 DEBUG: pid 19781: I am 19781
2006-01-04 22:20:52 DEBUG: pid 19782: I am 19782
2006-01-04 22:20:52 DEBUG: pid 19783: I am 19783
2006-01-04 22:20:52 DEBUG: pid 19784: I am 19784
2006-01-04 22:20:52 DEBUG: pid 19785: I am 19785
2006-01-04 22:20:52 DEBUG: pid 19787: I am 19787
2006-01-04 22:20:52 LOG:   pid 19422: degeneration done. shutdown
master host scn1(10079)
2006-01-04 22:20:52 DEBUG: pid 19422: reap_handler called

What could be the reason why this is happening?


More information about the Pgpool-general mailing list