[Pacemaker] lrmadmin -C blocks on subsequent invocations
Dave Williams
dave at opensourcesolutions.co.uk
Mon Nov 22 21:19:48 UTC 2010
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.
More information about the Pacemaker
mailing list