[Linux-HA] cib_update, cib writes Warnings

Lenaerts Jan Jan.Lenaerts at cronos.be
Mon Oct 3 01:31:38 MDT 2005


Date: Fri, 30 Sep 2005 15:18:16 +0200
From: "Andrew Beekhof (GMail)" <beekhof at gmail.com>
Subject: Re: [Linux-HA] cib_update, cib writes Warnings
To: General Linux-HA mailing list <linux-ha at lists.linux-ha.org>
Message-ID: <569DC91B-E216-46E0-AF6C-F242E00F4381 at gmail.com>
Content-Type: text/plain; charset=US-ASCII; delsp=yes; format=flowed

the output of the BasicSanityCheck:
vmsteven:~# /usr/lib/heartbeat/BasicSanityCheck
Starting heartbeat
Starting High-Availability services:
Done.

Reloading heartbeat
Reloading heartbeat
Stopping heartbeat
Stopping High-Availability services:
Done.

Checking STONITH basic sanity.
Performing apphbd success case tests
Performing apphbd failure case tests
Starting IPC tests
Starting LRM tests
Starting heartbeat
Starting High-Availability services:
Done.

starting STONITH Daemon tests
STONITH Daemon tests passed.
Stopping heartbeat
Stopping High-Availability services:
Done.

Starting CRM tests
CRM tests failed.
Starting heartbeat
Starting High-Availability services:
Done.


>Can you please try running BasicSanityCheck as root and let us know  
>if it passes?
>
>On Sep 30, 2005, at 3:00 PM, Lenaerts Jan wrote:

