hi, On 07/12/2010 05:36 PM, Lars Ellenberg wrote: > put some "( date ; env) >> /tmp/tmp.debug.log" into your script, > then we can determine if the crm shell assumes too much.
i did some digging around and found that cron seems to set the correct environment. so i used "inotifywait -m /" to watch for changes to /: # tail -f /var/log/syslog & # inotifywait -m / | grep --color crm_ & please find a c/p from three of such events attached. it now seems to me that the drbd monitor action creates these files. however, i'm unable to reproduce this behavior if i manually trigger a monitor action via "crm resource reprobe drbd_data:0" my drbd resource configuration: > primitive drbd_data ocf:linbit:drbd \ > op monitor interval="15" role="Started" timeout="10" \ > op monitor interval="10" role="Slave" timeout="10" \ > op monitor interval="5" role="Master" timeout="20" \ > op stop interval="0" timeout="100" \ > op start interval="0" timeout="240" \ > params drbd_resource="r0" > ms ms_drbd_data drbd_data \ > meta master-max="1" master-node-max="1" clone-max="2" > clone-node-max="1" globally-unique="false" notify="yes" interleave="true" > target-role="Started" migration-threshold="2" failure-timeout="1min" drbd version: > # cat /proc/drbd > version: 8.3.8 (api:88/proto:86-94) > GIT-hash: d78846e52224fd00562f7c225bcc25b2d422321d build by r...@localhost, > 2010-07-07 11:05:14 any ideas? thanks, raoul -- ____________________________________________________________________ DI (FH) Raoul Bhatia M.Sc. email. r.bha...@ipax.at Technischer Leiter IPAX - Aloy Bhatia Hava OG web. http://www.ipax.at Barawitzkagasse 10/2/2/11 email. off...@ipax.at 1190 Wien tel. +43 1 3670030 FN 277995t HG Wien fax. +43 1 3670030 15 ____________________________________________________________________
r...@c01n01 /var/log # Jul 13 12:05:05 c01n01 lrmd: [13212]: debug: rsc:mysql-proxy-tcp:39: monitor Jul 13 12:05:05 c01n01 lrmd: [6010]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 12:05:05 c01n01 lrmd: [13212]: debug: rsc:drbd_data:0:80: monitor Jul 13 12:05:05 c01n01 lrmd: [6017]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 12:05:05 c01n01 drbd[6017]: DEBUG: r0: Calling /usr/sbin/crm_master -Q -l reboot -v 10000 Jul 13 12:05:05 c01n01 attrd: [13213]: debug: attrd_local_callback: update message from crm_attribute: master-drbd_data:0=10000 Jul 13 12:05:05 c01n01 attrd: [13213]: debug: attrd_local_callback: Supplied: 10000, Current: 10000, Stored: 10000 Jul 13 12:05:05 c01n01 drbd[6017]: DEBUG: r0: Exit code 0 Jul 13 12:05:05 c01n01 drbd[6017]: DEBUG: r0: Command output: Jul 13 12:05:05 c01n01 lrmd: [13212]: debug: RA output: (drbd_data:0:monitor:stdout) r...@c01n01 /var/log # Jul 13 12:05:06 c01n01 lrmd: [13212]: debug: rsc:pure-ftpd:42: monitor Jul 13 12:05:06 c01n01 lrmd: [6058]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 12:05:10 c01n01 lrmd: [13212]: debug: rsc:drbd_data:0:80: monitor Jul 13 12:05:10 c01n01 lrmd: [6076]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 12:05:10 c01n01 drbd[6076]: DEBUG: r0: Calling /usr/sbin/crm_master -Q -l reboot -v 10000 Jul 13 12:05:10 c01n01 attrd: [13213]: debug: attrd_local_callback: update message from crm_attribute: master-drbd_data:0=10000 Jul 13 12:05:10 c01n01 attrd: [13213]: debug: attrd_local_callback: Supplied: 10000, Current: 10000, Stored: 10000 Jul 13 12:05:10 c01n01 drbd[6076]: DEBUG: r0: Exit code 0 Jul 13 12:05:10 c01n01 drbd[6076]: DEBUG: r0: Command output: Jul 13 12:05:10 c01n01 lrmd: [13212]: debug: RA output: (drbd_data:0:monitor:stdout) / CREATE .crm_help_index / OPEN .crm_help_index / MODIFY .crm_help_index / CLOSE_WRITE,CLOSE .crm_help_index / OPEN .crm_help_index / ACCESS .crm_help_index / CLOSE_NOWRITE,CLOSE .crm_help_index Jul 13 12:05:12 c01n01 cibadmin: [6151]: info: Invoked: cibadmin -Ql Jul 13 12:05:14 c01n01 lrmd: [13212]: debug: rsc:mysql-proxy-socket:41: monitor Jul 13 12:05:14 c01n01 lrmd: [6175]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER r...@c01n01 /var/log # r...@c01n01 /var/log # r...@c01n01 /var/log # Jul 13 12:05:15 c01n01 lrmd: [13212]: debug: rsc:mysql-proxy-tcp:39: monitor Jul 13 12:05:15 c01n01 lrmd: [6179]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 12:05:15 c01n01 lrmd: [13212]: debug: rsc:drbd_data:0:80: monitor Jul 13 12:05:15 c01n01 lrmd: [6183]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 12:05:15 c01n01 drbd[6183]: DEBUG: r0: Calling /usr/sbin/crm_master -Q -l reboot -v 10000 Jul 13 12:05:15 c01n01 attrd: [13213]: debug: attrd_local_callback: update message from crm_attribute: master-drbd_data:0=10000 Jul 13 12:05:15 c01n01 attrd: [13213]: debug: attrd_local_callback: Supplied: 10000, Current: 10000, Stored: 10000 Jul 13 12:05:15 c01n01 drbd[6183]: DEBUG: r0: Exit code 0 Jul 13 12:05:15 c01n01 drbd[6183]: DEBUG: r0: Command output: Jul 13 12:05:15 c01n01 lrmd: [13212]: debug: RA output: (drbd_data:0:monitor:stdout) Jul 13 12:05:16 c01n01 lrmd: [13212]: debug: rsc:pure-ftpd:42: monitor Jul 13 12:05:16 c01n01 lrmd: [6224]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER
# tail -f /var/log/syslog & # inotifywait -m / | grep --color crm_ & r...@c01n01 /var/log # Jul 13 11:47:36 c01n01 lrmd: [13212]: debug: rsc:drbd_data:0:18: monitor Jul 13 11:47:36 c01n01 lrmd: [15407]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 11:47:36 c01n01 drbd[15407]: DEBUG: r0: Calling /usr/sbin/crm_master -Q -l reboot -v 10000 Jul 13 11:47:36 c01n01 attrd: [13213]: debug: attrd_local_callback: update message from crm_attribute: master-drbd_data:0=10000 Jul 13 11:47:36 c01n01 attrd: [13213]: debug: attrd_local_callback: Supplied: 10000, Current: 10000, Stored: 10000 Jul 13 11:47:36 c01n01 drbd[15407]: DEBUG: r0: Exit code 0 Jul 13 11:47:36 c01n01 drbd[15407]: DEBUG: r0: Command output: Jul 13 11:47:36 c01n01 lrmd: [13212]: debug: RA output: (drbd_data:0:monitor:stdout) r...@c01n01 /var/log # / CREATE .crm_help_index / OPEN .crm_help_index / MODIFY .crm_help_index / CLOSE_WRITE,CLOSE .crm_help_index / OPEN .crm_help_index / ACCESS .crm_help_index / CLOSE_NOWRITE,CLOSE .crm_help_index Jul 13 11:47:41 c01n01 lrmd: [13212]: debug: rsc:drbd_data:0:18: monitor Jul 13 11:47:41 c01n01 lrmd: [15463]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 11:47:41 c01n01 drbd[15463]: DEBUG: r0: Calling /usr/sbin/crm_master -Q -l reboot -v 10000 Jul 13 11:47:41 c01n01 attrd: [13213]: debug: attrd_local_callback: update message from crm_attribute: master-drbd_data:0=10000 Jul 13 11:47:41 c01n01 attrd: [13213]: debug: attrd_local_callback: Supplied: 10000, Current: 10000, Stored: 10000 Jul 13 11:47:41 c01n01 drbd[15463]: DEBUG: r0: Exit code 0 Jul 13 11:47:41 c01n01 drbd[15463]: DEBUG: r0: Command output: Jul 13 11:47:41 c01n01 lrmd: [13212]: debug: RA output: (drbd_data:0:monitor:stdout) Jul 13 11:47:41 c01n01 cibadmin: [15524]: info: Invoked: cibadmin -Ql Jul 13 11:47:42 c01n01 lrmd: [13212]: debug: rsc:mysql-proxy-tcp:39: monitor Jul 13 11:47:42 c01n01 lrmd: [15529]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 11:47:42 c01n01 lrmd: [13212]: debug: rsc:mysql-proxy-socket:41: monitor Jul 13 11:47:42 c01n01 lrmd: [15533]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 11:47:43 c01n01 lrmd: [13212]: debug: rsc:pure-ftpd:42: monitor Jul 13 11:47:43 c01n01 lrmd: [15537]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 11:47:46 c01n01 lrmd: [13212]: debug: rsc:drbd_data:0:18: monitor Jul 13 11:47:46 c01n01 lrmd: [15546]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 11:47:46 c01n01 drbd[15546]: DEBUG: r0: Calling /usr/sbin/crm_master -Q -l reboot -v 10000 Jul 13 11:47:46 c01n01 attrd: [13213]: debug: attrd_local_callback: update message from crm_attribute: master-drbd_data:0=10000 Jul 13 11:47:46 c01n01 attrd: [13213]: debug: attrd_local_callback: Supplied: 10000, Current: 10000, Stored: 10000 Jul 13 11:47:46 c01n01 drbd[15546]: DEBUG: r0: Exit code 0 Jul 13 11:47:46 c01n01 drbd[15546]: DEBUG: r0: Command output: Jul 13 11:47:46 c01n01 lrmd: [13212]: debug: RA output: (drbd_data:0:monitor:stdout)
r...@c01n01 /var/log # Jul 13 11:52:26 c01n01 lrmd: [13212]: debug: rsc:mysql-server:44: monitor Jul 13 11:52:26 c01n01 lrmd: [21687]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 11:52:30 c01n01 lrmd: [13212]: debug: rsc:drbd_data:0:18: monitor Jul 13 11:52:30 c01n01 lrmd: [21695]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 11:52:30 c01n01 drbd[21695]: DEBUG: r0: Calling /usr/sbin/crm_master -Q -l reboot -v 10000 Jul 13 11:52:30 c01n01 attrd: [13213]: debug: attrd_local_callback: update message from crm_attribute: master-drbd_data:0=10000 Jul 13 11:52:30 c01n01 attrd: [13213]: debug: attrd_local_callback: Supplied: 10000, Current: 10000, Stored: 10000 Jul 13 11:52:30 c01n01 drbd[21695]: DEBUG: r0: Exit code 0 Jul 13 11:52:30 c01n01 drbd[21695]: DEBUG: r0: Command output: Jul 13 11:52:30 c01n01 lrmd: [13212]: debug: RA output: (drbd_data:0:monitor:stdout) Jul 13 11:52:33 c01n01 lrmd: [13212]: debug: rsc:mysql-proxy-tcp:39: monitor Jul 13 11:52:33 c01n01 lrmd: [21736]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 11:52:33 c01n01 lrmd: [13212]: debug: rsc:mysql-proxy-socket:41: monitor Jul 13 11:52:33 c01n01 lrmd: [21740]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 11:52:34 c01n01 lrmd: [13212]: debug: rsc:pure-ftpd:42: monitor Jul 13 11:52:34 c01n01 lrmd: [21744]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 11:52:35 c01n01 lrmd: [13212]: debug: rsc:drbd_data:0:18: monitor Jul 13 11:52:35 c01n01 lrmd: [21753]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 11:52:35 c01n01 drbd[21753]: DEBUG: r0: Calling /usr/sbin/crm_master -Q -l reboot -v 10000 Jul 13 11:52:35 c01n01 attrd: [13213]: debug: attrd_local_callback: update message from crm_attribute: master-drbd_data:0=10000 Jul 13 11:52:35 c01n01 attrd: [13213]: debug: attrd_local_callback: Supplied: 10000, Current: 10000, Stored: 10000 Jul 13 11:52:35 c01n01 drbd[21753]: DEBUG: r0: Exit code 0 Jul 13 11:52:35 c01n01 drbd[21753]: DEBUG: r0: Command output: Jul 13 11:52:35 c01n01 lrmd: [13212]: debug: RA output: (drbd_data:0:monitor:stdout) / CREATE .crm_help_index / OPEN .crm_help_index / MODIFY .crm_help_index / CLOSE_WRITE,CLOSE .crm_help_index / OPEN .crm_help_index / ACCESS .crm_help_index / CLOSE_NOWRITE,CLOSE .crm_help_index Jul 13 11:52:40 c01n01 cibadmin: [21829]: info: Invoked: cibadmin -Ql Jul 13 11:52:40 c01n01 lrmd: [13212]: debug: rsc:drbd_data:0:18: monitor Jul 13 11:52:40 c01n01 lrmd: [21843]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 11:52:40 c01n01 drbd[21843]: DEBUG: r0: Calling /usr/sbin/crm_master -Q -l reboot -v 10000 Jul 13 11:52:40 c01n01 attrd: [13213]: debug: attrd_local_callback: update message from crm_attribute: master-drbd_data:0=10000 Jul 13 11:52:40 c01n01 attrd: [13213]: debug: attrd_local_callback: Supplied: 10000, Current: 10000, Stored: 10000 Jul 13 11:52:40 c01n01 drbd[21843]: DEBUG: r0: Exit code 0 Jul 13 11:52:40 c01n01 drbd[21843]: DEBUG: r0: Command output: Jul 13 11:52:40 c01n01 lrmd: [13212]: debug: RA output: (drbd_data:0:monitor:stdout) Jul 13 11:52:43 c01n01 lrmd: [13212]: debug: rsc:mysql-proxy-tcp:39: monitor Jul 13 11:52:43 c01n01 lrmd: [21884]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 11:52:43 c01n01 lrmd: [13212]: debug: rsc:mysql-proxy-socket:41: monitor Jul 13 11:52:43 c01n01 lrmd: [21888]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 11:52:44 c01n01 lrmd: [13212]: debug: rsc:pure-ftpd:42: monitor Jul 13 11:52:44 c01n01 lrmd: [21892]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 11:52:45 c01n01 lrmd: [13212]: debug: rsc:drbd_data:0:18: monitor Jul 13 11:52:45 c01n01 lrmd: [21901]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 11:52:45 c01n01 drbd[21901]: DEBUG: r0: Calling /usr/sbin/crm_master -Q -l reboot -v 10000 Jul 13 11:52:45 c01n01 attrd: [13213]: debug: attrd_local_callback: update message from crm_attribute: master-drbd_data:0=10000 Jul 13 11:52:45 c01n01 attrd: [13213]: debug: attrd_local_callback: Supplied: 10000, Current: 10000, Stored: 10000 Jul 13 11:52:45 c01n01 drbd[21901]: DEBUG: r0: Exit code 0 Jul 13 11:52:45 c01n01 drbd[21901]: DEBUG: r0: Command output: Jul 13 11:52:45 c01n01 lrmd: [13212]: debug: RA output: (drbd_data:0:monitor:stdout) Jul 13 11:52:50 c01n01 lrmd: [13212]: debug: rsc:drbd_data:0:18: monitor Jul 13 11:52:50 c01n01 lrmd: [21956]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 11:52:50 c01n01 drbd[21956]: DEBUG: r0: Calling /usr/sbin/crm_master -Q -l reboot -v 10000 Jul 13 11:52:50 c01n01 attrd: [13213]: debug: attrd_local_callback: update message from crm_attribute: master-drbd_data:0=10000 Jul 13 11:52:50 c01n01 attrd: [13213]: debug: attrd_local_callback: Supplied: 10000, Current: 10000, Stored: 10000 Jul 13 11:52:50 c01n01 drbd[21956]: DEBUG: r0: Exit code 0 Jul 13 11:52:50 c01n01 pure-ftpd: (?...@93-189-24-205.rev.ipax.at) [INFO] New connection from 93-189-24-205.rev.ipax.at Jul 13 11:52:50 c01n01 drbd[21956]: DEBUG: r0: Command output: Jul 13 11:52:50 c01n01 pure-ftpd: (?...@93-189-24-205.rev.ipax.at) [INFO] Logout. Jul 13 11:52:50 c01n01 lrmd: [13212]: debug: RA output: (drbd_data:0:monitor:stdout) Jul 13 11:52:51 c01n01 lrmd: [13212]: debug: rsc:wwwip:26: monitor Jul 13 11:52:51 c01n01 lrmd: [21999]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 11:52:51 c01n01 lrmd: [13212]: debug: rsc:gld:30: monitor Jul 13 11:52:51 c01n01 lrmd: [22008]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 11:52:51 c01n01 lrmd: [13212]: debug: RA output: (gld:monitor:stdout) Checking GreyListing Daemon: gld ... Jul 13 11:52:51 c01n01 lrmd: [13212]: debug: RA output: (gld:monitor:stdout) gld is running Jul 13 11:52:51 c01n01 lrmd: [13212]: debug: RA output: (gld:monitor:stdout) . Jul 13 11:52:51 c01n01 lrmd: [13212]: debug: rsc:mailip:28: monitor Jul 13 11:52:51 c01n01 lrmd: [22035]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 11:52:51 c01n01 lrmd: [13212]: debug: rsc:fs_data:19: monitor Jul 13 11:52:51 c01n01 lrmd: [22044]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 11:52:51 c01n01 lrmd: [13212]: debug: rsc:saslauthd:32: monitor Jul 13 11:52:51 c01n01 lrmd: [22103]: debug: perform_ra_op: resetting scheduler class to SCHED_OTHER Jul 13 11:52:51 c01n01 lrmd: [13212]: debug: RA output: (saslauthd:monitor:stdout) Checking SASL Authentication Daemon: saslauthd Jul 13 11:52:51 c01n01 lrmd: [13212]: debug: RA output: (saslauthd:monitor:stdout) (running) Jul 13 11:52:51 c01n01 lrmd: [13212]: debug: RA output: (saslauthd:monitor:stdout) .
_______________________________________________ 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
