You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@vcl.apache.org by Alexander Patterson <al...@csueastbay.edu> on 2010/09/08 17:55:14 UTC
failed: cloning base image failed
Hello,
Been having an issue with our system. We just added a few new blades
and had our network team move over files to clone our blades so they
work correct.
I can't create images anymore. Normal operation works, but I can't
update or create images currently.
Here is the error code I am getting.
I think that vmkfstools was deleted (I can't find it anywhere), but I
only see that tool for ESX? Do we have this tool on the VCL web site?
Or am I missing something else that is needed to make images?
2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:run_ssh_command(6276)|SSH
command executed on vclesx05, returning (0, "none")
2010-09-08 08:50:40|6294|9915:9651|new|vmware.pm:_vmwareclone(1426)|srcDisk
is exists /virtualmachines/vmwarewinxp-build97-v1/vmwarewinxp-build97-v1.vmdk
2010-09-08 08:50:40|6294|9915:9651|new|vmware.pm:_vmwareclone(1427)|starting
clone process vmkfstools -d thin -i
/virtualmachines/vmwarewinxp-build97-v1/vmwarewinxp-build97-v1.vmdk
/virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk
2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:run_ssh_command(6180)|executing
SSH command on vclesx05:
|6294|9915:9651|new| /usr/bin/ssh -i /etc/vcl/vcl.key -l root -p 22
-x vclesx05 'ls -1
/virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk' 2>&1
2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:run_ssh_command(6262)|run_ssh_command
output:
|6294|9915:9651|new| ls:
/virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk: No such
file or directory
2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:run_ssh_command(6272)|SSH
command executed on vclesx05, command:
|6294|9915:9651|new| /usr/bin/ssh -i /etc/vcl/vcl.key -l root -p 22
-x vclesx05 'ls -1
/virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk' 2>&1
|6294|9915:9651|new| returning (2, "ls: /virtualmachines/9651vmgue...")
|6294|9915:9651|new| ---- WARNING ----
|6294|9915:9651|new| 2010-09-08
08:50:40|6294|9915:9651|new|vmware.pm:_vmwareclone(1457)|clone process
failed dstDisk /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk
does not exist
|6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
|6294|9915:9651|new| (-1) vmware.pm, _vmwareclone (line: 1457)
|6294|9915:9651|new| (-2) vmware.pm, load (line: 502)
|6294|9915:9651|new| (-3) new.pm, reload_image (line: 665)
|6294|9915:9651|new| (-4) new.pm, process (line: 266)
|6294|9915:9651|new| (-5) vcld, make_new_child (line: 594)
|6294|9915:9651|new| (-6) vcld, main (line: 341)
2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:insertloadlog(4710)|inserted
computer=107, failed, cloning base image failed
No recipient addresses found in header
2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:mail(1348)|SUCCESS --
Sending mail To: , PROBLEM -- vmware.pm
|6294|9915:9651|new| ---- CRITICAL ----
|6294|9915:9651|new| 2010-09-08
08:50:40|6294|9915:9651|new|vmware.pm:load(508)|problem cloning failed
/virtualmachines/vmwarewinxp-build97-v1/vmwarewinxp-build97-v1.vmdk to
/virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk
|6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
|6294|9915:9651|new| (-1) vmware.pm, load (line: 508)
|6294|9915:9651|new| (-2) new.pm, reload_image (line: 665)
|6294|9915:9651|new| (-3) new.pm, process (line: 266)
|6294|9915:9651|new| (-4) vcld, make_new_child (line: 594)
|6294|9915:9651|new| (-5) vcld, main (line: 341)
|6294|9915:9651|new| ---- WARNING ----
|6294|9915:9651|new| 2010-09-08
08:50:40|6294|9915:9651|new|new.pm:reload_image(670)|vmwarewinxp-build97-v1
failed to load on vmguest-104, returning
|6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
|6294|9915:9651|new| (-1) new.pm, reload_image (line: 670)
|6294|9915:9651|new| (-2) new.pm, process (line: 266)
|6294|9915:9651|new| (-3) vcld, make_new_child (line: 594)
|6294|9915:9651|new| (-4) vcld, main (line: 341)
2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:insertloadlog(4710)|inserted
computer=107, loadimagefailed, vmwarewinxp-build97-v1 failed to load
on vmguest-104
|6294|9915:9651|new| ---- WARNING ----
|6294|9915:9651|new| 2010-09-08
08:50:40|6294|9915:9651|new|new.pm:process(313)|failed to load
vmguest-104 with vmwarewinxp-build97-v1
|6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
|6294|9915:9651|new| (-1) new.pm, process (line: 313)
|6294|9915:9651|new| (-2) vcld, make_new_child (line: 594)
|6294|9915:9651|new| (-3) vcld, main (line: 341)
2010-09-08 08:50:40|6294|9915:9651|new|DataStructure.pm:get_computer_state_name(1946)|attempting
to retrieve current state of computer vmguest-104 from the database
2010-09-08 08:50:40|6294|9915:9651|new|DataStructure.pm:get_computer_state_name(1977)|retrieved
current state of computer vmguest-104 from the database: reloading
2010-09-08 08:50:40|6294|9915:9651|new|DataStructure.pm:_automethod(697)|data
structure updated:
$self->request_data->{reservation}{9651}{computer}{state}{name}
|6294|9915:9651|new| computer_state_name = reloading
No recipient addresses found in header
2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:mail(1348)|SUCCESS --
Sending mail To: , PROBLEM -- State.pm
|6294|9915:9651|new| ---- CRITICAL ----
|6294|9915:9651|new| 2010-09-08
08:50:40|6294|9915:9651|new|State.pm:reservation_failed(290)|reservation
failed on vmguest-104: process failed after trying to load or make
available
|6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
|6294|9915:9651|new| (-1) State.pm, reservation_failed (line: 290)
|6294|9915:9651|new| (-2) new.pm, process (line: 316)
|6294|9915:9651|new| (-3) vcld, make_new_child (line: 594)
|6294|9915:9651|new| (-4) vcld, main (line: 341)
2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:insertloadlog(4710)|inserted
computer=107, failed, process failed after trying to load or make
available
2010-09-08 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(293)|inserted
computerloadlog entry
2010-09-08 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(301)|updated
log ending value to 'failed', logid=3483
2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:update_computer_state(2228)|computer
107 state updated to: failed
2010-09-08 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(312)|computer
vmguest-104 (107) state set to failed
2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:update_request_state(2186)|request
9915 state updated to: failed, laststate to: new
2010-09-08 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(325)|set
request state to 'failed'/'new'
2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:is_inblockrequest(6972)|zero
rows were returned from database select
2010-09-08 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(343)|vmguest-104
is NOT in blockcomputers table
2010-09-08 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(346)|exiting
1
2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(905)|destructor
called, ref($self)=VCL::new
2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:delete_computerloadlog_reservation(7551)|removing
computerloadlog entries matching loadstate = begin
2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:delete_computerloadlog_reservation(7598)|deleted
rows from computerloadlog for reservation id=9651
2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(912)|removed
computerloadlog rows with loadstate=begin for reservation
2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(924)|number of
database handles state process created: 1
2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(933)|process
has a database handle stored in $ENV{dbh}, attempting disconnect
2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(935)|$ENV{dbh}:
database disconnect successful
2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(949)|VCL::new
process 6294 exiting
2010-09-08 08:50:40|4994|vcld:REAPER(744)|VCL process exited for
reservation 9651
2010-09-08 08:50:40|4994|vcld:main(165)|lastcheckin time updated for
management node 1: 2010-09-08 08:50:40
--
Thanks,
Alex Patterson
User Support Services
Operating System Analyst
California State University, East Bay
Re: failed: cloning base image failed
Posted by Aaron Peeler <aa...@ncsu.edu>.
Thanks Alex.
Also, I'll comment more on the cause of the problem and the solution.
We first started using vmware free server with the vmware.pm module and
only utilizing local disk in our environment(didn't have the funds at
the time for nice NAS storage). While this module also supports using
esx standard server with network mounted datastores, we mistakenly did
add support for free server version + network datastores.
The fix was detect which version of vmware (esx or free server) and use
a different vmware command.
esx uses vmkfstools
free server 1.x will use vmware-vdiskmanager for network mounted datastores
I committed the changes to the repository for the next release this morning.
In the 2.2 release, which I'll send an update in another email will also
support free server 2.x and esx/esxi 4.
We'll eventually look toward phasing out the older vmware.pm module and
replace it with the newer code, but in the for the next release folks
will be able to use either one.
Aaron
On 9/16/10 4:02 PM, Alexander Patterson wrote:
> The solution to our problem was solve by Aaron
> Thank you for fixing the code to work with our net storage we are using.
>
> CSUEB uses NFS mounts on our NFS to storage our images, Thanks to Aaron for
> modified vmware.pm.
>
>
> vmware.pm is in /usr/local/vcl/lib/VCL/Module/Provisioning/
>
> If anyone else runs into this issue, this is the solution
>
> Thanks
>
> -Alex
>
> On Wed, Sep 8, 2010 at 8:55 AM, Alexander Patterson<
> alexander.patterson@csueastbay.edu> wrote:
>
>> Hello,
>>
>> Been having an issue with our system. We just added a few new blades
>> and had our network team move over files to clone our blades so they
>> work correct.
>>
>> I can't create images anymore. Normal operation works, but I can't
>> update or create images currently.
>>
>> Here is the error code I am getting.
>>
>> I think that vmkfstools was deleted (I can't find it anywhere), but I
>> only see that tool for ESX? Do we have this tool on the VCL web site?
>> Or am I missing something else that is needed to make images?
>>
>>
>> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:run_ssh_command(6276)|SSH
>> command executed on vclesx05, returning (0, "none")
>> 2010-09-08 08:50:40|6294|9915:9651|new|vmware.pm:
>> _vmwareclone(1426)|srcDisk
>> is exists
>> /virtualmachines/vmwarewinxp-build97-v1/vmwarewinxp-build97-v1.vmdk
>> 2010-09-08 08:50:40|6294|9915:9651|new|vmware.pm:
>> _vmwareclone(1427)|starting
>> clone process vmkfstools -d thin -i
>> /virtualmachines/vmwarewinxp-build97-v1/vmwarewinxp-build97-v1.vmdk
>> /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk
>> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
>> run_ssh_command(6180)|executing
>> SSH command on vclesx05:
>> |6294|9915:9651|new| /usr/bin/ssh -i /etc/vcl/vcl.key -l root -p 22
>> -x vclesx05 'ls -1
>> /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk' 2>&1
>> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
>> run_ssh_command(6262)|run_ssh_command
>> output:
>> |6294|9915:9651|new| ls:
>> /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk: No such
>> file or directory
>> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:run_ssh_command(6272)|SSH
>> command executed on vclesx05, command:
>> |6294|9915:9651|new| /usr/bin/ssh -i /etc/vcl/vcl.key -l root -p 22
>> -x vclesx05 'ls -1
>> /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk' 2>&1
>> |6294|9915:9651|new| returning (2, "ls: /virtualmachines/9651vmgue...")
>>
>> |6294|9915:9651|new| ---- WARNING ----
>> |6294|9915:9651|new| 2010-09-08
>> 08:50:40|6294|9915:9651|new|vmware.pm:_vmwareclone(1457)|clone process
>> failed dstDisk /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk
>> does not exist
>> |6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
>> |6294|9915:9651|new| (-1) vmware.pm, _vmwareclone (line: 1457)
>> |6294|9915:9651|new| (-2) vmware.pm, load (line: 502)
>> |6294|9915:9651|new| (-3) new.pm, reload_image (line: 665)
>> |6294|9915:9651|new| (-4) new.pm, process (line: 266)
>> |6294|9915:9651|new| (-5) vcld, make_new_child (line: 594)
>> |6294|9915:9651|new| (-6) vcld, main (line: 341)
>>
>> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
>> insertloadlog(4710)|inserted
>> computer=107, failed, cloning base image failed
>> No recipient addresses found in header
>> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:mail(1348)|SUCCESS --
>> Sending mail To: , PROBLEM -- vmware.pm
>>
>> |6294|9915:9651|new| ---- CRITICAL ----
>> |6294|9915:9651|new| 2010-09-08
>> 08:50:40|6294|9915:9651|new|vmware.pm:load(508)|problem cloning failed
>> /virtualmachines/vmwarewinxp-build97-v1/vmwarewinxp-build97-v1.vmdk to
>> /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk
>> |6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
>> |6294|9915:9651|new| (-1) vmware.pm, load (line: 508)
>> |6294|9915:9651|new| (-2) new.pm, reload_image (line: 665)
>> |6294|9915:9651|new| (-3) new.pm, process (line: 266)
>> |6294|9915:9651|new| (-4) vcld, make_new_child (line: 594)
>> |6294|9915:9651|new| (-5) vcld, main (line: 341)
>>
>>
>> |6294|9915:9651|new| ---- WARNING ----
>> |6294|9915:9651|new| 2010-09-08
>> 08:50:40|6294|9915:9651|new|new.pm:
>> reload_image(670)|vmwarewinxp-build97-v1
>> failed to load on vmguest-104, returning
>> |6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
>> |6294|9915:9651|new| (-1) new.pm, reload_image (line: 670)
>> |6294|9915:9651|new| (-2) new.pm, process (line: 266)
>> |6294|9915:9651|new| (-3) vcld, make_new_child (line: 594)
>> |6294|9915:9651|new| (-4) vcld, main (line: 341)
>>
>> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
>> insertloadlog(4710)|inserted
>> computer=107, loadimagefailed, vmwarewinxp-build97-v1 failed to load
>> on vmguest-104
>>
>> |6294|9915:9651|new| ---- WARNING ----
>> |6294|9915:9651|new| 2010-09-08
>> 08:50:40|6294|9915:9651|new|new.pm:process(313)|failed to load
>> vmguest-104 with vmwarewinxp-build97-v1
>> |6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
>> |6294|9915:9651|new| (-1) new.pm, process (line: 313)
>> |6294|9915:9651|new| (-2) vcld, make_new_child (line: 594)
>> |6294|9915:9651|new| (-3) vcld, main (line: 341)
>>
>> 2010-09-08
>> 08:50:40|6294|9915:9651|new|DataStructure.pm:get_computer_state_name(1946)|attempting
>> to retrieve current state of computer vmguest-104 from the database
>> 2010-09-08
>> 08:50:40|6294|9915:9651|new|DataStructure.pm:get_computer_state_name(1977)|retrieved
>> current state of computer vmguest-104 from the database: reloading
>> 2010-09-08
>> 08:50:40|6294|9915:9651|new|DataStructure.pm:_automethod(697)|data
>> structure updated:
>> $self->request_data->{reservation}{9651}{computer}{state}{name}
>> |6294|9915:9651|new| computer_state_name = reloading
>> No recipient addresses found in header
>> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:mail(1348)|SUCCESS --
>> Sending mail To: , PROBLEM -- State.pm
>>
>> |6294|9915:9651|new| ---- CRITICAL ----
>> |6294|9915:9651|new| 2010-09-08
>> 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(290)|reservation
>> failed on vmguest-104: process failed after trying to load or make
>> available
>> |6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
>> |6294|9915:9651|new| (-1) State.pm, reservation_failed (line: 290)
>> |6294|9915:9651|new| (-2) new.pm, process (line: 316)
>> |6294|9915:9651|new| (-3) vcld, make_new_child (line: 594)
>> |6294|9915:9651|new| (-4) vcld, main (line: 341)
>>
>> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
>> insertloadlog(4710)|inserted
>> computer=107, failed, process failed after trying to load or make
>> available
>> 2010-09-08
>> 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(293)|inserted
>> computerloadlog entry
>> 2010-09-08
>> 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(301)|updated
>> log ending value to 'failed', logid=3483
>> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
>> update_computer_state(2228)|computer
>> 107 state updated to: failed
>> 2010-09-08
>> 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(312)|computer
>> vmguest-104 (107) state set to failed
>> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
>> update_request_state(2186)|request
>> 9915 state updated to: failed, laststate to: new
>> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(325)|set
>> request state to 'failed'/'new'
>> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
>> is_inblockrequest(6972)|zero
>> rows were returned from database select
>> 2010-09-08
>> 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(343)|vmguest-104
>> is NOT in blockcomputers table
>> 2010-09-08
>> 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(346)|exiting
>> 1
>> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(905)|destructor
>> called, ref($self)=VCL::new
>> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
>> delete_computerloadlog_reservation(7551)|removing
>> computerloadlog entries matching loadstate = begin
>> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
>> delete_computerloadlog_reservation(7598)|deleted
>> rows from computerloadlog for reservation id=9651
>> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(912)|removed
>> computerloadlog rows with loadstate=begin for reservation
>> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(924)|number of
>> database handles state process created: 1
>> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(933)|process
>> has a database handle stored in $ENV{dbh}, attempting disconnect
>> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(935)|$ENV{dbh}:
>> database disconnect successful
>> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(949)|VCL::new
>> process 6294 exiting
>> 2010-09-08 08:50:40|4994|vcld:REAPER(744)|VCL process exited for
>> reservation 9651
>> 2010-09-08 08:50:40|4994|vcld:main(165)|lastcheckin time updated for
>> management node 1: 2010-09-08 08:50:40
>>
>>
>> --
>> Thanks,
>> Alex Patterson
>> User Support Services
>> Operating System Analyst
>> California State University, East Bay
>>
>
>
--
Aaron Peeler
Program Manager
Virtual Computing Lab
NC State University
aaron_peeler@ncsu.edu
919-513-4571
Re: failed: cloning base image failed
Posted by Alexander Patterson <al...@csueastbay.edu>.
The solution to our problem was solve by Aaron
Thank you for fixing the code to work with our net storage we are using.
CSUEB uses NFS mounts on our NFS to storage our images, Thanks to Aaron for
modified vmware.pm.
vmware.pm is in /usr/local/vcl/lib/VCL/Module/Provisioning/
If anyone else runs into this issue, this is the solution
Thanks
-Alex
On Wed, Sep 8, 2010 at 8:55 AM, Alexander Patterson <
alexander.patterson@csueastbay.edu> wrote:
> Hello,
>
> Been having an issue with our system. We just added a few new blades
> and had our network team move over files to clone our blades so they
> work correct.
>
> I can't create images anymore. Normal operation works, but I can't
> update or create images currently.
>
> Here is the error code I am getting.
>
> I think that vmkfstools was deleted (I can't find it anywhere), but I
> only see that tool for ESX? Do we have this tool on the VCL web site?
> Or am I missing something else that is needed to make images?
>
>
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:run_ssh_command(6276)|SSH
> command executed on vclesx05, returning (0, "none")
> 2010-09-08 08:50:40|6294|9915:9651|new|vmware.pm:
> _vmwareclone(1426)|srcDisk
> is exists
> /virtualmachines/vmwarewinxp-build97-v1/vmwarewinxp-build97-v1.vmdk
> 2010-09-08 08:50:40|6294|9915:9651|new|vmware.pm:
> _vmwareclone(1427)|starting
> clone process vmkfstools -d thin -i
> /virtualmachines/vmwarewinxp-build97-v1/vmwarewinxp-build97-v1.vmdk
> /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
> run_ssh_command(6180)|executing
> SSH command on vclesx05:
> |6294|9915:9651|new| /usr/bin/ssh -i /etc/vcl/vcl.key -l root -p 22
> -x vclesx05 'ls -1
> /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk' 2>&1
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
> run_ssh_command(6262)|run_ssh_command
> output:
> |6294|9915:9651|new| ls:
> /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk: No such
> file or directory
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:run_ssh_command(6272)|SSH
> command executed on vclesx05, command:
> |6294|9915:9651|new| /usr/bin/ssh -i /etc/vcl/vcl.key -l root -p 22
> -x vclesx05 'ls -1
> /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk' 2>&1
> |6294|9915:9651|new| returning (2, "ls: /virtualmachines/9651vmgue...")
>
> |6294|9915:9651|new| ---- WARNING ----
> |6294|9915:9651|new| 2010-09-08
> 08:50:40|6294|9915:9651|new|vmware.pm:_vmwareclone(1457)|clone process
> failed dstDisk /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk
> does not exist
> |6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
> |6294|9915:9651|new| (-1) vmware.pm, _vmwareclone (line: 1457)
> |6294|9915:9651|new| (-2) vmware.pm, load (line: 502)
> |6294|9915:9651|new| (-3) new.pm, reload_image (line: 665)
> |6294|9915:9651|new| (-4) new.pm, process (line: 266)
> |6294|9915:9651|new| (-5) vcld, make_new_child (line: 594)
> |6294|9915:9651|new| (-6) vcld, main (line: 341)
>
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
> insertloadlog(4710)|inserted
> computer=107, failed, cloning base image failed
> No recipient addresses found in header
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:mail(1348)|SUCCESS --
> Sending mail To: , PROBLEM -- vmware.pm
>
> |6294|9915:9651|new| ---- CRITICAL ----
> |6294|9915:9651|new| 2010-09-08
> 08:50:40|6294|9915:9651|new|vmware.pm:load(508)|problem cloning failed
> /virtualmachines/vmwarewinxp-build97-v1/vmwarewinxp-build97-v1.vmdk to
> /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk
> |6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
> |6294|9915:9651|new| (-1) vmware.pm, load (line: 508)
> |6294|9915:9651|new| (-2) new.pm, reload_image (line: 665)
> |6294|9915:9651|new| (-3) new.pm, process (line: 266)
> |6294|9915:9651|new| (-4) vcld, make_new_child (line: 594)
> |6294|9915:9651|new| (-5) vcld, main (line: 341)
>
>
> |6294|9915:9651|new| ---- WARNING ----
> |6294|9915:9651|new| 2010-09-08
> 08:50:40|6294|9915:9651|new|new.pm:
> reload_image(670)|vmwarewinxp-build97-v1
> failed to load on vmguest-104, returning
> |6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
> |6294|9915:9651|new| (-1) new.pm, reload_image (line: 670)
> |6294|9915:9651|new| (-2) new.pm, process (line: 266)
> |6294|9915:9651|new| (-3) vcld, make_new_child (line: 594)
> |6294|9915:9651|new| (-4) vcld, main (line: 341)
>
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
> insertloadlog(4710)|inserted
> computer=107, loadimagefailed, vmwarewinxp-build97-v1 failed to load
> on vmguest-104
>
> |6294|9915:9651|new| ---- WARNING ----
> |6294|9915:9651|new| 2010-09-08
> 08:50:40|6294|9915:9651|new|new.pm:process(313)|failed to load
> vmguest-104 with vmwarewinxp-build97-v1
> |6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
> |6294|9915:9651|new| (-1) new.pm, process (line: 313)
> |6294|9915:9651|new| (-2) vcld, make_new_child (line: 594)
> |6294|9915:9651|new| (-3) vcld, main (line: 341)
>
> 2010-09-08
> 08:50:40|6294|9915:9651|new|DataStructure.pm:get_computer_state_name(1946)|attempting
> to retrieve current state of computer vmguest-104 from the database
> 2010-09-08
> 08:50:40|6294|9915:9651|new|DataStructure.pm:get_computer_state_name(1977)|retrieved
> current state of computer vmguest-104 from the database: reloading
> 2010-09-08
> 08:50:40|6294|9915:9651|new|DataStructure.pm:_automethod(697)|data
> structure updated:
> $self->request_data->{reservation}{9651}{computer}{state}{name}
> |6294|9915:9651|new| computer_state_name = reloading
> No recipient addresses found in header
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:mail(1348)|SUCCESS --
> Sending mail To: , PROBLEM -- State.pm
>
> |6294|9915:9651|new| ---- CRITICAL ----
> |6294|9915:9651|new| 2010-09-08
> 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(290)|reservation
> failed on vmguest-104: process failed after trying to load or make
> available
> |6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
> |6294|9915:9651|new| (-1) State.pm, reservation_failed (line: 290)
> |6294|9915:9651|new| (-2) new.pm, process (line: 316)
> |6294|9915:9651|new| (-3) vcld, make_new_child (line: 594)
> |6294|9915:9651|new| (-4) vcld, main (line: 341)
>
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
> insertloadlog(4710)|inserted
> computer=107, failed, process failed after trying to load or make
> available
> 2010-09-08
> 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(293)|inserted
> computerloadlog entry
> 2010-09-08
> 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(301)|updated
> log ending value to 'failed', logid=3483
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
> update_computer_state(2228)|computer
> 107 state updated to: failed
> 2010-09-08
> 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(312)|computer
> vmguest-104 (107) state set to failed
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
> update_request_state(2186)|request
> 9915 state updated to: failed, laststate to: new
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(325)|set
> request state to 'failed'/'new'
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
> is_inblockrequest(6972)|zero
> rows were returned from database select
> 2010-09-08
> 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(343)|vmguest-104
> is NOT in blockcomputers table
> 2010-09-08
> 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(346)|exiting
> 1
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(905)|destructor
> called, ref($self)=VCL::new
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
> delete_computerloadlog_reservation(7551)|removing
> computerloadlog entries matching loadstate = begin
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
> delete_computerloadlog_reservation(7598)|deleted
> rows from computerloadlog for reservation id=9651
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(912)|removed
> computerloadlog rows with loadstate=begin for reservation
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(924)|number of
> database handles state process created: 1
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(933)|process
> has a database handle stored in $ENV{dbh}, attempting disconnect
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(935)|$ENV{dbh}:
> database disconnect successful
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(949)|VCL::new
> process 6294 exiting
> 2010-09-08 08:50:40|4994|vcld:REAPER(744)|VCL process exited for
> reservation 9651
> 2010-09-08 08:50:40|4994|vcld:main(165)|lastcheckin time updated for
> management node 1: 2010-09-08 08:50:40
>
>
> --
> Thanks,
> Alex Patterson
> User Support Services
> Operating System Analyst
> California State University, East Bay
>
--
Thanks,
Alex Patterson
User Support Services
Operating System Analyst
California State University, East Bay
Re: failed: cloning base image failed
Posted by Alexander Patterson <al...@csueastbay.edu>.
Hello Andy,
We are using the VCL 2.1 that is currently out with the GSX viewer 1.9 the
same as NC state is currently using.
I am not current able to create images, or update current images.
I can check out images just fine, but the creation or modify options all
result in the same type of errors.
And for your other question, I wanted to know, did you still want me to
install VMware vSphere Perl SDK?
StateEst/Act
TimeTotal
Timeconfirming image exists(22)0:04/0:070:07starting load process(40)0:06/
0:240:31transferring image files to host server(27)4:15/0:150:46
failed: cloning base image failed
I am still getting the same Image Clone Error
When I go to create an image or update an images, I see the system create a
new folder at
/nfs/images/vmware/virtualmachines/10547vmguest-50
But it's empty and nothing ever gets loaded into it.
We have mapped our NFS mounts with the
/nfs/images/vmware/virtualmachines/10547vmguest-50 going to
/virtualmachines/ that goes to the same directory and both show the same
current images that are working.
See the Log Below
|10521|10811:10547|new|
/virtualmachines/vmwarewinxp-CSUXPbuild105-v0/vmwarewinxp-CSUXPbuild105-v0.vmdk
2010-09-13 10:58:53|10521|10811:10547|new|utils.pm:run_ssh_command(6276)|SSH
command executed on vclesx05, returning (0,
"/virtualmachines/vmwarewinxp-C...")
2010-09-13 10:58:53|10521|10811:10547|new|vmware.pm:
_vmwareclone(1420)|/virtualmachines/vmwarewinxp-CSUXPbuild105-v0/vmwarewinxp-CSUXPbuild105-v0.vmdk
2010-09-13 10:58:53|10521|10811:10547|new|utils.pm:run_ssh_command(6180)|executing
SSH command on vclesx05:
|10521|10811:10547|new| /usr/bin/ssh -i /etc/vcl/vcl.key -l root -p 22 -x
vclesx05 'mkdir -m 755 /virtualmachines/10547vmguest-50' 2>&1
2010-09-13 10:58:54|10521|10811:10547|new|utils.pm:run_ssh_command(6262)|run_ssh_command
output:
|10521|10811:10547|new| none
2010-09-13 10:58:54|10521|10811:10547|new|utils.pm:run_ssh_command(6276)|SSH
command executed on vclesx05, returning (0, "none")
2010-09-13 10:58:54|10521|10811:10547|new|vmware.pm:_vmwareclone(1426)|srcDisk
is exists
/virtualmachines/vmwarewinxp-CSUXPbuild105-v0/vmwarewinxp-CSUXPbuild105-v0.vmdk
2010-09-13 10:58:54|10521|10811:10547|new|vmware.pm:_vmwareclone(1427)|starting
clone process vmkfstools -d thin -i
/virtualmachines/vmwarewinxp-CSUXPbuild105-v0/vmwarewinxp-CSUXPbuild105-v0.vmdk
/virtualmachines/10547vmguest-50/vmwarewinxp-CSUXPbuild105-v0.vmdk
2010-09-13 10:58:54|10521|10811:10547|new|utils.pm:run_ssh_command(6180)|executing
SSH command on vclesx05:
|10521|10811:10547|new| /usr/bin/ssh -i /etc/vcl/vcl.key -l root -p 22 -x
vclesx05 'ls -1
/virtualmachines/10547vmguest-50/vmwarewinxp-CSUXPbuild105-v0.vmdk' 2>&1
2010-09-13 10:58:54|10521|10811:10547|new|utils.pm:run_ssh_command(6262)|run_ssh_command
output:
|10521|10811:10547|new| ls:
/virtualmachines/10547vmguest-50/vmwarewinxp-CSUXPbuild105-v0.vmdk: No such
file or directory
2010-09-13 10:58:54|10521|10811:10547|new|utils.pm:run_ssh_command(6272)|SSH
command executed on vclesx05, command:
|10521|10811:10547|new| /usr/bin/ssh -i /etc/vcl/vcl.key -l root -p 22 -x
vclesx05 'ls -1
/virtualmachines/10547vmguest-50/vmwarewinxp-CSUXPbuild105-v0.vmdk' 2>&1
|10521|10811:10547|new| returning (2, "ls: /virtualmachines/10547vmgu...")
|10521|10811:10547|new| ---- WARNING ----
|10521|10811:10547|new| 2010-09-13
10:58:54|10521|10811:10547|new|vmware.pm:_vmwareclone(1457)|clone
process failed dstDisk
/virtualmachines/10547vmguest-50/vmwarewinxp-CSUXPbuild105-v0.vmdk does not
exist
|10521|10811:10547|new| ( 0) utils.pm, notify (line: 737)
|10521|10811:10547|new| (-1) vmware.pm, _vmwareclone (line: 1457)
|10521|10811:10547|new| (-2) vmware.pm, load (line: 502)
|10521|10811:10547|new| (-3) new.pm, reload_image (line: 665)
|10521|10811:10547|new| (-4) new.pm, process (line: 266)
|10521|10811:10547|new| (-5) vcld, make_new_child (line: 594)
|10521|10811:10547|new| (-6) vcld, main (line: 341)
2010-09-13 10:58:54|10521|10811:10547|new|utils.pm:insertloadlog(4710)|inserted
computer=54, failed, cloning base image failed
No recipient addresses found in header
2010-09-13 10:58:54|10521|10811:10547|new|utils.pm:mail(1348)|SUCCESS --
Sending mail To: , PROBLEM -- vmware.pm
|10521|10811:10547|new| ---- CRITICAL ----
|10521|10811:10547|new| 2010-09-13
10:58:54|10521|10811:10547|new|vmware.pm:load(508)|problem
cloning failed
/virtualmachines/vmwarewinxp-CSUXPbuild105-v0/vmwarewinxp-CSUXPbuild105-v0.vmdk
to /virtualmachines/10547vmguest-50/vmwarewinxp-CSUXPbuild105-v0.vmdk
|10521|10811:10547|new| ( 0) utils.pm, notify (line: 737)
|10521|10811:10547|new| (-1) vmware.pm, load (line: 508)
|10521|10811:10547|new| (-2) new.pm, reload_image (line: 665)
|10521|10811:10547|new| (-3) new.pm, process (line: 266)
|10521|10811:10547|new| (-4) vcld, make_new_child (line: 594)
|10521|10811:10547|new| (-5) vcld, main (line: 341)
|10521|10811:10547|new| ---- WARNING ----
|10521|10811:10547|new| 2010-09-13
10:58:54|10521|10811:10547|new|new.pm:reload_image(670)|vmwarewinxp-CSUXPbuild105-v0
failed to load on vmguest-50, returning
|10521|10811:10547|new| ( 0) utils.pm, notify (line: 737)
|10521|10811:10547|new| (-1) new.pm, reload_image (line: 670)
|10521|10811:10547|new| (-2) new.pm, process (line: 266)
|10521|10811:10547|new| (-3) vcld, make_new_child (line: 594)
|10521|10811:10547|new| (-4) vcld, main (line: 341)
2010-09-13 10:58:54|10521|10811:10547|new|utils.pm:insertloadlog(4710)|inserted
computer=54, loadimagefailed, vmwarewinxp-CSUXPbuild105-v0 failed to load on
vmguest-50
|10521|10811:10547|new| ---- WARNING ----
|10521|10811:10547|new| 2010-09-13
10:58:54|10521|10811:10547|new|new.pm:process(313)|failed
to load vmguest-50 with vmwarewinxp-CSUXPbuild105-v0
|10521|10811:10547|new| ( 0) utils.pm, notify (line: 737)
|10521|10811:10547|new| (-1) new.pm, process (line: 313)
|10521|10811:10547|new| (-2) vcld, make_new_child (line: 594)
|10521|10811:10547|new| (-3) vcld, main (line: 341)
2010-09-13
10:58:54|10521|10811:10547|new|DataStructure.pm:get_computer_state_name(1946)|attempting
to retrieve current state of computer vmguest-50 from the database
2010-09-13
10:58:54|10521|10811:10547|new|DataStructure.pm:get_computer_state_name(1977)|retrieved
current state of computer vmguest-50 from the database: reloading
2010-09-13
10:58:54|10521|10811:10547|new|DataStructure.pm:_automethod(697)|data
structure updated:
$self->request_data->{reservation}{10547}{computer}{state}{name}
|10521|10811:10547|new| computer_state_name = reloading
No recipient addresses found in header
2010-09-13 10:58:54|10521|10811:10547|new|utils.pm:mail(1348)|SUCCESS --
Sending mail To: , PROBLEM -- State.pm
|10521|10811:10547|new| ---- CRITICAL ----
|10521|10811:10547|new| 2010-09-13
10:58:54|10521|10811:10547|new|State.pm:reservation_failed(290)|reservation
failed on vmguest-50: process failed after trying to load or make available
|10521|10811:10547|new| ( 0) utils.pm, notify (line: 737)
|10521|10811:10547|new| (-1) State.pm, reservation_failed (line: 290)
|10521|10811:10547|new| (-2) new.pm, process (line: 316)
|10521|10811:10547|new| (-3) vcld, make_new_child (line: 594)
|10521|10811:10547|new| (-4) vcld, main (line: 341)
2010-09-13 10:58:54|10521|10811:10547|new|utils.pm:insertloadlog(4710)|inserted
computer=54, failed, process failed after trying to load or make available
2010-09-13
10:58:54|10521|10811:10547|new|State.pm:reservation_failed(293)|inserted
computerloadlog entry
2010-09-13
10:58:54|10521|10811:10547|new|State.pm:reservation_failed(301)|updated log
ending value to 'failed', logid=3770
2010-09-13 10:58:54|10521|10811:10547|new|utils.pm:update_computer_state(2228)|computer
54 state updated to: failed
2010-09-13
10:58:54|10521|10811:10547|new|State.pm:reservation_failed(312)|computer
vmguest-50 (54) state set to failed
2010-09-13 10:58:54|10521|10811:10547|new|utils.pm:update_request_state(2186)|request
10811 state updated to: failed, laststate to: new
2010-09-13
10:58:54|10521|10811:10547|new|State.pm:reservation_failed(325)|set request
state to 'failed'/'new'
2010-09-13 10:58:54|10521|10811:10547|new|utils.pm:is_inblockrequest(6972)|zero
rows were returned from database select
2010-09-13
10:58:54|10521|10811:10547|new|State.pm:reservation_failed(343)|vmguest-50
is NOT in blockcomputers table
2010-09-13
10:58:54|10521|10811:10547|new|State.pm:reservation_failed(346)|exiting 1
2010-09-13 10:58:54|10521|10811:10547|new|State.pm:DESTROY(905)|destructor
called, ref($self)=VCL::new
2010-09-13 10:58:54|10521|10811:10547|new|utils.pm:delete_computerloadlog_reservation(7551)|removing
computerloadlog entries matching loadstate = begin
2010-09-13 10:58:54|10521|10811:10547|new|utils.pm:delete_computerloadlog_reservation(7598)|deleted
rows from computerloadlog for reservation id=10547
2010-09-13 10:58:54|10521|10811:10547|new|State.pm:DESTROY(912)|removed
computerloadlog rows with loadstate=begin for reservation
2010-09-13 10:58:54|10521|10811:10547|new|State.pm:DESTROY(924)|number of
database handles state process created: 1
2010-09-13 10:58:54|10521|10811:10547|new|State.pm:DESTROY(933)|process has
a database handle stored in $ENV{dbh}, attempting disconnect
2010-09-13 10:58:54|10521|10811:10547|new|State.pm:DESTROY(935)|$ENV{dbh}:
database disconnect successful
2010-09-13 10:58:54|10521|10811:10547|new|State.pm:DESTROY(949)|VCL::new
process 10521 exiting
2010-09-13 10:58:54|12153|vcld:REAPER(744)|VCL process exited for
reservation 10547
2010-09-13 10:58:54|12153|vcld:main(165)|lastcheckin time updated for
management node 1: 2010-09-13 10:58:54
2010-09-13 10:58:55|9166|10810:10546|new|utils.pm:run_ssh_command(6262)|run_ssh_command
output:
On Wed, Sep 8, 2010 at 5:48 PM, Andy Kurth <an...@ncsu.edu> wrote:
> Which version of VMware are you running on these blades? You could try to
> download and install the VMware vSphere Perl SDK on a host having this
> problem. I know vmkfstools gets installed when I install the SDK on a
> VMware Server 2.0 host. If this doesn't work you could try updating the
> host to reinstall the files with the host update utility that can be
> installed with the Windows vSphere Client.
>
> -Andy
>
>
> Alexander Patterson wrote:
>
>> Hello,
>>
>> Been having an issue with our system. We just added a few new blades
>> and had our network team move over files to clone our blades so they
>> work correct.
>>
>> I can't create images anymore. Normal operation works, but I can't
>> update or create images currently.
>>
>> Here is the error code I am getting.
>>
>> I think that vmkfstools was deleted (I can't find it anywhere), but I
>> only see that tool for ESX? Do we have this tool on the VCL web site?
>> Or am I missing something else that is needed to make images?
>>
>>
>> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:run_ssh_command(6276)|SSH
>> command executed on vclesx05, returning (0, "none")
>> 2010-09-08 08:50:40|6294|9915:9651|new|vmware.pm:
>> _vmwareclone(1426)|srcDisk
>> is exists
>> /virtualmachines/vmwarewinxp-build97-v1/vmwarewinxp-build97-v1.vmdk
>> 2010-09-08 08:50:40|6294|9915:9651|new|vmware.pm:
>> _vmwareclone(1427)|starting
>> clone process vmkfstools -d thin -i
>> /virtualmachines/vmwarewinxp-build97-v1/vmwarewinxp-build97-v1.vmdk
>> /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk
>> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
>> run_ssh_command(6180)|executing
>> SSH command on vclesx05:
>> |6294|9915:9651|new| /usr/bin/ssh -i /etc/vcl/vcl.key -l root -p 22
>> -x vclesx05 'ls -1
>> /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk' 2>&1
>> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
>> run_ssh_command(6262)|run_ssh_command
>> output:
>> |6294|9915:9651|new| ls:
>> /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk: No such
>> file or directory
>> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:run_ssh_command(6272)|SSH
>> command executed on vclesx05, command:
>> |6294|9915:9651|new| /usr/bin/ssh -i /etc/vcl/vcl.key -l root -p 22
>> -x vclesx05 'ls -1
>> /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk' 2>&1
>> |6294|9915:9651|new| returning (2, "ls: /virtualmachines/9651vmgue...")
>>
>> |6294|9915:9651|new| ---- WARNING ----
>> |6294|9915:9651|new| 2010-09-08
>> 08:50:40|6294|9915:9651|new|vmware.pm:_vmwareclone(1457)|clone process
>> failed dstDisk
>> /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk
>> does not exist
>> |6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
>> |6294|9915:9651|new| (-1) vmware.pm, _vmwareclone (line: 1457)
>> |6294|9915:9651|new| (-2) vmware.pm, load (line: 502)
>> |6294|9915:9651|new| (-3) new.pm, reload_image (line: 665)
>> |6294|9915:9651|new| (-4) new.pm, process (line: 266)
>> |6294|9915:9651|new| (-5) vcld, make_new_child (line: 594)
>> |6294|9915:9651|new| (-6) vcld, main (line: 341)
>>
>> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
>> insertloadlog(4710)|inserted
>> computer=107, failed, cloning base image failed
>> No recipient addresses found in header
>> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:mail(1348)|SUCCESS --
>> Sending mail To: , PROBLEM -- vmware.pm
>>
>> |6294|9915:9651|new| ---- CRITICAL ----
>> |6294|9915:9651|new| 2010-09-08
>> 08:50:40|6294|9915:9651|new|vmware.pm:load(508)|problem cloning failed
>> /virtualmachines/vmwarewinxp-build97-v1/vmwarewinxp-build97-v1.vmdk to
>> /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk
>> |6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
>> |6294|9915:9651|new| (-1) vmware.pm, load (line: 508)
>> |6294|9915:9651|new| (-2) new.pm, reload_image (line: 665)
>> |6294|9915:9651|new| (-3) new.pm, process (line: 266)
>> |6294|9915:9651|new| (-4) vcld, make_new_child (line: 594)
>> |6294|9915:9651|new| (-5) vcld, main (line: 341)
>>
>>
>> |6294|9915:9651|new| ---- WARNING ----
>> |6294|9915:9651|new| 2010-09-08
>> 08:50:40|6294|9915:9651|new|new.pm:
>> reload_image(670)|vmwarewinxp-build97-v1
>> failed to load on vmguest-104, returning
>> |6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
>> |6294|9915:9651|new| (-1) new.pm, reload_image (line: 670)
>> |6294|9915:9651|new| (-2) new.pm, process (line: 266)
>> |6294|9915:9651|new| (-3) vcld, make_new_child (line: 594)
>> |6294|9915:9651|new| (-4) vcld, main (line: 341)
>>
>> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
>> insertloadlog(4710)|inserted
>> computer=107, loadimagefailed, vmwarewinxp-build97-v1 failed to load
>> on vmguest-104
>>
>> |6294|9915:9651|new| ---- WARNING ----
>> |6294|9915:9651|new| 2010-09-08
>> 08:50:40|6294|9915:9651|new|new.pm:process(313)|failed to load
>> vmguest-104 with vmwarewinxp-build97-v1
>> |6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
>> |6294|9915:9651|new| (-1) new.pm, process (line: 313)
>> |6294|9915:9651|new| (-2) vcld, make_new_child (line: 594)
>> |6294|9915:9651|new| (-3) vcld, main (line: 341)
>>
>> 2010-09-08
>> 08:50:40|6294|9915:9651|new|DataStructure.pm:get_computer_state_name(1946)|attempting
>> to retrieve current state of computer vmguest-104 from the database
>> 2010-09-08
>> 08:50:40|6294|9915:9651|new|DataStructure.pm:get_computer_state_name(1977)|retrieved
>> current state of computer vmguest-104 from the database: reloading
>> 2010-09-08
>> 08:50:40|6294|9915:9651|new|DataStructure.pm:_automethod(697)|data
>> structure updated:
>> $self->request_data->{reservation}{9651}{computer}{state}{name}
>> |6294|9915:9651|new| computer_state_name = reloading
>> No recipient addresses found in header
>> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:mail(1348)|SUCCESS --
>> Sending mail To: , PROBLEM -- State.pm
>>
>> |6294|9915:9651|new| ---- CRITICAL ----
>> |6294|9915:9651|new| 2010-09-08
>> 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(290)|reservation
>> failed on vmguest-104: process failed after trying to load or make
>> available
>> |6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
>> |6294|9915:9651|new| (-1) State.pm, reservation_failed (line: 290)
>> |6294|9915:9651|new| (-2) new.pm, process (line: 316)
>> |6294|9915:9651|new| (-3) vcld, make_new_child (line: 594)
>> |6294|9915:9651|new| (-4) vcld, main (line: 341)
>>
>> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
>> insertloadlog(4710)|inserted
>> computer=107, failed, process failed after trying to load or make
>> available
>> 2010-09-08
>> 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(293)|inserted
>> computerloadlog entry
>> 2010-09-08
>> 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(301)|updated
>> log ending value to 'failed', logid=3483
>> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
>> update_computer_state(2228)|computer
>> 107 state updated to: failed
>> 2010-09-08
>> 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(312)|computer
>> vmguest-104 (107) state set to failed
>> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
>> update_request_state(2186)|request
>> 9915 state updated to: failed, laststate to: new
>> 2010-09-08
>> 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(325)|set
>> request state to 'failed'/'new'
>> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
>> is_inblockrequest(6972)|zero
>> rows were returned from database select
>> 2010-09-08
>> 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(343)|vmguest-104
>> is NOT in blockcomputers table
>> 2010-09-08
>> 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(346)|exiting
>> 1
>> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(905)|destructor
>> called, ref($self)=VCL::new
>> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
>> delete_computerloadlog_reservation(7551)|removing
>> computerloadlog entries matching loadstate = begin
>> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:
>> delete_computerloadlog_reservation(7598)|deleted
>> rows from computerloadlog for reservation id=9651
>> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(912)|removed
>> computerloadlog rows with loadstate=begin for reservation
>> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(924)|number of
>> database handles state process created: 1
>> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(933)|process
>> has a database handle stored in $ENV{dbh}, attempting disconnect
>> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(935)|$ENV{dbh}:
>> database disconnect successful
>> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(949)|VCL::new
>> process 6294 exiting
>> 2010-09-08 08:50:40|4994|vcld:REAPER(744)|VCL process exited for
>> reservation 9651
>> 2010-09-08 08:50:40|4994|vcld:main(165)|lastcheckin time updated for
>> management node 1: 2010-09-08 08:50:40
>>
>>
>>
--
Thanks,
Alex Patterson
User Support Services
Operating System Analyst
California State University, East Bay
Re: failed: cloning base image failed
Posted by Andy Kurth <an...@ncsu.edu>.
Which version of VMware are you running on these blades? You could try
to download and install the VMware vSphere Perl SDK on a host having
this problem. I know vmkfstools gets installed when I install the SDK
on a VMware Server 2.0 host. If this doesn't work you could try
updating the host to reinstall the files with the host update utility
that can be installed with the Windows vSphere Client.
-Andy
Alexander Patterson wrote:
> Hello,
>
> Been having an issue with our system. We just added a few new blades
> and had our network team move over files to clone our blades so they
> work correct.
>
> I can't create images anymore. Normal operation works, but I can't
> update or create images currently.
>
> Here is the error code I am getting.
>
> I think that vmkfstools was deleted (I can't find it anywhere), but I
> only see that tool for ESX? Do we have this tool on the VCL web site?
> Or am I missing something else that is needed to make images?
>
>
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:run_ssh_command(6276)|SSH
> command executed on vclesx05, returning (0, "none")
> 2010-09-08 08:50:40|6294|9915:9651|new|vmware.pm:_vmwareclone(1426)|srcDisk
> is exists /virtualmachines/vmwarewinxp-build97-v1/vmwarewinxp-build97-v1.vmdk
> 2010-09-08 08:50:40|6294|9915:9651|new|vmware.pm:_vmwareclone(1427)|starting
> clone process vmkfstools -d thin -i
> /virtualmachines/vmwarewinxp-build97-v1/vmwarewinxp-build97-v1.vmdk
> /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:run_ssh_command(6180)|executing
> SSH command on vclesx05:
> |6294|9915:9651|new| /usr/bin/ssh -i /etc/vcl/vcl.key -l root -p 22
> -x vclesx05 'ls -1
> /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk' 2>&1
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:run_ssh_command(6262)|run_ssh_command
> output:
> |6294|9915:9651|new| ls:
> /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk: No such
> file or directory
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:run_ssh_command(6272)|SSH
> command executed on vclesx05, command:
> |6294|9915:9651|new| /usr/bin/ssh -i /etc/vcl/vcl.key -l root -p 22
> -x vclesx05 'ls -1
> /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk' 2>&1
> |6294|9915:9651|new| returning (2, "ls: /virtualmachines/9651vmgue...")
>
> |6294|9915:9651|new| ---- WARNING ----
> |6294|9915:9651|new| 2010-09-08
> 08:50:40|6294|9915:9651|new|vmware.pm:_vmwareclone(1457)|clone process
> failed dstDisk /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk
> does not exist
> |6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
> |6294|9915:9651|new| (-1) vmware.pm, _vmwareclone (line: 1457)
> |6294|9915:9651|new| (-2) vmware.pm, load (line: 502)
> |6294|9915:9651|new| (-3) new.pm, reload_image (line: 665)
> |6294|9915:9651|new| (-4) new.pm, process (line: 266)
> |6294|9915:9651|new| (-5) vcld, make_new_child (line: 594)
> |6294|9915:9651|new| (-6) vcld, main (line: 341)
>
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:insertloadlog(4710)|inserted
> computer=107, failed, cloning base image failed
> No recipient addresses found in header
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:mail(1348)|SUCCESS --
> Sending mail To: , PROBLEM -- vmware.pm
>
> |6294|9915:9651|new| ---- CRITICAL ----
> |6294|9915:9651|new| 2010-09-08
> 08:50:40|6294|9915:9651|new|vmware.pm:load(508)|problem cloning failed
> /virtualmachines/vmwarewinxp-build97-v1/vmwarewinxp-build97-v1.vmdk to
> /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk
> |6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
> |6294|9915:9651|new| (-1) vmware.pm, load (line: 508)
> |6294|9915:9651|new| (-2) new.pm, reload_image (line: 665)
> |6294|9915:9651|new| (-3) new.pm, process (line: 266)
> |6294|9915:9651|new| (-4) vcld, make_new_child (line: 594)
> |6294|9915:9651|new| (-5) vcld, main (line: 341)
>
>
> |6294|9915:9651|new| ---- WARNING ----
> |6294|9915:9651|new| 2010-09-08
> 08:50:40|6294|9915:9651|new|new.pm:reload_image(670)|vmwarewinxp-build97-v1
> failed to load on vmguest-104, returning
> |6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
> |6294|9915:9651|new| (-1) new.pm, reload_image (line: 670)
> |6294|9915:9651|new| (-2) new.pm, process (line: 266)
> |6294|9915:9651|new| (-3) vcld, make_new_child (line: 594)
> |6294|9915:9651|new| (-4) vcld, main (line: 341)
>
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:insertloadlog(4710)|inserted
> computer=107, loadimagefailed, vmwarewinxp-build97-v1 failed to load
> on vmguest-104
>
> |6294|9915:9651|new| ---- WARNING ----
> |6294|9915:9651|new| 2010-09-08
> 08:50:40|6294|9915:9651|new|new.pm:process(313)|failed to load
> vmguest-104 with vmwarewinxp-build97-v1
> |6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
> |6294|9915:9651|new| (-1) new.pm, process (line: 313)
> |6294|9915:9651|new| (-2) vcld, make_new_child (line: 594)
> |6294|9915:9651|new| (-3) vcld, main (line: 341)
>
> 2010-09-08 08:50:40|6294|9915:9651|new|DataStructure.pm:get_computer_state_name(1946)|attempting
> to retrieve current state of computer vmguest-104 from the database
> 2010-09-08 08:50:40|6294|9915:9651|new|DataStructure.pm:get_computer_state_name(1977)|retrieved
> current state of computer vmguest-104 from the database: reloading
> 2010-09-08 08:50:40|6294|9915:9651|new|DataStructure.pm:_automethod(697)|data
> structure updated:
> $self->request_data->{reservation}{9651}{computer}{state}{name}
> |6294|9915:9651|new| computer_state_name = reloading
> No recipient addresses found in header
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:mail(1348)|SUCCESS --
> Sending mail To: , PROBLEM -- State.pm
>
> |6294|9915:9651|new| ---- CRITICAL ----
> |6294|9915:9651|new| 2010-09-08
> 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(290)|reservation
> failed on vmguest-104: process failed after trying to load or make
> available
> |6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
> |6294|9915:9651|new| (-1) State.pm, reservation_failed (line: 290)
> |6294|9915:9651|new| (-2) new.pm, process (line: 316)
> |6294|9915:9651|new| (-3) vcld, make_new_child (line: 594)
> |6294|9915:9651|new| (-4) vcld, main (line: 341)
>
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:insertloadlog(4710)|inserted
> computer=107, failed, process failed after trying to load or make
> available
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(293)|inserted
> computerloadlog entry
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(301)|updated
> log ending value to 'failed', logid=3483
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:update_computer_state(2228)|computer
> 107 state updated to: failed
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(312)|computer
> vmguest-104 (107) state set to failed
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:update_request_state(2186)|request
> 9915 state updated to: failed, laststate to: new
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(325)|set
> request state to 'failed'/'new'
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:is_inblockrequest(6972)|zero
> rows were returned from database select
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(343)|vmguest-104
> is NOT in blockcomputers table
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(346)|exiting
> 1
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(905)|destructor
> called, ref($self)=VCL::new
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:delete_computerloadlog_reservation(7551)|removing
> computerloadlog entries matching loadstate = begin
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:delete_computerloadlog_reservation(7598)|deleted
> rows from computerloadlog for reservation id=9651
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(912)|removed
> computerloadlog rows with loadstate=begin for reservation
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(924)|number of
> database handles state process created: 1
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(933)|process
> has a database handle stored in $ENV{dbh}, attempting disconnect
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(935)|$ENV{dbh}:
> database disconnect successful
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(949)|VCL::new
> process 6294 exiting
> 2010-09-08 08:50:40|4994|vcld:REAPER(744)|VCL process exited for
> reservation 9651
> 2010-09-08 08:50:40|4994|vcld:main(165)|lastcheckin time updated for
> management node 1: 2010-09-08 08:50:40
>
>
Re: failed: cloning base image failed
Posted by Alexander Patterson <al...@csueastbay.edu>.
I loaded up Vmware
I can SSH into this image without a password, but when I go to create
a new image in the VCL web page
State Est/Act
Time Total
Time
confirming image exists(22) 0:04/0:05 0:05
starting load process(40) 0:06/0:04 0:09
transferring image files to host server(27) 4:15/0:05 0:14
failed: cloning base image failed
Here is the longer error log (Same problem different Image)
2010-09-08 13:05:57|16896|10092:9828|new|utils.pm:insertloadlog(4710)|inserted
computer=44, info, image files do not exist on host server, preparing
to copy
2010-09-08 13:05:57|16896|10092:9828|new|vmware.pm:load(360)|file size
5605908 of vmwarewinxp-CSUXPbuild105-v0
2010-09-08 13:05:57|16896|10092:9828|new|vmware.pm:load(361)|checking
space on vclesx04 /virtualmachines
2010-09-08 13:05:57|16896|10092:9828|new|utils.pm:run_ssh_command(6180)|executing
SSH command on vclesx04:
|16896|10092:9828|new| /usr/bin/ssh -i /etc/vcl/vcl.key -l root -p 22
-x vclesx04 'df -k /virtualmachines' 2>&1
2010-09-08 13:05:57|16896|10092:9828|new|utils.pm:run_ssh_command(6262)|run_ssh_command
output:
|16896|10092:9828|new| Filesystem 1K-blocks Used Available Use% Mounted on
|16896|10092:9828|new| netappfiler02:/vol/sata1/virtualmachines
|16896|10092:9828|new| 5610301032 1319022320 4291278712 24% /virtualmachines
2010-09-08 13:05:57|16896|10092:9828|new|utils.pm:run_ssh_command(6276)|SSH
command executed on vclesx04, returning (0, "Filesystem 1K-blocks Used
Avai...")
2010-09-08 13:05:57|16896|10092:9828|new|utils.pm:run_ssh_command(6180)|executing
SSH command on vclesx04:
|16896|10092:9828|new| /usr/bin/ssh -i /etc/vcl/vcl.key -l root -p 22
-x vclesx04 'ls -1
/virtualmachines/vmwarewinxp-CSUXPbuild105-v0/vmwarewinxp-CSUXPbuild105-v0.vmdk'
2>&1
2010-09-08 13:05:57|16896|10092:9828|new|utils.pm:run_ssh_command(6262)|run_ssh_command
output:
|16896|10092:9828|new|
/virtualmachines/vmwarewinxp-CSUXPbuild105-v0/vmwarewinxp-CSUXPbuild105-v0.vmdk
2010-09-08 13:05:57|16896|10092:9828|new|utils.pm:run_ssh_command(6276)|SSH
command executed on vclesx04, returning (0,
"/virtualmachines/vmwarewinxp-C...")
2010-09-08 13:05:57|16896|10092:9828|new|vmware.pm:_vmwareclone(1420)|/virtualmachines/vmwarewinxp-CSUXPbuild105-v0/vmwarewinxp-CSUXPbuild105-v0.vmdk
2010-09-08 13:05:57|16896|10092:9828|new|utils.pm:run_ssh_command(6180)|executing
SSH command on vclesx04:
|16896|10092:9828|new| /usr/bin/ssh -i /etc/vcl/vcl.key -l root -p 22
-x vclesx04 'mkdir -m 755 /virtualmachines/9828vmguest-40' 2>&1
2010-09-08 13:05:58|16896|10092:9828|new|utils.pm:run_ssh_command(6262)|run_ssh_command
output:
|16896|10092:9828|new| none
2010-09-08 13:05:58|16896|10092:9828|new|utils.pm:run_ssh_command(6276)|SSH
command executed on vclesx04, returning (0, "none")
2010-09-08 13:05:58|16896|10092:9828|new|vmware.pm:_vmwareclone(1426)|srcDisk
is exists /virtualmachines/vmwarewinxp-CSUXPbuild105-v0/vmwarewinxp-CSUXPbuild105-v0.vmdk
2010-09-08 13:05:58|16896|10092:9828|new|vmware.pm:_vmwareclone(1427)|starting
clone process vmkfstools -d thin -i
/virtualmachines/vmwarewinxp-CSUXPbuild105-v0/vmwarewinxp-CSUXPbuild105-v0.vmdk
/virtualmachines/9828vmguest-40/vmwarewinxp-CSUXPbuild105-v0.vmdk
2010-09-08 13:05:58|16896|10092:9828|new|utils.pm:run_ssh_command(6180)|executing
SSH command on vclesx04:
|16896|10092:9828|new| /usr/bin/ssh -i /etc/vcl/vcl.key -l root -p 22
-x vclesx04 'ls -1
/virtualmachines/9828vmguest-40/vmwarewinxp-CSUXPbuild105-v0.vmdk'
2>&1
2010-09-08 13:06:01|4994|vcld:main(165)|lastcheckin time updated for
management node 1: 2010-09-08 13:06:01
2010-09-08 13:06:01|16896|10092:9828|new|utils.pm:run_ssh_command(6262)|run_ssh_command
output:
|16896|10092:9828|new| ls:
/virtualmachines/9828vmguest-40/vmwarewinxp-CSUXPbuild105-v0.vmdk: No
such file or directory
2010-09-08 13:06:01|16896|10092:9828|new|utils.pm:run_ssh_command(6272)|SSH
command executed on vclesx04, command:
|16896|10092:9828|new| /usr/bin/ssh -i /etc/vcl/vcl.key -l root -p 22
-x vclesx04 'ls -1
/virtualmachines/9828vmguest-40/vmwarewinxp-CSUXPbuild105-v0.vmdk'
2>&1
|16896|10092:9828|new| returning (2, "ls: /virtualmachines/9828vmgue...")
|16896|10092:9828|new| ---- WARNING ----
|16896|10092:9828|new| 2010-09-08
13:06:01|16896|10092:9828|new|vmware.pm:_vmwareclone(1457)|clone
process failed dstDisk
/virtualmachines/9828vmguest-40/vmwarewinxp-CSUXPbuild105-v0.vmdk does
not exist
|16896|10092:9828|new| ( 0) utils.pm, notify (line: 737)
|16896|10092:9828|new| (-1) vmware.pm, _vmwareclone (line: 1457)
|16896|10092:9828|new| (-2) vmware.pm, load (line: 502)
|16896|10092:9828|new| (-3) new.pm, reload_image (line: 665)
|16896|10092:9828|new| (-4) new.pm, process (line: 266)
|16896|10092:9828|new| (-5) vcld, make_new_child (line: 594)
|16896|10092:9828|new| (-6) vcld, main (line: 341)
2010-09-08 13:06:01|16896|10092:9828|new|utils.pm:insertloadlog(4710)|inserted
computer=44, failed, cloning base image failed
No recipient addresses found in header
2010-09-08 13:06:01|16896|10092:9828|new|utils.pm:mail(1348)|SUCCESS
-- Sending mail To: , PROBLEM -- vmware.pm
|16896|10092:9828|new| ---- CRITICAL ----
|16896|10092:9828|new| 2010-09-08
13:06:01|16896|10092:9828|new|vmware.pm:load(508)|problem cloning
failed /virtualmachines/vmwarewinxp-CSUXPbuild105-v0/vmwarewinxp-CSUXPbuild105-v0.vmdk
to /virtualmachines/9828vmguest-40/vmwarewinxp-CSUXPbuild105-v0.vmdk
|16896|10092:9828|new| ( 0) utils.pm, notify (line: 737)
|16896|10092:9828|new| (-1) vmware.pm, load (line: 508)
|16896|10092:9828|new| (-2) new.pm, reload_image (line: 665)
|16896|10092:9828|new| (-3) new.pm, process (line: 266)
|16896|10092:9828|new| (-4) vcld, make_new_child (line: 594)
|16896|10092:9828|new| (-5) vcld, main (line: 341)
|16896|10092:9828|new| ---- WARNING ----
|16896|10092:9828|new| 2010-09-08
13:06:01|16896|10092:9828|new|new.pm:reload_image(670)|vmwarewinxp-CSUXPbuild105-v0
failed to load on vmguest-40, returning
|16896|10092:9828|new| ( 0) utils.pm, notify (line: 737)
|16896|10092:9828|new| (-1) new.pm, reload_image (line: 670)
|16896|10092:9828|new| (-2) new.pm, process (line: 266)
|16896|10092:9828|new| (-3) vcld, make_new_child (line: 594)
|16896|10092:9828|new| (-4) vcld, main (line: 341)
2010-09-08 13:06:01|16896|10092:9828|new|utils.pm:insertloadlog(4710)|inserted
computer=44, loadimagefailed, vmwarewinxp-CSUXPbuild105-v0 failed to
load on vmguest-40
|16896|10092:9828|new| ---- WARNING ----
|16896|10092:9828|new| 2010-09-08
13:06:01|16896|10092:9828|new|new.pm:process(313)|failed to load
vmguest-40 with vmwarewinxp-CSUXPbuild105-v0
|16896|10092:9828|new| ( 0) utils.pm, notify (line: 737)
|16896|10092:9828|new| (-1) new.pm, process (line: 313)
|16896|10092:9828|new| (-2) vcld, make_new_child (line: 594)
|16896|10092:9828|new| (-3) vcld, main (line: 341)
2010-09-08 13:06:01|16896|10092:9828|new|DataStructure.pm:get_computer_state_name(1946)|attempting
to retrieve current state of computer vmguest-40 from the database
2010-09-08 13:06:01|16896|10092:9828|new|DataStructure.pm:get_computer_state_name(1977)|retrieved
current state of computer vmguest-40 from the database: reloading
2010-09-08 13:06:01|16896|10092:9828|new|DataStructure.pm:_automethod(697)|data
structure updated:
$self->request_data->{reservation}{9828}{computer}{state}{name}
|16896|10092:9828|new| computer_state_name = reloading
No recipient addresses found in header
2010-09-08 13:06:01|16896|10092:9828|new|utils.pm:mail(1348)|SUCCESS
-- Sending mail To: , PROBLEM -- State.pm
|16896|10092:9828|new| ---- CRITICAL ----
|16896|10092:9828|new| 2010-09-08
13:06:01|16896|10092:9828|new|State.pm:reservation_failed(290)|reservation
failed on vmguest-40: process failed after trying to load or make
available
|16896|10092:9828|new| ( 0) utils.pm, notify (line: 737)
|16896|10092:9828|new| (-1) State.pm, reservation_failed (line: 290)
|16896|10092:9828|new| (-2) new.pm, process (line: 316)
|16896|10092:9828|new| (-3) vcld, make_new_child (line: 594)
|16896|10092:9828|new| (-4) vcld, main (line: 341)
2010-09-08 13:06:01|16896|10092:9828|new|utils.pm:insertloadlog(4710)|inserted
computer=44, failed, process failed after trying to load or make
available
2010-09-08 13:06:01|16896|10092:9828|new|State.pm:reservation_failed(293)|inserted
computerloadlog entry
2010-09-08 13:06:01|16896|10092:9828|new|State.pm:reservation_failed(301)|updated
log ending value to 'failed', logid=3545
2010-09-08 13:06:01|16896|10092:9828|new|utils.pm:update_computer_state(2228)|computer
44 state updated to: failed
2010-09-08 13:06:01|16896|10092:9828|new|State.pm:reservation_failed(312)|computer
vmguest-40 (44) state set to failed
2010-09-08 13:06:01|16896|10092:9828|new|utils.pm:update_request_state(2186)|request
10092 state updated to: failed, laststate to: new
2010-09-08 13:06:01|16896|10092:9828|new|State.pm:reservation_failed(325)|set
request state to 'failed'/'new'
2010-09-08 13:06:01|16896|10092:9828|new|utils.pm:is_inblockrequest(6972)|zero
rows were returned from database select
2010-09-08 13:06:01|16896|10092:9828|new|State.pm:reservation_failed(343)|vmguest-40
is NOT in blockcomputers table
2010-09-08 13:06:01|16896|10092:9828|new|State.pm:reservation_failed(346)|exiting
1
2010-09-08 13:06:01|16896|10092:9828|new|State.pm:DESTROY(905)|destructor
called, ref($self)=VCL::new
2010-09-08 13:06:01|16896|10092:9828|new|utils.pm:delete_computerloadlog_reservation(7551)|removing
computerloadlog entries matching loadstate = begin
2010-09-08 13:06:01|16896|10092:9828|new|utils.pm:delete_computerloadlog_reservation(7598)|deleted
rows from computerloadlog for reservation id=9828
2010-09-08 13:06:01|16896|10092:9828|new|State.pm:DESTROY(912)|removed
computerloadlog rows with loadstate=begin for reservation
2010-09-08 13:06:01|16896|10092:9828|new|State.pm:DESTROY(924)|number
of database handles state process created: 1
2010-09-08 13:06:01|16896|10092:9828|new|State.pm:DESTROY(933)|process
has a database handle stored in $ENV{dbh}, attempting disconnect
2010-09-08 13:06:01|16896|10092:9828|new|State.pm:DESTROY(935)|$ENV{dbh}:
database disconnect successful
2010-09-08 13:06:01|16896|10092:9828|new|State.pm:DESTROY(949)|VCL::new
process 16896 exiting
2010-09-08 13:06:01|4994|vcld:REAPER(744)|VCL process exited for
reservation 9828
On Wed, Sep 8, 2010 at 8:55 AM, Alexander Patterson
<al...@csueastbay.edu> wrote:
> Hello,
>
> Been having an issue with our system. We just added a few new blades
> and had our network team move over files to clone our blades so they
> work correct.
>
> I can't create images anymore. Normal operation works, but I can't
> update or create images currently.
>
> Here is the error code I am getting.
>
> I think that vmkfstools was deleted (I can't find it anywhere), but I
> only see that tool for ESX? Do we have this tool on the VCL web site?
> Or am I missing something else that is needed to make images?
>
>
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:run_ssh_command(6276)|SSH
> command executed on vclesx05, returning (0, "none")
> 2010-09-08 08:50:40|6294|9915:9651|new|vmware.pm:_vmwareclone(1426)|srcDisk
> is exists /virtualmachines/vmwarewinxp-build97-v1/vmwarewinxp-build97-v1.vmdk
> 2010-09-08 08:50:40|6294|9915:9651|new|vmware.pm:_vmwareclone(1427)|starting
> clone process vmkfstools -d thin -i
> /virtualmachines/vmwarewinxp-build97-v1/vmwarewinxp-build97-v1.vmdk
> /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:run_ssh_command(6180)|executing
> SSH command on vclesx05:
> |6294|9915:9651|new| /usr/bin/ssh -i /etc/vcl/vcl.key -l root -p 22
> -x vclesx05 'ls -1
> /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk' 2>&1
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:run_ssh_command(6262)|run_ssh_command
> output:
> |6294|9915:9651|new| ls:
> /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk: No such
> file or directory
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:run_ssh_command(6272)|SSH
> command executed on vclesx05, command:
> |6294|9915:9651|new| /usr/bin/ssh -i /etc/vcl/vcl.key -l root -p 22
> -x vclesx05 'ls -1
> /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk' 2>&1
> |6294|9915:9651|new| returning (2, "ls: /virtualmachines/9651vmgue...")
>
> |6294|9915:9651|new| ---- WARNING ----
> |6294|9915:9651|new| 2010-09-08
> 08:50:40|6294|9915:9651|new|vmware.pm:_vmwareclone(1457)|clone process
> failed dstDisk /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk
> does not exist
> |6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
> |6294|9915:9651|new| (-1) vmware.pm, _vmwareclone (line: 1457)
> |6294|9915:9651|new| (-2) vmware.pm, load (line: 502)
> |6294|9915:9651|new| (-3) new.pm, reload_image (line: 665)
> |6294|9915:9651|new| (-4) new.pm, process (line: 266)
> |6294|9915:9651|new| (-5) vcld, make_new_child (line: 594)
> |6294|9915:9651|new| (-6) vcld, main (line: 341)
>
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:insertloadlog(4710)|inserted
> computer=107, failed, cloning base image failed
> No recipient addresses found in header
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:mail(1348)|SUCCESS --
> Sending mail To: , PROBLEM -- vmware.pm
>
> |6294|9915:9651|new| ---- CRITICAL ----
> |6294|9915:9651|new| 2010-09-08
> 08:50:40|6294|9915:9651|new|vmware.pm:load(508)|problem cloning failed
> /virtualmachines/vmwarewinxp-build97-v1/vmwarewinxp-build97-v1.vmdk to
> /virtualmachines/9651vmguest-104/vmwarewinxp-build97-v1.vmdk
> |6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
> |6294|9915:9651|new| (-1) vmware.pm, load (line: 508)
> |6294|9915:9651|new| (-2) new.pm, reload_image (line: 665)
> |6294|9915:9651|new| (-3) new.pm, process (line: 266)
> |6294|9915:9651|new| (-4) vcld, make_new_child (line: 594)
> |6294|9915:9651|new| (-5) vcld, main (line: 341)
>
>
> |6294|9915:9651|new| ---- WARNING ----
> |6294|9915:9651|new| 2010-09-08
> 08:50:40|6294|9915:9651|new|new.pm:reload_image(670)|vmwarewinxp-build97-v1
> failed to load on vmguest-104, returning
> |6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
> |6294|9915:9651|new| (-1) new.pm, reload_image (line: 670)
> |6294|9915:9651|new| (-2) new.pm, process (line: 266)
> |6294|9915:9651|new| (-3) vcld, make_new_child (line: 594)
> |6294|9915:9651|new| (-4) vcld, main (line: 341)
>
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:insertloadlog(4710)|inserted
> computer=107, loadimagefailed, vmwarewinxp-build97-v1 failed to load
> on vmguest-104
>
> |6294|9915:9651|new| ---- WARNING ----
> |6294|9915:9651|new| 2010-09-08
> 08:50:40|6294|9915:9651|new|new.pm:process(313)|failed to load
> vmguest-104 with vmwarewinxp-build97-v1
> |6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
> |6294|9915:9651|new| (-1) new.pm, process (line: 313)
> |6294|9915:9651|new| (-2) vcld, make_new_child (line: 594)
> |6294|9915:9651|new| (-3) vcld, main (line: 341)
>
> 2010-09-08 08:50:40|6294|9915:9651|new|DataStructure.pm:get_computer_state_name(1946)|attempting
> to retrieve current state of computer vmguest-104 from the database
> 2010-09-08 08:50:40|6294|9915:9651|new|DataStructure.pm:get_computer_state_name(1977)|retrieved
> current state of computer vmguest-104 from the database: reloading
> 2010-09-08 08:50:40|6294|9915:9651|new|DataStructure.pm:_automethod(697)|data
> structure updated:
> $self->request_data->{reservation}{9651}{computer}{state}{name}
> |6294|9915:9651|new| computer_state_name = reloading
> No recipient addresses found in header
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:mail(1348)|SUCCESS --
> Sending mail To: , PROBLEM -- State.pm
>
> |6294|9915:9651|new| ---- CRITICAL ----
> |6294|9915:9651|new| 2010-09-08
> 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(290)|reservation
> failed on vmguest-104: process failed after trying to load or make
> available
> |6294|9915:9651|new| ( 0) utils.pm, notify (line: 737)
> |6294|9915:9651|new| (-1) State.pm, reservation_failed (line: 290)
> |6294|9915:9651|new| (-2) new.pm, process (line: 316)
> |6294|9915:9651|new| (-3) vcld, make_new_child (line: 594)
> |6294|9915:9651|new| (-4) vcld, main (line: 341)
>
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:insertloadlog(4710)|inserted
> computer=107, failed, process failed after trying to load or make
> available
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(293)|inserted
> computerloadlog entry
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(301)|updated
> log ending value to 'failed', logid=3483
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:update_computer_state(2228)|computer
> 107 state updated to: failed
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(312)|computer
> vmguest-104 (107) state set to failed
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:update_request_state(2186)|request
> 9915 state updated to: failed, laststate to: new
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(325)|set
> request state to 'failed'/'new'
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:is_inblockrequest(6972)|zero
> rows were returned from database select
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(343)|vmguest-104
> is NOT in blockcomputers table
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:reservation_failed(346)|exiting
> 1
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(905)|destructor
> called, ref($self)=VCL::new
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:delete_computerloadlog_reservation(7551)|removing
> computerloadlog entries matching loadstate = begin
> 2010-09-08 08:50:40|6294|9915:9651|new|utils.pm:delete_computerloadlog_reservation(7598)|deleted
> rows from computerloadlog for reservation id=9651
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(912)|removed
> computerloadlog rows with loadstate=begin for reservation
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(924)|number of
> database handles state process created: 1
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(933)|process
> has a database handle stored in $ENV{dbh}, attempting disconnect
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(935)|$ENV{dbh}:
> database disconnect successful
> 2010-09-08 08:50:40|6294|9915:9651|new|State.pm:DESTROY(949)|VCL::new
> process 6294 exiting
> 2010-09-08 08:50:40|4994|vcld:REAPER(744)|VCL process exited for
> reservation 9651
> 2010-09-08 08:50:40|4994|vcld:main(165)|lastcheckin time updated for
> management node 1: 2010-09-08 08:50:40
>
>
> --
> Thanks,
> Alex Patterson
> User Support Services
> Operating System Analyst
> California State University, East Bay
>
--
Thanks,
Alex Patterson
User Support Services
Operating System Analyst
California State University, East Bay