Login | Register For Free | Help
Search for: (Advanced)

Mailing List Archive: Linux-HA: Pacemaker

Unable to start pacemaker on Fedora16

 

 

Linux-HA pacemaker RSS feed   Index | Next | Previous | View Threaded


kafecho at gmail

May 9, 2012, 4:26 AM

Post #1 of 3 (860 views)
Permalink
Unable to start pacemaker on Fedora16

Hi all,

I am new to Pacemaker/Corosync, so this is a newbbie question.

I am trying pacemaker on fedora16, going through the guide reading
Pacemaker 1.1 Clusters from scratch.

I have two fedora16 instances running inside virtual machines running
on VirtualBox on Windows7.

I've installed and configured Corosync to use a multicast address.
Corosync seems to correctly that both of my vms are up. However, when
I start pacemaker using /etc/init.d/pacemaker start I eventually get
an error and it terminates.

I've tried to setup Corosync in unicast as well as multicast mode, but
that does not seem to make a difference.

See the relevant portion in the /var/log/messages at the end of this email.

There is a line that says: "The Corosync quorum API is not supported
in this build". I am not quite sure what this means.

I am hoping someone can help me pinpoint the problem. I am not tied to
using Fedora16. I could try a different version, or a different
distribution all together.

All help would be greatly appreciated.

Cheers,

Guillaume.




