[one-users] intermittent error while executing monitoring script - /bin/sh: bad interpreter

Wed Feb 10 11:06:45 PST 2010

Hi,

Could this mean a kind of race condition between different monitor
actions?. May be you can try to increment the HOST_MONITORING_INTERVAL
in oned.conf, let say to 120 and check if that helps

Cheers

Ruben

On Wed, Feb 10, 2010 at 5:38 PM, Jack Jill <jacknjill111 at gmail.com> wrote:
> While looking at oned.log, I saw a few error messages:
> <quote>
>   bash: /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41: /bin/sh: bad
> interpreter: Text file busy
> </quote>
>
> After sometime the error goes away as seen below.
>
> Any idea what was the cause of this issue? I logged onto my 2 hosts and ran
> the above script and they executed fine returning the MODELNAME for the
> hosts.
>
>
>
> Snippet of oned.log:
> --------------------------
>
> Wed Feb 10 10:08:06 2010 [ReM][D]: VirtualMachinePoolInfo method invoked
> Wed Feb 10 10:08:08 2010 [VMM][I]: --Mark--
> Wed Feb 10 10:09:07 2010 [VMM][I]: Monitoring VM 35.
> Wed Feb 10 10:09:36 2010 [InM][I]: --Mark--
> Wed Feb 10 10:10:35 2010 [VMM][I]: Monitoring VM 35.
> Wed Feb 10 10:11:29 2010 [ReM][D]: VirtualMachinePoolInfo method invoked
> Wed Feb 10 10:11:35 2010 [VMM][I]: Monitoring VM 35.
> Wed Feb 10 10:12:56 2010 [ReM][D]: VirtualMachinePoolInfo method invoked
> Wed Feb 10 10:13:03 2010 [ReM][D]: VirtualMachineInfo method invoked
> Wed Feb 10 10:13:03 2010 [VMM][I]: Monitoring VM 35.
> Wed Feb 10 10:14:04 2010 [VMM][I]: Monitoring VM 35.
> Wed Feb 10 10:14:32 2010 [InM][I]: Monitoring host uecB (0)
> Wed Feb 10 10:14:33 2010 [InM][I]: Monitoring host 192.168.0.100 (3)
> Wed Feb 10 10:14:34 2010 [InM][I]: Command execution fail: 'mkdir -p
> /tmp/one-im/; cat > /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41; if
> [ "x$?" != "x0" ]; then exit -1; fi; chmod +x
> /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41;
> /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41'
> Wed Feb 10 10:14:34 2010 [InM][I]: STDERR follows.
> Wed Feb 10 10:14:34 2010 [InM][I]: bash:
> /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41: /bin/sh: bad
> interpreter: Text file busy
> Wed Feb 10 10:14:34 2010 [InM][I]: ExitCode: 126
> Wed Feb 10 10:14:39 2010 [InM][D]: Host 0 successfully monitored.
> Wed Feb 10 10:15:33 2010 [InM][I]: Monitoring host 192.168.0.100 (3)
> Wed Feb 10 10:15:33 2010 [VMM][I]: Monitoring VM 35.
> Wed Feb 10 10:16:02 2010 [InM][I]: Monitoring host uecB (0)
> Wed Feb 10 10:16:04 2010 [InM][I]: Command execution fail: 'mkdir -p
> /tmp/one-im/; cat > /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41; if
> [ "x$?" != "x0" ]; then exit -1; fi; chmod +x
> /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41;
> /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41'
> Wed Feb 10 10:16:04 2010 [InM][I]: STDERR follows.
> Wed Feb 10 10:16:04 2010 [InM][I]: bash:
> /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41: /bin/sh: bad
> interpreter: Text file busy
> Wed Feb 10 10:16:04 2010 [InM][I]: ExitCode: 126
> Wed Feb 10 10:16:09 2010 [InM][D]: Host 0 successfully monitored.
> Wed Feb 10 10:16:32 2010 [ReM][D]: VirtualMachinePoolInfo method invoked
> Wed Feb 10 10:16:32 2010 [InM][I]: Monitoring host 192.168.0.100 (3)
> Wed Feb 10 10:16:33 2010 [VMM][I]: Monitoring VM 35.
> Wed Feb 10 10:17:32 2010 [InM][I]: Monitoring host uecB (0)
> Wed Feb 10 10:17:33 2010 [InM][I]: Monitoring host 192.168.0.100 (3)
> Wed Feb 10 10:17:34 2010 [InM][I]: Command execution fail: 'mkdir -p
> /tmp/one-im/; cat > /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41; if
> [ "x$?" != "x0" ]; then exit -1; fi; chmod +x
> /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41;
> /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41'
> Wed Feb 10 10:17:34 2010 [InM][I]: STDERR follows.
> Wed Feb 10 10:17:34 2010 [InM][I]: bash:
> /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41: /bin/sh: bad
> interpreter: Text file busy
> Wed Feb 10 10:17:34 2010 [InM][I]: ExitCode: 126
> Wed Feb 10 10:17:39 2010 [InM][D]: Host 0 successfully monitored.
> Wed Feb 10 10:18:02 2010 [VMM][I]: --Mark--
> Wed Feb 10 10:18:02 2010 [VMM][I]: Monitoring VM 35.
> Wed Feb 10 10:18:32 2010 [InM][I]: Monitoring host 192.168.0.100 (3)
> Wed Feb 10 10:19:02 2010 [InM][I]: Monitoring host uecB (0)
> Wed Feb 10 10:19:04 2010 [InM][I]: Command execution fail: 'mkdir -p
> /tmp/one-im/; cat > /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41; if
> [ "x$?" != "x0" ]; then exit -1; fi; chmod +x
> /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41;
> /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41'
> Wed Feb 10 10:19:04 2010 [InM][I]: STDERR follows.
> Wed Feb 10 10:19:04 2010 [InM][I]: bash:
> /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41: /bin/sh: bad
> interpreter: Text file busy
> Wed Feb 10 10:19:04 2010 [InM][I]: ExitCode: 126
> Wed Feb 10 10:19:09 2010 [InM][D]: Host 0 successfully monitored.
> Wed Feb 10 10:19:30 2010 [VMM][I]: Monitoring VM 35.
> Wed Feb 10 10:19:33 2010 [InM][I]: --Mark--
> Wed Feb 10 10:19:33 2010 [InM][I]: Monitoring host 192.168.0.100 (3)
> Wed Feb 10 10:20:30 2010 [VMM][I]: Monitoring VM 35.
> Wed Feb 10 10:20:33 2010 [InM][I]: Monitoring host uecB (0)
> Wed Feb 10 10:20:33 2010 [InM][I]: Monitoring host 192.168.0.100 (3)
> Wed Feb 10 10:20:34 2010 [InM][I]: Command execution fail: 'mkdir -p
> /tmp/one-im/; cat > /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41; if
> [ "x$?" != "x0" ]; then exit -1; fi; chmod +x
> /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41;
> /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41'
> Wed Feb 10 10:20:34 2010 [InM][I]: STDERR follows.
> Wed Feb 10 10:20:34 2010 [InM][I]: bash:
> /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41: /bin/sh: bad
> interpreter: Text file busy
> Wed Feb 10 10:20:34 2010 [InM][I]: ExitCode: 126
> Wed Feb 10 10:20:39 2010 [InM][D]: Host 0 successfully monitored.
> Wed Feb 10 10:21:32 2010 [InM][I]: Monitoring host 192.168.0.100 (3)
> Wed Feb 10 10:21:59 2010 [VMM][I]: Monitoring VM 35.
> Wed Feb 10 10:22:02 2010 [InM][I]: Monitoring host uecB (0)
> Wed Feb 10 10:22:05 2010 [InM][I]: Command execution fail: 'mkdir -p
> /tmp/one-im/; cat > /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41; if
> [ "x$?" != "x0" ]; then exit -1; fi; chmod +x
> /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41;
> /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41'
> Wed Feb 10 10:22:05 2010 [InM][I]: STDERR follows.
> Wed Feb 10 10:22:05 2010 [InM][I]: bash:
> /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41: /bin/sh: bad
> interpreter: Text file busy
> Wed Feb 10 10:22:05 2010 [InM][I]: ExitCode: 126
> Wed Feb 10 10:22:09 2010 [InM][D]: Host 0 successfully monitored.
> Wed Feb 10 10:22:32 2010 [InM][I]: Monitoring host 192.168.0.100 (3)
> Wed Feb 10 10:23:27 2010 [VMM][I]: Monitoring VM 35.
> Wed Feb 10 10:23:33 2010 [InM][I]: Monitoring host uecB (0)
> Wed Feb 10 10:23:33 2010 [InM][I]: Monitoring host 192.168.0.100 (3)
> ^[[B^[[B^[[B^[[B^[[D^[[D^[[DWed Feb 10 10:23:34 2010 [InM][I]: Command
> execution fail: 'mkdir -p /tmp/one-im/; cat >
> /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41; if [ "x$?" != "x0" ];
> then exit -1; fi; chmod +x
> /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41;
> /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41'
> Wed Feb 10 10:23:34 2010 [InM][I]: STDERR follows.
> Wed Feb 10 10:23:34 2010 [InM][I]: bash:
> /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41: /bin/sh: bad
> interpreter: Text file busy
> Wed Feb 10 10:23:34 2010 [InM][I]: ExitCode: 126
> Wed Feb 10 10:23:39 2010 [InM][D]: Host 0 successfully monitored.
> Wed Feb 10 10:24:32 2010 [InM][I]: Monitoring host 192.168.0.100 (3)
> Wed Feb 10 10:24:56 2010 [VMM][I]: Monitoring VM 35.
> Wed Feb 10 10:25:02 2010 [InM][I]: Monitoring host uecB (0)
> Wed Feb 10 10:25:04 2010 [InM][I]: Command execution fail: 'mkdir -p
> /tmp/one-im/; cat > /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41; if
> [ "x$?" != "x0" ]; then exit -1; fi; chmod +x
> /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41;
> /tmp/one-im//one_im-38dc4dfb60e7d302b37a7e141baebe41'
> Wed Feb 10 10:25:04 2010 [InM][I]: ExitCode: 126
> Wed Feb 10 10:25:08 2010 [InM][D]: Host 0 successfully monitored.
> Wed Feb 10 10:25:33 2010 [InM][I]: Monitoring host 192.168.0.100 (3)
> Wed Feb 10 10:26:24 2010 [VMM][I]: Monitoring VM 35.
> Wed Feb 10 10:26:33 2010 [InM][I]: Monitoring host uecB (0)
> Wed Feb 10 10:26:33 2010 [InM][I]: Monitoring host 192.168.0.100 (3)
> Wed Feb 10 10:27:32 2010 [InM][I]: Monitoring host 192.168.0.100 (3)
> Wed Feb 10 10:27:53 2010 [VMM][I]: --Mark--
> Wed Feb 10 10:27:53 2010 [VMM][I]: Monitoring VM 35.
> Wed Feb 10 10:28:32 2010 [InM][I]: Monitoring host 192.168.0.100 (3)
> Wed Feb 10 10:28:53 2010 [VMM][I]: Monitoring VM 35.
> Wed Feb 10 10:29:32 2010 [InM][I]: --Mark--
> Wed Feb 10 10:29:32 2010 [InM][I]: Monitoring host 192.168.0.100 (3)
> Wed Feb 10 10:30:20 2010 [VMM][I]: Monitoring VM 35.
> Wed Feb 10 10:30:32 2010 [InM][I]: Monitoring host 192.168.0.100 (3)
> Wed Feb 10 10:31:20 2010 [VMM][I]: Monitoring VM 35.
> Wed Feb 10 10:31:33 2010 [InM][I]: Monitoring host 192.168.0.100 (3)
> Wed Feb 10 10:32:20 2010 [VMM][I]: Monitoring VM 35.
> Wed Feb 10 10:32:32 2010 [InM][I]: Monitoring host 192.168.0.100 (3)
> Wed Feb 10 10:33:32 2010 [InM][I]: Monitoring host 192.168.0.100 (3)
> Wed Feb 10 10:33:47 2010 [VMM][I]: Monitoring VM 35.
> Wed Feb 10 10:34:33 2010 [InM][I]: Monitoring host 192.168.0.100 (3)
> Wed Feb 10 10:34:47 2010 [VMM][I]: Monitoring VM 35.
>
>
>
>
>
>
> --
> Thanks,
> Rosh
> http://blogs.plexibus.com
>
>
> _______________________________________________
> Users mailing list
> Users at lists.opennebula.org
> http://lists.opennebula.org/listinfo.cgi/users-opennebula.org
>
>

-- 
Dr. Ruben Santiago Montero
Associate Professor, Complutense University of Madrid

URL:    http://dsa-research.org/doku.php?id=people:ruben
Weblog: http://blog.dsa-research.org/?author=7