[Openais] Migration from Heartbeat

Steven Dake sdake at redhat.com
Wed Aug 6 09:52:29 PDT 2008


One problem I see is that the pacemaker plugin isn't loaded.  I think
Andrew can help with this.  Addressing that issue should solve your
problems.  The rest of the openais logs themselves look correct.

Regards
-steve

On Wed, 2008-08-06 at 11:34 -0400, Audet, Jean-Michel wrote:
> Hi, 
> 
>       I was using heartbeat v2 full package for the last couple of
> months.  I had great functionality but a lot of errors (and a crash)
> when trying to send large amount of data from one node to another
> one.  Since the error was with the communication link, Andrew Beekhof
> suggests that I migrate to openais.  I have install package for RHEL4
> version 0.83 (RPM).  
> 
>  
> 
> I need 2 nodes in the Master/Slave configuration.  
> 
> I need that the cluster manager starts my application, which is name
> openhpid here. (See in CIB.xml).
> 
> I need to have a common IPaddress handle by the master node.  (See in
> CIB.xml).
> 
>  
> 
> This was working OK with the full heartbeat stack.
> 
>  
> 
> I have followed the steps from the documentation available on the web
> site.  Have been able to start openais in /etc/init.d/openais.
> 
>  
> 
> I am not sure what I am doing wrong.  The second nodes seem to join.
> However, no more action following the “starting mainloop” line.  In
> heartbeat, my application was starting couple of seconds following a
> similar line.
> 
>  
> 
> Oct 12 01:27:46 node1 attrd: [3882]: info: main: Starting mainloop... 
> 
>  
> 
>  
> 
> Anymore informations required, thanks!
> 
>  
> 
>  
> 
> I have attached the cib.xml file and the openais.conf file.
> 
>  
> 
>  
> 
> Here is the log when it starts:
> 
>  
> 
> Oct 12 01:27:35 node1 openais[3873]: [MAIN ] AIS Executive Service
> RELEASE 'trunk' 
> 
> Oct 12 01:27:35 node1 openais[3873]: [MAIN ] Copyright (C) 2002-2006
> MontaVista Software, Inc and contributors. 
> 
> Oct 12 01:27:35 node1 openais[3873]: [MAIN ] Copyright (C) 2006-2007
> Red Hat, Inc. 
> 
> Oct 12 01:27:35 node1 openais[3873]: [MAIN ] AIS Executive Service:
> started and ready to provide service. 
> 
> Oct 12 01:27:35 node1 openais[3873]: [MAIN ] Successfully read main
> configuration file '/etc/ais/openais.conf'. 
> 
> Oct 12 01:27:35 node1 openais[3873]: [TOTEM] Token Timeout (1000 ms)
> retransmit timeout (238 ms) 
> 
> Oct 12 01:27:35 node1 openais[3873]: [TOTEM] token hold (180 ms)
> retransmits before loss (4 retrans) 
> 
> Oct 12 01:27:35 node1 openais[3873]: [TOTEM] join (50 ms) send_join (0
> ms) consensus (800 ms) merge (200 ms) 
> 
> Oct 12 01:27:35 node1 openais[3873]: [TOTEM] downcheck (1000 ms) fail
> to recv const (50 msgs) 
> 
> Oct 12 01:27:35 node1 openais[3873]: [TOTEM] seqno unchanged const (30
> rotations) Maximum network MTU 1500 
> 
> Oct 12 01:27:35 node1 openais[3873]: [TOTEM] window size per rotation
> (50 messages) maximum messages per rotation (17 messages) 
> 
> Oct 12 01:27:35 node1 openais[3873]: [TOTEM] send threads (0 threads) 
> 
> Oct 12 01:27:35 node1 openais[3873]: [TOTEM] RRP token expired timeout
> (238 ms) 
> 
> Oct 12 01:27:35 node1 openais[3873]: [TOTEM] RRP token problem counter
> (2000 ms) 
> 
> Oct 12 01:27:35 node1 openais[3873]: [TOTEM] RRP threshold (10 problem
> count) 
> 
> Oct 12 01:27:35 node1 openais[3873]: [TOTEM] RRP mode set to none. 
> 
> Oct 12 01:27:35 node1 openais[3873]: [TOTEM]
> heartbeat_failures_allowed (0) 
> 
> Oct 12 01:27:35 node1 openais[3873]: [TOTEM] max_network_delay (50
> ms) 
> 
> Oct 12 01:27:35 node1 openais[3873]: [TOTEM] HeartBeat is Disabled. To
> enable set heartbeat_failures_allowed > 0 
> 
> Oct 12 01:27:35 node1 openais[3873]: [TOTEM] Receive multicast socket
> recv buffer size (262142 bytes). 
> 
> Oct 12 01:27:35 node1 openais[3873]: [TOTEM] Transmit multicast socket
> send buffer size (262142 bytes). 
> 
> Oct 12 01:27:35 node1 openais[3873]: [TOTEM] The network interface
> [192.168.0.72] is now up. 
> 
> Oct 12 01:27:35 node1 openais[3873]: [TOTEM] Created or loaded
> sequence id 9508.192.168.0.72 for this ring. 
> 
> Oct 12 01:27:35 node1 openais[3873]: [TOTEM] entering GATHER state
> from 15. 
> 
> Oct 12 01:27:35 node1 openais[3873]: [SERV ] Service initialized
> 'openais extended virtual synchrony service' 
> 
> Oct 12 01:27:35 node1 openais[3873]: [SERV ] Service initialized
> 'openais cluster membership service B.01.01' 
> 
> Oct 12 01:27:35 node1 openais[3873]: [SERV ] Service initialized
> 'openais availability management framework B.01.01' 
> 
> Oct 12 01:27:35 node1 openais[3873]: [SERV ] Service initialized
> 'openais checkpoint service B.01.01' 
> 
> Oct 12 01:27:35 node1 openais[3873]: [SERV ] Service initialized
> 'openais event service B.01.01' 
> 
> Oct 12 01:27:35 node1 openais[3873]: [SERV ] Service initialized
> 'openais distributed locking service B.01.01' 
> 
> Oct 12 01:27:35 node1 openais[3873]: [SERV ] Service initialized
> 'openais message service B.01.01' 
> 
> Oct 12 01:27:35 node1 openais[3873]: [SERV ] Service initialized
> 'openais configuration service' 
> 
> Oct 12 01:27:35 node1 openais[3873]: [SERV ] Service initialized
> 'openais cluster closed process group service v1.01' 
> 
> Oct 12 01:27:35 node1 openais[3873]: [crm  ] info: objdb_get_string:
> Defaulting to 'daemon' for option logfacility 
> 
> Oct 12 01:27:35 node1 openais[3873]: [crm  ] info: objdb_get_string:
> Defaulting to '20' for option initdead 
> 
> Oct 12 01:27:35 node1 openais[3873]: [crm  ] info: objdb_get_string:
> Defaulting to '1' for option debug 
> 
> Oct 12 01:27:35 node1 openais[3873]: [crm  ] info: crm_config_init_fn:
> CRM: Initialized 
> 
> Oct 12 01:27:35 node1 openais[3873]: [crm  ] Logging: Initialized
> crm_config_init_fn 
> 
> Oct 12 01:27:35 node1 openais[3873]: [crm  ] info: crm_config_init_fn:
> Local hostname: node1 
> 
> Oct 12 01:27:35 node1 openais[3873]: [crm  ] info: update_member:
> Creating entry for node 3232235592 born on 0 
> 
> Oct 12 01:27:35 node1 openais[3873]: [crm  ] info: update_member:
> 0x9c5cd88 Node 3232235592 now known as node1 (was: (null)) 
> 
> Oct 12 01:27:35 node1 openais[3873]: [crm  ] info: update_member: Node
> node1 now has 1 quorum votes (was 0) 
> 
> Oct 12 01:27:35 node1 openais[3873]: [crm  ] info: update_member: Node
> 3232235592/node1 is now: lost 
> 
> Oct 12 01:27:35 node1 cib: [3879]: info: G_main_add_SignalHandler:
> Added signal handler for signal 15
> 
> Oct 12 01:27:35 node1 stonithd: [3881]: info:
> G_main_add_SignalHandler: Added signal handler for signal 10
> 
> Oct 12 01:27:35 node1 lrmd: [3880]: info: G_main_add_SignalHandler:
> Added signal handler for signal 15
> 
> Oct 12 01:27:35 node1 cib: [3879]: info: G_main_add_TriggerHandler:
> Added signal manual handler
> 
> Oct 12 01:27:35 node1 openais[3873]: [crm  ] info: spawn_child: Forked
> child 3879 for process cib 
> 
> Oct 12 01:27:35 node1 attrd: [3882]: info: G_main_add_SignalHandler:
> Added signal handler for signal 15
> 
> Oct 12 01:27:35 node1 stonithd: [3881]: info:
> G_main_add_SignalHandler: Added signal handler for signal 12
> 
> Oct 12 01:27:35 node1 lrmd: [3880]: info: G_main_add_SignalHandler:
> Added signal handler for signal 17
> 
> Oct 12 01:27:35 node1 cib: [3879]: info: G_main_add_SignalHandler:
> Added signal handler for signal 17
> 
> Oct 12 01:27:35 node1 openais[3873]: [crm  ] info: spawn_child: Forked
> child 3880 for process lrmd 
> 
> Oct 12 01:27:35 node1 crmd: [3883]: info: main: CRM Hg Version: node:
> db3767abdef393d300c60f0beb2db898adc17c0c 
> 
> Oct 12 01:27:35 node1 attrd: [3882]: info: main: Starting up....
> 
> Oct 12 01:27:35 node1 cib: [3879]: info: main: Retrieval of a
> per-action CIB: disabled
> 
> Oct 12 01:27:35 node1 openais[3873]: [crm  ] info: spawn_child: Forked
> child 3881 for process stonithd 
> 
> Oct 12 01:27:35 node1 crmd: [3883]: info: crmd_init: Starting crmd
> 
> Oct 12 01:27:35 node1 attrd: [3882]: notice: init_ais_connection:
> Local node name: node1
> 
> Oct 12 01:27:35 node1 stonithd: [3881]: notice: init_ais_connection:
> Local node name: node1
> 
> Oct 12 01:27:35 node1 lrmd: [3880]: info: G_main_add_SignalHandler:
> Added signal handler for signal 10
> 
> Oct 12 01:27:35 node1 cib: [3879]: info: retrieveCib: Reading cluster
> configuration from: /var/lib/heartbeat/crm/cib.xml
> (digest: /var/lib/heartbeat/crm/cib.xml.sig)
> 
> Oct 12 01:27:35 node1 openais[3873]: [crm  ] info: spawn_child: Forked
> child 3882 for process attrd 
> 
> Oct 12 01:27:35 node1 attrd: [3882]: info: init_ais_connection:
> Creating connection to our AIS plugin
> 
> Oct 12 01:27:35 node1 stonithd: [3881]: info: init_ais_connection:
> Creating connection to our AIS plugin
> 
> Oct 12 01:27:35 node1 lrmd: [3880]: info: G_main_add_SignalHandler:
> Added signal handler for signal 12
> 
> Oct 12 01:27:35 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk] <cib generated="false" admin_epoch="0"
> epoch="0" num_updates="0" have_quorum="true" ignore_dtd="false"
> ccm_transition="1" num_peers="0" cib-last-written="Fri Oct 12 01:05:23
> 2007">
> 
> Oct 12 01:27:35 node1 openais[3873]: [crm  ] info: spawn_child: Forked
> child 3883 for process crmd 
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]   <configuration>
> 
> Oct 12 01:27:36 node1 openais[3873]: [crm  ] info: crm_exec_init_fn:
> CRM: Initialized 
> 
> Oct 12 01:27:36 node1 attrd: [3882]: info: init_ais_connection: AIS
> connection established
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]     <crm_config>
> 
> Oct 12 01:27:36 node1 openais[3873]: [SERV ] Service initialized 'LHA
> Cluster Manager' 
> 
> Oct 12 01:27:36 node1 lrmd: [3880]: info: Started.
> 
> Oct 12 01:27:36 node1 openais[3873]: [SYNC ] Not using a virtual
> synchrony filter. 
> 
> Oct 12 01:27:36 node1 openais[3873]: [TOTEM] Creating commit token
> because I am the rep. 
> 
> Oct 12 01:27:36 node1 crmd: [3883]: info: G_main_add_SignalHandler:
> Added signal handler for signal 15
> 
> Oct 12 01:27:36 node1 openais[3873]: [TOTEM] Saving state aru 0 high
> seq received 0 
> 
> Oct 12 01:27:36 node1 openais[3873]: [TOTEM] Storing new sequence id
> for ring 2524 
> 
> Oct 12 01:27:36 node1 crmd: [3883]: info: G_main_add_TriggerHandler:
> Added signal manual handler
> 
> Oct 12 01:27:36 node1 openais[3873]: [TOTEM] entering COMMIT state. 
> 
> Oct 12 01:27:36 node1 openais[3873]: [TOTEM] entering RECOVERY state. 
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]       <cluster_property_set
> id="idCluseterPropertySet">
> 
> Oct 12 01:27:36 node1 crmd: [3883]: info: G_main_add_SignalHandler:
> Added signal handler for signal 17
> 
> Oct 12 01:27:36 node1 openais[3873]: [TOTEM] position [0] member
> 192.168.0.72: 
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]         <attributes>
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]           <nvpair id="election_timeout"
> name="election_timeout" value="5sec"/>
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]           <nvpair
> id="crmd-integration-timeout" name="crmd-integration-timeout"
> value="30sec"/>
> 
> Oct 12 01:27:36 node1 openais[3873]: [TOTEM] previous ring seq 9508
> rep 192.168.0.72 
> 
> Oct 12 01:27:36 node1 openais[3873]: [TOTEM] aru 0 high delivered 0
> received flag 1 
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]           <nvpair
> id="crmd-finalization_timeout" name="crmd-finalization_timeout"
> value="30sec"/>
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]           <nvpair
> id="default-resource-stickiness" name="default-resource-stickiness"
> value="500"/>
> 
> Oct 12 01:27:36 node1 openais[3873]: [TOTEM] Did not need to originate
> any messages in recovery. 
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]           <nvpair
> id="default-resource-failure-stickiness"
> name="default-resource-failure-stickiness" value="-100"/>
> 
> Oct 12 01:27:36 node1 openais[3873]: [TOTEM] Sending initial ORF
> token 
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]         </attributes>
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]       </cluster_property_set>
> 
> Oct 12 01:27:36 node1 openais[3873]: [CLM  ] CLM CONFIGURATION CHANGE 
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]     </crm_config>
> 
> Oct 12 01:27:36 node1 openais[3873]: [CLM  ] New Configuration: 
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]     <nodes/>
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]     <resources>
> 
> Oct 12 01:27:36 node1 openais[3873]: [CLM  ] Members Left: 
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]       <primitive id="openhpid_1"
> class="heartbeat" type="openhpid" provider="heartbeat"/>
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]       <primitive id="openhpid_2"
> class="heartbeat" type="openhpid" provider="heartbeat"/>
> 
> Oct 12 01:27:36 node1 openais[3873]: [CLM  ] Members Joined: 
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]       <primitive id="openhpi_redundancy"
> class="ocf" type="IPaddr" provider="heartbeat" restart_type="ignore"
> is_managed="default">
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]         <instance_attributes
> id="b7de1d31-b108-4e13-9613-8284a85d3db0">
> 
> Oct 12 01:27:36 node1 openais[3873]: [crm  ] notice:
> global_confchg_fn: Transitional membership event on ring 9508: memb=0,
> new=0, lost=0 
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]           <attributes>
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]             <nvpair
> id="5c570f6b-924e-43c8-b8ae-5d03dd68b5f2" name="ip"
> value="192.168.0.100"/>
> 
> Oct 12 01:27:36 node1 openais[3873]: [CLM  ] CLM CONFIGURATION CHANGE 
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]           </attributes>
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]         </instance_attributes>
> 
> Oct 12 01:27:36 node1 openais[3873]: [CLM  ] New Configuration: 
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]       </primitive>
> 
> Oct 12 01:27:36 node1 openais[3873]: [CLM  ]    r(0)
> ip(192.168.0.72)  
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]     </resources>
> 
> Oct 12 01:27:36 node1 openais[3873]: [CLM  ] Members Left: 
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]     <constraints>
> 
> Oct 12 01:27:36 node1 openais[3873]: [CLM  ] Members Joined: 
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]       <rsc_location id="run_openhpid_1"
> rsc="openhpid_1">
> 
> Oct 12 01:27:36 node1 openais[3873]: [CLM  ]    r(0)
> ip(192.168.0.72)  
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]         <rule id="pref_run_openhpid_1"
> score="INFINITY">
> 
> Oct 12 01:27:36 node1 openais[3873]: [crm  ] notice:
> global_confchg_fn: Stable membership event on ring 9508: memb=1,
> new=1, lost=0 
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]           <expression
> id="expr_run_openhpid_1" attribute="#uname" operation="eq"
> value="node1"/>
> 
> Oct 12 01:27:36 node1 openais[3873]: [crm  ] info: update_member: Node
> 3232235592/node1 is now: member 
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]         </rule>
> 
> Oct 12 01:27:36 node1 openais[3873]: [crm  ] info: global_confchg_fn:
> NEW:  node1 3232235592 
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]         <rule id="pref_norun_openhpid_1"
> score="-INFINITY">
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]           <expression
> id="expr_norun_openhpid_1" attribute="#uname" operation="ne"
> value="node1"/>
> 
> Oct 12 01:27:36 node1 openais[3873]: [crm  ] info: global_confchg_fn:
> MEMB: node1 3232235592 
> 
> Oct 12 01:27:36 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]         </rule>
> 
> Oct 12 01:27:37 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]       </rsc_location>
> 
> Oct 12 01:27:37 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]       <rsc_location id="run_openhpid_2"
> rsc="openhpid_2">
> 
> Oct 12 01:27:37 node1 openais[3873]: [crm  ] info: update_member: Node
> node1 now has process list: 00000000000000000000000000003312 (13074) 
> 
> Oct 12 01:27:37 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]         <rule id="pref_run_openhpid_2"
> score="INFINITY">
> 
> Oct 12 01:27:37 node1 openais[3873]: [SYNC ] This node is within the
> primary component and will provide service. 
> 
> Oct 12 01:27:37 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]           <expression
> id="expr_run_openhpid_2" attribute="#uname" operation="eq"
> value="node2"/>
> 
> Oct 12 01:27:37 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]         </rule>
> 
> Oct 12 01:27:37 node1 openais[3873]: [TOTEM] entering OPERATIONAL
> state. 
> 
> Oct 12 01:27:37 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]         <rule id="pref_norun_openhpid_2"
> score="-INFINITY">
> 
> Oct 12 01:27:37 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]           <expression
> id="expr_norun_openhpid_2" attribute="#uname" operation="ne"
> value="node2"/>
> 
> Oct 12 01:27:37 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]         </rule>
> 
> Oct 12 01:27:37 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]       </rsc_location>
> 
> Oct 12 01:27:37 node1 openais[3873]: [CLM  ] got nodejoin message
> 192.168.0.72 
> 
> Oct 12 01:27:37 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]     </constraints>
> 
> Oct 12 01:27:37 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]   </configuration>
> 
> Oct 12 01:27:37 node1 openais[3873]: [TOTEM] The token was lost in the
> OPERATIONAL state. 
> 
> Oct 12 01:27:37 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk]   <status/>
> 
> Oct 12 01:27:37 node1 openais[3873]: [TOTEM] entering GATHER state
> from 2. 
> 
> Oct 12 01:27:37 node1 stonithd: [3881]: info: init_ais_connection: AIS
> connection established
> 
> Oct 12 01:27:37 node1 cib: [3879]: info: log_data_element:
> readCibXmlFile: [on-disk] </cib>
> 
> Oct 12 01:27:37 node1 openais[3873]: [TOTEM] entering GATHER state
> from 11. 
> 
> Oct 12 01:27:37 node1 openais[3873]: [TOTEM] Creating commit token
> because I am the rep. 
> 
> Oct 12 01:27:37 node1 cib: [3879]: info: startCib: CIB Initialization
> completed successfully
> 
> Oct 12 01:27:37 node1 openais[3873]: [TOTEM] Saving state aru 9 high
> seq received 9 
> 
> Oct 12 01:27:37 node1 stonithd: [3881]:
> notice: /usr/lib/heartbeat/stonithd start up successfully.
> 
> Oct 12 01:27:37 node1 cib: [3879]: notice: init_ais_connection: Local
> node name: node1
> 
> Oct 12 01:27:37 node1 openais[3873]: [TOTEM] Storing new sequence id
> for ring 252c 
> 
> Oct 12 01:27:37 node1 stonithd: [3881]: info:
> G_main_add_SignalHandler: Added signal handler for signal 17
> 
> Oct 12 01:27:37 node1 cib: [3879]: info: init_ais_connection: Creating
> connection to our AIS plugin
> 
> Oct 12 01:27:37 node1 openais[3873]: [TOTEM] entering COMMIT state. 
> 
> Oct 12 01:27:37 node1 cib: [3879]: info: init_ais_connection: AIS
> connection established
> 
> Oct 12 01:27:37 node1 cib: [3879]: info: cib_init: Starting cib
> mainloop
> 
> Oct 12 01:27:37 node1 openais[3873]: [TOTEM] entering RECOVERY state. 
> 
> Oct 12 01:27:37 node1 cib: [3891]: info: retrieveCib: Reading cluster
> configuration from: /var/lib/heartbeat/crm/cib.xml
> (digest: /var/lib/heartbeat/crm/cib.xml.sig)
> 
> Oct 12 01:27:37 node1 openais[3873]: [TOTEM] position [0] member
> 192.168.0.72: 
> 
> Oct 12 01:27:37 node1 openais[3873]: [TOTEM] previous ring seq 9508
> rep 192.168.0.72 
> 
> Oct 12 01:27:37 node1 openais[3873]: [TOTEM] aru 9 high delivered 9
> received flag 1 
> 
> Oct 12 01:27:37 node1 cib: [3891]: info: retrieveCib: Reading cluster
> configuration from: /var/lib/heartbeat/crm/cib.xml
> (digest: /var/lib/heartbeat/crm/cib.xml.sig)
> 
> Oct 12 01:27:37 node1 openais[3873]: [TOTEM] position [1] member
> 192.168.0.184: 
> 
> Oct 12 01:27:37 node1 cib: [3891]: info: retrieveCib: Reading cluster
> configuration from: /var/lib/heartbeat/crm/cib.xml.last
> (digest: /var/lib/heartbeat/crm/cib.xml.sig.last)
> 
> Oct 12 01:27:37 node1 openais[3873]: [TOTEM] previous ring seq 9512
> rep 192.168.0.184 
> 
> Oct 12 01:27:37 node1 openais[3873]: [TOTEM] aru 9 high delivered 9
> received flag 1 
> 
> Oct 12 01:27:37 node1 openais[3873]: [TOTEM] Did not need to originate
> any messages in recovery. 
> 
> Oct 12 01:27:37 node1 openais[3873]: [TOTEM] Sending initial ORF
> token 
> 
> Oct 12 01:27:37 node1 cib: [3891]: info: write_cib_contents: Wrote
> version 0.0.0 of the CIB to disk (digest:
> b73a3008926adbfd10fb92a44926a5e3)
> 
> Oct 12 01:27:37 node1 openais[3873]: [CLM  ] CLM CONFIGURATION CHANGE 
> 
> Oct 12 01:27:37 node1 openais[3873]: [CLM  ] New Configuration: 
> 
> Oct 12 01:27:37 node1 cib: [3891]: info: retrieveCib: Reading cluster
> configuration from: /var/lib/heartbeat/crm/cib.xml
> (digest: /var/lib/heartbeat/crm/cib.xml.sig)
> 
> Oct 12 01:27:37 node1 openais[3873]: [CLM  ]    r(0)
> ip(192.168.0.72)  
> 
> Oct 12 01:27:37 node1 openais[3873]: [CLM  ] Members Left: 
> 
> Oct 12 01:27:37 node1 openais[3873]: [CLM  ] Members Joined: 
> 
> Oct 12 01:27:37 node1 openais[3873]: [crm  ] notice:
> global_confchg_fn: Transitional membership event on ring 9516: memb=1,
> new=0, lost=0 
> 
> Oct 12 01:27:37 node1 crmd: [3883]: info: do_cib_control: CIB
> connection established
> 
> Oct 12 01:27:37 node1 cib: [3891]: info: retrieveCib: Reading cluster
> configuration from: /var/lib/heartbeat/crm/cib.xml.last
> (digest: /var/lib/heartbeat/crm/cib.xml.sig.last)
> 
> Oct 12 01:27:37 node1 openais[3873]: [crm  ] info: global_confchg_fn:
> memb: node1 3232235592 
> 
> Oct 12 01:27:37 node1 openais[3873]: [CLM  ] CLM CONFIGURATION CHANGE 
> 
> Oct 12 01:27:37 node1 cib: [3879]: info: cib_null_callback: Setting
> cib_refresh_notify callbacks for crmd: on
> 
> Oct 12 01:27:37 node1 openais[3873]: [CLM  ] New Configuration: 
> 
> Oct 12 01:27:37 node1 crmd: [3883]: notice: init_ais_connection: Local
> node name: node1
> 
> Oct 12 01:27:37 node1 openais[3873]: [CLM  ]    r(0)
> ip(192.168.0.72)  
> 
> Oct 12 01:27:38 node1 cib: [3879]: info: Managed write_cib_contents
> process 3891 exited with return code 0.
> 
> Oct 12 01:27:38 node1 crmd: [3883]: info: init_ais_connection:
> Creating connection to our AIS plugin
> 
> Oct 12 01:27:38 node1 cib: [3879]: WARN: G_SIG_dispatch: Dispatch
> function for SIGCHLD took too long to execute: 40 ms (> 30 ms)
> (GSource: 0xa05f0f8)
> 
> Oct 12 01:27:38 node1 openais[3873]: [CLM  ]    r(0)
> ip(192.168.0.184)  
> 
> Oct 12 01:27:38 node1 crmd: [3883]: info: init_ais_connection: AIS
> connection established
> 
> Oct 12 01:27:38 node1 openais[3873]: [CLM  ] Members Left: 
> 
> Oct 12 01:27:38 node1 crmd: [3883]: info: do_ha_control: Connected to
> Heartbeat
> 
> Oct 12 01:27:38 node1 openais[3873]: [CLM  ] Members Joined: 
> 
> Oct 12 01:27:38 node1 openais[3873]: [CLM  ]    r(0)
> ip(192.168.0.184)  
> 
> Oct 12 01:27:38 node1 openais[3873]: [crm  ] notice:
> global_confchg_fn: Stable membership event on ring 9516: memb=2,
> new=1, lost=0 
> 
> Oct 12 01:27:38 node1 openais[3873]: [crm  ] info: update_member:
> Creating entry for node 3232235704 born on 9516 
> 
> Oct 12 01:27:38 node1 openais[3873]: [crm  ] info: update_member: Node
> 3232235704/unknown is now: member 
> 
> Oct 12 01:27:38 node1 openais[3873]: [crm  ] info: global_confchg_fn:
> NEW:  .pending. 3232235704 
> 
> Oct 12 01:27:38 node1 crmd: [3883]: info: do_started: Delaying start,
> CCM (0000000000100000) not connected
> 
> Oct 12 01:27:38 node1 crmd: [3883]: info: crmd_init: Starting crmd's
> mainloop
> 
> Oct 12 01:27:38 node1 crmd: [3883]: info: do_started: Delaying start,
> CCM (0000000000100000) not connected
> 
> Oct 12 01:27:38 node1 openais[3873]: [crm  ] info: global_confchg_fn:
> MEMB: node1 3232235592 
> 
> Oct 12 01:27:38 node1 openais[3873]: [crm  ] info: global_confchg_fn:
> MEMB: .pending. 3232235704 
> 
> Oct 12 01:27:38 node1 openais[3873]: [SYNC ] This node is within the
> primary component and will provide service. 
> 
> Oct 12 01:27:38 node1 openais[3873]: [TOTEM] entering OPERATIONAL
> state. 
> 
> Oct 12 01:27:38 node1 openais[3873]: [crm  ] info: update_member:
> 0x9c5d680 Node 3232235704 now known as node2 (was: (null)) 
> 
> Oct 12 01:27:38 node1 openais[3873]: [crm  ] info: update_member: Node
> node2 now has process list: 00000000000000000000000000003312 (13074) 
> 
> Oct 12 01:27:38 node1 openais[3873]: [crm  ] info: update_member: Node
> node2 now has 1 quorum votes (was 0) 
> 
> Oct 12 01:27:38 node1 openais[3873]: [CLM  ] got nodejoin message
> 192.168.0.72 
> 
> Oct 12 01:27:38 node1 openais[3873]: [CLM  ] got nodejoin message
> 192.168.0.184 
> 
> Oct 12 01:27:38 node1 openais[3873]: [TOTEM] Receive multicast socket
> recv buffer size (262142 bytes). 
> 
> Oct 12 01:27:38 node1 openais[3873]: [TOTEM] Transmit multicast socket
> send buffer size (262142 bytes). 
> 
> Oct 12 01:27:46 node1 attrd: [3882]: info: main: Starting mainloop...
> 
> Oct 12 01:27:52 node1 dhclient: DHCPREQUEST on eth0 to 192.168.0.1
> port 67
> 
> Oct 12 01:27:52 node1 dhclient: DHCPACK from 192.168.0.1
> 
> Oct 12 01:27:52 node1 dhclient: bound to 192.168.0.72 -- renewal in
> 284 seconds.
> 
> Jean-Michel Audet
> 
> Concepteur Logiciel
> Software Designer
> Kontron Canada 
> Tel: (450) 979-5320 
> 1 800 354-4223 
> Fax: (450) 437-8053 
> <mailto:Jean-Michel.Audet at ca.Kontron.com> 
> Sales:<http://www.kontron.com/> 
> Support:<ftp://ftp.kontron.ca/Support/> 
> 
> L'information contenue dans le présent document est la propriété de
> Kontron Canada Inc. et est divulguée en toute confidentialité. Cette
> information ne doit pas être révisée, utilisée, divulguée ou
> distribuée sans le consentement écrit explicite de Kontron Canada Inc.
> Si vous n'êtes pas le destinataire prévu et avez reçu cette
> communication par erreur, veuillez contacter l'originateur et
> supprimer toute copie.
> 
> The information contained in this document is confidential and
> property of Kontron Canada Inc. Any unauthorized review, use,
> disclosure or distribution is prohibited without express written
> consent of Kontron Canada Inc. If you are not the intended recipient,
> please contact the sender and destroy all copies of the original
> message and enclosed attachments.
> 
>  
> 
> 
> _______________________________________________
> Openais mailing list
> Openais at lists.linux-foundation.org
> https://lists.linux-foundation.org/mailman/listinfo/openais



More information about the Openais mailing list