May 9 12:03:15 fedora1 pacemakerd: [3575]: info: Invoked:
/usr/sbin/pacemakerd -f
May 9 12:03:15 fedora1 pacemakerd: [3575]: info: crm_log_init_worker:
Changed active directory to /var/lib/heartbeat/cores/root
May 9 12:03:15 fedora1 pacemakerd: [3575]: info: config_find_next: No
additional configuration supplied for: service
May 9 12:03:15 fedora1 pacemakerd: [3575]: info: config_find_next: No
additional configuration supplied for: quorum
May 9 12:03:15 fedora1 pacemakerd: [3575]: info: get_config_opt: No
default for option: provider
May 9 12:03:15 fedora1 pacemakerd: [3575]: info: get_cluster_type:
Detected an active 'corosync' cluster
May 9 12:03:15 fedora1 pacemakerd: [3575]: info: read_config: Reading
configure for stack: corosync
May 9 12:03:15 fedora1 pacemakerd: [3575]: info: config_find_next:
Processing additional logging options...
May 9 12:03:15 fedora1 pacemakerd: [3575]: info: get_config_opt:
Found 'off' for option: debug
May 9 12:03:15 fedora1 pacemakerd: [3575]: info: get_config_opt:
Found '/var/log/cluster/corosync.log' for option: logfile
May 9 12:03:15 fedora1 pacemakerd: [3575]: info: get_config_opt:
Found 'yes' for option: to_logfile
May 9 12:03:15 fedora1 pacemakerd: [3575]: info: get_config_opt:
Found 'yes' for option: to_syslog
May 9 12:03:15 fedora1 pacemakerd: [3575]: info: get_config_opt:
Defaulting to 'daemon' for option: syslog_facility
May 9 12:03:15 fedora1 pacemakerd: [3575]: notice: main: Starting
Pacemaker 1.1.7-2.fc16 (Build:
ee0730e13d124c3d58f00016c3376a1de5323cff): generated-manpages
agent-manpages ascii-docs publican-docs ncurses corosync-plugin cman
May 9 12:03:15 fedora1 pacemakerd: [3575]: info: main: Maximum core
file size is: 4294967295
May 9 12:03:15 fedora1 pacemakerd: [3575]: notice:
update_node_processes: 0x9db66f0 Node 1746182666 now known as fedora1,
was:
May 9 12:03:15 fedora1 pacemakerd: [3575]: info:
G_main_add_SignalHandler: Added signal handler for signal 17
May 9 12:03:15 fedora1 pacemakerd: [3575]: info: start_child: Forked
child 3580 for process cib
May 9 12:03:15 fedora1 pacemakerd: [3575]: info: start_child: Forked
child 3581 for process stonith-ng
May 9 12:03:15 fedora1 pacemakerd: [3575]: info: start_child: Forked
child 3582 for process lrmd
May 9 12:03:15 fedora1 pacemakerd: [3575]: info: start_child: Forked
child 3583 for process attrd
May 9 12:03:15 fedora1 pacemakerd: [3575]: info: start_child: Forked
child 3584 for process pengine
May 9 12:03:15 fedora1 pacemakerd: [3575]: info: start_child: Forked
child 3585 for process crmd
May 9 12:03:15 fedora1 pacemakerd: [3575]: info: main: Starting mainloop
May 9 12:03:15 fedora1 stonith-ng: [3581]: info: Invoked:
/usr/libexec/pacemaker/stonithd
May 9 12:03:15 fedora1 lrmd: [3582]: info: G_main_add_SignalHandler:
Added signal handler for signal 15
May 9 12:03:15 fedora1 lrmd: [3582]: info: G_main_add_SignalHandler:
Added signal handler for signal 17
May 9 12:03:16 fedora1 attrd: [3583]: info: Invoked:
/usr/libexec/pacemaker/attrd
May 9 12:03:16 fedora1 pengine: [3584]: info: Invoked:
/usr/libexec/pacemaker/pengine
May 9 12:03:16 fedora1 stonith-ng: [3581]: info: crm_log_init_worker:
Changed active directory to /var/lib/heartbeat/cores/root
May 9 12:03:16 fedora1 stonith-ng: [3581]: info:
G_main_add_SignalHandler: Added signal handler for signal 17
May 9 12:03:16 fedora1 stonith-ng: [3581]: info: get_cluster_type:
Cluster type is: 'corosync'
May 9 12:03:16 fedora1 stonith-ng: [3581]: notice:
crm_cluster_connect: Connecting to cluster infrastructure: corosync
May 9 12:03:16 fedora1 crmd: [3585]: info: Invoked:
/usr/libexec/pacemaker/crmd
May 9 12:03:16 fedora1 attrd: [3583]: notice: crm_cluster_connect:
Connecting to cluster infrastructure: corosync
May 9 12:03:16 fedora1 crmd: [3585]: info: crm_log_init_worker:
Changed active directory to /var/lib/heartbeat/cores/hacluster
May 9 12:03:16 fedora1 cib: [3580]: info: crm_log_init_worker:
Changed active directory to /var/lib/heartbeat/cores/hacluster
May 9 12:03:16 fedora1 crmd: [3585]: notice: main: CRM Git Version:
ee0730e13d124c3d58f00016c3376a1de5323cff
May 9 12:03:16 fedora1 lrmd: [3582]: info: enabling coredumps
May 9 12:03:16 fedora1 crmd: [3585]: info: G_main_add_SignalHandler:
Added signal handler for signal 17
May 9 12:03:16 fedora1 lrmd: [3582]: info: G_main_add_SignalHandler:
Added signal handler for signal 10
May 9 12:03:16 fedora1 cib: [3580]: info: G_main_add_TriggerHandler:
Added signal manual handler
May 9 12:03:16 fedora1 lrmd: [3582]: info: G_main_add_SignalHandler:
Added signal handler for signal 12
May 9 12:03:16 fedora1 lrmd: [3582]: info: Started.
May 9 12:03:16 fedora1 cib: [3580]: info: G_main_add_SignalHandler:
Added signal handler for signal 17
May 9 12:03:16 fedora1 cib: [3580]: info: retrieveCib: Reading
cluster configuration from: /var/lib/heartbeat/crm/cib.xml (digest:
/var/lib/heartbeat/crm/cib.xml.sig)
May 9 12:03:16 fedora1 cib: [3580]: info: validate_with_relaxng:
Creating RNG parser context
May 9 12:03:16 fedora1 stonith-ng: [3581]: info:
init_ais_connection_once: Connection to 'corosync': established
May 9 12:03:16 fedora1 stonith-ng: [3581]: info: crm_new_peer: Node
fedora1 now has id: 1746182666
May 9 12:03:16 fedora1 stonith-ng: [3581]: info: crm_new_peer: Node
1746182666 is now known as fedora1
May 9 12:03:16 fedora1 attrd: [3583]: notice: main: Starting mainloop...
May 9 12:03:16 fedora1 cib: [3580]: info: startCib: CIB
Initialization completed successfully
May 9 12:03:16 fedora1 cib: [3580]: info: get_cluster_type: Cluster
type is: 'corosync'
May 9 12:03:16 fedora1 cib: [3580]: notice: crm_cluster_connect:
Connecting to cluster infrastructure: corosync
May 9 12:03:16 fedora1 cib: [3580]: info: init_ais_connection_once:
Connection to 'corosync': established
May 9 12:03:16 fedora1 cib: [3580]: info: crm_new_peer: Node fedora1
now has id: 1746182666
May 9 12:03:16 fedora1 cib: [3580]: info: crm_new_peer: Node
1746182666 is now known as fedora1
May 9 12:03:16 fedora1 cib: [3580]: info: cib_init: Starting cib mainloop
May 9 12:03:17 fedora1 crmd: [3585]: info: do_cib_control: CIB
connection established
May 9 12:03:17 fedora1 crmd: [3585]: info: get_cluster_type: Cluster
type is: 'corosync'
May 9 12:03:17 fedora1 crmd: [3585]: notice: crm_cluster_connect:
Connecting to cluster infrastructure: corosync
May 9 12:03:17 fedora1 crmd: [3585]: info: init_ais_connection_once:
Connection to 'corosync': established
May 9 12:03:17 fedora1 crmd: [3585]: info: crm_new_peer: Node fedora1
now has id: 1746182666
May 9 12:03:17 fedora1 crmd: [3585]: info: crm_new_peer: Node
1746182666 is now known as fedora1
May 9 12:03:17 fedora1 crmd: [3585]: info: ais_status_callback:
status: fedora1 is now unknown
May 9 12:03:17 fedora1 crmd: [3585]: ERROR: init_quorum_connection:
The Corosync quorum API is not supported in this build
May 9 12:03:17 fedora1 pacemakerd: [3575]: ERROR: pcmk_child_exit:
Child process crmd exited (pid=3585, rc=100)
May 9 12:03:17 fedora1 pacemakerd: [3575]: WARN: pcmk_child_exit:
Pacemaker child process crmd no longer wishes to be respawned.
Shutting ourselves down.
May 9 12:03:17 fedora1 pacemakerd: [3575]: notice:
pcmk_shutdown_worker: Shuting down Pacemaker
May 9 12:03:17 fedora1 pacemakerd: [3575]: notice: stop_child:
Stopping pengine: Sent -15 to process 3584
May 9 12:03:17 fedora1 pacemakerd: [3575]: info: pcmk_child_exit:
Child process pengine exited (pid=3584, rc=0)
May 9 12:03:17 fedora1 pacemakerd: [3575]: notice: stop_child:
Stopping attrd: Sent -15 to process 3583
May 9 12:03:17 fedora1 attrd: [3583]: notice: main: Exiting...
May 9 12:03:17 fedora1 pacemakerd: [3575]: info: pcmk_child_exit:
Child process attrd exited (pid=3583, rc=0)
May 9 12:03:17 fedora1 pacemakerd: [3575]: WARN: send_ipc_message:
IPC Channel to 3583 is not connected
May 9 12:03:17 fedora1 pacemakerd: [3575]: notice: stop_child:
Stopping lrmd: Sent -15 to process 3582
May 9 12:03:17 fedora1 lrmd: [3582]: info: lrmd is shutting down
May 9 12:03:17 fedora1 pacemakerd: [3575]: info: pcmk_child_exit:
Child process lrmd exited (pid=3582, rc=0)
May 9 12:03:17 fedora1 pacemakerd: [3575]: notice: stop_child:
Stopping stonith-ng: Sent -15 to process 3581
May 9 12:03:17 fedora1 stonith-ng: [3581]: notice: setup_cib:
Watching for stonith topology changes
May 9 12:03:17 fedora1 stonith-ng: [3581]: info: main: Starting
stonith-ng mainloop
May 9 12:03:17 fedora1 stonith-ng: [3581]: info: crm_signal_dispatch:
Invoking handler for signal 15: Terminated
May 9 12:03:17 fedora1 stonith-ng: [3581]: info: stonith_shutdown:
Terminating with 0 clients
May 9 12:03:17 fedora1 pacemakerd: [3575]: info: pcmk_child_exit:
Child process stonith-ng exited (pid=3581, rc=0)
May 9 12:03:17 fedora1 pacemakerd: [3575]: WARN: send_ipc_message:
IPC Channel to 3581 is not connected
May 9 12:03:17 fedora1 pacemakerd: [3575]: notice: stop_child:
Stopping cib: Sent -15 to process 3580
May 9 12:03:17 fedora1 cib: [3580]: info: crm_signal_dispatch:
Invoking handler for signal 15: Terminated
May 9 12:03:17 fedora1 cib: [3580]: info: disconnect_cib_client:
Flushed messages to/from <null>/cib_rw... send=0, recv=2
May 9 12:03:17 fedora1 cib: [3580]: info: disconnect_cib_client:
Flushed messages to/from <null>/cib_callback... send=0, recv=1
May 9 12:03:17 fedora1 cib: [3580]: info: cib_shutdown: Disconnected 2 clients
May 9 12:03:17 fedora1 cib: [3580]: WARN: send_ipc_message: IPC
Channel to 3581 is not connected
May 9 12:03:17 fedora1 cib: [3580]: WARN: send_via_callback_channel:
Delivery of reply to client
(null)/4924f6cc-1a00-456d-96d8-6ed5b0f4442d failed
May 9 12:03:17 fedora1 cib: [3580]: WARN: do_local_notify: A-Sync
reply to crmd failed: reply failed
May 9 12:03:17 fedora1 cib: [3580]: info: cib_process_disconnect: All
clients disconnected...
May 9 12:03:17 fedora1 cib: [3580]: info: terminate_cib:
initiate_exit: Disconnecting corosync
May 9 12:03:17 fedora1 cib: [3580]: notice: terminate_ais_connection:
Disconnecting from Corosync
May 9 12:03:17 fedora1 cib: [3580]: info: terminate_cib:
initiate_exit: Exiting...
May 9 12:03:17 fedora1 cib: [3580]: info: crm_xml_cleanup: Cleaning
up memory from libxml2
May 9 12:03:17 fedora1 cib: [3580]: info: main: Done
May 9 12:03:17 fedora1 pacemakerd: [3575]: info: pcmk_child_exit:
Child process cib exited (pid=3580, rc=0)
May 9 12:03:17 fedora1 pacemakerd: [3575]: notice:
pcmk_shutdown_worker: Shutdown complete
May 9 12:03:17 fedora1 pacemakerd: [3575]: notice:
pcmk_shutdown_worker: Attempting to inhibit respawning after fatal
error
May 9 12:03:17 fedora1 systemd[1]: pacemaker.service: main process
exited, code=exited, status=100
May 9 12:03:17 fedora1 systemd[1]: pacemaker.service holdoff time
over, scheduling restart.
May 9 12:03:17 fedora1 systemd[1]: Unit pacemaker.service entered failed state.
May 9 12:03:17 fedora1 pacemakerd: [3592]: info: Invoked:
/usr/sbin/pacemakerd -f
May 9 12:03:17 fedora1 pacemakerd: [3592]: info: crm_log_init_worker:
Changed active directory to /var/lib/heartbeat/cores/root
May 9 12:03:17 fedora1 pacemakerd: [3592]: info: config_find_next: No
additional configuration supplied for: service
May 9 12:03:17 fedora1 pacemakerd: [3592]: info: config_find_next: No
additional configuration supplied for: quorum
May 9 12:03:17 fedora1 pacemakerd: [3592]: info: get_config_opt: No
default for option: provider
May 9 12:03:17 fedora1 pacemakerd: [3592]: info: get_cluster_type:
Detected an active 'corosync' cluster
May 9 12:03:17 fedora1 pacemakerd: [3592]: info: read_config: Reading
configure for stack: corosync
May 9 12:03:17 fedora1 pacemakerd: [3592]: info: config_find_next:
Processing additional logging options...
May 9 12:03:17 fedora1 pacemakerd: [3592]: info: get_config_opt:
Found 'off' for option: debug
May 9 12:03:17 fedora1 pacemakerd: [3592]: info: get_config_opt:
Found '/var/log/cluster/corosync.log' for option: logfile
May 9 12:03:17 fedora1 pacemakerd: [3592]: info: get_config_opt:
Found 'yes' for option: to_logfile
May 9 12:03:17 fedora1 pacemakerd: [3592]: info: get_config_opt:
Found 'yes' for option: to_syslog
May 9 12:03:17 fedora1 pacemakerd: [3592]: info: get_config_opt:
Defaulting to 'daemon' for option: syslog_facility
May 9 12:03:17 fedora1 pacemakerd: [3592]: notice: main: Starting
Pacemaker 1.1.7-2.fc16 (Build:
ee0730e13d124c3d58f00016c3376a1de5323cff): generated-manpages
agent-manpages ascii-docs publican-docs ncurses corosync-plugin cman
May 9 12:03:17 fedora1 pacemakerd: [3592]: info: main: Maximum core
file size is: 4294967295
May 9 12:03:17 fedora1 pacemakerd: [3592]: notice:
update_node_processes: 0x81b06f0 Node 1746182666 now known as fedora1,
was:
May 9 12:03:17 fedora1 pacemakerd: [3592]: info:
G_main_add_SignalHandler: Added signal handler for signal 17
May 9 12:03:17 fedora1 pacemakerd: [3592]: info: start_child: Forked
child 3597 for process cib
May 9 12:03:17 fedora1 pacemakerd: [3592]: info: start_child: Forked
child 3598 for process stonith-ng
May 9 12:03:17 fedora1 pacemakerd: [3592]: info: start_child: Forked
child 3599 for process lrmd
May 9 12:03:17 fedora1 pacemakerd: [3592]: info: start_child: Forked
child 3600 for process attrd
May 9 12:03:17 fedora1 pacemakerd: [3592]: info: start_child: Forked
child 3601 for process pengine
May 9 12:03:17 fedora1 pacemakerd: [3592]: info: start_child: Forked
child 3602 for process crmd
May 9 12:03:17 fedora1 pacemakerd: [3592]: info: main: Starting mainloop
May 9 12:03:17 fedora1 lrmd: [3599]: info: G_main_add_SignalHandler:
Added signal handler for signal 15
May 9 12:03:17 fedora1 attrd: [3600]: info: Invoked:
/usr/libexec/pacemaker/attrd
May 9 12:03:17 fedora1 stonith-ng: [3598]: info: Invoked:
/usr/libexec/pacemaker/stonithd
May 9 12:03:17 fedora1 stonith-ng: [3598]: info: crm_log_init_worker:
Changed active directory to /var/lib/heartbeat/cores/root
May 9 12:03:17 fedora1 stonith-ng: [3598]: info:
G_main_add_SignalHandler: Added signal handler for signal 17
May 9 12:03:17 fedora1 stonith-ng: [3598]: info: get_cluster_type:
Cluster type is: 'corosync'
May 9 12:03:17 fedora1 stonith-ng: [3598]: notice:
crm_cluster_connect: Connecting to cluster infrastructure: corosync
May 9 12:03:17 fedora1 lrmd: [3599]: info: G_main_add_SignalHandler:
Added signal handler for signal 17
May 9 12:03:17 fedora1 attrd: [3600]: notice: crm_cluster_connect:
Connecting to cluster infrastructure: corosync
May 9 12:03:17 fedora1 crmd: [3602]: info: Invoked:
/usr/libexec/pacemaker/crmd
May 9 12:03:17 fedora1 pengine: [3601]: info: Invoked:
/usr/libexec/pacemaker/pengine
May 9 12:03:17 fedora1 cib: [3597]: info: crm_log_init_worker:
Changed active directory to /var/lib/heartbeat/cores/hacluster
May 9 12:03:17 fedora1 lrmd: [3599]: info: enabling coredumps
May 9 12:03:17 fedora1 lrmd: [3599]: info: G_main_add_SignalHandler:
Added signal handler for signal 10
May 9 12:03:17 fedora1 cib: [3597]: info: G_main_add_TriggerHandler:
Added signal manual handler
May 9 12:03:17 fedora1 cib: [3597]: info: G_main_add_SignalHandler:
Added signal handler for signal 17
May 9 12:03:17 fedora1 lrmd: [3599]: info: G_main_add_SignalHandler:
Added signal handler for signal 12
May 9 12:03:17 fedora1 cib: [3597]: info: retrieveCib: Reading
cluster configuration from: /var/lib/heartbeat/crm/cib.xml (digest:
/var/lib/heartbeat/crm/cib.xml.sig)
May 9 12:03:17 fedora1 lrmd: [3599]: info: Started.
May 9 12:03:17 fedora1 crmd: [3602]: info: crm_log_init_worker:
Changed active directory to /var/lib/heartbeat/cores/hacluster
May 9 12:03:17 fedora1 cib: [3597]: info: validate_with_relaxng:
Creating RNG parser context
May 9 12:03:17 fedora1 crmd: [3602]: notice: main: CRM Git Version:
ee0730e13d124c3d58f00016c3376a1de5323cff
May 9 12:03:17 fedora1 crmd: [3602]: info: G_main_add_SignalHandler:
Added signal handler for signal 17
May 9 12:03:17 fedora1 stonith-ng: [3598]: info:
init_ais_connection_once: Connection to 'corosync': established
May 9 12:03:17 fedora1 stonith-ng: [3598]: info: crm_new_peer: Node
fedora1 now has id: 1746182666
May 9 12:03:17 fedora1 stonith-ng: [3598]: info: crm_new_peer: Node
1746182666 is now known as fedora1
May 9 12:03:17 fedora1 attrd: [3600]: notice: main: Starting mainloop...
May 9 12:03:17 fedora1 cib: [3597]: info: startCib: CIB
Initialization completed successfully
May 9 12:03:17 fedora1 cib: [3597]: info: get_cluster_type: Cluster
type is: 'corosync'
May 9 12:03:17 fedora1 cib: [3597]: notice: crm_cluster_connect:
Connecting to cluster infrastructure: corosync
May 9 12:03:17 fedora1 cib: [3597]: info: init_ais_connection_once:
Connection to 'corosync': established
May 9 12:03:17 fedora1 cib: [3597]: info: crm_new_peer: Node fedora1
now has id: 1746182666
May 9 12:03:17 fedora1 cib: [3597]: info: crm_new_peer: Node
1746182666 is now known as fedora1
May 9 12:03:17 fedora1 cib: [3597]: info: cib_init: Starting cib mainloop
May 9 12:03:18 fedora1 crmd: [3602]: info: do_cib_control: CIB
connection established
May 9 12:03:18 fedora1 crmd: [3602]: info: get_cluster_type: Cluster
type is: 'corosync'
May 9 12:03:18 fedora1 crmd: [3602]: notice: crm_cluster_connect:
Connecting to cluster infrastructure: corosync
May 9 12:03:18 fedora1 stonith-ng: [3598]: notice: setup_cib:
Watching for stonith topology changes
May 9 12:03:18 fedora1 stonith-ng: [3598]: info: main: Starting
stonith-ng mainloop
May 9 12:03:18 fedora1 crmd: [3602]: info: init_ais_connection_once:
Connection to 'corosync': established
May 9 12:03:18 fedora1 crmd: [3602]: info: crm_new_peer: Node fedora1
now has id: 1746182666
May 9 12:03:18 fedora1 crmd: [3602]: info: crm_new_peer: Node
1746182666 is now known as fedora1
May 9 12:03:18 fedora1 crmd: [3602]: info: ais_status_callback:
status: fedora1 is now unknown
May 9 12:03:18 fedora1 crmd: [3602]: ERROR: init_quorum_connection:
The Corosync quorum API is not supported in this build
May 9 12:03:18 fedora1 pacemakerd: [3592]: ERROR: pcmk_child_exit:
Child process crmd exited (pid=3602, rc=100)
May 9 12:03:18 fedora1 pacemakerd: [3592]: WARN: pcmk_child_exit:
Pacemaker child process crmd no longer wishes to be respawned.
Shutting ourselves down.
May 9 12:03:18 fedora1 pacemakerd: [3592]: notice:
pcmk_shutdown_worker: Shuting down Pacemaker
May 9 12:03:18 fedora1 pacemakerd: [3592]: notice: stop_child:
Stopping pengine: Sent -15 to process 3601
May 9 12:03:18 fedora1 pacemakerd: [3592]: info: pcmk_child_exit:
Child process pengine exited (pid=3601, rc=0)
May 9 12:03:18 fedora1 attrd: [3600]: notice: main: Exiting...
May 9 12:03:18 fedora1 pacemakerd: [3592]: notice: stop_child:
Stopping attrd: Sent -15 to process 3600
May 9 12:03:18 fedora1 pacemakerd: [3592]: info: pcmk_child_exit:
Child process attrd exited (pid=3600, rc=0)
May 9 12:03:18 fedora1 pacemakerd: [3592]: WARN: send_ipc_message:
IPC Channel to 3600 is not connected
May 9 12:03:18 fedora1 lrmd: [3599]: info: lrmd is shutting down
May 9 12:03:18 fedora1 pacemakerd: [3592]: notice: stop_child:
Stopping lrmd: Sent -15 to process 3599
May 9 12:03:18 fedora1 pacemakerd: [3592]: info: pcmk_child_exit:
Child process lrmd exited (pid=3599, rc=0)
May 9 12:03:18 fedora1 pacemakerd: [3592]: notice: stop_child:
Stopping stonith-ng: Sent -15 to process 3598
May 9 12:03:18 fedora1 stonith-ng: [3598]: info: crm_signal_dispatch:
Invoking handler for signal 15: Terminated
May 9 12:03:18 fedora1 stonith-ng: [3598]: info: stonith_shutdown:
Terminating with 0 clients
May 9 12:03:18 fedora1 pacemakerd: [3592]: info: pcmk_child_exit:
Child process stonith-ng exited (pid=3598, rc=0)
May 9 12:03:18 fedora1 pacemakerd: [3592]: WARN: send_ipc_message:
IPC Channel to 3598 is not connected
May 9 12:03:18 fedora1 pacemakerd: [3592]: notice: stop_child:
Stopping cib: Sent -15 to process 3597
May 9 12:03:18 fedora1 cib: [3597]: info: crm_signal_dispatch:
Invoking handler for signal 15: Terminated
May 9 12:03:18 fedora1 cib: [3597]: info: cib_shutdown: Disconnected 2 clients
May 9 12:03:18 fedora1 cib: [3597]: info: cib_process_disconnect: All
clients disconnected...
May 9 12:03:18 fedora1 cib: [3597]: info: terminate_cib:
initiate_exit: Disconnecting corosync
May 9 12:03:18 fedora1 cib: [3597]: notice: terminate_ais_connection:
Disconnecting from Corosync
May 9 12:03:18 fedora1 cib: [3597]: info: terminate_cib:
initiate_exit: Exiting...
May 9 12:03:18 fedora1 cib: [3597]: info: crm_xml_cleanup: Cleaning
up memory from libxml2
May 9 12:03:18 fedora1 cib: [3597]: info: main: Done
May 9 12:03:18 fedora1 pacemakerd: [3592]: info: pcmk_child_exit:
Child process cib exited (pid=3597, rc=0)
May 9 12:03:18 fedora1 pacemakerd: [3592]: notice:
pcmk_shutdown_worker: Shutdown complete
May 9 12:03:18 fedora1 pacemakerd: [3592]: notice:
pcmk_shutdown_worker: Attempting to inhibit respawning after fatal
error
May 9 12:03:18 fedora1 systemd[1]: pacemaker.service: main process
exited, code=exited, status=100
May 9 12:03:18 fedora1 systemd[1]: pacemaker.service holdoff time
over, scheduling restart.
May 9 12:03:18 fedora1 systemd[1]: Unit pacemaker.service entered failed state.
May 9 12:03:18 fedora1 systemd[1]: pacemaker.service start request
repeated too quickly, refusing to start.

