OK - I have found you can throw a SIGUSR1 to lrmd to print some debug.
This is the what was shown just after I executed the first
lrmadmin -C
Nov 22 21:12:39 node1 lrmd: [1038]: debug: on_op_done: BEGIN resource dump
Nov 22 21:12:39 node1 lrmd: [1038]: debug: on_op_done: resource
vsftpd/vsftpd/upstart/<null>
Nov 22 21:12:39 node1 lrmd: [1038]: debug: on_op_done: rsc->op_list...
Nov 22 21:12:39 node1 lrmd: [1038]: debug: rsc->op_list: lrmd_op: operation
monitor[20] on upstart::vsftpd::vsftpd for client 1041, its parameters:
CRM_meta_name=[monitor] cr
Nov 22 21:12:39 node1 lrmd: [1038]: debug: rsc->op_list: lrmd_op2: rt_tag: 0,
interval: 5000, delay: 0
Nov 22 21:12:39 node1 lrmd: [1038]: debug: rsc->op_list: lrmd_op3: t_recv:
210940ms, t_add: 20ms, t_perform: 20ms, t_done: 0ms, t_rcchange: 210940ms
Nov 22 21:12:39 node1 lrmd: [1038]: debug: on_op_done: rsc->repeat_op_list...
Nov 22 21:12:39 node1 lrmd: [1038]: debug: on_op_done: rsc->last_op_done...
Nov 22 21:12:39 node1 lrmd: [1038]: debug: rsc->last_op_done: lrmd_op:
operation monitor[20] on upstart::vsftpd::vsftpd for client 1041, its
parameters: CRM_meta_name=[monito
Nov 22 21:12:39 node1 lrmd: [1038]: debug: rsc->last_op_done: lrmd_op2: rt_tag:
0, interval: 5000, delay: 0
Nov 22 21:12:39 node1 lrmd: [1038]: debug: rsc->last_op_done: lrmd_op3: t_recv:
210940ms, t_add: 5040ms, t_perform: 5040ms, t_done: 5020ms, t_rcchange: 210940ms
Nov 22 21:12:39 node1 lrmd: [1038]: debug: rsc->last_op_table: lrmd_op:
operation monitor[5] on upstart::vsftpd::vsftpd for client 1041, its
parameters: crm_feature_set=[3.0.
Nov 22 21:12:39 node1 lrmd: [1038]: debug: rsc->last_op_table: lrmd_op2:
rt_tag: 0, interval: 0, delay: 0
Nov 22 21:12:39 node1 lrmd: [1038]: debug: rsc->last_op_table: lrmd_op3:
t_recv: 214510ms, t_add: 214510ms, t_perform: 214510ms, t_done: 214470ms,
t_rcchange: 214510ms
Nov 22 21:12:39 node1 lrmd: [1038]: debug: rsc->last_op_table: lrmd_op:
operation stop[8] on upstart::vsftpd::vsftpd for client 1041, its parameters:
crm_feature_set=[3.0.1]
Nov 22 21:12:39 node1 lrmd: [1038]: debug: rsc->last_op_table: lrmd_op2:
rt_tag: 0, interval: 0, delay: 0
Nov 22 21:12:39 node1 lrmd: [1038]: debug: rsc->last_op_table: lrmd_op3:
t_recv: 213210ms, t_add: 213210ms, t_perform: 213210ms, t_done: 213180ms,
t_rcchange: 213210ms
Nov 22 21:12:39 node1 lrmd: [1038]: debug: rsc->last_op_table: lrmd_op:
operation monitor[20] on upstart::vsftpd::vsftpd for client 1041, its
parameters: CRM_meta_name=[monit
Nov 22 21:12:39 node1 lrmd: [1038]: debug: rsc->last_op_table: lrmd_op2:
rt_tag: 0, interval: 5000, delay: 0
Nov 22 21:12:39 node1 lrmd: [1038]: debug: rsc->last_op_table: lrmd_op3:
t_recv: 210940ms, t_add: 5040ms, t_perform: 5040ms, t_done: 5020ms, t_rcchange:
210940ms
Nov 22 21:12:39 node1 lrmd: [1038]: debug: rsc->last_op_table: lrmd_op:
operation start[19] on upstart::vsftpd::vsftpd for client 1041, its parameters:
crm_feature_set=[3.0.1
Nov 22 21:12:39 node1 lrmd: [1038]: debug: rsc->last_op_table: lrmd_op2:
rt_tag: 0, interval: 0, delay: 0
Nov 22 21:12:39 node1 lrmd: [1038]: debug: rsc->last_op_table: lrmd_op3:
t_recv: 210990ms, t_add: 210990ms, t_perform: 210990ms, t_done: 210960ms,
t_rcchange: 210990ms
Nov 22 21:12:39 node1 lrmd: [1038]: debug: on_op_done: END resource dump
Nov 22 21:12:39 node1 lrmd: [1038]: debug: on_op_done:operation monitor[20] on
upstart::vsftpd::vsftpd for client 1041, its parameters:
CRM_meta_name=[monitor] crm_feature_se
Nov 22 21:12:39 node1 lrmd: [1038]: debug: lrmd_op_destroy: free the operation
monitor[20] on upstart::vsftpd::vsftpd for client 1041, its parameters:
CRM_meta_name=[monitor]
Nov 22 21:12:39 node1 lrmd: [1038]: debug: replace_last_op: replace last op
monitor_5000 for client crmd
Nov 22 21:12:39 node1 lrmd: [1038]: debug: lrmd_op_destroy: free the operation
monitor[20] on upstart::vsftpd::vsftpd for client 1041, its parameters:
CRM_meta_name=[monitor]
Nov 22 21:12:39 node1 lrmd: [1038]: debug: to_repeatlist: repeat operation
monitor[20] on upstart::vsftpd::vsftpd for client 1041, its parameters:
CRM_meta_name=[monitor] crm
Nov 22 21:12:39 node1 lrmd: [1038]: debug: lrmd_op_destroy: free the operation
monitor[20] on upstart::vsftpd::vsftpd for client 1041, its parameters:
CRM_meta_name=[monitor]
Nov 22 21:12:39 node1 lrmd: [1038]: debug: perform_op: no op to perform?
Nov 22 21:12:42 node1 lrmd: [1038]: debug:
G_main_IPC_Channel_constructor(sock=11,11)
Nov 22 21:12:42 node1 lrmd: [1038]: debug: dumping request:
>>>#012lrm_t=reg#012lrm_app=lrmadmin#012lrm_pid=2438#012lrm_gid=0#012lrm_uid=0#012<<<
Nov 22 21:12:42 node1 lrmd: [1038]: debug: on_msg_register:client lrmadmin
[2438] registered
Nov 22 21:12:42 node1 lrmd: [1038]: debug:
G_main_IPC_Channel_constructor(sock=12,12)
Nov 22 21:12:42 node1 lrmd: [1038]: debug: dumping request:
>>>#012lrm_t=rclasses#012<<<
Nov 22 21:12:42 node1 lrmd: [1038]: debug: on_msg_get_rsc_classes:client [2438]
wants to get rsc classes
Nov 22 21:12:42 node1 lrmd: [1038]: debug: on_receive_cmd: the IPC to client
[pid:2438] disconnected.
Nov 22 21:12:42 node1 lrmd: [1038]: debug: G_CH_destroy_int(chp=0x25e5830,
sock=11) {
Nov 22 21:12:42 node1 lrmd: [1038]: debug: G_CH_destroy_int: Calling
dnotify(sock=11, arg=0x25ea310) function
Nov 22 21:12:42 node1 lrmd: [1038]: debug: G_main_del_IPC_Channel(sock=11)
lrmd doesnt respond to subsequent signal requests so I cannot get any further
debug using this technique.
_______________________________________________
Pacemaker mailing list: Pacemaker@oss.clusterlabs.org
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://developerbugs.linux-foundation.org/enter_bug.cgi?product=Pacemaker
