logd[1019]: 2007/11/30_18:33:30 info: logd started with /etc/logd.cf.
logd[1022]: 2007/11/30_18:33:30 info: G_main_add_SignalHandler: Added signal handler for signal 15
logd[1019]: 2007/11/30_18:33:30 info: G_main_add_SignalHandler: Added signal handler for signal 15
heartbeat[1040]: 2007/11/30_18:33:30 info: Enabling logging daemon 
heartbeat[1040]: 2007/11/30_18:33:30 info: logfile and debug file are those specified in logd config file (default /etc/logd.cf)
heartbeat[1040]: 2007/11/30_18:33:30 info: **************************
heartbeat[1040]: 2007/11/30_18:33:30 info: Configuration validated. Starting heartbeat 2.1.3
heartbeat[1041]: 2007/11/30_18:33:30 info: heartbeat: version 2.1.3
heartbeat[1041]: 2007/11/30_18:33:31 info: Heartbeat generation: 59
heartbeat[1041]: 2007/11/30_18:33:31 info: Removing /var/run/heartbeat/rsctmp failed, recreating.
heartbeat[1041]: 2007/11/30_18:33:31 info: glib: UDP Broadcast heartbeat started on port 694 (694) interface eth2
heartbeat[1041]: 2007/11/30_18:33:31 info: glib: UDP Broadcast heartbeat closed on port 694 interface eth2 - Status: 1
heartbeat[1041]: 2007/11/30_18:33:31 info: G_main_add_TriggerHandler: Added signal manual handler
heartbeat[1041]: 2007/11/30_18:33:31 info: G_main_add_TriggerHandler: Added signal manual handler
heartbeat[1041]: 2007/11/30_18:33:31 info: G_main_add_SignalHandler: Added signal handler for signal 17
heartbeat[1041]: 2007/11/30_18:33:31 info: Local status now set to: 'up'
heartbeat[1041]: 2007/11/30_18:33:32 info: Link prec370e:eth2 up.
heartbeat[1041]: 2007/11/30_18:33:32 info: Link prec370d:eth2 up.
heartbeat[1041]: 2007/11/30_18:33:32 info: Status update for node prec370d: status up
heartbeat[1041]: 2007/11/30_18:33:32 debug: get_delnodelist: delnodelist= 
heartbeat[1041]: 2007/11/30_18:33:33 info: Comm_now_up(): updating status to active
heartbeat[1041]: 2007/11/30_18:33:33 info: Local status now set to: 'active'
heartbeat[1041]: 2007/11/30_18:33:33 info: Starting child client "/usr/lib64/heartbeat/ccm" (90,90)
heartbeat[1041]: 2007/11/30_18:33:33 info: Starting child client "/usr/lib64/heartbeat/cib" (90,90)
heartbeat[1041]: 2007/11/30_18:33:33 info: Starting child client "/usr/lib64/heartbeat/lrmd -r" (0,0)
heartbeat[1041]: 2007/11/30_18:33:33 info: Starting child client "/usr/lib64/heartbeat/stonithd" (0,0)
heartbeat[1041]: 2007/11/30_18:33:33 info: Starting child client "/usr/lib64/heartbeat/attrd" (90,90)
heartbeat[1041]: 2007/11/30_18:33:33 info: Starting child client "/usr/lib64/heartbeat/crmd" (90,90)
heartbeat[1041]: 2007/11/30_18:33:33 info: Starting child client "/usr/lib64/heartbeat/mgmtd -v" (0,0)
heartbeat[1041]: 2007/11/30_18:33:33 info: Status update for node prec370d: status active
heartbeat[1049]: 2007/11/30_18:33:33 info: Starting "/usr/lib64/heartbeat/ccm" as uid 90  gid 90 (pid 1049)
heartbeat[1050]: 2007/11/30_18:33:33 info: Starting "/usr/lib64/heartbeat/cib" as uid 90  gid 90 (pid 1050)
heartbeat[1051]: 2007/11/30_18:33:33 info: Starting "/usr/lib64/heartbeat/lrmd -r" as uid 0  gid 0 (pid 1051)
heartbeat[1052]: 2007/11/30_18:33:33 info: Starting "/usr/lib64/heartbeat/stonithd" as uid 0  gid 0 (pid 1052)
heartbeat[1053]: 2007/11/30_18:33:33 info: Starting "/usr/lib64/heartbeat/attrd" as uid 90  gid 90 (pid 1053)
heartbeat[1054]: 2007/11/30_18:33:33 info: Starting "/usr/lib64/heartbeat/crmd" as uid 90  gid 90 (pid 1054)
heartbeat[1055]: 2007/11/30_18:33:33 info: Starting "/usr/lib64/heartbeat/mgmtd -v" as uid 0  gid 0 (pid 1055)
cib[1050]: 2007/11/30_18:33:33 info: G_main_add_SignalHandler: Added signal handler for signal 15
cib[1050]: 2007/11/30_18:33:33 info: G_main_add_TriggerHandler: Added signal manual handler
cib[1050]: 2007/11/30_18:33:33 info: G_main_add_SignalHandler: Added signal handler for signal 17
cib[1050]: 2007/11/30_18:33:33 info: main: Retrieval of a per-action CIB: disabled
cib[1050]: 2007/11/30_18:33:33 info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml (digest: /var/lib/heartbeat/crm/cib.xml.sig)
cib[1050]: 2007/11/30_18:33:33 WARN: retrieveCib: Cluster configuration not found: /var/lib/heartbeat/crm/cib.xml
cib[1050]: 2007/11/30_18:33:33 WARN: readCibXmlFile: Primary configuration corrupt or unusable, trying backup...
cib[1050]: 2007/11/30_18:33:33 info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml.last (digest: /var/lib/heartbeat/crm/cib.xml.sig.last)
attrd[1053]: 2007/11/30_18:33:33 info: G_main_add_SignalHandler: Added signal handler for signal 15
cib[1050]: 2007/11/30_18:33:33 WARN: retrieveCib: Cluster configuration not found: /var/lib/heartbeat/crm/cib.xml.last
attrd[1053]: 2007/11/30_18:33:33 info: register_with_ha: Hostname: prec370e
ccm[1049]: 2007/11/30_18:33:33 info: Hostname: prec370e
mgmtd[1055]: 2007/11/30_18:33:33 info: G_main_add_SignalHandler: Added signal handler for signal 15
cib[1050]: 2007/11/30_18:33:33 WARN: readCibXmlFile: Continuing with an empty configuration.
cib[1050]: 2007/11/30_18:33:33 WARN: readCibXmlFile: No value for admin_epoch was specified in the configuration.
cib[1050]: 2007/11/30_18:33:33 WARN: readCibXmlFile: The reccomended course of action is to shutdown, run crm_verify and fix any errors it reports.
cib[1050]: 2007/11/30_18:33:33 WARN: readCibXmlFile: We will default to zero and continue but may get confused about which configuration to use if multiple nodes are powered up at the same time.
cib[1050]: 2007/11/30_18:33:33 info: log_data_element: readCibXmlFile: [on-disk] <cib generated="true" admin_epoch="0" epoch="0" num_updates="0" have_quorum="false">
cib[1050]: 2007/11/30_18:33:33 info: log_data_element: readCibXmlFile: [on-disk]   <configuration>
cib[1050]: 2007/11/30_18:33:33 info: log_data_element: readCibXmlFile: [on-disk]     <crm_config/>
cib[1050]: 2007/11/30_18:33:33 info: log_data_element: readCibXmlFile: [on-disk]     <nodes/>
cib[1050]: 2007/11/30_18:33:33 info: log_data_element: readCibXmlFile: [on-disk]     <resources/>
cib[1050]: 2007/11/30_18:33:33 info: log_data_element: readCibXmlFile: [on-disk]     <constraints/>
cib[1050]: 2007/11/30_18:33:33 info: log_data_element: readCibXmlFile: [on-disk]   </configuration>
cib[1050]: 2007/11/30_18:33:33 info: log_data_element: readCibXmlFile: [on-disk]   <status/>
cib[1050]: 2007/11/30_18:33:33 info: log_data_element: readCibXmlFile: [on-disk] </cib>
mgmtd[1055]: 2007/11/30_18:33:33 debug: Enabling coredumps
mgmtd[1055]: 2007/11/30_18:33:33 info: G_main_add_SignalHandler: Added signal handler for signal 10
mgmtd[1055]: 2007/11/30_18:33:33 info: G_main_add_SignalHandler: Added signal handler for signal 12
mgmtd[1055]: 2007/11/30_18:33:33 WARN: lrm_signon: can not initiate connection
mgmtd[1055]: 2007/11/30_18:33:33 info: login to lrm: 0, ret:0
lrmd[1051]: 2007/11/30_18:33:33 info: G_main_add_SignalHandler: Added signal handler for signal 15
cib[1050]: 2007/11/30_18:33:33 notice: readCibXmlFile: Enabling DTD validation on the existing (sane) configuration
lrmd[1051]: 2007/11/30_18:33:33 info: G_main_add_SignalHandler: Added signal handler for signal 17
lrmd[1051]: 2007/11/30_18:33:33 info: G_main_add_SignalHandler: Added signal handler for signal 10
lrmd[1051]: 2007/11/30_18:33:33 info: G_main_add_SignalHandler: Added signal handler for signal 12
lrmd[1051]: 2007/11/30_18:33:33 info: Started.
stonithd[1052]: 2007/11/30_18:33:33 info: G_main_add_SignalHandler: Added signal handler for signal 10
cib[1050]: 2007/11/30_18:33:33 info: startCib: CIB Initialization completed successfully
cib[1050]: 2007/11/30_18:33:33 info: cib_register_ha: Signing in with Heartbeat
stonithd[1052]: 2007/11/30_18:33:33 info: G_main_add_SignalHandler: Added signal handler for signal 12
cib[1050]: 2007/11/30_18:33:33 info: cib_register_ha: FSA Hostname: prec370e
attrd[1053]: 2007/11/30_18:33:33 info: register_with_ha: UUID: 9d9ca527-cea9-470c-9e03-e49fe5630bba
cib[1050]: 2007/11/30_18:33:33 info: ccm_connect: Registering with CCM...
stonithd[1052]: 2007/11/30_18:33:33 info: Signing in with heartbeat.
cib[1050]: 2007/11/30_18:33:33 WARN: ccm_connect: CCM Activation failed
cib[1050]: 2007/11/30_18:33:33 WARN: ccm_connect: CCM Connection failed 1 times (30 max)
stonithd[1052]: 2007/11/30_18:33:33 notice: /usr/lib64/heartbeat/stonithd start up successfully.
stonithd[1052]: 2007/11/30_18:33:33 info: G_main_add_SignalHandler: Added signal handler for signal 17
crmd[1054]: 2007/11/30_18:33:33 info: main: CRM Hg Version: 436fed03563c tip