_______________________________________________
Pacemaker mailing list: Pacemaker [at] oss
http://oss.clusterlabs.org/mailman/listinfo/pacemaker

Project Home: http://www.clusterlabs.org
Getting started: http://www.clusterlabs.org/doc/Cluster_from_Scratch.pdf
Bugs: http://bugs.clusterlabs.org


andrew at beekhof

May 9, 2012, 9:06 PM

Post #2 of 3 (718 views)
Permalink
Re: Unable to start pacemaker on Fedora16 [In reply to]

What is the corosync version?
I'm assuming 1.4.x

Did you create the services section as directed in:

http://clusterlabs.org/doc/en-US/Pacemaker/1.1/html/Clusters_from_Scratch/_configuring_corosync.html

after "Finally, tell Corosync to load the Pacemaker plugin."?

On Wed, May 9, 2012 at 9:26 PM, Guillaume Belrose <kafecho [at] gmail> wrote:
> Hi all,
>
> I am new to Pacemaker/Corosync, so this is a newbbie question.
>
> I am trying pacemaker on fedora16, going through the guide reading
> Pacemaker 1.1 Clusters from scratch.
>
> I have two fedora16 instances running inside virtual machines running
> on VirtualBox on Windows7.
>
> I've installed and configured Corosync to use a multicast address.
> Corosync seems to correctly that both of my vms are up. However, when
> I start pacemaker using /etc/init.d/pacemaker start I eventually get
> an error and it terminates.
>
> I've tried to setup Corosync in unicast as well as multicast mode, but
> that does not seem to make a difference.
>
> See the relevant portion in the /var/log/messages at the end of this email.
>
> There is a line that says: "The Corosync quorum API is not supported
> in this build". I am not quite sure what this means.
>
> I am hoping someone can help me pinpoint the problem. I am not tied to
> using Fedora16. I could try a different version, or a different
> distribution all together.
>
> All help would be greatly appreciated.
>
> Cheers,
>
> Guillaume.
>
>
>
>
> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: Invoked:
> /usr/sbin/pacemakerd -f
> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: crm_log_init_worker:
> Changed active directory to /var/lib/heartbeat/cores/root
> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: config_find_next: No
> additional configuration supplied for: service
> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: config_find_next: No
> additional configuration supplied for: quorum
> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: get_config_opt: No
> default for option: provider
> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: get_cluster_type:
> Detected an active 'corosync' cluster
> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: read_config: Reading
> configure for stack: corosync
> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: config_find_next:
> Processing additional logging options...
> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: get_config_opt:
> Found 'off' for option: debug
> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: get_config_opt:
> Found '/var/log/cluster/corosync.log' for option: logfile
> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: get_config_opt:
> Found 'yes' for option: to_logfile
> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: get_config_opt:
> Found 'yes' for option: to_syslog
> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: get_config_opt:
> Defaulting to 'daemon' for option: syslog_facility
> May  9 12:03:15 fedora1 pacemakerd: [3575]: notice: main: Starting
> Pacemaker 1.1.7-2.fc16 (Build:
> ee0730e13d124c3d58f00016c3376a1de5323cff):  generated-manpages
> agent-manpages ascii-docs publican-docs ncurses  corosync-plugin cman
> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: main: Maximum core
> file size is: 4294967295
> May  9 12:03:15 fedora1 pacemakerd: [3575]: notice:
> update_node_processes: 0x9db66f0 Node 1746182666 now known as fedora1,
> was:
> May  9 12:03:15 fedora1 pacemakerd: [3575]: info:
> G_main_add_SignalHandler: Added signal handler for signal 17
> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: start_child: Forked
> child 3580 for process cib
> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: start_child: Forked
> child 3581 for process stonith-ng
> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: start_child: Forked
> child 3582 for process lrmd
> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: start_child: Forked
> child 3583 for process attrd
> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: start_child: Forked
> child 3584 for process pengine
> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: start_child: Forked
> child 3585 for process crmd
> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: main: Starting mainloop
> May  9 12:03:15 fedora1 stonith-ng: [3581]: info: Invoked:
> /usr/libexec/pacemaker/stonithd
> May  9 12:03:15 fedora1 lrmd: [3582]: info: G_main_add_SignalHandler:
> Added signal handler for signal 15
> May  9 12:03:15 fedora1 lrmd: [3582]: info: G_main_add_SignalHandler:
> Added signal handler for signal 17
> May  9 12:03:16 fedora1 attrd: [3583]: info: Invoked:
> /usr/libexec/pacemaker/attrd
> May  9 12:03:16 fedora1 pengine: [3584]: info: Invoked:
> /usr/libexec/pacemaker/pengine
> May  9 12:03:16 fedora1 stonith-ng: [3581]: info: crm_log_init_worker:
> Changed active directory to /var/lib/heartbeat/cores/root
> May  9 12:03:16 fedora1 stonith-ng: [3581]: info:
> G_main_add_SignalHandler: Added signal handler for signal 17
> May  9 12:03:16 fedora1 stonith-ng: [3581]: info: get_cluster_type:
> Cluster type is: 'corosync'
> May  9 12:03:16 fedora1 stonith-ng: [3581]: notice:
> crm_cluster_connect: Connecting to cluster infrastructure: corosync
> May  9 12:03:16 fedora1 crmd: [3585]: info: Invoked:
> /usr/libexec/pacemaker/crmd
> May  9 12:03:16 fedora1 attrd: [3583]: notice: crm_cluster_connect:
> Connecting to cluster infrastructure: corosync
> May  9 12:03:16 fedora1 crmd: [3585]: info: crm_log_init_worker:
> Changed active directory to /var/lib/heartbeat/cores/hacluster
> May  9 12:03:16 fedora1 cib: [3580]: info: crm_log_init_worker:
> Changed active directory to /var/lib/heartbeat/cores/hacluster
> May  9 12:03:16 fedora1 crmd: [3585]: notice: main: CRM Git Version:
> ee0730e13d124c3d58f00016c3376a1de5323cff
> May  9 12:03:16 fedora1 lrmd: [3582]: info: enabling coredumps
> May  9 12:03:16 fedora1 crmd: [3585]: info: G_main_add_SignalHandler:
> Added signal handler for signal 17
> May  9 12:03:16 fedora1 lrmd: [3582]: info: G_main_add_SignalHandler:
> Added signal handler for signal 10
> May  9 12:03:16 fedora1 cib: [3580]: info: G_main_add_TriggerHandler:
> Added signal manual handler
> May  9 12:03:16 fedora1 lrmd: [3582]: info: G_main_add_SignalHandler:
> Added signal handler for signal 12
> May  9 12:03:16 fedora1 lrmd: [3582]: info: Started.
> May  9 12:03:16 fedora1 cib: [3580]: info: G_main_add_SignalHandler:
> Added signal handler for signal 17
> May  9 12:03:16 fedora1 cib: [3580]: info: retrieveCib: Reading
> cluster configuration from: /var/lib/heartbeat/crm/cib.xml (digest:
> /var/lib/heartbeat/crm/cib.xml.sig)
> May  9 12:03:16 fedora1 cib: [3580]: info: validate_with_relaxng:
> Creating RNG parser context
> May  9 12:03:16 fedora1 stonith-ng: [3581]: info:
> init_ais_connection_once: Connection to 'corosync': established
> May  9 12:03:16 fedora1 stonith-ng: [3581]: info: crm_new_peer: Node
> fedora1 now has id: 1746182666
> May  9 12:03:16 fedora1 stonith-ng: [3581]: info: crm_new_peer: Node
> 1746182666 is now known as fedora1
> May  9 12:03:16 fedora1 attrd: [3583]: notice: main: Starting mainloop...
> May  9 12:03:16 fedora1 cib: [3580]: info: startCib: CIB
> Initialization completed successfully
> May  9 12:03:16 fedora1 cib: [3580]: info: get_cluster_type: Cluster
> type is: 'corosync'
> May  9 12:03:16 fedora1 cib: [3580]: notice: crm_cluster_connect:
> Connecting to cluster infrastructure: corosync
> May  9 12:03:16 fedora1 cib: [3580]: info: init_ais_connection_once:
> Connection to 'corosync': established
> May  9 12:03:16 fedora1 cib: [3580]: info: crm_new_peer: Node fedora1
> now has id: 1746182666
> May  9 12:03:16 fedora1 cib: [3580]: info: crm_new_peer: Node
> 1746182666 is now known as fedora1
> May  9 12:03:16 fedora1 cib: [3580]: info: cib_init: Starting cib mainloop
> May  9 12:03:17 fedora1 crmd: [3585]: info: do_cib_control: CIB
> connection established
> May  9 12:03:17 fedora1 crmd: [3585]: info: get_cluster_type: Cluster
> type is: 'corosync'
> May  9 12:03:17 fedora1 crmd: [3585]: notice: crm_cluster_connect:
> Connecting to cluster infrastructure: corosync
> May  9 12:03:17 fedora1 crmd: [3585]: info: init_ais_connection_once:
> Connection to 'corosync': established
> May  9 12:03:17 fedora1 crmd: [3585]: info: crm_new_peer: Node fedora1
> now has id: 1746182666
> May  9 12:03:17 fedora1 crmd: [3585]: info: crm_new_peer: Node
> 1746182666 is now known as fedora1
> May  9 12:03:17 fedora1 crmd: [3585]: info: ais_status_callback:
> status: fedora1 is now unknown
> May  9 12:03:17 fedora1 crmd: [3585]: ERROR: init_quorum_connection:
> The Corosync quorum API is not supported in this build
> May  9 12:03:17 fedora1 pacemakerd: [3575]: ERROR: pcmk_child_exit:
> Child process crmd exited (pid=3585, rc=100)
> May  9 12:03:17 fedora1 pacemakerd: [3575]: WARN: pcmk_child_exit:
> Pacemaker child process crmd no longer wishes to be respawned.
> Shutting ourselves down.
> May  9 12:03:17 fedora1 pacemakerd: [3575]: notice:
> pcmk_shutdown_worker: Shuting down Pacemaker
> May  9 12:03:17 fedora1 pacemakerd: [3575]: notice: stop_child:
> Stopping pengine: Sent -15 to process 3584
> May  9 12:03:17 fedora1 pacemakerd: [3575]: info: pcmk_child_exit:
> Child process pengine exited (pid=3584, rc=0)
> May  9 12:03:17 fedora1 pacemakerd: [3575]: notice: stop_child:
> Stopping attrd: Sent -15 to process 3583
> May  9 12:03:17 fedora1 attrd: [3583]: notice: main: Exiting...
> May  9 12:03:17 fedora1 pacemakerd: [3575]: info: pcmk_child_exit:
> Child process attrd exited (pid=3583, rc=0)
> May  9 12:03:17 fedora1 pacemakerd: [3575]: WARN: send_ipc_message:
> IPC Channel to 3583 is not connected
> May  9 12:03:17 fedora1 pacemakerd: [3575]: notice: stop_child:
> Stopping lrmd: Sent -15 to process 3582
> May  9 12:03:17 fedora1 lrmd: [3582]: info: lrmd is shutting down
> May  9 12:03:17 fedora1 pacemakerd: [3575]: info: pcmk_child_exit:
> Child process lrmd exited (pid=3582, rc=0)
> May  9 12:03:17 fedora1 pacemakerd: [3575]: notice: stop_child:
> Stopping stonith-ng: Sent -15 to process 3581
> May  9 12:03:17 fedora1 stonith-ng: [3581]: notice: setup_cib:
> Watching for stonith topology changes
> May  9 12:03:17 fedora1 stonith-ng: [3581]: info: main: Starting
> stonith-ng mainloop
> May  9 12:03:17 fedora1 stonith-ng: [3581]: info: crm_signal_dispatch:
> Invoking handler for signal 15: Terminated
> May  9 12:03:17 fedora1 stonith-ng: [3581]: info: stonith_shutdown:
> Terminating with  0 clients
> May  9 12:03:17 fedora1 pacemakerd: [3575]: info: pcmk_child_exit:
> Child process stonith-ng exited (pid=3581, rc=0)
> May  9 12:03:17 fedora1 pacemakerd: [3575]: WARN: send_ipc_message:
> IPC Channel to 3581 is not connected
> May  9 12:03:17 fedora1 pacemakerd: [3575]: notice: stop_child:
> Stopping cib: Sent -15 to process 3580
> May  9 12:03:17 fedora1 cib: [3580]: info: crm_signal_dispatch:
> Invoking handler for signal 15: Terminated
> May  9 12:03:17 fedora1 cib: [3580]: info: disconnect_cib_client:
> Flushed messages to/from <null>/cib_rw... send=0, recv=2
> May  9 12:03:17 fedora1 cib: [3580]: info: disconnect_cib_client:
> Flushed messages to/from <null>/cib_callback... send=0, recv=1
> May  9 12:03:17 fedora1 cib: [3580]: info: cib_shutdown: Disconnected 2 clients
> May  9 12:03:17 fedora1 cib: [3580]: WARN: send_ipc_message: IPC
> Channel to 3581 is not connected
> May  9 12:03:17 fedora1 cib: [3580]: WARN: send_via_callback_channel:
> Delivery of reply to client
> (null)/4924f6cc-1a00-456d-96d8-6ed5b0f4442d failed
> May  9 12:03:17 fedora1 cib: [3580]: WARN: do_local_notify: A-Sync
> reply to crmd failed: reply failed
> May  9 12:03:17 fedora1 cib: [3580]: info: cib_process_disconnect: All
> clients disconnected...
> May  9 12:03:17 fedora1 cib: [3580]: info: terminate_cib:
> initiate_exit: Disconnecting corosync
> May  9 12:03:17 fedora1 cib: [3580]: notice: terminate_ais_connection:
> Disconnecting from Corosync
> May  9 12:03:17 fedora1 cib: [3580]: info: terminate_cib:
> initiate_exit: Exiting...
> May  9 12:03:17 fedora1 cib: [3580]: info: crm_xml_cleanup: Cleaning
> up memory from libxml2
> May  9 12:03:17 fedora1 cib: [3580]: info: main: Done
> May  9 12:03:17 fedora1 pacemakerd: [3575]: info: pcmk_child_exit:
> Child process cib exited (pid=3580, rc=0)
> May  9 12:03:17 fedora1 pacemakerd: [3575]: notice:
> pcmk_shutdown_worker: Shutdown complete
> May  9 12:03:17 fedora1 pacemakerd: [3575]: notice:
> pcmk_shutdown_worker: Attempting to inhibit respawning after fatal
> error
> May  9 12:03:17 fedora1 systemd[1]: pacemaker.service: main process
> exited, code=exited, status=100
> May  9 12:03:17 fedora1 systemd[1]: pacemaker.service holdoff time
> over, scheduling restart.
> May  9 12:03:17 fedora1 systemd[1]: Unit pacemaker.service entered failed state.
> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: Invoked:
> /usr/sbin/pacemakerd -f
> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: crm_log_init_worker:
> Changed active directory to /var/lib/heartbeat/cores/root
> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: config_find_next: No
> additional configuration supplied for: service
> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: config_find_next: No
> additional configuration supplied for: quorum
> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: get_config_opt: No
> default for option: provider
> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: get_cluster_type:
> Detected an active 'corosync' cluster
> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: read_config: Reading
> configure for stack: corosync
> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: config_find_next:
> Processing additional logging options...
> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: get_config_opt:
> Found 'off' for option: debug
> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: get_config_opt:
> Found '/var/log/cluster/corosync.log' for option: logfile
> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: get_config_opt:
> Found 'yes' for option: to_logfile
> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: get_config_opt:
> Found 'yes' for option: to_syslog
> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: get_config_opt:
> Defaulting to 'daemon' for option: syslog_facility
> May  9 12:03:17 fedora1 pacemakerd: [3592]: notice: main: Starting
> Pacemaker 1.1.7-2.fc16 (Build:
> ee0730e13d124c3d58f00016c3376a1de5323cff):  generated-manpages
> agent-manpages ascii-docs publican-docs ncurses  corosync-plugin cman
> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: main: Maximum core
> file size is: 4294967295
> May  9 12:03:17 fedora1 pacemakerd: [3592]: notice:
> update_node_processes: 0x81b06f0 Node 1746182666 now known as fedora1,
> was:
> May  9 12:03:17 fedora1 pacemakerd: [3592]: info:
> G_main_add_SignalHandler: Added signal handler for signal 17
> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: start_child: Forked
> child 3597 for process cib
> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: start_child: Forked
> child 3598 for process stonith-ng
> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: start_child: Forked
> child 3599 for process lrmd
> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: start_child: Forked
> child 3600 for process attrd
> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: start_child: Forked
> child 3601 for process pengine
> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: start_child: Forked
> child 3602 for process crmd
> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: main: Starting mainloop
> May  9 12:03:17 fedora1 lrmd: [3599]: info: G_main_add_SignalHandler:
> Added signal handler for signal 15
> May  9 12:03:17 fedora1 attrd: [3600]: info: Invoked:
> /usr/libexec/pacemaker/attrd
> May  9 12:03:17 fedora1 stonith-ng: [3598]: info: Invoked:
> /usr/libexec/pacemaker/stonithd
> May  9 12:03:17 fedora1 stonith-ng: [3598]: info: crm_log_init_worker:
> Changed active directory to /var/lib/heartbeat/cores/root
> May  9 12:03:17 fedora1 stonith-ng: [3598]: info:
> G_main_add_SignalHandler: Added signal handler for signal 17
> May  9 12:03:17 fedora1 stonith-ng: [3598]: info: get_cluster_type:
> Cluster type is: 'corosync'
> May  9 12:03:17 fedora1 stonith-ng: [3598]: notice:
> crm_cluster_connect: Connecting to cluster infrastructure: corosync
> May  9 12:03:17 fedora1 lrmd: [3599]: info: G_main_add_SignalHandler:
> Added signal handler for signal 17
> May  9 12:03:17 fedora1 attrd: [3600]: notice: crm_cluster_connect:
> Connecting to cluster infrastructure: corosync
> May  9 12:03:17 fedora1 crmd: [3602]: info: Invoked:
> /usr/libexec/pacemaker/crmd
> May  9 12:03:17 fedora1 pengine: [3601]: info: Invoked:
> /usr/libexec/pacemaker/pengine
> May  9 12:03:17 fedora1 cib: [3597]: info: crm_log_init_worker:
> Changed active directory to /var/lib/heartbeat/cores/hacluster
> May  9 12:03:17 fedora1 lrmd: [3599]: info: enabling coredumps
> May  9 12:03:17 fedora1 lrmd: [3599]: info: G_main_add_SignalHandler:
> Added signal handler for signal 10
> May  9 12:03:17 fedora1 cib: [3597]: info: G_main_add_TriggerHandler:
> Added signal manual handler
> May  9 12:03:17 fedora1 cib: [3597]: info: G_main_add_SignalHandler:
> Added signal handler for signal 17
> May  9 12:03:17 fedora1 lrmd: [3599]: info: G_main_add_SignalHandler:
> Added signal handler for signal 12
> May  9 12:03:17 fedora1 cib: [3597]: info: retrieveCib: Reading
> cluster configuration from: /var/lib/heartbeat/crm/cib.xml (digest:
> /var/lib/heartbeat/crm/cib.xml.sig)
> May  9 12:03:17 fedora1 lrmd: [3599]: info: Started.
> May  9 12:03:17 fedora1 crmd: [3602]: info: crm_log_init_worker:
> Changed active directory to /var/lib/heartbeat/cores/hacluster
> May  9 12:03:17 fedora1 cib: [3597]: info: validate_with_relaxng:
> Creating RNG parser context
> May  9 12:03:17 fedora1 crmd: [3602]: notice: main: CRM Git Version:
> ee0730e13d124c3d58f00016c3376a1de5323cff
> May  9 12:03:17 fedora1 crmd: [3602]: info: G_main_add_SignalHandler:
> Added signal handler for signal 17
> May  9 12:03:17 fedora1 stonith-ng: [3598]: info:
> init_ais_connection_once: Connection to 'corosync': established
> May  9 12:03:17 fedora1 stonith-ng: [3598]: info: crm_new_peer: Node
> fedora1 now has id: 1746182666
> May  9 12:03:17 fedora1 stonith-ng: [3598]: info: crm_new_peer: Node
> 1746182666 is now known as fedora1
> May  9 12:03:17 fedora1 attrd: [3600]: notice: main: Starting mainloop...
> May  9 12:03:17 fedora1 cib: [3597]: info: startCib: CIB
> Initialization completed successfully
> May  9 12:03:17 fedora1 cib: [3597]: info: get_cluster_type: Cluster
> type is: 'corosync'
> May  9 12:03:17 fedora1 cib: [3597]: notice: crm_cluster_connect:
> Connecting to cluster infrastructure: corosync
> May  9 12:03:17 fedora1 cib: [3597]: info: init_ais_connection_once:
> Connection to 'corosync': established
> May  9 12:03:17 fedora1 cib: [3597]: info: crm_new_peer: Node fedora1
> now has id: 1746182666
> May  9 12:03:17 fedora1 cib: [3597]: info: crm_new_peer: Node
> 1746182666 is now known as fedora1
> May  9 12:03:17 fedora1 cib: [3597]: info: cib_init: Starting cib mainloop
> May  9 12:03:18 fedora1 crmd: [3602]: info: do_cib_control: CIB
> connection established
> May  9 12:03:18 fedora1 crmd: [3602]: info: get_cluster_type: Cluster
> type is: 'corosync'
> May  9 12:03:18 fedora1 crmd: [3602]: notice: crm_cluster_connect:
> Connecting to cluster infrastructure: corosync
> May  9 12:03:18 fedora1 stonith-ng: [3598]: notice: setup_cib:
> Watching for stonith topology changes
> May  9 12:03:18 fedora1 stonith-ng: [3598]: info: main: Starting
> stonith-ng mainloop
> May  9 12:03:18 fedora1 crmd: [3602]: info: init_ais_connection_once:
> Connection to 'corosync': established
> May  9 12:03:18 fedora1 crmd: [3602]: info: crm_new_peer: Node fedora1
> now has id: 1746182666
> May  9 12:03:18 fedora1 crmd: [3602]: info: crm_new_peer: Node
> 1746182666 is now known as fedora1
> May  9 12:03:18 fedora1 crmd: [3602]: info: ais_status_callback:
> status: fedora1 is now unknown
> May  9 12:03:18 fedora1 crmd: [3602]: ERROR: init_quorum_connection:
> The Corosync quorum API is not supported in this build
> May  9 12:03:18 fedora1 pacemakerd: [3592]: ERROR: pcmk_child_exit:
> Child process crmd exited (pid=3602, rc=100)
> May  9 12:03:18 fedora1 pacemakerd: [3592]: WARN: pcmk_child_exit:
> Pacemaker child process crmd no longer wishes to be respawned.
> Shutting ourselves down.
> May  9 12:03:18 fedora1 pacemakerd: [3592]: notice:
> pcmk_shutdown_worker: Shuting down Pacemaker
> May  9 12:03:18 fedora1 pacemakerd: [3592]: notice: stop_child:
> Stopping pengine: Sent -15 to process 3601
> May  9 12:03:18 fedora1 pacemakerd: [3592]: info: pcmk_child_exit:
> Child process pengine exited (pid=3601, rc=0)
> May  9 12:03:18 fedora1 attrd: [3600]: notice: main: Exiting...
> May  9 12:03:18 fedora1 pacemakerd: [3592]: notice: stop_child:
> Stopping attrd: Sent -15 to process 3600
> May  9 12:03:18 fedora1 pacemakerd: [3592]: info: pcmk_child_exit:
> Child process attrd exited (pid=3600, rc=0)
> May  9 12:03:18 fedora1 pacemakerd: [3592]: WARN: send_ipc_message:
> IPC Channel to 3600 is not connected
> May  9 12:03:18 fedora1 lrmd: [3599]: info: lrmd is shutting down
> May  9 12:03:18 fedora1 pacemakerd: [3592]: notice: stop_child:
> Stopping lrmd: Sent -15 to process 3599
> May  9 12:03:18 fedora1 pacemakerd: [3592]: info: pcmk_child_exit:
> Child process lrmd exited (pid=3599, rc=0)
> May  9 12:03:18 fedora1 pacemakerd: [3592]: notice: stop_child:
> Stopping stonith-ng: Sent -15 to process 3598
> May  9 12:03:18 fedora1 stonith-ng: [3598]: info: crm_signal_dispatch:
> Invoking handler for signal 15: Terminated
> May  9 12:03:18 fedora1 stonith-ng: [3598]: info: stonith_shutdown:
> Terminating with  0 clients
> May  9 12:03:18 fedora1 pacemakerd: [3592]: info: pcmk_child_exit:
> Child process stonith-ng exited (pid=3598, rc=0)
> May  9 12:03:18 fedora1 pacemakerd: [3592]: WARN: send_ipc_message:
> IPC Channel to 3598 is not connected
> May  9 12:03:18 fedora1 pacemakerd: [3592]: notice: stop_child:
> Stopping cib: Sent -15 to process 3597
> May  9 12:03:18 fedora1 cib: [3597]: info: crm_signal_dispatch:
> Invoking handler for signal 15: Terminated
> May  9 12:03:18 fedora1 cib: [3597]: info: cib_shutdown: Disconnected 2 clients
> May  9 12:03:18 fedora1 cib: [3597]: info: cib_process_disconnect: All
> clients disconnected...
> May  9 12:03:18 fedora1 cib: [3597]: info: terminate_cib:
> initiate_exit: Disconnecting corosync
> May  9 12:03:18 fedora1 cib: [3597]: notice: terminate_ais_connection:
> Disconnecting from Corosync
> May  9 12:03:18 fedora1 cib: [3597]: info: terminate_cib:
> initiate_exit: Exiting...
> May  9 12:03:18 fedora1 cib: [3597]: info: crm_xml_cleanup: Cleaning
> up memory from libxml2
> May  9 12:03:18 fedora1 cib: [3597]: info: main: Done
> May  9 12:03:18 fedora1 pacemakerd: [3592]: info: pcmk_child_exit:
> Child process cib exited (pid=3597, rc=0)
> May  9 12:03:18 fedora1 pacemakerd: [3592]: notice:
> pcmk_shutdown_worker: Shutdown complete
> May  9 12:03:18 fedora1 pacemakerd: [3592]: notice:
> pcmk_shutdown_worker: Attempting to inhibit respawning after fatal
> error
> May  9 12:03:18 fedora1 systemd[1]: pacemaker.service: main process
> exited, code=exited, status=100
> May  9 12:03:18 fedora1 systemd[1]: pacemaker.service holdoff time
> over, scheduling restart.
> May  9 12:03:18 fedora1 systemd[1]: Unit pacemaker.service entered failed state.
> May  9 12:03:18 fedora1 systemd[1]: pacemaker.service start request
> repeated too quickly, refusing to start.
>
> _______________________________________________
> Pacemaker mailing list: Pacemaker [at] oss
> http://oss.clusterlabs.org/mailman/listinfo/pacemaker
>
> Project Home: http://www.clusterlabs.org
> Getting started: http://www.clusterlabs.org/doc/Cluster_from_Scratch.pdf
> Bugs: http://bugs.clusterlabs.org