>>
>> hello,
>>
>> I'am running debian 2.6.8-2-386, and installed heartbeat 2.0.2  
>> (unstable)with the .deb packages from the ultra monkey site
>> it worked perfect with the configuration from heartbeat 1.x, but  
>> when I started using crm & the cib config file  I've got nothing  
>> but problems.
>> (btw, there was a smal bug in the .deb package so i created the / 
>> var/lib/heartbeat/ccm and /var/run/heartbeat/crm dir's AND gave  
>> cib.xml all rights because it warned me it couldn't write to the  
>> cib.xml)
>> it doesn't work at all with 2 nodes on heartbeat, but I first want  
>> to solve the problem of starting one node correct.
>>
>> when I start the slave node(vmsteven) it doesn't start any resources.
>> and gives lots of cib_update & cib writes warnings
more logs and confs in the  Linux-HA Digest, Vol 22, Issue 112
> Sep 25 23:31:52 localhost ccm: [10156]: info:  
> G_main_add_SignalHandler: Added signal handler for signal 15
> Sep 25 23:31:52 localhost heartbeat: [10157]: info: Starting "/usr/ 
> lib/heartbeat/cib" as uid 1001  gid 105 (pid 10157)
> Sep 25 23:31:52 localhost cib: [10157]: info:  
> G_main_add_SignalHandler: Added signal handler for signal 15
> Sep 25 23:31:52 localhost cib: [10157]: info: mask 
> (main.c:cib_register_ha): Signing in with Heartbeat
> Sep 25 23:31:52 localhost cib: [10157]: info: mask 
> (main.c:cib_register_ha): FSA Hostname: vmsteven
> Sep 25 23:31:52 localhost cib: [10157]: WARN: mask(assign_uuid):  
> Updated object <nvpair name="ip" value="10.0.200.30"  
> id="95e807e2-133d-4faa-a03a-35696e6a0718"/>
> Sep 25 23:31:52 localhost cib: [10157]: WARN: mask(assign_uuid):  
> Updated object <nvpair name="netmask" value="16"  
> id="e93bab83-30d7-4bfb-9207-f9c51236369d"/>
> Sep 25 23:31:52 localhost cib: [10157]: WARN: mask(assign_uuid):  
> Updated object <nvpair name="nic" value="eth0"  
> id="ae207928-1a5b-40fb-891d-25d772a47839"/>
> Sep 25 23:31:52 localhost cib: [10157]: WARN: mask(assign_uuid):  
> Updated object <op id="ea208716-a238-404d-84f9-d83d12ae6d9a"  
> interval="120s" name="monitor" timeout="60s"/>
> Sep 25 23:31:52 localhost cib: [10157]: WARN: mask(assign_uuid):  
> Updated object <expression attribute="#uname" operation="eq"  
> value="vnbak" id="3129142c-25cf-4078-b50b-3ff1293d3b1a"/>
> Sep 25 23:31:52 localhost cib: [10157]: WARN: mask 
> (io.c:initializeCib): Option suppress_cib_writes not set
> Sep 25 23:31:52 localhost cib: [10157]: info: mask 
> (main.c:startCib): CIB Initialization completed successfully
> Sep 25 23:31:52 localhost cib: [10157]: info: mask 
> (main.c:init_start): Starting cib mainloop
> Sep 25 23:31:52 localhost heartbeat: [10158]: info: Starting "/usr/ 
> lib/heartbeat/stonithd" as uid 0  gid 0 (pid 10158)
> Sep 25 23:31:52 localhost heartbeat: [10159]: info: Starting "/usr/ 
> lib/heartbeat/lrmd" as uid 0  gid 0 (pid 10159)
> Sep 25 23:31:52 localhost heartbeat: [10160]: info: Starting "/usr/ 
> lib/heartbeat/crmd" as uid 1001  gid 105 (pid 10160)
> Sep 25 23:31:52 localhost crmd: [10160]: info: mask 
> (main.c:init_start): Starting crmd
> Sep 25 23:31:52 localhost crmd: [10160]: info: mask 
> (control.c:register_with_ha): FSA Hostname: vmsteven
> Sep 25 23:31:52 localhost crmd: [10160]: info: mask 
> (control.c:do_startup): Register Signal Handler
> Sep 25 23:31:52 localhost crmd: [10160]: info:  
> G_main_add_SignalHandler: Added signal handler for signal 15
> Sep 25 23:31:52 localhost crmd: [10160]: info:  
> G_main_add_TriggerHandler: Added signal manual handler
> Sep 25 23:31:52 localhost crmd: [10160]: info: mask 
> (control.c:do_startup): Init server comms
> Sep 25 23:31:52 localhost crmd: [10160]: info: mask 
> (control.c:do_startup): Creating CIB object
> Sep 25 23:31:52 localhost crmd: [10160]: info:  
> G_main_add_SignalHandler: Added signal handler for signal 17
> Sep 25 23:31:52 localhost crmd: [10160]: info: mask 
> (cib_native.c:cib_native_signon): Connection to CIB successful
> Sep 25 23:31:52 localhost crmd: [10160]: info: mask 
> (ccm.c:do_ccm_control): CCM Activation passed... all set to go!
> Sep 25 23:31:52 localhost crmd: [10160]: info: mask 
> (control.c:do_started): Delaying start, CCM (0000000000100000) not  
> connected
> Sep 25 23:31:52 localhost crmd: [10160]: info: mask 
> (main.c:init_start): Starting crmd's mainloop
> Sep 25 23:31:52 localhost crmd: [10160]: info: mask 
> (control.c:do_started): Delaying start, CCM (0000000000100000) not  
> connected
> Sep 25 23:31:52 localhost stonithd: [10158]: info: Enable using  
> logging daemon
> Sep 25 23:31:52 localhost stonithd: [10158]: info:  
> G_main_add_SignalHandler: Added signal handler for signal 10
> Sep 25 23:31:52 localhost stonithd: [10158]: info:  
> G_main_add_SignalHandler: Added signal handler for signal 12
> Sep 25 23:31:52 localhost stonithd: [10158]: info: pid 10158 locked  
> in memory.
> Sep 25 23:31:52 localhost stonithd: [10158]: info: Signing in with  
> heartbeat.
> Sep 25 23:31:52 localhost stonithd: [10158]: notice: /usr/lib/ 
> heartbeat/stonithd start up successfully.
> Sep 25 23:31:52 localhost stonithd: [10158]: info:  
> G_main_add_SignalHandler: Added signal handler for signal 17
> Sep 25 23:31:52 localhost lrmd: [10159]: info: Enable using logging  
> daemon
> Sep 25 23:31:52 localhost heartbeat: [10148]: WARN: Exiting /usr/ 
> lib/heartbeat/lrmd process 10159 returned rc 100.
> Sep 25 23:31:53 localhost ccm: [10156]: info: ccm from vmsteven  
> started
> Sep 25 23:31:53 localhost cib: [10157]: info: mem_handle_event: Got  
> an event OC_EV_MS_NEW_MEMBERSHIP from ccm
> Sep 25 23:31:53 localhost cib: [10157]: info: mem_handle_event:  
> instance=1, nodes=1, new=1, lost=0, n_idx=0, new_idx=0, old_idx=3
> Sep 25 23:31:53 localhost crmd: [10160]: info: mem_handle_event:  
> Got an event OC_EV_MS_NEW_MEMBERSHIP from ccm
> Sep 25 23:31:53 localhost cib: [10157]: info: mask 
> (callbacks.c:cib_ccm_msg_callback): Process CCM event=NEW  
> MEMBERSHIP (id=1)Sep 25 23:31:53 localhost crmd: [10160]: info:  
> mem_handle_event: instance=1, nodes=1, new=1, lost=0, n_idx=0,  
> new_idx=0, old_idx=3
> Sep 25 23:31:53 localhost cib: [10157]: info: mask 
> (callbacks.c:cib_ccm_msg_callback): Quorum (re)attained after  
> event=NEW MEMBERSHIP (id=1)
> Sep 25 23:31:53 localhost crmd: [10160]: info: mask 
> (callbacks.c:crmd_ccm_msg_callback): Quorum (re)attained after  
> event=NEW MEMBERSHIP (id=1)
> Sep 25 23:31:53 localhost crmd: [10160]: info: mask 
> (ccm.c:ccm_event_detail): NEW MEMBERSHIP: trans=1, nodes=1, new=1,  
> lost=0 n_idx=0, new_idx=0, old_idx=3
> Sep 25 23:31:53 localhost crmd: [10160]: info: mask 
> (ccm.c:ccm_event_detail): ^INEW:     vmsteven [nodeid=0, born=1]
> Sep 25 23:31:53 localhost crmd: [10160]: info: mask 
> (control.c:do_started): The local CRM is operational
> Sep 25 23:31:53 localhost crmd: [10160]: info: mask 
> (fsa.c:do_state_transition): State transition S_STARTING ->  
> S_PENDING [ input=I_PENDING cause=C_CCM_CALLBACK origin=do_started ]
> Sep 25 23:32:05 localhost crmd: [10160]: info: mask 
> (utils.c:crm_timer_popped): Election Trigger (I_DC_TIMEOUT) just  
> popped!
> Sep 25 23:32:05 localhost crmd: [10160]: WARN: mask(misc.c:do_log):  
> [[FSA]] Input I_DC_TIMEOUT from crm_timer_popped() received in  
> state (S_PENDING)
> Sep 25 23:32:05 localhost crmd: [10160]: info: mask 
> (fsa.c:do_state_transition): State transition S_PENDING ->  
> S_ELECTION [ input=I_DC_TIMEOUT cause=C_TIMER_POPPED  
> origin=crm_timer_popped ]
> Sep 25 23:32:11 localhost crmd: [10160]: info: mask 
> (utils.c:crm_timer_popped): Election Timeout (I_ELECTION_DC) just  
> popped!
> Sep 25 23:32:11 localhost pengine: [10162]: info:  
> G_main_add_SignalHandler: Added signal handler for signal 15
> Sep 25 23:32:11 localhost crmd: [10160]: info: mask 
> (fsa.c:do_state_transition): State transition S_ELECTION ->  
> S_INTEGRATION [ input=I_ELECTION_DC cause=C_TIMER_POPPED  
> origin=crm_timer_popped ]
> Sep 25 23:32:11 localhost pengine: [10162]: info: mask 
> (main.c:init_start): Starting pengine
> Sep 25 23:32:11 localhost crmd: [10160]: info: mask 
> (subsystems.c:start_subsystem): Starting sub-system "tengine"
> Sep 25 23:32:11 localhost crmd: [10160]: info: mask 
> (subsystems.c:start_subsystem): Starting sub-system "pengine"
> Sep 25 23:32:11 localhost crmd: [10160]: info: mask 
> (election.c:do_dc_takeover): Taking over DC status for this partition
> Sep 25 23:32:11 localhost crmd: [10160]: info: mask 
> (join_dc.c:do_dc_join_offer_all): 0) Offering membership to 1 clients
> Sep 25 23:32:11 localhost crmd: [10160]: notice: mask 
> (callbacks.c:crmd_client_status_callback): Status update: Client  
> vmsteven/crmd now has status [online]
> Sep 25 23:32:11 localhost cib: [10157]: info: mask 
> (messages.c:cib_process_readwrite): We are now in R/W mode
> Sep 25 23:32:11 localhost cib: [10157]: info: mask 
> (messages.c:revision_check): Updating CIB revision to 1
> Sep 25 23:32:11 localhost cib: [10157]: WARN: mask 
> (io.c:initializeCib): Option suppress_cib_writes not set
> Sep 25 23:32:11 localhost cib: [10157]: WARN: mask 
> (io.c:initializeCib): Option suppress_cib_writes not set
> Sep 25 23:32:11 localhost tengine: [10161]: info:  
> G_main_add_SignalHandler: Added signal handler for signal 15
> Sep 25 23:32:11 localhost cib: [10157]: WARN: mask 
> (callbacks.c:cib_process_command): Activation failed
> Sep 25 23:32:11 localhost cib: [10157]: WARN: mask 
> (notify.c:do_cib_notify): cib_update of <status > FAILED:  
> Activation FailedSep 25 23:32:11 localhost cib: [10157]: WARN: mask 
> (notify.c:do_cib_notify): cib_update of <status > FAILED:  
> Activation FailedSep 25 23:32:11 localhost cib: [10157]: WARN: mask 
> (callbacks.c:cib_process_request): Request not broadcast: call  
> failed: Activation Failed
> Sep 25 23:32:11 localhost cib: [10157]: WARN: mask 
> (io.c:initializeCib): Option suppress_cib_writes not set
> Sep 25 23:32:11 localhost cib: [10157]: WARN: mask 
> (io.c:initializeCib): Option suppress_cib_writes not set
> Sep 25 23:32:11 localhost cib: [10157]: WARN: mask 
> (callbacks.c:cib_process_command): Activation failed
> Sep 25 23:32:11 localhost cib: [10157]: WARN: mask 
> (notify.c:do_cib_notify): cib_update of <status > FAILED:  
> Activation FailedSep 25 23:32:11 localhost cib: [10157]: WARN: mask 
> (notify.c:do_cib_notify): cib_update of <status > FAILED:  
> Activation FailedSep 25 23:32:11 localhost tengine: [10161]: info:  
> mask(cib_native.c:cib_native_signon): Connection to CIB successful
> Sep 25 23:32:11 localhost tengine: [10161]: info: mask 
> (main.c:init_start): Starting tengine
> Sep 25 23:32:11 localhost tengine: [10161]: info: mask 
> (tengine.c:initialize_graph): Registering TE UUID:  
> 397704d9-843b-42e2-846a-672d73bfea1b
> Sep 25 23:32:11 localhost cib: [10157]: info: mask 
> (callbacks.c:cib_null_callback): Setting cib_diff_notify callbacks  
> for tengine: on
> Sep 25 23:32:11 localhost crmd: [10160]: WARN: mask 
> (cib_native.c:cib_native_callback): CIB command failed: Activation  
> Failed
> Sep 25 23:32:11 localhost crmd: [10160]: WARN: mask 
> (cib_native.c:cib_native_callback): CIB command failed: Activation  
-------------- next part --------------
A non-text attachment was scrubbed...
Name: winmail.dat
Type: application/ms-tnef
Size: 6819 bytes
Desc: not available
URL: <http://lists.linux-ha.org/pipermail/linux-ha/attachments/20051003/cbe8ea9f/attachment.bin>


More information about the Linux-HA mailing list