crmd[1054]: 2007/11/30_18:33:33 info: crmd_init: Starting crmd
crmd[1054]: 2007/11/30_18:33:33 info: G_main_add_SignalHandler: Added signal handler for signal 15
crmd[1054]: 2007/11/30_18:33:33 info: G_main_add_TriggerHandler: Added signal manual handler
crmd[1054]: 2007/11/30_18:33:33 info: G_main_add_SignalHandler: Added signal handler for signal 17
mgmtd[1055]: 2007/11/30_18:33:34 info: init_crm
ccm[1049]: 2007/11/30_18:33:36 info: G_main_add_SignalHandler: Added signal handler for signal 15
cib[1050]: 2007/11/30_18:33:36 info: ccm_connect: Registering with CCM...
cib[1050]: 2007/11/30_18:33:36 info: cib_init: Starting cib mainloop
crmd[1054]: 2007/11/30_18:33:36 info: do_cib_control: CIB connection established
cib[1050]: 2007/11/30_18:33:36 info: cib_null_callback: Setting cib_refresh_notify callbacks for crmd: on
crmd[1054]: 2007/11/30_18:33:36 info: register_with_ha: Hostname: prec370e
cib[1050]: 2007/11/30_18:33:36 info: cib_client_status_callback: Status update: Client prec370e/cib now has status [join]
cib[1050]: 2007/11/30_18:33:36 info: cib_client_status_callback: Status update: Client prec370e/cib now has status [online]
cib[1050]: 2007/11/30_18:33:36 info: cib_null_callback: Setting cib_diff_notify callbacks for mgmtd: on
cib[1058]: 2007/11/30_18:33:36 info: write_cib_contents: Wrote version 0.0.0 of the CIB to disk (digest: d4b0210011b76cfdbc977156856a43c5)
cib[1058]: 2007/11/30_18:33:36 info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml (digest: /var/lib/heartbeat/crm/cib.xml.sig)
cib[1050]: 2007/11/30_18:33:37 info: cib_client_status_callback: Status update: Client prec370d/cib now has status [online]
crmd[1054]: 2007/11/30_18:33:37 info: register_with_ha: UUID: 9d9ca527-cea9-470c-9e03-e49fe5630bba
mgmtd[1055]: 2007/11/30_18:33:37 debug: main: run the loop...
mgmtd[1055]: 2007/11/30_18:33:37 info: Started.
crmd[1054]: 2007/11/30_18:33:37 info: populate_cib_nodes: Requesting the list of configured nodes
crmd[1054]: 2007/11/30_18:33:38 notice: populate_cib_nodes: Node: prec370e (uuid: 9d9ca527-cea9-470c-9e03-e49fe5630bba)
crmd[1054]: 2007/11/30_18:33:39 notice: populate_cib_nodes: Node: prec370d (uuid: 6a42b4b7-7a31-4ae7-b241-ed4ad4267ec6)
crmd[1054]: 2007/11/30_18:33:39 info: do_ha_control: Connected to Heartbeat
cib[1059]: 2007/11/30_18:33:39 info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml (digest: /var/lib/heartbeat/crm/cib.xml.sig)
crmd[1054]: 2007/11/30_18:33:39 info: do_ccm_control: CCM connection established... waiting for first callback
cib[1059]: 2007/11/30_18:33:39 info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml (digest: /var/lib/heartbeat/crm/cib.xml.sig)
crmd[1054]: 2007/11/30_18:33:39 info: do_started: Delaying start, CCM (0000000000100000) not connected
cib[1059]: 2007/11/30_18:33:39 info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml.last (digest: /var/lib/heartbeat/crm/cib.xml.sig.last)
crmd[1054]: 2007/11/30_18:33:39 info: crmd_init: Starting crmd's mainloop
crmd[1054]: 2007/11/30_18:33:39 notice: crmd_client_status_callback: Status update: Client prec370e/crmd now has status [online]
cib[1059]: 2007/11/30_18:33:39 info: write_cib_contents: Wrote version 0.0.0 of the CIB to disk (digest: 74c9004ef52945d7aabb0795ab710c48)
cib[1059]: 2007/11/30_18:33:39 info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml (digest: /var/lib/heartbeat/crm/cib.xml.sig)
cib[1059]: 2007/11/30_18:33:39 info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml.last (digest: /var/lib/heartbeat/crm/cib.xml.sig.last)
heartbeat[1041]: 2007/11/30_18:33:39 WARN: 1 lost packet(s) for [prec370d] [19:21]
heartbeat[1041]: 2007/11/30_18:33:39 info: No pkts missing from prec370d!
ccm[1049]: 2007/11/30_18:33:39 debug: quorum plugin: majority
ccm[1049]: 2007/11/30_18:33:39 debug: cluster:linux-ha, member_count=1, member_quorum_votes=100
crmd[1054]: 2007/11/30_18:33:39 notice: crmd_client_status_callback: Status update: Client prec370e/crmd now has status [online]
ccm[1049]: 2007/11/30_18:33:39 debug: total_node_count=2, total_quorum_votes=200
cib[1050]: 2007/11/30_18:33:39 info: mem_handle_event: Got an event OC_EV_MS_NEW_MEMBERSHIP from ccm
ccm[1049]: 2007/11/30_18:33:39 debug: quorum plugin: twonodes
cib[1050]: 2007/11/30_18:33:39 info: mem_handle_event: instance=1, nodes=1, new=1, lost=0, n_idx=0, new_idx=0, old_idx=3
ccm[1049]: 2007/11/30_18:33:39 debug: cluster:linux-ha, member_count=1, member_quorum_votes=100
cib[1050]: 2007/11/30_18:33:39 info: cib_ccm_msg_callback: PEER: prec370e
ccm[1049]: 2007/11/30_18:33:39 debug: total_node_count=2, total_quorum_votes=200
ccm[1049]: 2007/11/30_18:33:39 info: Break tie for 2 nodes cluster
crmd[1054]: 2007/11/30_18:33:40 notice: crmd_client_status_callback: Status update: Client prec370d/crmd now has status [offline]
crmd[1054]: 2007/11/30_18:33:40 notice: crmd_client_status_callback: Status update: Client prec370d/crmd now has status [online]
crmd[1054]: 2007/11/30_18:33:40 info: do_started: Delaying start, CCM (0000000000100000) not connected
crmd[1054]: 2007/11/30_18:33:40 info: mem_handle_event: Got an event OC_EV_MS_NEW_MEMBERSHIP from ccm
crmd[1054]: 2007/11/30_18:33:40 info: mem_handle_event: instance=1, nodes=1, new=1, lost=0, n_idx=0, new_idx=0, old_idx=3
crmd[1054]: 2007/11/30_18:33:40 info: crmd_ccm_msg_callback: Quorum (re)attained after event=NEW MEMBERSHIP (id=1)
crmd[1054]: 2007/11/30_18:33:40 info: ccm_event_detail: NEW MEMBERSHIP: trans=1, nodes=1, new=1, lost=0 n_idx=0, new_idx=0, old_idx=3
crmd[1054]: 2007/11/30_18:33:40 info: ccm_event_detail: 	CURRENT: prec370e [nodeid=1, born=1]
crmd[1054]: 2007/11/30_18:33:40 info: ccm_event_detail: 	NEW:     prec370e [nodeid=1, born=1]
crmd[1054]: 2007/11/30_18:33:40 info: do_started: The local CRM is operational
crmd[1054]: 2007/11/30_18:33:40 info: do_state_transition: State transition S_STARTING -> S_PENDING [ input=I_PENDING cause=C_CCM_CALLBACK origin=do_started ]
ccm[1049]: 2007/11/30_18:33:40 debug: quorum plugin: majority
ccm[1049]: 2007/11/30_18:33:40 debug: cluster:linux-ha, member_count=2, member_quorum_votes=200
cib[1050]: 2007/11/30_18:33:40 info: mem_handle_event: Got an event OC_EV_MS_INVALID from ccm
ccm[1049]: 2007/11/30_18:33:40 debug: total_node_count=2, total_quorum_votes=200
cib[1050]: 2007/11/30_18:33:40 info: mem_handle_event: no mbr_track info
cib[1050]: 2007/11/30_18:33:40 info: mem_handle_event: Got an event OC_EV_MS_NEW_MEMBERSHIP from ccm
cib[1050]: 2007/11/30_18:33:40 info: mem_handle_event: instance=2, nodes=2, new=1, lost=0, n_idx=0, new_idx=2, old_idx=4
cib[1050]: 2007/11/30_18:33:40 info: cib_ccm_msg_callback: PEER: prec370e
cib[1050]: 2007/11/30_18:33:40 info: cib_ccm_msg_callback: PEER: prec370d
heartbeat[1041]: 2007/11/30_18:33:41 WARN: 1 lost packet(s) for [prec370d] [23:25]
heartbeat[1041]: 2007/11/30_18:33:41 info: No pkts missing from prec370d!
crmd[1054]: 2007/11/30_18:33:41 info: mem_handle_event: Got an event OC_EV_MS_INVALID from ccm
crmd[1054]: 2007/11/30_18:33:41 info: mem_handle_event: no mbr_track info
crmd[1054]: 2007/11/30_18:33:41 info: mem_handle_event: Got an event OC_EV_MS_NEW_MEMBERSHIP from ccm
crmd[1054]: 2007/11/30_18:33:41 info: mem_handle_event: instance=2, nodes=2, new=1, lost=0, n_idx=0, new_idx=2, old_idx=4
crmd[1054]: 2007/11/30_18:33:41 info: crmd_ccm_msg_callback: Quorum (re)attained after event=NEW MEMBERSHIP (id=2)
crmd[1054]: 2007/11/30_18:33:41 info: ccm_event_detail: NEW MEMBERSHIP: trans=2, nodes=2, new=1, lost=0 n_idx=0, new_idx=2, old_idx=4
crmd[1054]: 2007/11/30_18:33:41 info: ccm_event_detail: 	CURRENT: prec370e [nodeid=1, born=1]
crmd[1054]: 2007/11/30_18:33:41 info: ccm_event_detail: 	CURRENT: prec370d [nodeid=0, born=2]
crmd[1054]: 2007/11/30_18:33:41 info: ccm_event_detail: 	NEW:     prec370d [nodeid=0, born=2]
attrd[1053]: 2007/11/30_18:33:43 info: main: Starting mainloop...
crmd[1054]: 2007/11/30_18:34:11 info: crm_timer_popped: Election Trigger (I_DC_TIMEOUT) just popped!
crmd[1054]: 2007/11/30_18:34:11 WARN: do_log: [[FSA]] Input I_DC_TIMEOUT from crm_timer_popped() received in state (S_PENDING)
crmd[1054]: 2007/11/30_18:34:11 info: do_state_transition: State transition S_PENDING -> S_ELECTION [ input=I_DC_TIMEOUT cause=C_TIMER_POPPED origin=crm_timer_popped ]
crmd[1054]: 2007/11/30_18:34:11 info: do_election_count_vote: Updated voted hash for prec370e to vote
crmd[1054]: 2007/11/30_18:34:11 info: do_election_count_vote: Election ignore: our vote (prec370e)
crmd[1054]: 2007/11/30_18:34:11 info: do_election_check: Still waiting on 1 non-votes (2 total)
crmd[1054]: 2007/11/30_18:34:11 info: do_election_count_vote: Updated voted hash for prec370d to no-vote
crmd[1054]: 2007/11/30_18:34:11 info: do_election_count_vote: Election ignore: no-vote from prec370d
crmd[1054]: 2007/11/30_18:34:11 info: do_state_transition: State transition S_ELECTION -> S_INTEGRATION [ input=I_ELECTION_DC cause=C_FSA_INTERNAL origin=do_election_check ]
crmd[1054]: 2007/11/30_18:34:11 info: start_subsystem: Starting sub-system "tengine"
crmd[1054]: 2007/11/30_18:34:11 info: start_subsystem: Starting sub-system "pengine"
crmd[1054]: 2007/11/30_18:34:11 info: do_dc_takeover: Taking over DC status for this partition
cib[1050]: 2007/11/30_18:34:11 info: cib_process_readwrite: We are now in R/W mode
cib[1050]: 2007/11/30_18:34:11 info: revision_check: Updating CIB revision to 2.0
tengine[1060]: 2007/11/30_18:34:11 info: G_main_add_SignalHandler: Added signal handler for signal 15
cib[1050]: 2007/11/30_18:34:11 info: log_data_element: cib:diff: - <cib epoch="0"/>
cib[1050]: 2007/11/30_18:34:11 info: log_data_element: cib:diff: + <cib epoch="1">
cib[1050]: 2007/11/30_18:34:11 info: log_data_element: cib:diff: +   <configuration>
cib[1050]: 2007/11/30_18:34:11 info: log_data_element: cib:diff: +     <crm_config>
cib[1050]: 2007/11/30_18:34:11 info: log_data_element: cib:diff: +       <cluster_property_set id="cib-bootstrap-options">
cib[1050]: 2007/11/30_18:34:11 info: log_data_element: cib:diff: +         <attributes>
cib[1050]: 2007/11/30_18:34:11 info: log_data_element: cib:diff: +           <nvpair id="cib-bootstrap-options-dc-version" name="dc-version" value="2.1.3-436fed03563c tip"/>
cib[1050]: 2007/11/30_18:34:11 info: log_data_element: cib:diff: +         </attributes>
cib[1050]: 2007/11/30_18:34:11 info: log_data_element: cib:diff: +       </cluster_property_set>
cib[1050]: 2007/11/30_18:34:11 info: log_data_element: cib:diff: +     </crm_config>
cib[1050]: 2007/11/30_18:34:11 info: log_data_element: cib:diff: +   </configuration>
cib[1050]: 2007/11/30_18:34:11 info: log_data_element: cib:diff: + </cib>
cib[1062]: 2007/11/30_18:34:11 info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml (digest: /var/lib/heartbeat/crm/cib.xml.sig)
cib[1062]: 2007/11/30_18:34:11 info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml (digest: /var/lib/heartbeat/crm/cib.xml.sig)
tengine[1060]: 2007/11/30_18:34:11 info: G_main_add_TriggerHandler: Added signal manual handler
crmd[1054]: 2007/11/30_18:34:11 info: join_make_offer: Making join offers based on membership 2
tengine[1060]: 2007/11/30_18:34:11 info: G_main_add_TriggerHandler: Added signal manual handler
crmd[1054]: 2007/11/30_18:34:11 info: do_dc_join_offer_all: join-1: Waiting on 2 outstanding join acks
cib[1062]: 2007/11/30_18:34:11 info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml.last (digest: /var/lib/heartbeat/crm/cib.xml.sig.last)
pengine[1061]: 2007/11/30_18:34:11 info: G_main_add_SignalHandler: Added signal handler for signal 15
cib[1050]: 2007/11/30_18:34:11 info: cib_null_callback: Setting cib_diff_notify callbacks for tengine: on
cib[1062]: 2007/11/30_18:34:11 info: write_cib_contents: Wrote version 0.1.1 of the CIB to disk (digest: 7c83b48616a798e17142f58d67d16b22)
tengine[1060]: 2007/11/30_18:34:11 info: te_init: Registering TE UUID: 01a2babe-2973-4acf-bf6f-909494580d61
tengine[1060]: 2007/11/30_18:34:11 info: set_graph_functions: Setting custom graph functions
tengine[1060]: 2007/11/30_18:34:11 info: unpack_graph: Unpacked transition -1: 0 actions in 0 synapses
tengine[1060]: 2007/11/30_18:34:11 info: te_init: Starting tengine
pengine[1061]: 2007/11/30_18:34:11 info: pe_init: Starting pengine
tengine[1060]: 2007/11/30_18:34:11 info: te_connect_stonith: Attempting connection to fencing daemon...
cib[1062]: 2007/11/30_18:34:11 info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml (digest: /var/lib/heartbeat/crm/cib.xml.sig)
cib[1062]: 2007/11/30_18:34:11 info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml.last (digest: /var/lib/heartbeat/crm/cib.xml.sig.last)
crmd[1054]: 2007/11/30_18:34:12 info: update_dc: Set DC to prec370e (2.0)
tengine[1060]: 2007/11/30_18:34:12 info: te_connect_stonith: Connected
crmd[1054]: 2007/11/30_18:34:13 info: do_state_transition: State transition S_INTEGRATION -> S_FINALIZE_JOIN [ input=I_INTEGRATED cause=C_FSA_INTERNAL origin=check_join_state ]
crmd[1054]: 2007/11/30_18:34:13 info: do_state_transition: All 2 cluster nodes responded to the join offer.
crmd[1054]: 2007/11/30_18:34:13 info: update_attrd: Connecting to attrd...
attrd[1053]: 2007/11/30_18:34:13 info: attrd_local_callback: Sending full refresh
cib[1050]: 2007/11/30_18:34:13 info: sync_our_cib: Syncing CIB to prec370d
cib[1050]: 2007/11/30_18:34:13 info: sync_our_cib: Syncing CIB to all peers
crmd[1054]: 2007/11/30_18:34:13 info: update_dc: Set DC to prec370e (2.0)
crmd[1054]: 2007/11/30_18:34:13 info: do_dc_join_ack: join-1: Updating node state to member for prec370d
crmd[1054]: 2007/11/30_18:34:13 info: do_dc_join_ack: join-1: Updating node state to member for prec370e
crmd[1054]: 2007/11/30_18:34:13 info: do_state_transition: State transition S_FINALIZE_JOIN -> S_POLICY_ENGINE [ input=I_FINALIZED cause=C_FSA_INTERNAL origin=check_join_state ]
tengine[1060]: 2007/11/30_18:34:13 info: update_abort_priority: Abort priority upgraded to 1000000
crmd[1054]: 2007/11/30_18:34:13 info: do_state_transition: All 2 cluster nodes are eligible to run resources.
tengine[1060]: 2007/11/30_18:34:13 info: update_abort_priority: 'DC Takeover' abort superceeded
pengine[1061]: 2007/11/30_18:34:13 info: determine_online_status: Node prec370e is online
pengine[1061]: 2007/11/30_18:34:13 info: determine_online_status: Node prec370d is online
crmd[1054]: 2007/11/30_18:34:13 info: do_state_transition: State transition S_POLICY_ENGINE -> S_TRANSITION_ENGINE [ input=I_PE_SUCCESS cause=C_IPC_MESSAGE origin=route_message ]
tengine[1060]: 2007/11/30_18:34:13 info: unpack_graph: Unpacked transition 0: 2 actions in 2 synapses
tengine[1060]: 2007/11/30_18:34:13 info: send_rsc_command: Initiating action 2: probe_complete on prec370e
tengine[1060]: 2007/11/30_18:34:13 info: send_rsc_command: Initiating action 3: probe_complete on prec370d
tengine[1060]: 2007/11/30_18:34:13 info: run_graph: Transition 0: (Complete=2, Pending=0, Fired=0, Skipped=0, Incomplete=0)
tengine[1060]: 2007/11/30_18:34:13 info: notify_crmd: Transition 0 status: te_complete - <null>
crmd[1054]: 2007/11/30_18:34:13 info: do_state_transition: State transition S_TRANSITION_ENGINE -> S_IDLE [ input=I_TE_SUCCESS cause=C_IPC_MESSAGE origin=route_message ]
pengine[1061]: 2007/11/30_18:34:13 info: process_pe_message: Transition 0: PEngine Input stored in: /var/lib/heartbeat/pengine/pe-input-0.bz2
tengine[1060]: 2007/11/30_18:34:13 info: extract_event: Aborting on transient_attributes changes for 9d9ca527-cea9-470c-9e03-e49fe5630bba
tengine[1060]: 2007/11/30_18:34:13 info: update_abort_priority: Abort priority upgraded to 1000000
crmd[1054]: 2007/11/30_18:34:13 info: do_state_transition: State transition S_IDLE -> S_POLICY_ENGINE [ input=I_PE_CALC cause=C_IPC_MESSAGE origin=route_message ]
crmd[1054]: 2007/11/30_18:34:13 info: do_state_transition: All 2 cluster nodes are eligible to run resources.
pengine[1061]: 2007/11/30_18:34:13 info: determine_online_status: Node prec370e is online
pengine[1061]: 2007/11/30_18:34:13 info: determine_online_status: Node prec370d is online
crmd[1054]: 2007/11/30_18:34:13 info: do_state_transition: State transition S_POLICY_ENGINE -> S_TRANSITION_ENGINE [ input=I_PE_SUCCESS cause=C_IPC_MESSAGE origin=route_message ]
tengine[1060]: 2007/11/30_18:34:13 info: unpack_graph: Unpacked transition 1: 1 actions in 1 synapses
crmd[1054]: 2007/11/30_18:34:13 info: do_state_transition: State transition S_TRANSITION_ENGINE -> S_IDLE [ input=I_TE_SUCCESS cause=C_IPC_MESSAGE origin=route_message ]
tengine[1060]: 2007/11/30_18:34:13 info: send_rsc_command: Initiating action 3: probe_complete on prec370d
tengine[1060]: 2007/11/30_18:34:13 info: run_graph: Transition 1: (Complete=1, Pending=0, Fired=0, Skipped=0, Incomplete=0)
tengine[1060]: 2007/11/30_18:34:13 info: notify_crmd: Transition 1 status: te_complete - <null>
pengine[1061]: 2007/11/30_18:34:13 info: process_pe_message: Transition 1: PEngine Input stored in: /var/lib/heartbeat/pengine/pe-input-1.bz2
tengine[1060]: 2007/11/30_18:34:15 info: extract_event: Aborting on transient_attributes changes for 6a42b4b7-7a31-4ae7-b241-ed4ad4267ec6
tengine[1060]: 2007/11/30_18:34:15 info: update_abort_priority: Abort priority upgraded to 1000000
crmd[1054]: 2007/11/30_18:34:15 info: do_state_transition: State transition S_IDLE -> S_POLICY_ENGINE [ input=I_PE_CALC cause=C_IPC_MESSAGE origin=route_message ]
crmd[1054]: 2007/11/30_18:34:15 info: do_state_transition: All 2 cluster nodes are eligible to run resources.
pengine[1061]: 2007/11/30_18:34:15 info: determine_online_status: Node prec370e is online
pengine[1061]: 2007/11/30_18:34:15 info: determine_online_status: Node prec370d is online
crmd[1054]: 2007/11/30_18:34:15 info: do_state_transition: State transition S_POLICY_ENGINE -> S_TRANSITION_ENGINE [ input=I_PE_SUCCESS cause=C_IPC_MESSAGE origin=route_message ]
tengine[1060]: 2007/11/30_18:34:15 info: unpack_graph: Unpacked transition 2: 0 actions in 0 synapses
tengine[1060]: 2007/11/30_18:34:15 info: run_graph: Transition 2: (Complete=0, Pending=0, Fired=0, Skipped=0, Incomplete=0)
tengine[1060]: 2007/11/30_18:34:15 info: notify_crmd: Transition 2 status: te_complete - <null>
crmd[1054]: 2007/11/30_18:34:15 info: do_state_transition: State transition S_TRANSITION_ENGINE -> S_IDLE [ input=I_TE_SUCCESS cause=C_IPC_MESSAGE origin=route_message ]
pengine[1061]: 2007/11/30_18:34:15 info: process_pe_message: Transition 2: PEngine Input stored in: /var/lib/heartbeat/pengine/pe-input-2.bz2
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: - <cib epoch="1" num_updates="9" cib_feature_revision="2.0"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: + <cib epoch="2" num_updates="1" cib_feature_revision="1.3">
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +   <configuration>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +     <crm_config>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +       <cluster_property_set id="idCluseterPropertySet">
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +         <attributes>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <nvpair id="symmetric-cluster" name="symmetric-cluster" value="true"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <nvpair id="no-quorum-policy" name="no-quorum-policy" value="ignore"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <nvpair id="stonith-enabled" name="stonith-enabled" value="false"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <nvpair id="short-resource-names" name="short_resource_names" value="true"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <nvpair id="is-managed-default" name="is-managed-default" value="true"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <nvpair id="transition-idle-timeout" name="transition-idle-timeout" value="120s"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <nvpair id="default-resource-stickiness" name="default-resource-stickiness" value="INFINITY"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <nvpair id="stop-orphan-resources" name="stop-orphan-resources" value="true"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <nvpair id="stop-orphan-actions" name="stop-orphan-actions" value="true"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <nvpair id="remove-after-stop" name="remove-after-stop" value="false"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <nvpair id="default-resource-failure-stickiness" name="default-resource-failure-stickiness" value="-INFINITY"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <nvpair id="stonith-action" name="stonith-action" value="reboot"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <nvpair id="default-action-timeout" name="default-action-timeout" value="120s"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <nvpair id="dc_deadtime" name="dc_deadtime" value="10s"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <nvpair id="cluster_recheck_interval" name="cluster_recheck_interval" value="0"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <nvpair id="election_timeout" name="election_timeout" value="2min"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <nvpair id="shutdown_escalation" name="shutdown_escalation" value="20min"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <nvpair id="crmd-integration-timeout" name="crmd-integration-timeout" value="3min"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <nvpair id="crmd-finalization-timeout" name="crmd-finalization-timeout" value="10min"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <nvpair id="cluster-delay" name="cluster-delay" value="60s"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <nvpair id="pe-error-series-max" name="pe-error-series-max" value="-1"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <nvpair id="pe-warn-series-max" name="pe-warn-series-max" value="-1"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <nvpair id="pe-input-series-max" name="pe-input-series-max" value="-1"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <nvpair id="startup-fencing" name="startup-fencing" value="true"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +         </attributes>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +       </cluster_property_set>
tengine[1060]: 2007/11/30_18:34:31 info: update_abort_priority: Abort priority upgraded to 1000000
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +     </crm_config>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +     <resources>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +       <group id="grpDummy">
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +         <primitive id="prmDummy" class="ocf" type="Dummy" provider="heartbeat">
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <operations>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +             <op id="opDummyStart" name="start" timeout="60s" on_fail="fence"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +             <op id="opDummyMonitor" name="monitor" interval="10s" timeout="10s" on_fail="fence"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +             <op id="opDummyStop" name="stop" timeout="60s" on_fail="fence"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           </operations>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <instance_attributes id="atrDummy">
crmd[1054]: 2007/11/30_18:34:31 info: do_state_transition: State transition S_IDLE -> S_POLICY_ENGINE [ input=I_PE_CALC cause=C_IPC_MESSAGE origin=route_message ]
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +             <attributes>
crmd[1054]: 2007/11/30_18:34:31 info: do_state_transition: All 2 cluster nodes are eligible to run resources.
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +               <nvpair id="atrDummy1" name="delay" value="1"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +               <nvpair id="atrDummy2" name="state" value="/var/run/heartbeat/rsctmp/Dummy.state"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +             </attributes>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           </instance_attributes>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +         </primitive>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +       </group>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +     </resources>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +     <constraints>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +       <rsc_location id="rlcDummy" rsc="grpDummy">
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +         <rule score="300" id="rulNode1">
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <expression value="prec370d" attribute="#uname" operation="eq" id="expNode1"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +         </rule>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +         <rule score="200" id="rulNode2">
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <expression value="prec370e" attribute="#uname" operation="eq" id="expNode2"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +         </rule>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +       </rsc_location>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +       <rsc_location id="ping:disconn" rsc="grpDummy">
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +         <rule id="ping1:disconn:rule" score="-INFINITY" boolean_op="and">
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <expression id="ping1:disconn:expr:defined" attribute="default_ping_set" operation="defined"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +           <expression id="ping1:disconn:expr:positive" attribute="default_ping_set" operation="lt" value="100"/>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +         </rule>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +       </rsc_location>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +     </constraints>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: +   </configuration>
cib[1050]: 2007/11/30_18:34:31 info: log_data_element: cib:diff: + </cib>
cib[1065]: 2007/11/30_18:34:31 info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml (digest: /var/lib/heartbeat/crm/cib.xml.sig)
cib[1065]: 2007/11/30_18:34:31 info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml (digest: /var/lib/heartbeat/crm/cib.xml.sig)
cib[1065]: 2007/11/30_18:34:31 info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml.last (digest: /var/lib/heartbeat/crm/cib.xml.sig.last)
cib[1065]: 2007/11/30_18:34:31 info: write_cib_contents: Wrote version 0.2.1 of the CIB to disk (digest: 3bf3061dbb183c4dde5ebe419ce03e75)
pengine[1061]: 2007/11/30_18:34:31 notice: unpack_config: On loss of CCM Quorum: Ignore
pengine[1061]: 2007/11/30_18:34:31 info: determine_online_status: Node prec370e is online
pengine[1061]: 2007/11/30_18:34:31 info: determine_online_status: Node prec370d is online
pengine[1061]: 2007/11/30_18:34:31 notice: group_print: Resource Group: grpDummy
pengine[1061]: 2007/11/30_18:34:31 notice: native_print:     prmDummy	(heartbeat::ocf:Dummy):	Stopped 
pengine[1061]: 2007/11/30_18:34:31 ERROR: unpack_operation: Specifying on_fail=fence and stonith-enabled=false makes no sense
pengine[1061]: 2007/11/30_18:34:31 notice: StartRsc:  prec370d	Start prmDummy
pengine[1061]: 2007/11/30_18:34:31 ERROR: unpack_operation: Specifying on_fail=fence and stonith-enabled=false makes no sense
pengine[1061]: 2007/11/30_18:34:31 notice: RecurringOp: prec370d	   prmDummy_monitor_10000
pengine[1061]: 2007/11/30_18:34:31 ERROR: unpack_operation: Specifying on_fail=fence and stonith-enabled=false makes no sense
crmd[1054]: 2007/11/30_18:34:31 info: do_state_transition: State transition S_POLICY_ENGINE -> S_TRANSITION_ENGINE [ input=I_PE_SUCCESS cause=C_IPC_MESSAGE origin=route_message ]
cib[1065]: 2007/11/30_18:34:31 info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml (digest: /var/lib/heartbeat/crm/cib.xml.sig)
tengine[1060]: 2007/11/30_18:34:31 info: unpack_graph: Unpacked transition 3: 9 actions in 9 synapses
pengine[1061]: 2007/11/30_18:34:31 info: process_pe_message: Transition 3: PEngine Input stored in: /var/lib/heartbeat/pengine/pe-input-3.bz2
tengine[1060]: 2007/11/30_18:34:31 info: send_rsc_command: Initiating action 3: prmDummy_monitor_0 on prec370e
pengine[1061]: 2007/11/30_18:34:31 info: process_pe_message: Configuration ERRORs found during PE processing.  Please run "crm_verify -L" to identify issues.
tengine[1060]: 2007/11/30_18:34:31 info: send_rsc_command: Initiating action 5: prmDummy_monitor_0 on prec370d
crmd[1054]: 2007/11/30_18:34:31 info: do_lrm_rsc_op: Performing op=prmDummy_monitor_0 key=3:3:01a2babe-2973-4acf-bf6f-909494580d61)
cib[1065]: 2007/11/30_18:34:31 info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml.last (digest: /var/lib/heartbeat/crm/cib.xml.sig.last)
lrmd[1051]: 2007/11/30_18:34:31 info: rsc:prmDummy: monitor
Dummy[1066][1072]: 2007/11/30_18:34:31 DEBUG: prmDummy monitor : 7
crmd[1054]: 2007/11/30_18:34:31 info: process_lrm_event: LRM operation prmDummy_monitor_0 (call=2, rc=7) complete 
tengine[1060]: 2007/11/30_18:34:31 info: match_graph_event: Action prmDummy_monitor_0 (3) confirmed on prec370e (rc=0)
tengine[1060]: 2007/11/30_18:34:31 info: send_rsc_command: Initiating action 2: probe_complete on prec370e
tengine[1060]: 2007/11/30_18:34:31 info: match_graph_event: Action prmDummy_monitor_0 (5) confirmed on prec370d (rc=0)
tengine[1060]: 2007/11/30_18:34:31 info: send_rsc_command: Initiating action 4: probe_complete on prec370d
tengine[1060]: 2007/11/30_18:34:31 info: te_pseudo_action: Pseudo action 1 fired and confirmed
tengine[1060]: 2007/11/30_18:34:31 info: te_pseudo_action: Pseudo action 9 fired and confirmed
tengine[1060]: 2007/11/30_18:34:31 info: send_rsc_command: Initiating action 7: prmDummy_start_0 on prec370d
tengine[1060]: 2007/11/30_18:34:33 info: match_graph_event: Action prmDummy_start_0 (7) confirmed on prec370d (rc=0)
tengine[1060]: 2007/11/30_18:34:33 info: te_pseudo_action: Pseudo action 10 fired and confirmed
tengine[1060]: 2007/11/30_18:34:33 info: send_rsc_command: Initiating action 8: prmDummy_monitor_10000 on prec370d
tengine[1060]: 2007/11/30_18:34:33 info: match_graph_event: Action prmDummy_monitor_10000 (8) confirmed on prec370d (rc=0)
tengine[1060]: 2007/11/30_18:34:33 info: run_graph: Transition 3: (Complete=9, Pending=0, Fired=0, Skipped=0, Incomplete=0)
tengine[1060]: 2007/11/30_18:34:33 info: notify_crmd: Transition 3 status: te_complete - <null>
crmd[1054]: 2007/11/30_18:34:33 info: do_state_transition: State transition S_TRANSITION_ENGINE -> S_IDLE [ input=I_TE_SUCCESS cause=C_IPC_MESSAGE origin=route_message ]
tengine[1060]: 2007/11/30_18:37:15 info: update_abort_priority: Abort priority upgraded to 1000000
crmd[1054]: 2007/11/30_18:37:15 info: do_state_transition: State transition S_IDLE -> S_POLICY_ENGINE [ input=I_PE_CALC cause=C_IPC_MESSAGE origin=route_message ]
cib[1050]: 2007/11/30_18:37:15 info: log_data_element: cib:diff: - <cib epoch="2" num_updates="7"/>
crmd[1054]: 2007/11/30_18:37:15 info: do_state_transition: All 2 cluster nodes are eligible to run resources.
cib[1050]: 2007/11/30_18:37:15 info: log_data_element: cib:diff: + <cib epoch="3" num_updates="1">
cib[1050]: 2007/11/30_18:37:15 info: log_data_element: cib:diff: +   <configuration>
cib[1050]: 2007/11/30_18:37:15 info: log_data_element: cib:diff: +     <resources>
cib[1050]: 2007/11/30_18:37:15 info: log_data_element: cib:diff: +       <group id="grpDummy">
cib[1050]: 2007/11/30_18:37:15 info: log_data_element: cib:diff: +         <primitive resource_stickiness="0" id="prmDummy"/>
cib[1050]: 2007/11/30_18:37:15 info: log_data_element: cib:diff: +       </group>
cib[1050]: 2007/11/30_18:37:15 info: log_data_element: cib:diff: +     </resources>
cib[1050]: 2007/11/30_18:37:15 info: log_data_element: cib:diff: +   </configuration>
cib[1050]: 2007/11/30_18:37:15 info: log_data_element: cib:diff: + </cib>
cib[1088]: 2007/11/30_18:37:15 info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml (digest: /var/lib/heartbeat/crm/cib.xml.sig)
cib[1088]: 2007/11/30_18:37:15 info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml (digest: /var/lib/heartbeat/crm/cib.xml.sig)
pengine[1061]: 2007/11/30_18:37:15 notice: unpack_config: On loss of CCM Quorum: Ignore
cib[1088]: 2007/11/30_18:37:15 info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml.last (digest: /var/lib/heartbeat/crm/cib.xml.sig.last)
pengine[1061]: 2007/11/30_18:37:15 info: determine_online_status: Node prec370e is online
pengine[1061]: 2007/11/30_18:37:15 info: determine_online_status: Node prec370d is online
pengine[1061]: 2007/11/30_18:37:15 ERROR: unpack_operation: Specifying on_fail=fence and stonith-enabled=false makes no sense
pengine[1061]: 2007/11/30_18:37:15 notice: group_print: Resource Group: grpDummy
pengine[1061]: 2007/11/30_18:37:15 notice: native_print:     prmDummy	(heartbeat::ocf:Dummy):	Started prec370d
pengine[1061]: 2007/11/30_18:37:15 ERROR: unpack_operation: Specifying on_fail=fence and stonith-enabled=false makes no sense
pengine[1061]: 2007/11/30_18:37:15 ERROR: unpack_operation: Specifying on_fail=fence and stonith-enabled=false makes no sense
pengine[1061]: 2007/11/30_18:37:15 ERROR: unpack_operation: Specifying on_fail=fence and stonith-enabled=false makes no sense
pengine[1061]: 2007/11/30_18:37:15 ERROR: unpack_operation: Specifying on_fail=fence and stonith-enabled=false makes no sense
pengine[1061]: 2007/11/30_18:37:15 notice: NoRoleChange: Leave resource prmDummy	(prec370d)
crmd[1054]: 2007/11/30_18:37:15 info: do_state_transition: State transition S_POLICY_ENGINE -> S_TRANSITION_ENGINE [ input=I_PE_SUCCESS cause=C_IPC_MESSAGE origin=route_message ]
tengine[1060]: 2007/11/30_18:37:15 info: unpack_graph: Unpacked transition 4: 0 actions in 0 synapses
tengine[1060]: 2007/11/30_18:37:15 info: run_graph: Transition 4: (Complete=0, Pending=0, Fired=0, Skipped=0, Incomplete=0)
crmd[1054]: 2007/11/30_18:37:15 info: do_state_transition: State transition S_TRANSITION_ENGINE -> S_IDLE [ input=I_TE_SUCCESS cause=C_IPC_MESSAGE origin=route_message ]
tengine[1060]: 2007/11/30_18:37:15 info: notify_crmd: Transition 4 status: te_complete - <null>
pengine[1061]: 2007/11/30_18:37:15 info: process_pe_message: Transition 4: PEngine Input stored in: /var/lib/heartbeat/pengine/pe-input-4.bz2
pengine[1061]: 2007/11/30_18:37:15 info: process_pe_message: Configuration ERRORs found during PE processing.  Please run "crm_verify -L" to identify issues.
cib[1088]: 2007/11/30_18:37:15 info: write_cib_contents: Wrote version 0.3.1 of the CIB to disk (digest: 13f5286231b44cdd1d20b7c9bec128ed)
cib[1088]: 2007/11/30_18:37:15 info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml (digest: /var/lib/heartbeat/crm/cib.xml.sig)
cib[1088]: 2007/11/30_18:37:15 info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml.last (digest: /var/lib/heartbeat/crm/cib.xml.sig.last)
cib[1050]: 2007/11/30_18:37:28 info: log_data_element: cib:diff: - <cib epoch="3">
tengine[1060]: 2007/11/30_18:37:28 info: update_abort_priority: Abort priority upgraded to 1000000
cib[1050]: 2007/11/30_18:37:28 info: log_data_element: cib:diff: -   <configuration>
cib[1050]: 2007/11/30_18:37:28 info: log_data_element: cib:diff: -     <resources>
crmd[1054]: 2007/11/30_18:37:28 info: do_state_transition: State transition S_IDLE -> S_POLICY_ENGINE [ input=I_PE_CALC cause=C_IPC_MESSAGE origin=route_message ]
cib[1050]: 2007/11/30_18:37:28 info: log_data_element: cib:diff: -       <group id="grpDummy">
crmd[1054]: 2007/11/30_18:37:28 info: do_state_transition: All 2 cluster nodes are eligible to run resources.
cib[1050]: 2007/11/30_18:37:28 info: log_data_element: cib:diff: -         <primitive id="prmDummy">
cib[1050]: 2007/11/30_18:37:28 info: log_data_element: cib:diff: -           <operations>
cib[1050]: 2007/11/30_18:37:28 info: log_data_element: cib:diff: -             <op id="opDummyStart" name="start" timeout="60s" on_fail="fence"/>
cib[1050]: 2007/11/30_18:37:28 info: log_data_element: cib:diff: -             <op id="opDummyMonitor" name="monitor" interval="10s" timeout="10s" on_fail="fence"/>
cib[1050]: 2007/11/30_18:37:28 info: log_data_element: cib:diff: -             <op id="opDummyStop" name="stop" timeout="60s" on_fail="fence"/>
cib[1050]: 2007/11/30_18:37:28 info: log_data_element: cib:diff: -           </operations>
cib[1050]: 2007/11/30_18:37:28 info: log_data_element: cib:diff: -           <instance_attributes id="atrDummy">
cib[1050]: 2007/11/30_18:37:28 info: log_data_element: cib:diff: -             <attributes>
cib[1050]: 2007/11/30_18:37:28 info: log_data_element: cib:diff: -               <nvpair id="atrDummy1" name="delay" value="1"/>
cib[1050]: 2007/11/30_18:37:28 info: log_data_element: cib:diff: -               <nvpair id="atrDummy2" name="state" value="/var/run/heartbeat/rsctmp/Dummy.state"/>
cib[1050]: 2007/11/30_18:37:28 info: log_data_element: cib:diff: -             </attributes>
cib[1050]: 2007/11/30_18:37:28 info: log_data_element: cib:diff: -           </instance_attributes>
cib[1050]: 2007/11/30_18:37:28 info: log_data_element: cib:diff: -         </primitive>
cib[1050]: 2007/11/30_18:37:28 info: log_data_element: cib:diff: -       </group>
cib[1050]: 2007/11/30_18:37:28 info: log_data_element: cib:diff: -     </resources>
cib[1050]: 2007/11/30_18:37:28 info: log_data_element: cib:diff: -   </configuration>
cib[1050]: 2007/11/30_18:37:28 info: log_data_element: cib:diff: - </cib>
cib[1050]: 2007/11/30_18:37:28 info: log_data_element: cib:diff: + <cib epoch="4"/>
cib[1093]: 2007/11/30_18:37:28 info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml (digest: /var/lib/heartbeat/crm/cib.xml.sig)
cib[1093]: 2007/11/30_18:37:28 info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml (digest: /var/lib/heartbeat/crm/cib.xml.sig)
cib[1093]: 2007/11/30_18:37:28 info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml.last (digest: /var/lib/heartbeat/crm/cib.xml.sig.last)
crmd[1054]: 2007/11/30_18:37:28 info: do_state_transition: State transition S_POLICY_ENGINE -> S_TRANSITION_ENGINE [ input=I_PE_SUCCESS cause=C_IPC_MESSAGE origin=route_message ]
pengine[1061]: 2007/11/30_18:37:28 notice: unpack_config: On loss of CCM Quorum: Ignore
pengine[1061]: 2007/11/30_18:37:28 info: determine_online_status: Node prec370e is online
pengine[1061]: 2007/11/30_18:37:28 info: determine_online_status: Node prec370d is online
pengine[1061]: 2007/11/30_18:37:28 notice: group_print: Resource Group: grpDummy
pengine[1061]: 2007/11/30_18:37:28 notice: native_print:     prmDummy	(heartbeat::ocf:Dummy):	Started prec370d
pengine[1061]: 2007/11/30_18:37:28 info: log_data_element: check_action_definition: params:restart <parameters/>
pengine[1061]: 2007/11/30_18:37:28 WARN: check_action_definition: Parameters to prmDummy_start_0 on prec370d changed: recorded d8e112f8d663c70ee8cc067c357ad6f2 vs. f2317cad3d54cec5d7d7aa7d0bf35cf8 (restart:2.0) 0:0;7:3:01a2babe-2973-4acf-bf6f-909494580d61
pengine[1061]: 2007/11/30_18:37:28 info: check_action_definition: Orphan action will be stopped: prmDummy_monitor_10000 on prec370d
pengine[1061]: 2007/11/30_18:37:28 notice: StopRsc:   prec370d	Stop prmDummy
tengine[1060]: 2007/11/30_18:37:28 info: unpack_graph: Unpacked transition 5: 8 actions in 8 synapses
pengine[1061]: 2007/11/30_18:37:28 notice: StartRsc:  prec370d	Start prmDummy
pengine[1061]: 2007/11/30_18:37:28 notice: NoRoleChange: Restart resource prmDummy	(prec370d)
tengine[1060]: 2007/11/30_18:37:28 info: te_pseudo_action: Pseudo action 11 fired and confirmed
tengine[1060]: 2007/11/30_18:37:28 info: send_rsc_command: Initiating action 8: prmDummy_stop_0 on prec370d
pengine[1061]: 2007/11/30_18:37:28 info: process_pe_message: Transition 5: PEngine Input stored in: /var/lib/heartbeat/pengine/pe-input-5.bz2
cib[1093]: 2007/11/30_18:37:28 info: write_cib_contents: Wrote version 0.4.1 of the CIB to disk (digest: d6ed1a78ae733a503b45e51f866c0490)
cib[1093]: 2007/11/30_18:37:28 info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml (digest: /var/lib/heartbeat/crm/cib.xml.sig)
cib[1093]: 2007/11/30_18:37:28 info: retrieveCib: Reading cluster configuration from: /var/lib/heartbeat/crm/cib.xml.last (digest: /var/lib/heartbeat/crm/cib.xml.sig.last)
tengine[1060]: 2007/11/30_18:37:30 info: match_graph_event: Action prmDummy_stop_0 (8) confirmed on prec370d (rc=0)
tengine[1060]: 2007/11/30_18:37:30 info: te_pseudo_action: Pseudo action 12 fired and confirmed
tengine[1060]: 2007/11/30_18:37:30 info: send_rsc_command: Initiating action 7: prmDummy_cancel_10000 on prec370d
tengine[1060]: 2007/11/30_18:37:30 info: te_pseudo_action: Pseudo action 5 fired and confirmed
tengine[1060]: 2007/11/30_18:37:30 info: te_pseudo_action: Pseudo action 9 fired and confirmed
tengine[1060]: 2007/11/30_18:37:30 info: send_rsc_command: Initiating action 6: prmDummy_start_0 on prec370d
tengine[1060]: 2007/11/30_18:37:31 info: process_te_message: Processing (N)ACK lrm_invoke-lrmd-1196415451-5 from prec370d
tengine[1060]: 2007/11/30_18:37:31 info: match_graph_event: Action prmDummy_monitor_10000 (7) confirmed on prec370d (rc=0)
crmd[1054]: 2007/11/30_18:37:31 info: do_state_transition: State transition S_TRANSITION_ENGINE -> S_IDLE [ input=I_TE_SUCCESS cause=C_IPC_MESSAGE origin=route_message ]
tengine[1060]: 2007/11/30_18:37:31 info: match_graph_event: Action prmDummy_start_0 (6) confirmed on prec370d (rc=0)
tengine[1060]: 2007/11/30_18:37:31 info: te_pseudo_action: Pseudo action 10 fired and confirmed
tengine[1060]: 2007/11/30_18:37:31 info: run_graph: Transition 5: (Complete=8, Pending=0, Fired=0, Skipped=0, Incomplete=0)
tengine[1060]: 2007/11/30_18:37:31 info: notify_crmd: Transition 5 status: te_complete - <null>
crmd[1054]: 2007/11/30_18:38:39 info: handle_request: Current ping state: S_IDLE