_______________________________________________
Pacemaker mailing list: Pacemaker [at] oss
http://oss.clusterlabs.org/mailman/listinfo/pacemaker

Project Home: http://www.clusterlabs.org
Getting started: http://www.clusterlabs.org/doc/Cluster_from_Scratch.pdf
Bugs: http://bugs.clusterlabs.org


kafecho at gmail

May 10, 2012, 1:58 AM

Post #3 of 3 (690 views)
Permalink
Re: Unable to start pacemaker on Fedora16 [In reply to]

Hi Andrew,

Thanks for the reply. I eventually solved the issue, only due to me
not reading the guide properly ( as I said, newbbie user).

I had forgotten to configure the pcmk file under
/etc/corosync.conf/service.d and I was not running as root but using
sudo.

I eventually got it working on Fedora16 and also on Centos 6.2.

I am now progressing step by step with the tutorial document which is
very well written.

Thanks.

Guillaume.


On 10 May 2012 05:06, Andrew Beekhof <andrew [at] beekhof> wrote:
> What is the corosync version?
> I'm assuming 1.4.x
>
> Did you create the services section as directed in:
>
>   http://clusterlabs.org/doc/en-US/Pacemaker/1.1/html/Clusters_from_Scratch/_configuring_corosync.html
>
> after  "Finally, tell Corosync to load the Pacemaker plugin."?
>
> On Wed, May 9, 2012 at 9:26 PM, Guillaume Belrose <kafecho [at] gmail> wrote:
>> Hi all,
>>
>> I am new to Pacemaker/Corosync, so this is a newbbie question.
>>
>> I am trying pacemaker on fedora16, going through the guide reading
>> Pacemaker 1.1 Clusters from scratch.
>>
>> I have two fedora16 instances running inside virtual machines running
>> on VirtualBox on Windows7.
>>
>> I've installed and configured Corosync to use a multicast address.
>> Corosync seems to correctly that both of my vms are up. However, when
>> I start pacemaker using /etc/init.d/pacemaker start I eventually get
>> an error and it terminates.
>>
>> I've tried to setup Corosync in unicast as well as multicast mode, but
>> that does not seem to make a difference.
>>
>> See the relevant portion in the /var/log/messages at the end of this email.
>>
>> There is a line that says: "The Corosync quorum API is not supported
>> in this build". I am not quite sure what this means.
>>
>> I am hoping someone can help me pinpoint the problem. I am not tied to
>> using Fedora16. I could try a different version, or a different
>> distribution all together.
>>
>> All help would be greatly appreciated.
>>
>> Cheers,
>>
>> Guillaume.
>>
>>
>>
>>
>> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: Invoked:
>> /usr/sbin/pacemakerd -f
>> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: crm_log_init_worker:
>> Changed active directory to /var/lib/heartbeat/cores/root
>> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: config_find_next: No
>> additional configuration supplied for: service
>> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: config_find_next: No
>> additional configuration supplied for: quorum
>> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: get_config_opt: No
>> default for option: provider
>> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: get_cluster_type:
>> Detected an active 'corosync' cluster
>> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: read_config: Reading
>> configure for stack: corosync
>> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: config_find_next:
>> Processing additional logging options...
>> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: get_config_opt:
>> Found 'off' for option: debug
>> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: get_config_opt:
>> Found '/var/log/cluster/corosync.log' for option: logfile
>> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: get_config_opt:
>> Found 'yes' for option: to_logfile
>> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: get_config_opt:
>> Found 'yes' for option: to_syslog
>> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: get_config_opt:
>> Defaulting to 'daemon' for option: syslog_facility
>> May  9 12:03:15 fedora1 pacemakerd: [3575]: notice: main: Starting
>> Pacemaker 1.1.7-2.fc16 (Build:
>> ee0730e13d124c3d58f00016c3376a1de5323cff):  generated-manpages
>> agent-manpages ascii-docs publican-docs ncurses  corosync-plugin cman
>> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: main: Maximum core
>> file size is: 4294967295
>> May  9 12:03:15 fedora1 pacemakerd: [3575]: notice:
>> update_node_processes: 0x9db66f0 Node 1746182666 now known as fedora1,
>> was:
>> May  9 12:03:15 fedora1 pacemakerd: [3575]: info:
>> G_main_add_SignalHandler: Added signal handler for signal 17
>> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: start_child: Forked
>> child 3580 for process cib
>> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: start_child: Forked
>> child 3581 for process stonith-ng
>> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: start_child: Forked
>> child 3582 for process lrmd
>> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: start_child: Forked
>> child 3583 for process attrd
>> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: start_child: Forked
>> child 3584 for process pengine
>> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: start_child: Forked
>> child 3585 for process crmd
>> May  9 12:03:15 fedora1 pacemakerd: [3575]: info: main: Starting mainloop
>> May  9 12:03:15 fedora1 stonith-ng: [3581]: info: Invoked:
>> /usr/libexec/pacemaker/stonithd
>> May  9 12:03:15 fedora1 lrmd: [3582]: info: G_main_add_SignalHandler:
>> Added signal handler for signal 15
>> May  9 12:03:15 fedora1 lrmd: [3582]: info: G_main_add_SignalHandler:
>> Added signal handler for signal 17
>> May  9 12:03:16 fedora1 attrd: [3583]: info: Invoked:
>> /usr/libexec/pacemaker/attrd
>> May  9 12:03:16 fedora1 pengine: [3584]: info: Invoked:
>> /usr/libexec/pacemaker/pengine
>> May  9 12:03:16 fedora1 stonith-ng: [3581]: info: crm_log_init_worker:
>> Changed active directory to /var/lib/heartbeat/cores/root
>> May  9 12:03:16 fedora1 stonith-ng: [3581]: info:
>> G_main_add_SignalHandler: Added signal handler for signal 17
>> May  9 12:03:16 fedora1 stonith-ng: [3581]: info: get_cluster_type:
>> Cluster type is: 'corosync'
>> May  9 12:03:16 fedora1 stonith-ng: [3581]: notice:
>> crm_cluster_connect: Connecting to cluster infrastructure: corosync
>> May  9 12:03:16 fedora1 crmd: [3585]: info: Invoked:
>> /usr/libexec/pacemaker/crmd
>> May  9 12:03:16 fedora1 attrd: [3583]: notice: crm_cluster_connect:
>> Connecting to cluster infrastructure: corosync
>> May  9 12:03:16 fedora1 crmd: [3585]: info: crm_log_init_worker:
>> Changed active directory to /var/lib/heartbeat/cores/hacluster
>> May  9 12:03:16 fedora1 cib: [3580]: info: crm_log_init_worker:
>> Changed active directory to /var/lib/heartbeat/cores/hacluster
>> May  9 12:03:16 fedora1 crmd: [3585]: notice: main: CRM Git Version:
>> ee0730e13d124c3d58f00016c3376a1de5323cff
>> May  9 12:03:16 fedora1 lrmd: [3582]: info: enabling coredumps
>> May  9 12:03:16 fedora1 crmd: [3585]: info: G_main_add_SignalHandler:
>> Added signal handler for signal 17
>> May  9 12:03:16 fedora1 lrmd: [3582]: info: G_main_add_SignalHandler:
>> Added signal handler for signal 10
>> May  9 12:03:16 fedora1 cib: [3580]: info: G_main_add_TriggerHandler:
>> Added signal manual handler
>> May  9 12:03:16 fedora1 lrmd: [3582]: info: G_main_add_SignalHandler:
>> Added signal handler for signal 12
>> May  9 12:03:16 fedora1 lrmd: [3582]: info: Started.
>> May  9 12:03:16 fedora1 cib: [3580]: info: G_main_add_SignalHandler:
>> Added signal handler for signal 17
>> May  9 12:03:16 fedora1 cib: [3580]: info: retrieveCib: Reading
>> cluster configuration from: /var/lib/heartbeat/crm/cib.xml (digest:
>> /var/lib/heartbeat/crm/cib.xml.sig)
>> May  9 12:03:16 fedora1 cib: [3580]: info: validate_with_relaxng:
>> Creating RNG parser context
>> May  9 12:03:16 fedora1 stonith-ng: [3581]: info:
>> init_ais_connection_once: Connection to 'corosync': established
>> May  9 12:03:16 fedora1 stonith-ng: [3581]: info: crm_new_peer: Node
>> fedora1 now has id: 1746182666
>> May  9 12:03:16 fedora1 stonith-ng: [3581]: info: crm_new_peer: Node
>> 1746182666 is now known as fedora1
>> May  9 12:03:16 fedora1 attrd: [3583]: notice: main: Starting mainloop...
>> May  9 12:03:16 fedora1 cib: [3580]: info: startCib: CIB
>> Initialization completed successfully
>> May  9 12:03:16 fedora1 cib: [3580]: info: get_cluster_type: Cluster
>> type is: 'corosync'
>> May  9 12:03:16 fedora1 cib: [3580]: notice: crm_cluster_connect:
>> Connecting to cluster infrastructure: corosync
>> May  9 12:03:16 fedora1 cib: [3580]: info: init_ais_connection_once:
>> Connection to 'corosync': established
>> May  9 12:03:16 fedora1 cib: [3580]: info: crm_new_peer: Node fedora1
>> now has id: 1746182666
>> May  9 12:03:16 fedora1 cib: [3580]: info: crm_new_peer: Node
>> 1746182666 is now known as fedora1
>> May  9 12:03:16 fedora1 cib: [3580]: info: cib_init: Starting cib mainloop
>> May  9 12:03:17 fedora1 crmd: [3585]: info: do_cib_control: CIB
>> connection established
>> May  9 12:03:17 fedora1 crmd: [3585]: info: get_cluster_type: Cluster
>> type is: 'corosync'
>> May  9 12:03:17 fedora1 crmd: [3585]: notice: crm_cluster_connect:
>> Connecting to cluster infrastructure: corosync
>> May  9 12:03:17 fedora1 crmd: [3585]: info: init_ais_connection_once:
>> Connection to 'corosync': established
>> May  9 12:03:17 fedora1 crmd: [3585]: info: crm_new_peer: Node fedora1
>> now has id: 1746182666
>> May  9 12:03:17 fedora1 crmd: [3585]: info: crm_new_peer: Node
>> 1746182666 is now known as fedora1
>> May  9 12:03:17 fedora1 crmd: [3585]: info: ais_status_callback:
>> status: fedora1 is now unknown
>> May  9 12:03:17 fedora1 crmd: [3585]: ERROR: init_quorum_connection:
>> The Corosync quorum API is not supported in this build
>> May  9 12:03:17 fedora1 pacemakerd: [3575]: ERROR: pcmk_child_exit:
>> Child process crmd exited (pid=3585, rc=100)
>> May  9 12:03:17 fedora1 pacemakerd: [3575]: WARN: pcmk_child_exit:
>> Pacemaker child process crmd no longer wishes to be respawned.
>> Shutting ourselves down.
>> May  9 12:03:17 fedora1 pacemakerd: [3575]: notice:
>> pcmk_shutdown_worker: Shuting down Pacemaker
>> May  9 12:03:17 fedora1 pacemakerd: [3575]: notice: stop_child:
>> Stopping pengine: Sent -15 to process 3584
>> May  9 12:03:17 fedora1 pacemakerd: [3575]: info: pcmk_child_exit:
>> Child process pengine exited (pid=3584, rc=0)
>> May  9 12:03:17 fedora1 pacemakerd: [3575]: notice: stop_child:
>> Stopping attrd: Sent -15 to process 3583
>> May  9 12:03:17 fedora1 attrd: [3583]: notice: main: Exiting...
>> May  9 12:03:17 fedora1 pacemakerd: [3575]: info: pcmk_child_exit:
>> Child process attrd exited (pid=3583, rc=0)
>> May  9 12:03:17 fedora1 pacemakerd: [3575]: WARN: send_ipc_message:
>> IPC Channel to 3583 is not connected
>> May  9 12:03:17 fedora1 pacemakerd: [3575]: notice: stop_child:
>> Stopping lrmd: Sent -15 to process 3582
>> May  9 12:03:17 fedora1 lrmd: [3582]: info: lrmd is shutting down
>> May  9 12:03:17 fedora1 pacemakerd: [3575]: info: pcmk_child_exit:
>> Child process lrmd exited (pid=3582, rc=0)
>> May  9 12:03:17 fedora1 pacemakerd: [3575]: notice: stop_child:
>> Stopping stonith-ng: Sent -15 to process 3581
>> May  9 12:03:17 fedora1 stonith-ng: [3581]: notice: setup_cib:
>> Watching for stonith topology changes
>> May  9 12:03:17 fedora1 stonith-ng: [3581]: info: main: Starting
>> stonith-ng mainloop
>> May  9 12:03:17 fedora1 stonith-ng: [3581]: info: crm_signal_dispatch:
>> Invoking handler for signal 15: Terminated
>> May  9 12:03:17 fedora1 stonith-ng: [3581]: info: stonith_shutdown:
>> Terminating with  0 clients
>> May  9 12:03:17 fedora1 pacemakerd: [3575]: info: pcmk_child_exit:
>> Child process stonith-ng exited (pid=3581, rc=0)
>> May  9 12:03:17 fedora1 pacemakerd: [3575]: WARN: send_ipc_message:
>> IPC Channel to 3581 is not connected
>> May  9 12:03:17 fedora1 pacemakerd: [3575]: notice: stop_child:
>> Stopping cib: Sent -15 to process 3580
>> May  9 12:03:17 fedora1 cib: [3580]: info: crm_signal_dispatch:
>> Invoking handler for signal 15: Terminated
>> May  9 12:03:17 fedora1 cib: [3580]: info: disconnect_cib_client:
>> Flushed messages to/from <null>/cib_rw... send=0, recv=2
>> May  9 12:03:17 fedora1 cib: [3580]: info: disconnect_cib_client:
>> Flushed messages to/from <null>/cib_callback... send=0, recv=1
>> May  9 12:03:17 fedora1 cib: [3580]: info: cib_shutdown: Disconnected 2 clients
>> May  9 12:03:17 fedora1 cib: [3580]: WARN: send_ipc_message: IPC
>> Channel to 3581 is not connected
>> May  9 12:03:17 fedora1 cib: [3580]: WARN: send_via_callback_channel:
>> Delivery of reply to client
>> (null)/4924f6cc-1a00-456d-96d8-6ed5b0f4442d failed
>> May  9 12:03:17 fedora1 cib: [3580]: WARN: do_local_notify: A-Sync
>> reply to crmd failed: reply failed
>> May  9 12:03:17 fedora1 cib: [3580]: info: cib_process_disconnect: All
>> clients disconnected...
>> May  9 12:03:17 fedora1 cib: [3580]: info: terminate_cib:
>> initiate_exit: Disconnecting corosync
>> May  9 12:03:17 fedora1 cib: [3580]: notice: terminate_ais_connection:
>> Disconnecting from Corosync
>> May  9 12:03:17 fedora1 cib: [3580]: info: terminate_cib:
>> initiate_exit: Exiting...
>> May  9 12:03:17 fedora1 cib: [3580]: info: crm_xml_cleanup: Cleaning
>> up memory from libxml2
>> May  9 12:03:17 fedora1 cib: [3580]: info: main: Done
>> May  9 12:03:17 fedora1 pacemakerd: [3575]: info: pcmk_child_exit:
>> Child process cib exited (pid=3580, rc=0)
>> May  9 12:03:17 fedora1 pacemakerd: [3575]: notice:
>> pcmk_shutdown_worker: Shutdown complete
>> May  9 12:03:17 fedora1 pacemakerd: [3575]: notice:
>> pcmk_shutdown_worker: Attempting to inhibit respawning after fatal
>> error
>> May  9 12:03:17 fedora1 systemd[1]: pacemaker.service: main process
>> exited, code=exited, status=100
>> May  9 12:03:17 fedora1 systemd[1]: pacemaker.service holdoff time
>> over, scheduling restart.
>> May  9 12:03:17 fedora1 systemd[1]: Unit pacemaker.service entered failed state.
>> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: Invoked:
>> /usr/sbin/pacemakerd -f
>> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: crm_log_init_worker:
>> Changed active directory to /var/lib/heartbeat/cores/root
>> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: config_find_next: No
>> additional configuration supplied for: service
>> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: config_find_next: No
>> additional configuration supplied for: quorum
>> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: get_config_opt: No
>> default for option: provider
>> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: get_cluster_type:
>> Detected an active 'corosync' cluster
>> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: read_config: Reading
>> configure for stack: corosync
>> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: config_find_next:
>> Processing additional logging options...
>> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: get_config_opt:
>> Found 'off' for option: debug
>> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: get_config_opt:
>> Found '/var/log/cluster/corosync.log' for option: logfile
>> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: get_config_opt:
>> Found 'yes' for option: to_logfile
>> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: get_config_opt:
>> Found 'yes' for option: to_syslog
>> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: get_config_opt:
>> Defaulting to 'daemon' for option: syslog_facility
>> May  9 12:03:17 fedora1 pacemakerd: [3592]: notice: main: Starting
>> Pacemaker 1.1.7-2.fc16 (Build:
>> ee0730e13d124c3d58f00016c3376a1de5323cff):  generated-manpages
>> agent-manpages ascii-docs publican-docs ncurses  corosync-plugin cman
>> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: main: Maximum core
>> file size is: 4294967295
>> May  9 12:03:17 fedora1 pacemakerd: [3592]: notice:
>> update_node_processes: 0x81b06f0 Node 1746182666 now known as fedora1,
>> was:
>> May  9 12:03:17 fedora1 pacemakerd: [3592]: info:
>> G_main_add_SignalHandler: Added signal handler for signal 17
>> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: start_child: Forked
>> child 3597 for process cib
>> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: start_child: Forked
>> child 3598 for process stonith-ng
>> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: start_child: Forked
>> child 3599 for process lrmd
>> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: start_child: Forked
>> child 3600 for process attrd
>> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: start_child: Forked
>> child 3601 for process pengine
>> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: start_child: Forked
>> child 3602 for process crmd
>> May  9 12:03:17 fedora1 pacemakerd: [3592]: info: main: Starting mainloop
>> May  9 12:03:17 fedora1 lrmd: [3599]: info: G_main_add_SignalHandler:
>> Added signal handler for signal 15
>> May  9 12:03:17 fedora1 attrd: [3600]: info: Invoked:
>> /usr/libexec/pacemaker/attrd
>> May  9 12:03:17 fedora1 stonith-ng: [3598]: info: Invoked:
>> /usr/libexec/pacemaker/stonithd
>> May  9 12:03:17 fedora1 stonith-ng: [3598]: info: crm_log_init_worker:
>> Changed active directory to /var/lib/heartbeat/cores/root
>> May  9 12:03:17 fedora1 stonith-ng: [3598]: info:
>> G_main_add_SignalHandler: Added signal handler for signal 17
>> May  9 12:03:17 fedora1 stonith-ng: [3598]: info: get_cluster_type:
>> Cluster type is: 'corosync'
>> May  9 12:03:17 fedora1 stonith-ng: [3598]: notice:
>> crm_cluster_connect: Connecting to cluster infrastructure: corosync
>> May  9 12:03:17 fedora1 lrmd: [3599]: info: G_main_add_SignalHandler:
>> Added signal handler for signal 17
>> May  9 12:03:17 fedora1 attrd: [3600]: notice: crm_cluster_connect:
>> Connecting to cluster infrastructure: corosync
>> May  9 12:03:17 fedora1 crmd: [3602]: info: Invoked:
>> /usr/libexec/pacemaker/crmd
>> May  9 12:03:17 fedora1 pengine: [3601]: info: Invoked:
>> /usr/libexec/pacemaker/pengine
>> May  9 12:03:17 fedora1 cib: [3597]: info: crm_log_init_worker:
>> Changed active directory to /var/lib/heartbeat/cores/hacluster
>> May  9 12:03:17 fedora1 lrmd: [3599]: info: enabling coredumps
>> May  9 12:03:17 fedora1 lrmd: [3599]: info: G_main_add_SignalHandler:
>> Added signal handler for signal 10
>> May  9 12:03:17 fedora1 cib: [3597]: info: G_main_add_TriggerHandler:
>> Added signal manual handler
>> May  9 12:03:17 fedora1 cib: [3597]: info: G_main_add_SignalHandler:
>> Added signal handler for signal 17
>> May  9 12:03:17 fedora1 lrmd: [3599]: info: G_main_add_SignalHandler:
>> Added signal handler for signal 12
>> May  9 12:03:17 fedora1 cib: [3597]: info: retrieveCib: Reading
>> cluster configuration from: /var/lib/heartbeat/crm/cib.xml (digest:
>> /var/lib/heartbeat/crm/cib.xml.sig)
>> May  9 12:03:17 fedora1 lrmd: [3599]: info: Started.
>> May  9 12:03:17 fedora1 crmd: [3602]: info: crm_log_init_worker:
>> Changed active directory to /var/lib/heartbeat/cores/hacluster
>> May  9 12:03:17 fedora1 cib: [3597]: info: validate_with_relaxng:
>> Creating RNG parser context
>> May  9 12:03:17 fedora1 crmd: [3602]: notice: main: CRM Git Version:
>> ee0730e13d124c3d58f00016c3376a1de5323cff
>> May  9 12:03:17 fedora1 crmd: [3602]: info: G_main_add_SignalHandler:
>> Added signal handler for signal 17
>> May  9 12:03:17 fedora1 stonith-ng: [3598]: info:
>> init_ais_connection_once: Connection to 'corosync': established
>> May  9 12:03:17 fedora1 stonith-ng: [3598]: info: crm_new_peer: Node
>> fedora1 now has id: 1746182666
>> May  9 12:03:17 fedora1 stonith-ng: [3598]: info: crm_new_peer: Node
>> 1746182666 is now known as fedora1
>> May  9 12:03:17 fedora1 attrd: [3600]: notice: main: Starting mainloop...
>> May  9 12:03:17 fedora1 cib: [3597]: info: startCib: CIB
>> Initialization completed successfully
>> May  9 12:03:17 fedora1 cib: [3597]: info: get_cluster_type: Cluster
>> type is: 'corosync'
>> May  9 12:03:17 fedora1 cib: [3597]: notice: crm_cluster_connect:
>> Connecting to cluster infrastructure: corosync
>> May  9 12:03:17 fedora1 cib: [3597]: info: init_ais_connection_once:
>> Connection to 'corosync': established
>> May  9 12:03:17 fedora1 cib: [3597]: info: crm_new_peer: Node fedora1
>> now has id: 1746182666
>> May  9 12:03:17 fedora1 cib: [3597]: info: crm_new_peer: Node
>> 1746182666 is now known as fedora1
>> May  9 12:03:17 fedora1 cib: [3597]: info: cib_init: Starting cib mainloop
>> May  9 12:03:18 fedora1 crmd: [3602]: info: do_cib_control: CIB
>> connection established
>> May  9 12:03:18 fedora1 crmd: [3602]: info: get_cluster_type: Cluster
>> type is: 'corosync'
>> May  9 12:03:18 fedora1 crmd: [3602]: notice: crm_cluster_connect:
>> Connecting to cluster infrastructure: corosync
>> May  9 12:03:18 fedora1 stonith-ng: [3598]: notice: setup_cib:
>> Watching for stonith topology changes
>> May  9 12:03:18 fedora1 stonith-ng: [3598]: info: main: Starting
>> stonith-ng mainloop
>> May  9 12:03:18 fedora1 crmd: [3602]: info: init_ais_connection_once:
>> Connection to 'corosync': established
>> May  9 12:03:18 fedora1 crmd: [3602]: info: crm_new_peer: Node fedora1
>> now has id: 1746182666
>> May  9 12:03:18 fedora1 crmd: [3602]: info: crm_new_peer: Node
>> 1746182666 is now known as fedora1
>> May  9 12:03:18 fedora1 crmd: [3602]: info: ais_status_callback:
>> status: fedora1 is now unknown
>> May  9 12:03:18 fedora1 crmd: [3602]: ERROR: init_quorum_connection:
>> The Corosync quorum API is not supported in this build
>> May  9 12:03:18 fedora1 pacemakerd: [3592]: ERROR: pcmk_child_exit:
>> Child process crmd exited (pid=3602, rc=100)
>> May  9 12:03:18 fedora1 pacemakerd: [3592]: WARN: pcmk_child_exit:
>> Pacemaker child process crmd no longer wishes to be respawned.
>> Shutting ourselves down.
>> May  9 12:03:18 fedora1 pacemakerd: [3592]: notice:
>> pcmk_shutdown_worker: Shuting down Pacemaker
>> May  9 12:03:18 fedora1 pacemakerd: [3592]: notice: stop_child:
>> Stopping pengine: Sent -15 to process 3601
>> May  9 12:03:18 fedora1 pacemakerd: [3592]: info: pcmk_child_exit:
>> Child process pengine exited (pid=3601, rc=0)
>> May  9 12:03:18 fedora1 attrd: [3600]: notice: main: Exiting...
>> May  9 12:03:18 fedora1 pacemakerd: [3592]: notice: stop_child:
>> Stopping attrd: Sent -15 to process 3600
>> May  9 12:03:18 fedora1 pacemakerd: [3592]: info: pcmk_child_exit:
>> Child process attrd exited (pid=3600, rc=0)
>> May  9 12:03:18 fedora1 pacemakerd: [3592]: WARN: send_ipc_message:
>> IPC Channel to 3600 is not connected
>> May  9 12:03:18 fedora1 lrmd: [3599]: info: lrmd is shutting down
>> May  9 12:03:18 fedora1 pacemakerd: [3592]: notice: stop_child:
>> Stopping lrmd: Sent -15 to process 3599
>> May  9 12:03:18 fedora1 pacemakerd: [3592]: info: pcmk_child_exit:
>> Child process lrmd exited (pid=3599, rc=0)
>> May  9 12:03:18 fedora1 pacemakerd: [3592]: notice: stop_child:
>> Stopping stonith-ng: Sent -15 to process 3598
>> May  9 12:03:18 fedora1 stonith-ng: [3598]: info: crm_signal_dispatch:
>> Invoking handler for signal 15: Terminated
>> May  9 12:03:18 fedora1 stonith-ng: [3598]: info: stonith_shutdown:
>> Terminating with  0 clients
>> May  9 12:03:18 fedora1 pacemakerd: [3592]: info: pcmk_child_exit:
>> Child process stonith-ng exited (pid=3598, rc=0)
>> May  9 12:03:18 fedora1 pacemakerd: [3592]: WARN: send_ipc_message:
>> IPC Channel to 3598 is not connected
>> May  9 12:03:18 fedora1 pacemakerd: [3592]: notice: stop_child:
>> Stopping cib: Sent -15 to process 3597
>> May  9 12:03:18 fedora1 cib: [3597]: info: crm_signal_dispatch:
>> Invoking handler for signal 15: Terminated
>> May  9 12:03:18 fedora1 cib: [3597]: info: cib_shutdown: Disconnected 2 clients
>> May  9 12:03:18 fedora1 cib: [3597]: info: cib_process_disconnect: All
>> clients disconnected...
>> May  9 12:03:18 fedora1 cib: [3597]: info: terminate_cib:
>> initiate_exit: Disconnecting corosync
>> May  9 12:03:18 fedora1 cib: [3597]: notice: terminate_ais_connection:
>> Disconnecting from Corosync
>> May  9 12:03:18 fedora1 cib: [3597]: info: terminate_cib:
>> initiate_exit: Exiting...
>> May  9 12:03:18 fedora1 cib: [3597]: info: crm_xml_cleanup: Cleaning
>> up memory from libxml2
>> May  9 12:03:18 fedora1 cib: [3597]: info: main: Done
>> May  9 12:03:18 fedora1 pacemakerd: [3592]: info: pcmk_child_exit:
>> Child process cib exited (pid=3597, rc=0)
>> May  9 12:03:18 fedora1 pacemakerd: [3592]: notice:
>> pcmk_shutdown_worker: Shutdown complete
>> May  9 12:03:18 fedora1 pacemakerd: [3592]: notice:
>> pcmk_shutdown_worker: Attempting to inhibit respawning after fatal
>> error
>> May  9 12:03:18 fedora1 systemd[1]: pacemaker.service: main process
>> exited, code=exited, status=100
>> May  9 12:03:18 fedora1 systemd[1]: pacemaker.service holdoff time
>> over, scheduling restart.
>> May  9 12:03:18 fedora1 systemd[1]: Unit pacemaker.service entered failed state.
>> May  9 12:03:18 fedora1 systemd[1]: pacemaker.service start request
>> repeated too quickly, refusing to start.
>>
>> _______________________________________________
>> Pacemaker mailing list: Pacemaker [at] oss
>> http://oss.clusterlabs.org/mailman/listinfo/pacemaker
>>
>> Project Home: http://www.clusterlabs.org
>> Getting started: http://www.clusterlabs.org/doc/Cluster_from_Scratch.pdf
>> Bugs: http://bugs.clusterlabs.org
>
> _______________________________________________
> Pacemaker mailing list: Pacemaker [at] oss
> http://oss.clusterlabs.org/mailman/listinfo/pacemaker
>
> Project Home: http://www.clusterlabs.org
> Getting started: http://www.clusterlabs.org/doc/Cluster_from_Scratch.pdf
> Bugs: http://bugs.clusterlabs.org

_______________________________________________
Pacemaker mailing list: Pacemaker [at] oss
http://oss.clusterlabs.org/mailman/listinfo/pacemaker

Project Home: http://www.clusterlabs.org
Getting started: http://www.clusterlabs.org/doc/Cluster_from_Scratch.pdf
Bugs: http://bugs.clusterlabs.org

Linux-HA pacemaker RSS feed   Index | Next | Previous | View Threaded
 
 


Interested in having your list archived? Contact Gossamer Threads
 
  Web Applications & Managed Hosting Powered by Gossamer Threads Inc.