You are viewing a plain text version of this content. The canonical link for it is here.
Posted to user@vcl.apache.org by Vincent YA Chen <ya...@tw.ibm.com> on 2013/06/13 11:43:27 UTC
Capture A Base Image problem
Dears
Your kindly advise is appreciated .Now, I am evaluating VCL solution and
trying to build up a testing environment , but I encounter a problem on
image capture .
I follow the installation procedure (
https://cwiki.apache.org/VCL/vcl-23-installation.html ) to
install/configure all the components ( Database, Web Components,
Management Node Components) and
do image capture (https://cwiki.apache.org/VCL/capture-a-base-image.html )
; however , the management node always show below error msg (VCL::image
object could not be created and initialized)
VCL::image object could not be created and initialized
------------------------------------------------------------------------
time: 2013-06-13 09:18:15
caller: vcld:make_new_child(574)
( 0) vcld, make_new_child (line: 574)
(-1) vcld, main (line: 350)
------------------------------------------------------------------------
management node: cent59.ibm.demo
reservation PID: 3661
parent vcld PID: 21145
request ID: 6
reservation ID: 6
request state/laststate: image/image
request start time: 2013-06-13 09:17:49
request end time: 2013-06-13 10:17:49
for imaging: no
log ID: none
computer: xp2.ibm.demo
computer id: 4
computer type: virtualmachine
computer eth0 MAC address: 00:0c:29:36:ac:73
computer eth1 MAC address: 00:0c:29:36:ac:7d
computer private IP address: 192.168.72.152
computer public IP address: 172.16.1.152
computer in block allocation: no
provisioning module: VCL::Module::Provisioning::VMware::VMware
vm host: esxi4.ibm.demo
vm host ID: 2
vm host computer ID: 3
vm profile: VMware ESXi - local storage
vm profile VM path: /var/lib/vmware/runningvms
vm profile repository path: <undefined>
vm profile datastore path: /var/lib/vmware/images
vm profile disk type: dedicated
image: vmwarewinxp-xp217-v0
image display name: xp21
image ID: 7
image revision ID: 7
image size: 1450 MB
use Sysprep: no
root access: yes
image owner ID: 1
image owner affiliation: Local
image revision date created: 2013-06-13 09:17:49
image revision production: yes
OS module: VCL::Module::OS::Windows::Version_5::XP
user: admin
user name: vcl admin
user ID: 1
user affiliation: Local
------------------------------------------------------------------------
RECENT LOG ENTRIES FOR THIS PROCESS:
|3661|6:6|image| : "cent59"
2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_automethod(836)|data
structure updated, hash path:
$self->request_data->{reservation}{0}{computer}{SHORTNAME}, data
identifier: computer_short_name, data:
|3661|6:6|image| : "cent59"
2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_automethod(836)|data
structure updated, hash path:
$self->request_data->{reservation}{0}{computer}{IPaddress}, data
identifier: computer_ip_address, data:
|3661|6:6|image| : "192.168.72.200"
2013-06-13
09:17:54|3661|6:6|image|Module.pm:create_mn_os_object(381)|VCL::Module::OS::Linux::ManagementNode
OS object created, address: acc0bb8
2013-06-13 09:17:54|3661|6:6|image|Module.pm:new(192)|VCL::image object
created for state image, address: ab57c98
2013-06-13 09:17:54|3661|6:6|image|State.pm:initialize(88)|obtained a
database handle for this state process, stored as $ENV{dbh}
2013-06-13 09:17:54|3661|6:6|image|State.pm:check_image_os(790)|no
corrections need to be made to image OS: vmwarewinxp
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:is_parent_reservation(993)|returning
true: parent reservation ID for this request: 6
2013-06-13
09:17:54|3661|6:6|image|utils.pm:rename_vcld_process(6785)|reservation
count: 1
2013-06-13
09:17:54|3661|6:6|image|utils.pm:rename_vcld_process(6804)|PARENTIMAGE: 1
2013-06-13
09:17:54|3661|6:6|image|utils.pm:rename_vcld_process(6805)|SUBIMAGE: 0
2013-06-13
09:17:54|3661|6:6|image|utils.pm:rename_vcld_process(6823)|renamed process
to 'vcld 6:6 image xp2>esxi4.ibm.demo vmwarewinxp-xp217-v0 admin'
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:is_parent_reservation(993)|returning
true: parent reservation ID for this request: 6
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:is_parent_reservation(993)|returning
true: parent reservation ID for this request: 6
2013-06-13
09:17:54|3661|6:6|image|Module.pm:create_os_object(308)|VCL::Module::OS::Windows::Version_5::XP
module loaded
2013-06-13
09:17:54|3661|6:6|image|Module.pm:new(196)|VCL::Module::OS::Windows::Version_5::XP
object created for image vmwarewinxp-xp217-v0, address: b040f54
2013-06-13
09:17:54|3661|6:6|image|Module.pm:create_os_object(314)|VCL::Module::OS::Windows::Version_5::XP
OS object created, address: b040f54
2013-06-13 09:17:54|3661|6:6|image|State.pm:initialize(125)|computer is a
VM, attempting to create VM host OS object
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:_initialize(613)|computer ID
argument was specified, retrieving data for computer ID: 3
2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(637)|image
ID argument was specified: 1, DataStructure object will contain image
information for the production imagerevision of this image
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:_initialize(668)|retrieved data
for imagerevision ID: 1
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:_initialize(684)|retrieved data
for image ID: 1
2013-06-13
09:17:54|3661|6:6|image|Module.pm:create_vmhost_os_object(454)|attempting
to load VM host OS module: VCL::Module::OS::Linux::UnixLab (image: 1)
2013-06-13
09:17:54|3661|6:6|image|Module.pm:create_vmhost_os_object(460)|VM host OS
module loaded: VCL::Module::OS::Linux::UnixLab
2013-06-13
09:17:54|3661|6:6|image|Module.pm:new(196)|VCL::Module::OS::Linux::UnixLab
object created for image noimage, address: b402944
2013-06-13
09:17:54|3661|6:6|image|Module.pm:create_vmhost_os_object(465)|VCL::Module::OS::Linux::UnixLab
OS object created, address: b402944
2013-06-13
09:17:54|3661|6:6|image|Module.pm:create_provisioning_object(519)|VCL::Module::Provisioning::VMware::VMware
module loaded
2013-06-13
09:17:54|3661|6:6|image|Module.pm:new(200)|VCL::Module::Provisioning::VMware::VMware
object created for computer xp2, address: b41a4f4
2013-06-13 09:17:54|3661|6:6|image|VMware.pm:initialize(267)|initializing
VCL::Module::Provisioning::VMware::VMware object
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:_initialize(613)|computer ID
argument was specified, retrieving data for computer ID: 3
2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(637)|image
ID argument was specified: 1, DataStructure object will contain image
information for the production imagerevision of this image
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:_initialize(668)|retrieved data
for imagerevision ID: 1
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:_initialize(684)|retrieved data
for image ID: 1
2013-06-13
09:17:54|3661|6:6|image|VMware.pm:get_vmhost_datastructure(1392)|created
DataStructure object for VM host: esxi4
2013-06-13 09:17:54|3661|6:6|image|VMware.pm:initialize(287)|VM profile
assigned to esxi4: VMware ESXi - local storage
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:_initialize(613)|computer ID
argument was specified, retrieving data for computer ID: 3
2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(637)|image
ID argument was specified: 1, DataStructure object will contain image
information for the production imagerevision of this image
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:_initialize(668)|retrieved data
for imagerevision ID: 1
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:_initialize(684)|retrieved data
for image ID: 1
2013-06-13
09:17:54|3661|6:6|image|VMware.pm:get_vmhost_datastructure(1392)|created
DataStructure object for VM host: esxi4
2013-06-13
09:17:54|3661|6:6|image|VMware.pm:get_vmhost_api_object(1495)|attempting
to load VMware control module:
VCL::Module::Provisioning::VMware::vSphere_SDK
2013-06-13
09:17:54|3661|6:6|image|VMware.pm:get_vmhost_api_object(1501)|loaded
VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
2013-06-13
09:17:54|3661|6:6|image|Module.pm:new(200)|VCL::Module::Provisioning::VMware::vSphere_SDK
object created for computer xp2, address: b74cf70
2013-06-13 09:17:54|3661|6:6|image|vSphere_SDK.pm:initialize(98)|vSphere
SDK for Perl does not appear to be installed on this managment node,
unable to load VMware vSphere SDK Perl modules, error:
|3661|6:6|image| Can't locate VMware/VIRuntime.pm in @INC (@INC contains:
/usr/local/vcl/bin/../../../.. /usr/local/vcl/bin/../..
/usr/local/vcl/bin/../../.. /usr/local/vcl/bin/../../../../..
/usr/local/vcl/bin/.. /usr/local/vcl/bin/../lib
/usr/lib/perl5/site_perl/5.8.8/i386-linux-thread-multi
/usr/lib/perl5/site_perl/5.8.8 /usr/lib/perl5/site_perl
/usr/lib/perl5/vendor_perl/5.8.8/i386-linux-thread-multi
/usr/lib/perl5/vendor_perl/5.8.8 /usr/lib/perl5/vendor_perl
/usr/lib/perl5/5.8.8/i386-linux-thread-multi /usr/lib/perl5/5.8.8 .) at
(eval 238) line 1.
|3661|6:6|image| BEGIN failed--compilation aborted at (eval 238) line 1.
2013-06-13
09:17:54|3661|6:6|image|VMware.pm:get_vmhost_api_object(1515)|API object
could not be created: VCL::Module::Provisioning::VMware::vSphere_SDK
|3661|6:6|image| ---- WARNING ----
|3661|6:6|image| 2013-06-13
09:18:05|3661|6:6|image|utils.pm:nmap_port(2454)|error occurred running
nmap command: '/usr/bin/nmap esxi4 -P0 -p 22 -T Aggressive', output:
|3661|6:6|image| Starting Nmap 4.11 ( http://www.insecure.org/nmap/ ) at
2013-06-13 09:17 CST
|3661|6:6|image| Failed to resolve given hostname/IP: esxi4. Note that
you can't use '/mask' AND '1-4,7,100-' style IP ranges
|3661|6:6|image| WARNING: No targets were specified, so 0 hosts scanned.
|3661|6:6|image| Nmap finished: 0 IP addresses (0 hosts up) scanned in
10.125 seconds
|3661|6:6|image| ( 0) utils.pm, nmap_port (line: 2454)
|3661|6:6|image| (-1) OS.pm, is_ssh_responding (line: 612)
|3661|6:6|image| (-2) VMware.pm, initialize (line: 303)
|3661|6:6|image| (-3) Module.pm, new (line: 207)
|3661|6:6|image| (-4) Module.pm, create_provisioning_object (line: 522)
|3661|6:6|image| (-5) State.pm, initialize (line: 136)
|3661|6:6|image| ---- WARNING ----
|3661|6:6|image| 2013-06-13
09:18:15|3661|6:6|image|utils.pm:nmap_port(2454)|error occurred running
nmap command: '/usr/bin/nmap esxi4 -P0 -p 24 -T Aggressive', output:
|3661|6:6|image| Starting Nmap 4.11 ( http://www.insecure.org/nmap/ ) at
2013-06-13 09:18 CST
|3661|6:6|image| Failed to resolve given hostname/IP: esxi4. Note that
you can't use '/mask' AND '1-4,7,100-' style IP ranges
|3661|6:6|image| WARNING: No targets were specified, so 0 hosts scanned.
|3661|6:6|image| Nmap finished: 0 IP addresses (0 hosts up) scanned in
10.001 seconds
|3661|6:6|image| ( 0) utils.pm, nmap_port (line: 2454)
|3661|6:6|image| (-1) OS.pm, is_ssh_responding (line: 613)
|3661|6:6|image| (-2) VMware.pm, initialize (line: 303)
|3661|6:6|image| (-3) Module.pm, new (line: 207)
|3661|6:6|image| (-4) Module.pm, create_provisioning_object (line: 522)
|3661|6:6|image| (-5) State.pm, initialize (line: 136)
2013-06-13 09:18:15|3661|6:6|image|OS.pm:is_ssh_responding(615)|esxi4 is
NOT responding to SSH, ports 22 or 24 are both closed
2013-06-13 09:18:15|3661|6:6|image|VMware.pm:initialize(307)|unable to
control OS of VM host esxi4 using VCL::Module::OS::Linux::UnixLab OS
object because VM host is not responding to SSH
|3661|6:6|image| ---- WARNING ----
|3661|6:6|image| 2013-06-13
09:18:15|3661|6:6|image|Module.pm:create_provisioning_object(530)|provisioning
object could not be created, returning 0
|3661|6:6|image| ( 0) Module.pm, create_provisioning_object (line: 530)
|3661|6:6|image| (-1) State.pm, initialize (line: 136)
|3661|6:6|image| (-2) Module.pm, new (line: 207)
|3661|6:6|image| (-3) vcld, make_new_child (line: 567)
|3661|6:6|image| (-4) vcld, main (line: 350)
|3661|6:6|image| ---- WARNING ----
|3661|6:6|image| 2013-06-13
09:18:15|3661|6:6|image|State.pm:initialize(145)|failed to create
provisioning object
|3661|6:6|image| ( 0) State.pm, initialize (line: 145)
|3661|6:6|image| (-1) Module.pm, new (line: 207)
|3661|6:6|image| (-2) vcld, make_new_child (line: 567)
|3661|6:6|image| (-3) vcld, main (line: 350)
2013-06-13
09:18:15|3661|6:6|image|utils.pm:delete_computerloadlog_reservation(6429)|removing
computerloadlog entries matching loadstate = begin
2013-06-13
09:18:15|3661|6:6|image|utils.pm:delete_computerloadlog_reservation(6476)|deleted
rows from computerloadlog for reservation id=6
2013-06-13 09:18:15|3661|6:6|image|State.pm:DESTROY(929)|VCL::image
process duration: 21 seconds
2013-06-13
09:18:15|3661|6:6|image|DataStructure.pm:get_computer_private_ip_address(1630)|attempting
to retrieve private IP address for computer: xp2
2013-06-13
09:18:15|3661|6:6|image|DataStructure.pm:get_computer_private_ip_address(1634)|retrieved
contents of /etc/hosts on this management node, contains 7 lines
2013-06-13
09:18:15|3661|6:6|image|DataStructure.pm:get_computer_private_ip_address(1673)|did
not find any lines in /etc/hosts containing 'xp2', returning private IP
address defined in the database: 192.168.72.152
2013-06-13 09:18:15|3661|6:6|image|utils.pm:getnewdbh(2512)|unable to use
database handle stored in $ENV{dbh}
2013-06-13 09:18:15|3661|6:6|image|utils.pm:getnewdbh(2569)|database
handle stored in $ENV{dbh}
2013-06-13 09:18:15|3661|6:6|image|utils.pm:is_inblockrequest(5793)|zero
rows were returned from database select
2013-06-13
09:18:15|3661|6:6|image|DataStructure.pm:get_image_affiliation_name(2118)|image
owner id: 1
2013-06-13
09:18:15|3661|6:6|image|DataStructure.pm:retrieve_user_data(1401)|attempting
to retrieve and store data for user: user.id = '1'
2013-06-13
09:18:15|3661|6:6|image|DataStructure.pm:retrieve_user_data(1464)|data has
been retrieved for user: admin (id: 1)
My Environment :
Hypervisor : ESXi 4.0.0
Management Node : CentOS 5.9
Image O.S : Window XP SP3
VCL : 2.3
if there were further information required , plz kindly let me know,
thank you
Best Regards,
Vincent YA Chen 陳彥安
4F, 7 Song Ren Road
I/T Specialist
Taipei, 110
End User Service
Taiwan
GTS Service Delivery, Taiwan
Phone:
+886-2-8723-9081
Mobile:
+886-911-227-378
e-mail:
yachen@tw.ibm.com
Re: Capture A Base Image problem
Posted by "Pablo J. Rebollo Sosa" <pa...@upr.edu>.
I suggest you to define "repository path" in the VM host profile. Be sure the the directory exists in the hypervisor. Finally, I don't see from the log when the process fail. Maybe there's something more.
Pablo
On Jun 14, 2013, at 3:07 AM, Vincent YA Chen <ya...@tw.ibm.com> wrote:
> Dear Sir
>
> thanks a lot !
> After I edit the host file , I could login those two systems without password . I do image capture again but still get below err msg , your consistent help is appreciated .
>
>
> EHR - getline_hr () called before column_names () at /usr/local/vcl/bin/../lib/VCL/Module/OS/Windows.pm line 7415
> ------------------------------------------------------------------------
> time: 2013-06-14 14:26:20
> caller: vcld:die_handler(639)
> ( 0) vcld, die_handler (line: 639)
> (-1) Carp.pm, croak (line: 269)
> (-2) CSV_XS.pm, getline_hr_all (line: 566)
> (-3) Windows.pm, get_task_info (line: 7415)
> (-4) Windows.pm, get_network_configuration (line: 5585)
> (-5) OS.pm, get_private_interface_name (line: 1043)
> (-6) OS.pm, get_private_network_configuration (line: 1280)
> (-7) (eval 369), (eval) (line: 1)
> (-8) OS.pm, get_mac_address (line: 1342)
> (-9) OS.pm, get_private_mac_address (line: 1376)
> (-10) VMware.pm, get_active_vmx_file_path (line: 974)
> (-11) VMware.pm, capture (line: 618)
> (-12) image.pm, process (line: 162)
> (-13) vcld, make_new_child (line: 571)
> (-14) vcld, main (line: 350)
> ------------------------------------------------------------------------
> management node: cent59.ibm.demo
> reservation PID: 14554
> parent vcld PID: 21145
>
> request ID: 9
> reservation ID: 9
> request state/laststate: image/image
> request start time: 2013-06-14 14:25:56
> request end time: 2013-06-14 15:25:56
> for imaging: no
> log ID: none
>
> computer: xp2.ibm.demo
> computer id: 4
> computer type: virtualmachine
> computer eth0 MAC address: 00:0c:29:36:ac:73
> computer eth1 MAC address: 00:0c:29:36:ac:7d
> computer private IP address: 192.168.72.152
> computer public IP address: 172.16.1.152
> computer in block allocation: no
> provisioning module: VCL::Module::Provisioning::VMware::VMware
>
> vm host: esxi4.ibm.demo
> vm host ID: 2
> vm host computer ID: 3
> vm profile: VMware ESXi - local storage
> vm profile VM path: /var/lib/vmware/runningvms
> vm profile repository path: <undefined>
> vm profile datastore path: /var/lib/vmware/images
> vm profile disk type: dedicated
>
> image: vmwarewinxp-xp2410-v0
> image display name: xp24
> image ID: 10
> image revision ID: 10
> image size: 1450 MB
> use Sysprep: no
> root access: yes
> image owner ID: 1
> image owner affiliation: Local
> image revision date created: 2013-06-14 14:26:07
> image revision production: yes
> OS module: VCL::Module::OS::Windows::Version_5::XP
>
> user: admin
> user name: vcl admin
> user ID: 1
> user affiliation: Local
> ------------------------------------------------------------------------
> RECENT LOG ENTRIES FOR THIS PROCESS:
> |14554|9:9|image| VMware API object type: VCL::Module::Provisioning::VMware::VIM_SSH
> 2013-06-14 14:26:02|14554|9:9|image|utils.pm:run_ssh_command(4935)|executing SSH command on esxi4:
> |14554|9:9|image| /usr/bin/ssh -i /etc/vcl/vcl.key -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o ConnectionAttempts=1 -o ConnectTimeout=3 -l root -p 22 -x esxi4 'vmware -v' 2>&1
> 2013-06-14 14:26:02|14554|9:9|image|utils.pm:run_ssh_command(5053)|run_ssh_command output:
> |14554|9:9|image| VMware ESXi 4.0.0 build-208167
> 2013-06-14 14:26:02|14554|9:9|image|utils.pm:run_ssh_command(5067)|SSH command executed on esxi4, returning (0, "VMware ESXi 4.0.0 build-208167")
> 2013-06-14 14:26:02|14554|9:9|image|VMware.pm:get_vmhost_product_name(6621)|VMware product being used on VM host esxi4: 'VMware ESXi 4.0.0 build-208167'
> 2013-06-14 14:26:02|14554|9:9|image|VMware.pm:get_vmx_base_directory_path(3089)|determined vmx base directory path: /var/lib/vmware/runningvms
> 2013-06-14 14:26:02|14554|9:9|image|utils.pm:run_ssh_command(4935)|executing SSH command on esxi4:
> |14554|9:9|image| /usr/bin/ssh -i /etc/vcl/vcl.key -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o ConnectionAttempts=1 -o ConnectTimeout=3 -l root -p 22 -x esxi4 'stat /var/lib/vmware/runningvms' 2>&1
> 2013-06-14 14:26:03|14554|9:9|image|utils.pm:run_ssh_command(5053)|run_ssh_command output:
> |14554|9:9|image| File: "/var/lib/vmware/runningvms"
> |14554|9:9|image| Size: 512 Blocks: 8 IO Block: 131072 directory
> |14554|9:9|image| Device: eh/14d Inode: 4066 Links: 1
> |14554|9:9|image| Access: (0755/drwxr-xr-x) Uid: ( 0/ root) Gid: ( 0/ root)
> |14554|9:9|image| Access: 2013-06-09 03:51:35.000000000
> |14554|9:9|image| Modify: 2013-06-09 03:51:35.000000000
> |14554|9:9|image| Change: 2013-06-09 03:51:35.000000000
> 2013-06-14 14:26:03|14554|9:9|image|utils.pm:run_ssh_command(5067)|SSH command executed on esxi4, returning (0, "File: "/var/lib/vmware/running...")
> 2013-06-14 14:26:03|14554|9:9|image|Linux.pm:file_exists(1356)|'/var/lib/vmware/runningvms' exists on esxi4, files: 0, directories: 1, links: 0
> 2013-06-14 14:26:03|14554|9:9|image|VMware.pm:is_vm_dedicated(4246)|VM disk mode does not need to be dedicated
> 2013-06-14 14:26:03|14554|9:9|image|VMware.pm:get_vmdk_base_directory_path_shared(3561)|using VM profile datastore path as the vmdk base directory path: /var/lib/vmware/images
> 2013-06-14 14:26:03|14554|9:9|image|utils.pm:run_ssh_command(4935)|executing SSH command on esxi4:
> |14554|9:9|image| /usr/bin/ssh -i /etc/vcl/vcl.key -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o ConnectionAttempts=1 -o ConnectTimeout=3 -l root -p 22 -x esxi4 'stat /var/lib/vmware/images' 2>&1
> 2013-06-14 14:26:03|14554|9:9|image|utils.pm:run_ssh_command(5053)|run_ssh_command output:
> |14554|9:9|image| File: "/var/lib/vmware/images"
> |14554|9:9|image| Size: 512 Blocks: 8 IO Block: 131072 directory
> |14554|9:9|image| Device: eh/14d Inode: 3158 Links: 1
> |14554|9:9|image| Access: (0755/drwxr-xr-x) Uid: ( 0/ root) Gid: ( 0/ root)
> |14554|9:9|image| Access: 2013-06-09 02:43:35.000000000
> |14554|9:9|image| Modify: 2013-06-09 02:50:48.000000000
> |14554|9:9|image| Change: 2013-06-09 02:50:48.000000000
> 2013-06-14 14:26:03|14554|9:9|image|utils.pm:run_ssh_command(5067)|SSH command executed on esxi4, returning (0, "File: "/var/lib/vmware/images"...")
> 2013-06-14 14:26:03|14554|9:9|image|Linux.pm:file_exists(1356)|'/var/lib/vmware/images' exists on esxi4, files: 0, directories: 1, links: 0
> 2013-06-14 14:26:03|14554|9:9|image|Module.pm:create_provisioning_object(525)|VCL::Module::Provisioning::VMware::VMware provisioner object created for xp2, address: b423f7c
> 2013-06-14 14:26:03|14554|9:9|image|State.pm:initialize(154)|returning 1
> 2013-06-14 14:26:03|14554|9:9|image|vcld:make_new_child(568)|VCL::image object created and initialized
> 2013-06-14 14:26:06|14554|9:9|image|utils.pm:mail(1266)|SUCCESS -- Sending mail To: yachen@tw.ibm.com, VCL IMAGE Creation Started: vmwarewinxp-xp2410-v0
> 2013-06-14 14:26:06|14554|9:9|image|VMware.pm:get_vmdk_base_directory_path_shared(3561)|using VM profile datastore path as the vmdk base directory path: /var/lib/vmware/images
> 2013-06-14 14:26:06|14554|9:9|image|utils.pm:run_ssh_command(4935)|executing SSH command on esxi4:
> |14554|9:9|image| /usr/bin/ssh -i /etc/vcl/vcl.key -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o ConnectionAttempts=1 -o ConnectTimeout=3 -l root -p 22 -x esxi4 'stat /var/lib/vmware/images/vmwarewinxp\-xp2410\-v0/vmwarewinxp\-xp2410\-v0\.vmdk' 2>&1
> 2013-06-14 14:26:07|14554|9:9|image|utils.pm:run_ssh_command(5053)|run_ssh_command output:
> |14554|9:9|image| stat: cannot stat '/var/lib/vmware/images/vmwarewinxp-xp2410-v0/vmwarewinxp-xp2410-v0.vmdk': No such file or directory
> 2013-06-14 14:26:07|14554|9:9|image|utils.pm:run_ssh_command(5063)|SSH command executed on esxi4, command:
> |14554|9:9|image| /usr/bin/ssh -i /etc/vcl/vcl.key -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o ConnectionAttempts=1 -o ConnectTimeout=3 -l root -p 22 -x esxi4 'stat /var/lib/vmware/images/vmwarewinxp\-xp2410\-v0/vmwarewinxp\-xp2410\-v0\.vmdk' 2>&1
> |14554|9:9|image| returning (1, "stat: cannot stat '/var/lib/vm...")
> 2013-06-14 14:26:07|14554|9:9|image|VMware.pm:does_image_exist(4584)|image does not exist in the shared directory on the VM host
> |14554|9:9|image| ---- WARNING ----
> |14554|9:9|image| 2013-06-14 14:26:07|14554|9:9|image|DataStructure.pm:_automethod(814)|corresponding data has not been initialized for get_vmhost_profile_repository_path: $self->request_data->{reservation}{9}{computer}{vmhost}{vmprofile}{repositorypath}
> |14554|9:9|image| ( 0) DataStructure.pm, _automethod (line: 814)
> |14554|9:9|image| (-1) Autoload.pm, __ANON__ (line: 80)
> |14554|9:9|image| (-2) VMware.pm, get_repository_vmdk_base_directory_path (line: 4127)
> |14554|9:9|image| (-3) VMware.pm, get_repository_vmdk_directory_path (line: 4168)
> |14554|9:9|image| (-4) VMware.pm, get_repository_vmdk_file_path (line: 4197)
> |14554|9:9|image| (-5) VMware.pm, does_image_exist (line: 4588)
> 2013-06-14 14:26:07|14554|9:9|image|VMware.pm:get_repository_vmdk_base_directory_path(4129)|repository path is not configured in the VM profile
> 2013-06-14 14:26:07|14554|9:9|image|VMware.pm:get_repository_vmdk_directory_path(4170)|image repository vmdk directory path cannot be determined because repository path is not configured in the VM profile
> 2013-06-14 14:26:07|14554|9:9|image|VMware.pm:does_image_exist(4590)|image does not exist on the VM host and image repository path is not configured in the VM profile
> 2013-06-14 14:26:07|14554|9:9|image|image.pm:process(145)|image vmwarewinxp-xp2410-v0 does not exist in the repository
> 2013-06-14 14:26:07|14554|9:9|image|DataStructure.pm:_automethod(836)|data structure updated, hash path: $self->request_data->{reservation}{9}{image}{lastupdate}, data identifier: image_lastupdate, data:
> |14554|9:9|image| : "2013-06-14 14:26:07"
> 2013-06-14 14:26:07|14554|9:9|image|DataStructure.pm:_automethod(836)|data structure updated, hash path: $self->request_data->{reservation}{9}{imagerevision}{datecreated}, data identifier: imagerevision_date_created, data:
> |14554|9:9|image| : "2013-06-14 14:26:07"
> 2013-06-14 14:26:07|14554|9:9|image|image.pm:process(161)|calling provisioning module's capture() subroutine
> 2013-06-14 14:26:07|14554|9:9|image|VMware.pm:get_vmdk_base_directory_path_shared(3561)|using VM profile datastore path as the vmdk base directory path: /var/lib/vmware/images
> |14554|9:9|image| ---- WARNING ----
> |14554|9:9|image| 2013-06-14 14:26:07|14554|9:9|image|DataStructure.pm:_automethod(814)|corresponding data has not been initialized for get_vmhost_profile_repository_path: $self->request_data->{reservation}{9}{computer}{vmhost}{vmprofile}{repositorypath}
> |14554|9:9|image| ( 0) DataStructure.pm, _automethod (line: 814)
> |14554|9:9|image| (-1) Autoload.pm, __ANON__ (line: 80)
> |14554|9:9|image| (-2) VMware.pm, get_repository_vmdk_base_directory_path (line: 4127)
> |14554|9:9|image| (-3) VMware.pm, is_repository_mounted_on_vmhost (line: 6694)
> |14554|9:9|image| (-4) VMware.pm, capture (line: 603)
> |14554|9:9|image| (-5) image.pm, process (line: 162)
> 2013-06-14 14:26:07|14554|9:9|image|VMware.pm:get_repository_vmdk_base_directory_path(4129)|repository path is not configured in the VM profile
> 2013-06-14 14:26:07|14554|9:9|image|VMware.pm:is_repository_mounted_on_vmhost(6696)|unable to determine if image repository is mounted on VM host esxi4, repository path is not configured in the VM profile
> 2013-06-14 14:26:15|14554|9:9|image|OS.pm:is_ssh_responding(640)|xp2 is responding to SSH, port 22: open, port 24: closed
> 2013-06-14 14:26:16|14554|9:9|image|OS.pm:get_os_type(2216)|Windows OS is currently installed on xp2, output:
> |14554|9:9|image| CYGWIN_NT-5.1 xp2 1.7.18(0.263/5/3) 2013-04-19 10:39 i686 Cygwin
> 2013-06-14 14:26:16|14554|9:9|image|VMware.pm:get_active_vmx_file_path(963)|'windows' OS type currently installed on xp2 matches the OS type of the image assigned to this reservation
> 2013-06-14 14:26:17|14554|9:9|image|Windows.pm:is_64_bit(8587)|32-bit Windows OS detected, PROCESSOR_IDENTIFIER: x86 Family 6 Model 37 Stepping 5, GenuineIntel
> 2013-06-14 14:26:17|14554|9:9|image|Windows.pm:get_system32_path(8630)|32-bit Windows OS installed on xp2, using C:/Windows/System32
> 2013-06-14 14:26:17|14554|9:9|image|DataStructure.pm:get_computer_private_ip_address(1630)|attempting to retrieve private IP address for computer: xp2
> 2013-06-14 14:26:17|14554|9:9|image|DataStructure.pm:get_computer_private_ip_address(1634)|retrieved contents of /etc/hosts on this management node, contains 10 lines
> 2013-06-14 14:26:17|14554|9:9|image|DataStructure.pm:get_computer_private_ip_address(1694)|returning IP address from /etc/hosts file: 192.168.72.152
> 2013-06-14 14:26:17|14554|9:9|image|Windows.pm:get_network_configuration(5584)|attempt 1/12: checking if devices still appear to be initializing before retrieving network configuration
> 2013-06-14 14:26:19|14554|9:9|image|Windows.pm:get_task_info(7387)|ran tasklist.exe
> |14554|9:9|image| ---- WARNING ----
> |14554|9:9|image| 2013-06-14 14:26:20|14554|9:9|image|vcld:warning_handler(613)|Use of uninitialized value in join or string at /usr/local/vcl/bin/../lib/VCL/Module/OS/Windows.pm line 7410.
> |14554|9:9|image| ( 0) vcld, warning_handler (line: 613)
> |14554|9:9|image| (-1) Windows.pm, get_task_info (line: 7410)
> |14554|9:9|image| (-2) Windows.pm, get_network_configuration (line: 5585)
> |14554|9:9|image| (-3) OS.pm, get_private_interface_name (line: 1043)
> |14554|9:9|image| (-4) OS.pm, get_private_network_configuration (line: 1280)
> |14554|9:9|image| (-5) (eval 369), (eval) (line: 1)
> 2013-06-14 14:26:20|14554|9:9|image|Windows.pm:get_task_info(7410)|column names:
> 2013-06-14 14:26:20|14554|9:9|image|DataStructure.pm:get_computer_private_ip_address(1606)|returning private IP address previously retrieved: 192.168.72.152
> 2013-06-14 14:26:20|14554|9:9|image|utils.pm:is_inblockrequest(5793)|zero rows were returned from database select
> 2013-06-14 14:26:20|14554|9:9|image|DataStructure.pm:get_image_affiliation_name(2118)|image owner id: 1
> 2013-06-14 14:26:20|14554|9:9|image|DataStructure.pm:retrieve_user_data(1401)|attempting to retrieve and store data for user: user.id = '1'
> 2013-06-14 14:26:20|14554|9:9|image|DataStructure.pm:retrieve_user_data(1464)|data has been retrieved for user: admin (id: 1)
>
>
>
>
>
> Best Regards,
> Vincent YA Chen 陳彥安 4F, 7 Song Ren Road
> <Mail Attachment.gif>
> I/T Specialist Taipei, 110
> End User Service Taiwan
> GTS Service Delivery, Taiwan
> Phone: +886-2-8723-9081
> Mobile: +886-911-227-378
> e-mail: yachen@tw.ibm.com
>
>
>
>
>
> From: "Pablo J. Rebollo-Sosa" <pa...@upr.edu>
> To: "user@vcl.apache.org" <us...@vcl.apache.org>
> Cc: "user@vcl.apache.org" <us...@vcl.apache.org>, Ken JB Yu/Taiwan/IBM@IBMTW
> Date: 2013/06/14 上午 01:36
> Subject: Re: Capture A Base Image problem
>
>
>
> You need to use the names defined on the management system instead of the IP for the connection test.
>
> For example:
>
> ssh -i /etc/vcl/vcl.key esxi4
>
> ssh -i /etc/vcl/vcl.key xp2
>
> Pablo
>
> Sent from my iPhone
>
> On Jun 13, 2013, at 10:53 AM, Vincent YA Chen <ya...@tw.ibm.com> wrote:
>
> Dear Sir
>
> thank you for your kindly reply , yes , the management node could log in both systems without password
>
>
>
> [root@cent59 ~]# ssh -i /etc/vcl/vcl.key 192.168.72.150
> Warning: Permanently added '192.168.72.150' (RSA) to the list of known hosts.
> You have activated Tech Support Mode.
> The time and date of this activation have been sent to the system logs.
>
> Tech Support Mode is not supported unless used in consultation
> with VMware Tech Support.
>
> VMware offers supported, powerful system administration tools. Please
> see www.vmware.com/go/sysadmintools for details.
>
> Tech Support Mode may be disabled by an administrative user.
> Disabling requires a reboot of the system. Please consult the ESXi
> Configuration Guide for additional important information.
>
> ~ #
>
>
> [root@cent59 ~]# ssh -i /etc/vcl/vcl.key 192.168.72.152Warning: Permanently added '192.168.72.152' (RSA) to the list of known hosts.
>
> root@xp2 ~
> $
> Best Regards,
> Vincent YA Chen 陳彥安 4F, 7 Song Ren Road
> <mime-attachment.gif>
> I/T Specialist Taipei, 110
> End User Service Taiwan
> GTS Service Delivery, Taiwan
> Phone: +886-2-8723-9081
> Mobile: +886-911-227-378
> e-mail: yachen@tw.ibm.com
>
>
>
>
>
>
> From: "Pablo J. Rebollo Sosa" <pa...@upr.edu>
> To: user@vcl.apache.org
> Cc: Ken JB Yu/Taiwan/IBM@IBMTW
> Date: 2013/06/13 下午 08:18
> Subject: Re: Capture A Base Image problem
>
>
>
> First of all, verify you can resolve the hypervisor and virtual machine to capture names. Then try log into both systems without password with the private/public key.
>
> For example:
>
> ssh -i /etc/vcl/vcl.key esxi4
> ssh -i /etc/vcl/vcl.key xp2
>
> Notice that the example don't use FQDN.
>
> Pablo
>
> On Jun 13, 2013, at 5:43 AM, Vincent YA Chen <ya...@tw.ibm.com> wrote:
>
> Dears
>
> Your kindly advise is appreciated .Now, I am evaluating VCL solution and trying to build up a testing environment , but I encounter a problem on image capture .
> I follow the installation procedure (https://cwiki.apache.org/VCL/vcl-23-installation.html ) to install/configure all the components ( Database, Web Components, Management Node Components) and
> do image capture (https://cwiki.apache.org/VCL/capture-a-base-image.html ) ; however , the management node always show below error msg (VCL::image object could not be created and initialized)
>
>
>
> VCL::image object could not be created and initialized
> ------------------------------------------------------------------------
> time: 2013-06-13 09:18:15
> caller: vcld:make_new_child(574)
> ( 0) vcld, make_new_child (line: 574)
> (-1) vcld, main (line: 350)
> ------------------------------------------------------------------------
> management node: cent59.ibm.demo
> reservation PID: 3661
> parent vcld PID: 21145
>
> request ID: 6
> reservation ID: 6
> request state/laststate: image/image
> request start time: 2013-06-13 09:17:49
> request end time: 2013-06-13 10:17:49
> for imaging: no
> log ID: none
>
> computer: xp2.ibm.demo
> computer id: 4
> computer type: virtualmachine
> computer eth0 MAC address: 00:0c:29:36:ac:73
> computer eth1 MAC address: 00:0c:29:36:ac:7d
> computer private IP address: 192.168.72.152
> computer public IP address: 172.16.1.152
> computer in block allocation: no
> provisioning module: VCL::Module::Provisioning::VMware::VMware
>
> vm host: esxi4.ibm.demo
> vm host ID: 2
> vm host computer ID: 3
> vm profile: VMware ESXi - local storage
> vm profile VM path: /var/lib/vmware/runningvms
> vm profile repository path: <undefined>
> vm profile datastore path: /var/lib/vmware/images
> vm profile disk type: dedicated
>
> image: vmwarewinxp-xp217-v0
> image display name: xp21
> image ID: 7
> image revision ID: 7
> image size: 1450 MB
> use Sysprep: no
> root access: yes
> image owner ID: 1
> image owner affiliation: Local
> image revision date created: 2013-06-13 09:17:49
> image revision production: yes
> OS module: VCL::Module::OS::Windows::Version_5::XP
>
> user: admin
> user name: vcl admin
> user ID: 1
> user affiliation: Local
> ------------------------------------------------------------------------
> RECENT LOG ENTRIES FOR THIS PROCESS:
> |3661|6:6|image| : "cent59"
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_automethod(836)|data structure updated, hash path: $self->request_data->{reservation}{0}{computer}{SHORTNAME}, data identifier: computer_short_name, data:
> |3661|6:6|image| : "cent59"
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_automethod(836)|data structure updated, hash path: $self->request_data->{reservation}{0}{computer}{IPaddress}, data identifier: computer_ip_address, data:
> |3661|6:6|image| : "192.168.72.200"
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:create_mn_os_object(381)|VCL::Module::OS::Linux::ManagementNode OS object created, address: acc0bb8
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:new(192)|VCL::image object created for state image, address: ab57c98
> 2013-06-13 09:17:54|3661|6:6|image|State.pm:initialize(88)|obtained a database handle for this state process, stored as $ENV{dbh}
> 2013-06-13 09:17:54|3661|6:6|image|State.pm:check_image_os(790)|no corrections need to be made to image OS: vmwarewinxp
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:is_parent_reservation(993)|returning true: parent reservation ID for this request: 6
> 2013-06-13 09:17:54|3661|6:6|image|utils.pm:rename_vcld_process(6785)|reservation count: 1
> 2013-06-13 09:17:54|3661|6:6|image|utils.pm:rename_vcld_process(6804)|PARENTIMAGE: 1
> 2013-06-13 09:17:54|3661|6:6|image|utils.pm:rename_vcld_process(6805)|SUBIMAGE: 0
> 2013-06-13 09:17:54|3661|6:6|image|utils.pm:rename_vcld_process(6823)|renamed process to 'vcld 6:6 image xp2>esxi4.ibm.demo vmwarewinxp-xp217-v0 admin'
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:is_parent_reservation(993)|returning true: parent reservation ID for this request: 6
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:is_parent_reservation(993)|returning true: parent reservation ID for this request: 6
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:create_os_object(308)|VCL::Module::OS::Windows::Version_5::XP module loaded
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:new(196)|VCL::Module::OS::Windows::Version_5::XP object created for image vmwarewinxp-xp217-v0, address: b040f54
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:create_os_object(314)|VCL::Module::OS::Windows::Version_5::XP OS object created, address: b040f54
> 2013-06-13 09:17:54|3661|6:6|image|State.pm:initialize(125)|computer is a VM, attempting to create VM host OS object
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(613)|computer ID argument was specified, retrieving data for computer ID: 3
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(637)|image ID argument was specified: 1, DataStructure object will contain image information for the production imagerevision of this image
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(668)|retrieved data for imagerevision ID: 1
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(684)|retrieved data for image ID: 1
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:create_vmhost_os_object(454)|attempting to load VM host OS module: VCL::Module::OS::Linux::UnixLab (image: 1)
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:create_vmhost_os_object(460)|VM host OS module loaded: VCL::Module::OS::Linux::UnixLab
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:new(196)|VCL::Module::OS::Linux::UnixLab object created for image noimage, address: b402944
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:create_vmhost_os_object(465)|VCL::Module::OS::Linux::UnixLab OS object created, address: b402944
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:create_provisioning_object(519)|VCL::Module::Provisioning::VMware::VMware module loaded
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:new(200)|VCL::Module::Provisioning::VMware::VMware object created for computer xp2, address: b41a4f4
> 2013-06-13 09:17:54|3661|6:6|image|VMware.pm:initialize(267)|initializing VCL::Module::Provisioning::VMware::VMware object
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(613)|computer ID argument was specified, retrieving data for computer ID: 3
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(637)|image ID argument was specified: 1, DataStructure object will contain image information for the production imagerevision of this image
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(668)|retrieved data for imagerevision ID: 1
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(684)|retrieved data for image ID: 1
> 2013-06-13 09:17:54|3661|6:6|image|VMware.pm:get_vmhost_datastructure(1392)|created DataStructure object for VM host: esxi4
> 2013-06-13 09:17:54|3661|6:6|image|VMware.pm:initialize(287)|VM profile assigned to esxi4: VMware ESXi - local storage
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(613)|computer ID argument was specified, retrieving data for computer ID: 3
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(637)|image ID argument was specified: 1, DataStructure object will contain image information for the production imagerevision of this image
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(668)|retrieved data for imagerevision ID: 1
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(684)|retrieved data for image ID: 1
> 2013-06-13 09:17:54|3661|6:6|image|VMware.pm:get_vmhost_datastructure(1392)|created DataStructure object for VM host: esxi4
> 2013-06-13 09:17:54|3661|6:6|image|VMware.pm:get_vmhost_api_object(1495)|attempting to load VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
> 2013-06-13 09:17:54|3661|6:6|image|VMware.pm:get_vmhost_api_object(1501)|loaded VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:new(200)|VCL::Module::Provisioning::VMware::vSphere_SDK object created for computer xp2, address: b74cf70
> 2013-06-13 09:17:54|3661|6:6|image|vSphere_SDK.pm:initialize(98)|vSphere SDK for Perl does not appear to be installed on this managment node, unable to load VMware vSphere SDK Perl modules, error:
> |3661|6:6|image| Can't locate VMware/VIRuntime.pm in @INC (@INC contains: /usr/local/vcl/bin/../../../.. /usr/local/vcl/bin/../.. /usr/local/vcl/bin/../../.. /usr/local/vcl/bin/../../../../.. /usr/local/vcl/bin/.. /usr/local/vcl/bin/../lib /usr/lib/perl5/site_perl/5.8.8/i386-linux-thread-multi /usr/lib/perl5/site_perl/5.8.8 /usr/lib/perl5/site_perl /usr/lib/perl5/vendor_perl/5.8.8/i386-linux-thread-multi /usr/lib/perl5/vendor_perl/5.8.8 /usr/lib/perl5/vendor_perl /usr/lib/perl5/5.8.8/i386-linux-thread-multi /usr/lib/perl5/5.8.8 .) at (eval 238) line 1.
> |3661|6:6|image| BEGIN failed--compilation aborted at (eval 238) line 1.
> 2013-06-13 09:17:54|3661|6:6|image|VMware.pm:get_vmhost_api_object(1515)|API object could not be created: VCL::Module::Provisioning::VMware::vSphere_SDK
> |3661|6:6|image| ---- WARNING ----
> |3661|6:6|image| 2013-06-13 09:18:05|3661|6:6|image|utils.pm:nmap_port(2454)|error occurred running nmap command: '/usr/bin/nmap esxi4 -P0 -p 22 -T Aggressive', output:
> |3661|6:6|image| Starting Nmap 4.11 ( http://www.insecure.org/nmap/ ) at 2013-06-13 09:17 CST
> |3661|6:6|image| Failed to resolve given hostname/IP: esxi4. Note that you can't use '/mask' AND '1-4,7,100-' style IP ranges
> |3661|6:6|image| WARNING: No targets were specified, so 0 hosts scanned.
> |3661|6:6|image| Nmap finished: 0 IP addresses (0 hosts up) scanned in 10.125 seconds
> |3661|6:6|image| ( 0) utils.pm, nmap_port (line: 2454)
> |3661|6:6|image| (-1) OS.pm, is_ssh_responding (line: 612)
> |3661|6:6|image| (-2) VMware.pm, initialize (line: 303)
> |3661|6:6|image| (-3) Module.pm, new (line: 207)
> |3661|6:6|image| (-4) Module.pm, create_provisioning_object (line: 522)
> |3661|6:6|image| (-5) State.pm, initialize (line: 136)
> |3661|6:6|image| ---- WARNING ----
> |3661|6:6|image| 2013-06-13 09:18:15|3661|6:6|image|utils.pm:nmap_port(2454)|error occurred running nmap command: '/usr/bin/nmap esxi4 -P0 -p 24 -T Aggressive', output:
> |3661|6:6|image| Starting Nmap 4.11 ( http://www.insecure.org/nmap/ ) at 2013-06-13 09:18 CST
> |3661|6:6|image| Failed to resolve given hostname/IP: esxi4. Note that you can't use '/mask' AND '1-4,7,100-' style IP ranges
> |3661|6:6|image| WARNING: No targets were specified, so 0 hosts scanned.
> |3661|6:6|image| Nmap finished: 0 IP addresses (0 hosts up) scanned in 10.001 seconds
> |3661|6:6|image| ( 0) utils.pm, nmap_port (line: 2454)
> |3661|6:6|image| (-1) OS.pm, is_ssh_responding (line: 613)
> |3661|6:6|image| (-2) VMware.pm, initialize (line: 303)
> |3661|6:6|image| (-3) Module.pm, new (line: 207)
> |3661|6:6|image| (-4) Module.pm, create_provisioning_object (line: 522)
> |3661|6:6|image| (-5) State.pm, initialize (line: 136)
> 2013-06-13 09:18:15|3661|6:6|image|OS.pm:is_ssh_responding(615)|esxi4 is NOT responding to SSH, ports 22 or 24 are both closed
> 2013-06-13 09:18:15|3661|6:6|image|VMware.pm:initialize(307)|unable to control OS of VM host esxi4 using VCL::Module::OS::Linux::UnixLab OS object because VM host is not responding to SSH
> |3661|6:6|image| ---- WARNING ----
> |3661|6:6|image| 2013-06-13 09:18:15|3661|6:6|image|Module.pm:create_provisioning_object(530)|provisioning object could not be created, returning 0
> |3661|6:6|image| ( 0) Module.pm, create_provisioning_object (line: 530)
> |3661|6:6|image| (-1) State.pm, initialize (line: 136)
> |3661|6:6|image| (-2) Module.pm, new (line: 207)
> |3661|6:6|image| (-3) vcld, make_new_child (line: 567)
> |3661|6:6|image| (-4) vcld, main (line: 350)
> |3661|6:6|image| ---- WARNING ----
> |3661|6:6|image| 2013-06-13 09:18:15|3661|6:6|image|State.pm:initialize(145)|failed to create provisioning object
> |3661|6:6|image| ( 0) State.pm, initialize (line: 145)
> |3661|6:6|image| (-1) Module.pm, new (line: 207)
> |3661|6:6|image| (-2) vcld, make_new_child (line: 567)
> |3661|6:6|image| (-3) vcld, main (line: 350)
> 2013-06-13 09:18:15|3661|6:6|image|utils.pm:delete_computerloadlog_reservation(6429)|removing computerloadlog entries matching loadstate = begin
> 2013-06-13 09:18:15|3661|6:6|image|utils.pm:delete_computerloadlog_reservation(6476)|deleted rows from computerloadlog for reservation id=6
> 2013-06-13 09:18:15|3661|6:6|image|State.pm:DESTROY(929)|VCL::image process duration: 21 seconds
> 2013-06-13 09:18:15|3661|6:6|image|DataStructure.pm:get_computer_private_ip_address(1630)|attempting to retrieve private IP address for computer: xp2
> 2013-06-13 09:18:15|3661|6:6|image|DataStructure.pm:get_computer_private_ip_address(1634)|retrieved contents of /etc/hosts on this management node, contains 7 lines
> 2013-06-13 09:18:15|3661|6:6|image|DataStructure.pm:get_computer_private_ip_address(1673)|did not find any lines in /etc/hosts containing 'xp2', returning private IP address defined in the database: 192.168.72.152
> 2013-06-13 09:18:15|3661|6:6|image|utils.pm:getnewdbh(2512)|unable to use database handle stored in $ENV{dbh}
> 2013-06-13 09:18:15|3661|6:6|image|utils.pm:getnewdbh(2569)|database handle stored in $ENV{dbh}
> 2013-06-13 09:18:15|3661|6:6|image|utils.pm:is_inblockrequest(5793)|zero rows were returned from database select
> 2013-06-13 09:18:15|3661|6:6|image|DataStructure.pm:get_image_affiliation_name(2118)|image owner id: 1
> 2013-06-13 09:18:15|3661|6:6|image|DataStructure.pm:retrieve_user_data(1401)|attempting to retrieve and store data for user: user.id = '1'
> 2013-06-13 09:18:15|3661|6:6|image|DataStructure.pm:retrieve_user_data(1464)|data has been retrieved for user: admin (id: 1)
>
>
>
> My Environment :
>
> Hypervisor : ESXi 4.0.0
> Management Node : CentOS 5.9
> Image O.S : Window XP SP3
> VCL : 2.3
>
> if there were further information required , plz kindly let me know, thank you
> Best Regards,
> Vincent YA Chen 陳彥安 4F, 7 Song Ren Road
> <Mail Attachment.gif>
> I/T Specialist Taipei, 110
> End User Service Taiwan
> GTS Service Delivery, Taiwan
> Phone: +886-2-8723-9081
> Mobile: +886-911-227-378
> e-mail: yachen@tw.ibm.com
>
>
>
>
>
>
Re: Capture A Base Image problem
Posted by Vincent YA Chen <ya...@tw.ibm.com>.
Dear Sir
thanks a lot !
After I edit the host file , I could login those two systems without
password . I do image capture again but still get below err msg , your
consistent help is appreciated .
EHR - getline_hr () called before column_names () at
/usr/local/vcl/bin/../lib/VCL/Module/OS/Windows.pm line 7415
------------------------------------------------------------------------
time: 2013-06-14 14:26:20
caller: vcld:die_handler(639)
( 0) vcld, die_handler (line: 639)
(-1) Carp.pm, croak (line: 269)
(-2) CSV_XS.pm, getline_hr_all (line: 566)
(-3) Windows.pm, get_task_info (line: 7415)
(-4) Windows.pm, get_network_configuration (line: 5585)
(-5) OS.pm, get_private_interface_name (line: 1043)
(-6) OS.pm, get_private_network_configuration (line: 1280)
(-7) (eval 369), (eval) (line: 1)
(-8) OS.pm, get_mac_address (line: 1342)
(-9) OS.pm, get_private_mac_address (line: 1376)
(-10) VMware.pm, get_active_vmx_file_path (line: 974)
(-11) VMware.pm, capture (line: 618)
(-12) image.pm, process (line: 162)
(-13) vcld, make_new_child (line: 571)
(-14) vcld, main (line: 350)
------------------------------------------------------------------------
management node: cent59.ibm.demo
reservation PID: 14554
parent vcld PID: 21145
request ID: 9
reservation ID: 9
request state/laststate: image/image
request start time: 2013-06-14 14:25:56
request end time: 2013-06-14 15:25:56
for imaging: no
log ID: none
computer: xp2.ibm.demo
computer id: 4
computer type: virtualmachine
computer eth0 MAC address: 00:0c:29:36:ac:73
computer eth1 MAC address: 00:0c:29:36:ac:7d
computer private IP address: 192.168.72.152
computer public IP address: 172.16.1.152
computer in block allocation: no
provisioning module: VCL::Module::Provisioning::VMware::VMware
vm host: esxi4.ibm.demo
vm host ID: 2
vm host computer ID: 3
vm profile: VMware ESXi - local storage
vm profile VM path: /var/lib/vmware/runningvms
vm profile repository path: <undefined>
vm profile datastore path: /var/lib/vmware/images
vm profile disk type: dedicated
image: vmwarewinxp-xp2410-v0
image display name: xp24
image ID: 10
image revision ID: 10
image size: 1450 MB
use Sysprep: no
root access: yes
image owner ID: 1
image owner affiliation: Local
image revision date created: 2013-06-14 14:26:07
image revision production: yes
OS module: VCL::Module::OS::Windows::Version_5::XP
user: admin
user name: vcl admin
user ID: 1
user affiliation: Local
------------------------------------------------------------------------
RECENT LOG ENTRIES FOR THIS PROCESS:
|14554|9:9|image| VMware API object type:
VCL::Module::Provisioning::VMware::VIM_SSH
2013-06-14
14:26:02|14554|9:9|image|utils.pm:run_ssh_command(4935)|executing SSH
command on esxi4:
|14554|9:9|image| /usr/bin/ssh -i /etc/vcl/vcl.key -o
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o
ConnectionAttempts=1 -o ConnectTimeout=3 -l root -p 22 -x esxi4 'vmware
-v' 2>&1
2013-06-14
14:26:02|14554|9:9|image|utils.pm:run_ssh_command(5053)|run_ssh_command
output:
|14554|9:9|image| VMware ESXi 4.0.0 build-208167
2013-06-14 14:26:02|14554|9:9|image|utils.pm:run_ssh_command(5067)|SSH
command executed on esxi4, returning (0, "VMware ESXi 4.0.0 build-208167")
2013-06-14
14:26:02|14554|9:9|image|VMware.pm:get_vmhost_product_name(6621)|VMware
product being used on VM host esxi4: 'VMware ESXi 4.0.0 build-208167'
2013-06-14
14:26:02|14554|9:9|image|VMware.pm:get_vmx_base_directory_path(3089)|determined
vmx base directory path: /var/lib/vmware/runningvms
2013-06-14
14:26:02|14554|9:9|image|utils.pm:run_ssh_command(4935)|executing SSH
command on esxi4:
|14554|9:9|image| /usr/bin/ssh -i /etc/vcl/vcl.key -o
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o
ConnectionAttempts=1 -o ConnectTimeout=3 -l root -p 22 -x esxi4 'stat
/var/lib/vmware/runningvms' 2>&1
2013-06-14
14:26:03|14554|9:9|image|utils.pm:run_ssh_command(5053)|run_ssh_command
output:
|14554|9:9|image| File: "/var/lib/vmware/runningvms"
|14554|9:9|image| Size: 512 Blocks: 8 IO
Block: 131072 directory
|14554|9:9|image| Device: eh/14d Inode: 4066 Links:
1
|14554|9:9|image| Access: (0755/drwxr-xr-x) Uid: ( 0/ root) Gid:
( 0/ root)
|14554|9:9|image| Access: 2013-06-09 03:51:35.000000000
|14554|9:9|image| Modify: 2013-06-09 03:51:35.000000000
|14554|9:9|image| Change: 2013-06-09 03:51:35.000000000
2013-06-14 14:26:03|14554|9:9|image|utils.pm:run_ssh_command(5067)|SSH
command executed on esxi4, returning (0, "File:
"/var/lib/vmware/running...")
2013-06-14
14:26:03|14554|9:9|image|Linux.pm:file_exists(1356)|'/var/lib/vmware/runningvms'
exists on esxi4, files: 0, directories: 1, links: 0
2013-06-14 14:26:03|14554|9:9|image|VMware.pm:is_vm_dedicated(4246)|VM
disk mode does not need to be dedicated
2013-06-14
14:26:03|14554|9:9|image|VMware.pm:get_vmdk_base_directory_path_shared(3561)|using
VM profile datastore path as the vmdk base directory path:
/var/lib/vmware/images
2013-06-14
14:26:03|14554|9:9|image|utils.pm:run_ssh_command(4935)|executing SSH
command on esxi4:
|14554|9:9|image| /usr/bin/ssh -i /etc/vcl/vcl.key -o
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o
ConnectionAttempts=1 -o ConnectTimeout=3 -l root -p 22 -x esxi4 'stat
/var/lib/vmware/images' 2>&1
2013-06-14
14:26:03|14554|9:9|image|utils.pm:run_ssh_command(5053)|run_ssh_command
output:
|14554|9:9|image| File: "/var/lib/vmware/images"
|14554|9:9|image| Size: 512 Blocks: 8 IO
Block: 131072 directory
|14554|9:9|image| Device: eh/14d Inode: 3158 Links:
1
|14554|9:9|image| Access: (0755/drwxr-xr-x) Uid: ( 0/ root) Gid:
( 0/ root)
|14554|9:9|image| Access: 2013-06-09 02:43:35.000000000
|14554|9:9|image| Modify: 2013-06-09 02:50:48.000000000
|14554|9:9|image| Change: 2013-06-09 02:50:48.000000000
2013-06-14 14:26:03|14554|9:9|image|utils.pm:run_ssh_command(5067)|SSH
command executed on esxi4, returning (0, "File:
"/var/lib/vmware/images"...")
2013-06-14
14:26:03|14554|9:9|image|Linux.pm:file_exists(1356)|'/var/lib/vmware/images'
exists on esxi4, files: 0, directories: 1, links: 0
2013-06-14
14:26:03|14554|9:9|image|Module.pm:create_provisioning_object(525)|VCL::Module::Provisioning::VMware::VMware
provisioner object created for xp2, address: b423f7c
2013-06-14 14:26:03|14554|9:9|image|State.pm:initialize(154)|returning 1
2013-06-14 14:26:03|14554|9:9|image|vcld:make_new_child(568)|VCL::image
object created and initialized
2013-06-14 14:26:06|14554|9:9|image|utils.pm:mail(1266)|SUCCESS -- Sending
mail To: yachen@tw.ibm.com, VCL IMAGE Creation Started:
vmwarewinxp-xp2410-v0
2013-06-14
14:26:06|14554|9:9|image|VMware.pm:get_vmdk_base_directory_path_shared(3561)|using
VM profile datastore path as the vmdk base directory path:
/var/lib/vmware/images
2013-06-14
14:26:06|14554|9:9|image|utils.pm:run_ssh_command(4935)|executing SSH
command on esxi4:
|14554|9:9|image| /usr/bin/ssh -i /etc/vcl/vcl.key -o
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o
ConnectionAttempts=1 -o ConnectTimeout=3 -l root -p 22 -x esxi4 'stat
/var/lib/vmware/images/vmwarewinxp\-xp2410\-v0/vmwarewinxp\-xp2410\-v0\.vmdk'
2>&1
2013-06-14
14:26:07|14554|9:9|image|utils.pm:run_ssh_command(5053)|run_ssh_command
output:
|14554|9:9|image| stat: cannot stat
'/var/lib/vmware/images/vmwarewinxp-xp2410-v0/vmwarewinxp-xp2410-v0.vmdk':
No such file or directory
2013-06-14 14:26:07|14554|9:9|image|utils.pm:run_ssh_command(5063)|SSH
command executed on esxi4, command:
|14554|9:9|image| /usr/bin/ssh -i /etc/vcl/vcl.key -o
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o
ConnectionAttempts=1 -o ConnectTimeout=3 -l root -p 22 -x esxi4 'stat
/var/lib/vmware/images/vmwarewinxp\-xp2410\-v0/vmwarewinxp\-xp2410\-v0\.vmdk'
2>&1
|14554|9:9|image| returning (1, "stat: cannot stat '/var/lib/vm...")
2013-06-14 14:26:07|14554|9:9|image|VMware.pm:does_image_exist(4584)|image
does not exist in the shared directory on the VM host
|14554|9:9|image| ---- WARNING ----
|14554|9:9|image| 2013-06-14
14:26:07|14554|9:9|image|DataStructure.pm:_automethod(814)|corresponding
data has not been initialized for get_vmhost_profile_repository_path:
$self->request_data->{reservation}{9}{computer}{vmhost}{vmprofile}{repositorypath}
|14554|9:9|image| ( 0) DataStructure.pm, _automethod (line: 814)
|14554|9:9|image| (-1) Autoload.pm, __ANON__ (line: 80)
|14554|9:9|image| (-2) VMware.pm, get_repository_vmdk_base_directory_path
(line: 4127)
|14554|9:9|image| (-3) VMware.pm, get_repository_vmdk_directory_path
(line: 4168)
|14554|9:9|image| (-4) VMware.pm, get_repository_vmdk_file_path (line:
4197)
|14554|9:9|image| (-5) VMware.pm, does_image_exist (line: 4588)
2013-06-14
14:26:07|14554|9:9|image|VMware.pm:get_repository_vmdk_base_directory_path(4129)|repository
path is not configured in the VM profile
2013-06-14
14:26:07|14554|9:9|image|VMware.pm:get_repository_vmdk_directory_path(4170)|image
repository vmdk directory path cannot be determined because repository
path is not configured in the VM profile
2013-06-14 14:26:07|14554|9:9|image|VMware.pm:does_image_exist(4590)|image
does not exist on the VM host and image repository path is not configured
in the VM profile
2013-06-14 14:26:07|14554|9:9|image|image.pm:process(145)|image
vmwarewinxp-xp2410-v0 does not exist in the repository
2013-06-14 14:26:07|14554|9:9|image|DataStructure.pm:_automethod(836)|data
structure updated, hash path:
$self->request_data->{reservation}{9}{image}{lastupdate}, data identifier:
image_lastupdate, data:
|14554|9:9|image| : "2013-06-14 14:26:07"
2013-06-14 14:26:07|14554|9:9|image|DataStructure.pm:_automethod(836)|data
structure updated, hash path:
$self->request_data->{reservation}{9}{imagerevision}{datecreated}, data
identifier: imagerevision_date_created, data:
|14554|9:9|image| : "2013-06-14 14:26:07"
2013-06-14 14:26:07|14554|9:9|image|image.pm:process(161)|calling
provisioning module's capture() subroutine
2013-06-14
14:26:07|14554|9:9|image|VMware.pm:get_vmdk_base_directory_path_shared(3561)|using
VM profile datastore path as the vmdk base directory path:
/var/lib/vmware/images
|14554|9:9|image| ---- WARNING ----
|14554|9:9|image| 2013-06-14
14:26:07|14554|9:9|image|DataStructure.pm:_automethod(814)|corresponding
data has not been initialized for get_vmhost_profile_repository_path:
$self->request_data->{reservation}{9}{computer}{vmhost}{vmprofile}{repositorypath}
|14554|9:9|image| ( 0) DataStructure.pm, _automethod (line: 814)
|14554|9:9|image| (-1) Autoload.pm, __ANON__ (line: 80)
|14554|9:9|image| (-2) VMware.pm, get_repository_vmdk_base_directory_path
(line: 4127)
|14554|9:9|image| (-3) VMware.pm, is_repository_mounted_on_vmhost (line:
6694)
|14554|9:9|image| (-4) VMware.pm, capture (line: 603)
|14554|9:9|image| (-5) image.pm, process (line: 162)
2013-06-14
14:26:07|14554|9:9|image|VMware.pm:get_repository_vmdk_base_directory_path(4129)|repository
path is not configured in the VM profile
2013-06-14
14:26:07|14554|9:9|image|VMware.pm:is_repository_mounted_on_vmhost(6696)|unable
to determine if image repository is mounted on VM host esxi4, repository
path is not configured in the VM profile
2013-06-14 14:26:15|14554|9:9|image|OS.pm:is_ssh_responding(640)|xp2 is
responding to SSH, port 22: open, port 24: closed
2013-06-14 14:26:16|14554|9:9|image|OS.pm:get_os_type(2216)|Windows OS is
currently installed on xp2, output:
|14554|9:9|image| CYGWIN_NT-5.1 xp2 1.7.18(0.263/5/3) 2013-04-19 10:39
i686 Cygwin
2013-06-14
14:26:16|14554|9:9|image|VMware.pm:get_active_vmx_file_path(963)|'windows'
OS type currently installed on xp2 matches the OS type of the image
assigned to this reservation
2013-06-14 14:26:17|14554|9:9|image|Windows.pm:is_64_bit(8587)|32-bit
Windows OS detected, PROCESSOR_IDENTIFIER: x86 Family 6 Model 37 Stepping
5, GenuineIntel
2013-06-14
14:26:17|14554|9:9|image|Windows.pm:get_system32_path(8630)|32-bit Windows
OS installed on xp2, using C:/Windows/System32
2013-06-14
14:26:17|14554|9:9|image|DataStructure.pm:get_computer_private_ip_address(1630)|attempting
to retrieve private IP address for computer: xp2
2013-06-14
14:26:17|14554|9:9|image|DataStructure.pm:get_computer_private_ip_address(1634)|retrieved
contents of /etc/hosts on this management node, contains 10 lines
2013-06-14
14:26:17|14554|9:9|image|DataStructure.pm:get_computer_private_ip_address(1694)|returning
IP address from /etc/hosts file: 192.168.72.152
2013-06-14
14:26:17|14554|9:9|image|Windows.pm:get_network_configuration(5584)|attempt
1/12: checking if devices still appear to be initializing before
retrieving network configuration
2013-06-14 14:26:19|14554|9:9|image|Windows.pm:get_task_info(7387)|ran
tasklist.exe
|14554|9:9|image| ---- WARNING ----
|14554|9:9|image| 2013-06-14
14:26:20|14554|9:9|image|vcld:warning_handler(613)|Use of uninitialized
value in join or string at
/usr/local/vcl/bin/../lib/VCL/Module/OS/Windows.pm line 7410.
|14554|9:9|image| ( 0) vcld, warning_handler (line: 613)
|14554|9:9|image| (-1) Windows.pm, get_task_info (line: 7410)
|14554|9:9|image| (-2) Windows.pm, get_network_configuration (line: 5585)
|14554|9:9|image| (-3) OS.pm, get_private_interface_name (line: 1043)
|14554|9:9|image| (-4) OS.pm, get_private_network_configuration (line:
1280)
|14554|9:9|image| (-5) (eval 369), (eval) (line: 1)
2013-06-14 14:26:20|14554|9:9|image|Windows.pm:get_task_info(7410)|column
names:
2013-06-14
14:26:20|14554|9:9|image|DataStructure.pm:get_computer_private_ip_address(1606)|returning
private IP address previously retrieved: 192.168.72.152
2013-06-14 14:26:20|14554|9:9|image|utils.pm:is_inblockrequest(5793)|zero
rows were returned from database select
2013-06-14
14:26:20|14554|9:9|image|DataStructure.pm:get_image_affiliation_name(2118)|image
owner id: 1
2013-06-14
14:26:20|14554|9:9|image|DataStructure.pm:retrieve_user_data(1401)|attempting
to retrieve and store data for user: user.id = '1'
2013-06-14
14:26:20|14554|9:9|image|DataStructure.pm:retrieve_user_data(1464)|data
has been retrieved for user: admin (id: 1)
Best Regards,
Vincent YA Chen 陳彥安
4F, 7 Song Ren Road
I/T Specialist
Taipei, 110
End User Service
Taiwan
GTS Service Delivery, Taiwan
Phone:
+886-2-8723-9081
Mobile:
+886-911-227-378
e-mail:
yachen@tw.ibm.com
From: "Pablo J. Rebollo-Sosa" <pa...@upr.edu>
To: "user@vcl.apache.org" <us...@vcl.apache.org>
Cc: "user@vcl.apache.org" <us...@vcl.apache.org>, Ken JB
Yu/Taiwan/IBM@IBMTW
Date: 2013/06/14 上午 01:36
Subject: Re: Capture A Base Image problem
You need to use the names defined on the management system instead of the
IP for the connection test.
For example:
ssh -i /etc/vcl/vcl.key esxi4
ssh -i /etc/vcl/vcl.key xp2
Pablo
Sent from my iPhone
On Jun 13, 2013, at 10:53 AM, Vincent YA Chen <ya...@tw.ibm.com> wrote:
Dear Sir
thank you for your kindly reply , yes , the management node could log in
both systems without password
[root@cent59 ~]# ssh -i /etc/vcl/vcl.key 192.168.72.150
Warning: Permanently added '192.168.72.150' (RSA) to the list of known
hosts.
You have activated Tech Support Mode.
The time and date of this activation have been sent to the system logs.
Tech Support Mode is not supported unless used in consultation
with VMware Tech Support.
VMware offers supported, powerful system administration tools. Please
see www.vmware.com/go/sysadmintools for details.
Tech Support Mode may be disabled by an administrative user.
Disabling requires a reboot of the system. Please consult the ESXi
Configuration Guide for additional important information.
~ #
[root@cent59 ~]# ssh -i /etc/vcl/vcl.key 192.168.72.152Warning:
Permanently added '192.168.72.152' (RSA) to the list of known hosts.
root@xp2 ~
$
Best Regards,
Vincent YA Chen 陳彥安
4F, 7 Song Ren Road
<mime-attachment.gif>
I/T Specialist
Taipei, 110
End User Service
Taiwan
GTS Service Delivery, Taiwan
Phone:
+886-2-8723-9081
Mobile:
+886-911-227-378
e-mail:
yachen@tw.ibm.com
From: "Pablo J. Rebollo Sosa" <pa...@upr.edu>
To: user@vcl.apache.org
Cc: Ken JB Yu/Taiwan/IBM@IBMTW
Date: 2013/06/13 下午 08:18
Subject: Re: Capture A Base Image problem
First of all, verify you can resolve the hypervisor and virtual machine to
capture names. Then try log into both systems without password with the
private/public key.
For example:
ssh -i /etc/vcl/vcl.key esxi4
ssh -i /etc/vcl/vcl.key xp2
Notice that the example don't use FQDN.
Pablo
On Jun 13, 2013, at 5:43 AM, Vincent YA Chen <ya...@tw.ibm.com> wrote:
Dears
Your kindly advise is appreciated .Now, I am evaluating VCL solution and
trying to build up a testing environment , but I encounter a problem on
image capture .
I follow the installation procedure (
https://cwiki.apache.org/VCL/vcl-23-installation.html ) to
install/configure all the components ( Database, Web Components,
Management Node Components) and
do image capture (https://cwiki.apache.org/VCL/capture-a-base-image.html )
; however , the management node always show below error msg (VCL::image
object could not be created and initialized)
VCL::image object could not be created and initialized
------------------------------------------------------------------------
time: 2013-06-13 09:18:15
caller: vcld:make_new_child(574)
( 0) vcld, make_new_child (line: 574)
(-1) vcld, main (line: 350)
------------------------------------------------------------------------
management node: cent59.ibm.demo
reservation PID: 3661
parent vcld PID: 21145
request ID: 6
reservation ID: 6
request state/laststate: image/image
request start time: 2013-06-13 09:17:49
request end time: 2013-06-13 10:17:49
for imaging: no
log ID: none
computer: xp2.ibm.demo
computer id: 4
computer type: virtualmachine
computer eth0 MAC address: 00:0c:29:36:ac:73
computer eth1 MAC address: 00:0c:29:36:ac:7d
computer private IP address: 192.168.72.152
computer public IP address: 172.16.1.152
computer in block allocation: no
provisioning module: VCL::Module::Provisioning::VMware::VMware
vm host: esxi4.ibm.demo
vm host ID: 2
vm host computer ID: 3
vm profile: VMware ESXi - local storage
vm profile VM path: /var/lib/vmware/runningvms
vm profile repository path: <undefined>
vm profile datastore path: /var/lib/vmware/images
vm profile disk type: dedicated
image: vmwarewinxp-xp217-v0
image display name: xp21
image ID: 7
image revision ID: 7
image size: 1450 MB
use Sysprep: no
root access: yes
image owner ID: 1
image owner affiliation: Local
image revision date created: 2013-06-13 09:17:49
image revision production: yes
OS module: VCL::Module::OS::Windows::Version_5::XP
user: admin
user name: vcl admin
user ID: 1
user affiliation: Local
------------------------------------------------------------------------
RECENT LOG ENTRIES FOR THIS PROCESS:
|3661|6:6|image| : "cent59"
2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_automethod(836)|data
structure updated, hash path:
$self->request_data->{reservation}{0}{computer}{SHORTNAME}, data
identifier: computer_short_name, data:
|3661|6:6|image| : "cent59"
2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_automethod(836)|data
structure updated, hash path:
$self->request_data->{reservation}{0}{computer}{IPaddress}, data
identifier: computer_ip_address, data:
|3661|6:6|image| : "192.168.72.200"
2013-06-13
09:17:54|3661|6:6|image|Module.pm:create_mn_os_object(381)|VCL::Module::OS::Linux::ManagementNode
OS object created, address: acc0bb8
2013-06-13 09:17:54|3661|6:6|image|Module.pm:new(192)|VCL::image object
created for state image, address: ab57c98
2013-06-13 09:17:54|3661|6:6|image|State.pm:initialize(88)|obtained a
database handle for this state process, stored as $ENV{dbh}
2013-06-13 09:17:54|3661|6:6|image|State.pm:check_image_os(790)|no
corrections need to be made to image OS: vmwarewinxp
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:is_parent_reservation(993)|returning
true: parent reservation ID for this request: 6
2013-06-13
09:17:54|3661|6:6|image|utils.pm:rename_vcld_process(6785)|reservation
count: 1
2013-06-13
09:17:54|3661|6:6|image|utils.pm:rename_vcld_process(6804)|PARENTIMAGE: 1
2013-06-13
09:17:54|3661|6:6|image|utils.pm:rename_vcld_process(6805)|SUBIMAGE: 0
2013-06-13
09:17:54|3661|6:6|image|utils.pm:rename_vcld_process(6823)|renamed process
to 'vcld 6:6 image xp2>esxi4.ibm.demo vmwarewinxp-xp217-v0 admin'
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:is_parent_reservation(993)|returning
true: parent reservation ID for this request: 6
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:is_parent_reservation(993)|returning
true: parent reservation ID for this request: 6
2013-06-13
09:17:54|3661|6:6|image|Module.pm:create_os_object(308)|VCL::Module::OS::Windows::Version_5::XP
module loaded
2013-06-13
09:17:54|3661|6:6|image|Module.pm:new(196)|VCL::Module::OS::Windows::Version_5::XP
object created for image vmwarewinxp-xp217-v0, address: b040f54
2013-06-13
09:17:54|3661|6:6|image|Module.pm:create_os_object(314)|VCL::Module::OS::Windows::Version_5::XP
OS object created, address: b040f54
2013-06-13 09:17:54|3661|6:6|image|State.pm:initialize(125)|computer is a
VM, attempting to create VM host OS object
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:_initialize(613)|computer ID
argument was specified, retrieving data for computer ID: 3
2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(637)|image
ID argument was specified: 1, DataStructure object will contain image
information for the production imagerevision of this image
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:_initialize(668)|retrieved data
for imagerevision ID: 1
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:_initialize(684)|retrieved data
for image ID: 1
2013-06-13
09:17:54|3661|6:6|image|Module.pm:create_vmhost_os_object(454)|attempting
to load VM host OS module: VCL::Module::OS::Linux::UnixLab (image: 1)
2013-06-13
09:17:54|3661|6:6|image|Module.pm:create_vmhost_os_object(460)|VM host OS
module loaded: VCL::Module::OS::Linux::UnixLab
2013-06-13
09:17:54|3661|6:6|image|Module.pm:new(196)|VCL::Module::OS::Linux::UnixLab
object created for image noimage, address: b402944
2013-06-13
09:17:54|3661|6:6|image|Module.pm:create_vmhost_os_object(465)|VCL::Module::OS::Linux::UnixLab
OS object created, address: b402944
2013-06-13
09:17:54|3661|6:6|image|Module.pm:create_provisioning_object(519)|VCL::Module::Provisioning::VMware::VMware
module loaded
2013-06-13
09:17:54|3661|6:6|image|Module.pm:new(200)|VCL::Module::Provisioning::VMware::VMware
object created for computer xp2, address: b41a4f4
2013-06-13 09:17:54|3661|6:6|image|VMware.pm:initialize(267)|initializing
VCL::Module::Provisioning::VMware::VMware object
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:_initialize(613)|computer ID
argument was specified, retrieving data for computer ID: 3
2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(637)|image
ID argument was specified: 1, DataStructure object will contain image
information for the production imagerevision of this image
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:_initialize(668)|retrieved data
for imagerevision ID: 1
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:_initialize(684)|retrieved data
for image ID: 1
2013-06-13
09:17:54|3661|6:6|image|VMware.pm:get_vmhost_datastructure(1392)|created
DataStructure object for VM host: esxi4
2013-06-13 09:17:54|3661|6:6|image|VMware.pm:initialize(287)|VM profile
assigned to esxi4: VMware ESXi - local storage
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:_initialize(613)|computer ID
argument was specified, retrieving data for computer ID: 3
2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(637)|image
ID argument was specified: 1, DataStructure object will contain image
information for the production imagerevision of this image
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:_initialize(668)|retrieved data
for imagerevision ID: 1
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:_initialize(684)|retrieved data
for image ID: 1
2013-06-13
09:17:54|3661|6:6|image|VMware.pm:get_vmhost_datastructure(1392)|created
DataStructure object for VM host: esxi4
2013-06-13
09:17:54|3661|6:6|image|VMware.pm:get_vmhost_api_object(1495)|attempting
to load VMware control module:
VCL::Module::Provisioning::VMware::vSphere_SDK
2013-06-13
09:17:54|3661|6:6|image|VMware.pm:get_vmhost_api_object(1501)|loaded
VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
2013-06-13
09:17:54|3661|6:6|image|Module.pm:new(200)|VCL::Module::Provisioning::VMware::vSphere_SDK
object created for computer xp2, address: b74cf70
2013-06-13 09:17:54|3661|6:6|image|vSphere_SDK.pm:initialize(98)|vSphere
SDK for Perl does not appear to be installed on this managment node,
unable to load VMware vSphere SDK Perl modules, error:
|3661|6:6|image| Can't locate VMware/VIRuntime.pm in @INC (@INC contains:
/usr/local/vcl/bin/../../../.. /usr/local/vcl/bin/../..
/usr/local/vcl/bin/../../.. /usr/local/vcl/bin/../../../../..
/usr/local/vcl/bin/.. /usr/local/vcl/bin/../lib
/usr/lib/perl5/site_perl/5.8.8/i386-linux-thread-multi
/usr/lib/perl5/site_perl/5.8.8 /usr/lib/perl5/site_perl
/usr/lib/perl5/vendor_perl/5.8.8/i386-linux-thread-multi
/usr/lib/perl5/vendor_perl/5.8.8 /usr/lib/perl5/vendor_perl
/usr/lib/perl5/5.8.8/i386-linux-thread-multi /usr/lib/perl5/5.8.8 .) at
(eval 238) line 1.
|3661|6:6|image| BEGIN failed--compilation aborted at (eval 238) line 1.
2013-06-13
09:17:54|3661|6:6|image|VMware.pm:get_vmhost_api_object(1515)|API object
could not be created: VCL::Module::Provisioning::VMware::vSphere_SDK
|3661|6:6|image| ---- WARNING ----
|3661|6:6|image| 2013-06-13
09:18:05|3661|6:6|image|utils.pm:nmap_port(2454)|error occurred running
nmap command: '/usr/bin/nmap esxi4 -P0 -p 22 -T Aggressive', output:
|3661|6:6|image| Starting Nmap 4.11 ( http://www.insecure.org/nmap/ ) at
2013-06-13 09:17 CST
|3661|6:6|image| Failed to resolve given hostname/IP: esxi4. Note that
you can't use '/mask' AND '1-4,7,100-' style IP ranges
|3661|6:6|image| WARNING: No targets were specified, so 0 hosts scanned.
|3661|6:6|image| Nmap finished: 0 IP addresses (0 hosts up) scanned in
10.125 seconds
|3661|6:6|image| ( 0) utils.pm, nmap_port (line: 2454)
|3661|6:6|image| (-1) OS.pm, is_ssh_responding (line: 612)
|3661|6:6|image| (-2) VMware.pm, initialize (line: 303)
|3661|6:6|image| (-3) Module.pm, new (line: 207)
|3661|6:6|image| (-4) Module.pm, create_provisioning_object (line: 522)
|3661|6:6|image| (-5) State.pm, initialize (line: 136)
|3661|6:6|image| ---- WARNING ----
|3661|6:6|image| 2013-06-13
09:18:15|3661|6:6|image|utils.pm:nmap_port(2454)|error occurred running
nmap command: '/usr/bin/nmap esxi4 -P0 -p 24 -T Aggressive', output:
|3661|6:6|image| Starting Nmap 4.11 ( http://www.insecure.org/nmap/ ) at
2013-06-13 09:18 CST
|3661|6:6|image| Failed to resolve given hostname/IP: esxi4. Note that
you can't use '/mask' AND '1-4,7,100-' style IP ranges
|3661|6:6|image| WARNING: No targets were specified, so 0 hosts scanned.
|3661|6:6|image| Nmap finished: 0 IP addresses (0 hosts up) scanned in
10.001 seconds
|3661|6:6|image| ( 0) utils.pm, nmap_port (line: 2454)
|3661|6:6|image| (-1) OS.pm, is_ssh_responding (line: 613)
|3661|6:6|image| (-2) VMware.pm, initialize (line: 303)
|3661|6:6|image| (-3) Module.pm, new (line: 207)
|3661|6:6|image| (-4) Module.pm, create_provisioning_object (line: 522)
|3661|6:6|image| (-5) State.pm, initialize (line: 136)
2013-06-13 09:18:15|3661|6:6|image|OS.pm:is_ssh_responding(615)|esxi4 is
NOT responding to SSH, ports 22 or 24 are both closed
2013-06-13 09:18:15|3661|6:6|image|VMware.pm:initialize(307)|unable to
control OS of VM host esxi4 using VCL::Module::OS::Linux::UnixLab OS
object because VM host is not responding to SSH
|3661|6:6|image| ---- WARNING ----
|3661|6:6|image| 2013-06-13
09:18:15|3661|6:6|image|Module.pm:create_provisioning_object(530)|provisioning
object could not be created, returning 0
|3661|6:6|image| ( 0) Module.pm, create_provisioning_object (line: 530)
|3661|6:6|image| (-1) State.pm, initialize (line: 136)
|3661|6:6|image| (-2) Module.pm, new (line: 207)
|3661|6:6|image| (-3) vcld, make_new_child (line: 567)
|3661|6:6|image| (-4) vcld, main (line: 350)
|3661|6:6|image| ---- WARNING ----
|3661|6:6|image| 2013-06-13
09:18:15|3661|6:6|image|State.pm:initialize(145)|failed to create
provisioning object
|3661|6:6|image| ( 0) State.pm, initialize (line: 145)
|3661|6:6|image| (-1) Module.pm, new (line: 207)
|3661|6:6|image| (-2) vcld, make_new_child (line: 567)
|3661|6:6|image| (-3) vcld, main (line: 350)
2013-06-13
09:18:15|3661|6:6|image|utils.pm:delete_computerloadlog_reservation(6429)|removing
computerloadlog entries matching loadstate = begin
2013-06-13
09:18:15|3661|6:6|image|utils.pm:delete_computerloadlog_reservation(6476)|deleted
rows from computerloadlog for reservation id=6
2013-06-13 09:18:15|3661|6:6|image|State.pm:DESTROY(929)|VCL::image
process duration: 21 seconds
2013-06-13
09:18:15|3661|6:6|image|DataStructure.pm:get_computer_private_ip_address(1630)|attempting
to retrieve private IP address for computer: xp2
2013-06-13
09:18:15|3661|6:6|image|DataStructure.pm:get_computer_private_ip_address(1634)|retrieved
contents of /etc/hosts on this management node, contains 7 lines
2013-06-13
09:18:15|3661|6:6|image|DataStructure.pm:get_computer_private_ip_address(1673)|did
not find any lines in /etc/hosts containing 'xp2', returning private IP
address defined in the database: 192.168.72.152
2013-06-13 09:18:15|3661|6:6|image|utils.pm:getnewdbh(2512)|unable to use
database handle stored in $ENV{dbh}
2013-06-13 09:18:15|3661|6:6|image|utils.pm:getnewdbh(2569)|database
handle stored in $ENV{dbh}
2013-06-13 09:18:15|3661|6:6|image|utils.pm:is_inblockrequest(5793)|zero
rows were returned from database select
2013-06-13
09:18:15|3661|6:6|image|DataStructure.pm:get_image_affiliation_name(2118)|image
owner id: 1
2013-06-13
09:18:15|3661|6:6|image|DataStructure.pm:retrieve_user_data(1401)|attempting
to retrieve and store data for user: user.id = '1'
2013-06-13
09:18:15|3661|6:6|image|DataStructure.pm:retrieve_user_data(1464)|data has
been retrieved for user: admin (id: 1)
My Environment :
Hypervisor : ESXi 4.0.0
Management Node : CentOS 5.9
Image O.S : Window XP SP3
VCL : 2.3
if there were further information required , plz kindly let me know,
thank you
Best Regards,
Vincent YA Chen 陳彥安
4F, 7 Song Ren Road
<Mail Attachment.gif>
I/T Specialist
Taipei, 110
End User Service
Taiwan
GTS Service Delivery, Taiwan
Phone:
+886-2-8723-9081
Mobile:
+886-911-227-378
e-mail:
yachen@tw.ibm.com
Re: Capture A Base Image problem
Posted by "Pablo J. Rebollo-Sosa" <pa...@upr.edu>.
You need to use the names defined on the management system instead of the IP for the connection test.
> For example:
>
> ssh -i /etc/vcl/vcl.key esxi4
> ssh -i /etc/vcl/vcl.key xp2
Pablo
Sent from my iPhone
On Jun 13, 2013, at 10:53 AM, Vincent YA Chen <ya...@tw.ibm.com> wrote:
> Dear Sir
>
> thank you for your kindly reply , yes , the management node could log in both systems without password
>
>
>
> [root@cent59 ~]# ssh -i /etc/vcl/vcl.key 192.168.72.150
> Warning: Permanently added '192.168.72.150' (RSA) to the list of known hosts.
> You have activated Tech Support Mode.
> The time and date of this activation have been sent to the system logs.
>
> Tech Support Mode is not supported unless used in consultation
> with VMware Tech Support.
>
> VMware offers supported, powerful system administration tools. Please
> see www.vmware.com/go/sysadmintools for details.
>
> Tech Support Mode may be disabled by an administrative user.
> Disabling requires a reboot of the system. Please consult the ESXi
> Configuration Guide for additional important information.
>
> ~ #
>
>
> [root@cent59 ~]# ssh -i /etc/vcl/vcl.key 192.168.72.152Warning: Permanently added '192.168.72.152' (RSA) to the list of known hosts.
>
> root@xp2 ~
> $
>
> Best Regards,
> Vincent YA Chen 陳彥安 4F, 7 Song Ren Road
> <mime-attachment.gif>
> I/T Specialist Taipei, 110
> End User Service Taiwan
> GTS Service Delivery, Taiwan
> Phone: +886-2-8723-9081
> Mobile: +886-911-227-378
> e-mail: yachen@tw.ibm.com
>
>
>
>
>
> From: "Pablo J. Rebollo Sosa" <pa...@upr.edu>
> To: user@vcl.apache.org
> Cc: Ken JB Yu/Taiwan/IBM@IBMTW
> Date: 2013/06/13 下午 08:18
> Subject: Re: Capture A Base Image problem
>
>
>
> First of all, verify you can resolve the hypervisor and virtual machine to capture names. Then try log into both systems without password with the private/public key.
>
> For example:
>
> ssh -i /etc/vcl/vcl.key esxi4
> ssh -i /etc/vcl/vcl.key xp2
>
> Notice that the example don't use FQDN.
>
> Pablo
>
> On Jun 13, 2013, at 5:43 AM, Vincent YA Chen <ya...@tw.ibm.com> wrote:
>
> Dears
>
> Your kindly advise is appreciated .Now, I am evaluating VCL solution and trying to build up a testing environment , but I encounter a problem on image capture .
> I follow the installation procedure (https://cwiki.apache.org/VCL/vcl-23-installation.html ) to install/configure all the components ( Database, Web Components, Management Node Components) and
> do image capture (https://cwiki.apache.org/VCL/capture-a-base-image.html ) ; however , the management node always show below error msg (VCL::image object could not be created and initialized)
>
>
>
> VCL::image object could not be created and initialized
> ------------------------------------------------------------------------
> time: 2013-06-13 09:18:15
> caller: vcld:make_new_child(574)
> ( 0) vcld, make_new_child (line: 574)
> (-1) vcld, main (line: 350)
> ------------------------------------------------------------------------
> management node: cent59.ibm.demo
> reservation PID: 3661
> parent vcld PID: 21145
>
> request ID: 6
> reservation ID: 6
> request state/laststate: image/image
> request start time: 2013-06-13 09:17:49
> request end time: 2013-06-13 10:17:49
> for imaging: no
> log ID: none
>
> computer: xp2.ibm.demo
> computer id: 4
> computer type: virtualmachine
> computer eth0 MAC address: 00:0c:29:36:ac:73
> computer eth1 MAC address: 00:0c:29:36:ac:7d
> computer private IP address: 192.168.72.152
> computer public IP address: 172.16.1.152
> computer in block allocation: no
> provisioning module: VCL::Module::Provisioning::VMware::VMware
>
> vm host: esxi4.ibm.demo
> vm host ID: 2
> vm host computer ID: 3
> vm profile: VMware ESXi - local storage
> vm profile VM path: /var/lib/vmware/runningvms
> vm profile repository path: <undefined>
> vm profile datastore path: /var/lib/vmware/images
> vm profile disk type: dedicated
>
> image: vmwarewinxp-xp217-v0
> image display name: xp21
> image ID: 7
> image revision ID: 7
> image size: 1450 MB
> use Sysprep: no
> root access: yes
> image owner ID: 1
> image owner affiliation: Local
> image revision date created: 2013-06-13 09:17:49
> image revision production: yes
> OS module: VCL::Module::OS::Windows::Version_5::XP
>
> user: admin
> user name: vcl admin
> user ID: 1
> user affiliation: Local
> ------------------------------------------------------------------------
> RECENT LOG ENTRIES FOR THIS PROCESS:
> |3661|6:6|image| : "cent59"
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_automethod(836)|data structure updated, hash path: $self->request_data->{reservation}{0}{computer}{SHORTNAME}, data identifier: computer_short_name, data:
> |3661|6:6|image| : "cent59"
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_automethod(836)|data structure updated, hash path: $self->request_data->{reservation}{0}{computer}{IPaddress}, data identifier: computer_ip_address, data:
> |3661|6:6|image| : "192.168.72.200"
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:create_mn_os_object(381)|VCL::Module::OS::Linux::ManagementNode OS object created, address: acc0bb8
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:new(192)|VCL::image object created for state image, address: ab57c98
> 2013-06-13 09:17:54|3661|6:6|image|State.pm:initialize(88)|obtained a database handle for this state process, stored as $ENV{dbh}
> 2013-06-13 09:17:54|3661|6:6|image|State.pm:check_image_os(790)|no corrections need to be made to image OS: vmwarewinxp
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:is_parent_reservation(993)|returning true: parent reservation ID for this request: 6
> 2013-06-13 09:17:54|3661|6:6|image|utils.pm:rename_vcld_process(6785)|reservation count: 1
> 2013-06-13 09:17:54|3661|6:6|image|utils.pm:rename_vcld_process(6804)|PARENTIMAGE: 1
> 2013-06-13 09:17:54|3661|6:6|image|utils.pm:rename_vcld_process(6805)|SUBIMAGE: 0
> 2013-06-13 09:17:54|3661|6:6|image|utils.pm:rename_vcld_process(6823)|renamed process to 'vcld 6:6 image xp2>esxi4.ibm.demo vmwarewinxp-xp217-v0 admin'
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:is_parent_reservation(993)|returning true: parent reservation ID for this request: 6
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:is_parent_reservation(993)|returning true: parent reservation ID for this request: 6
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:create_os_object(308)|VCL::Module::OS::Windows::Version_5::XP module loaded
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:new(196)|VCL::Module::OS::Windows::Version_5::XP object created for image vmwarewinxp-xp217-v0, address: b040f54
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:create_os_object(314)|VCL::Module::OS::Windows::Version_5::XP OS object created, address: b040f54
> 2013-06-13 09:17:54|3661|6:6|image|State.pm:initialize(125)|computer is a VM, attempting to create VM host OS object
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(613)|computer ID argument was specified, retrieving data for computer ID: 3
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(637)|image ID argument was specified: 1, DataStructure object will contain image information for the production imagerevision of this image
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(668)|retrieved data for imagerevision ID: 1
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(684)|retrieved data for image ID: 1
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:create_vmhost_os_object(454)|attempting to load VM host OS module: VCL::Module::OS::Linux::UnixLab (image: 1)
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:create_vmhost_os_object(460)|VM host OS module loaded: VCL::Module::OS::Linux::UnixLab
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:new(196)|VCL::Module::OS::Linux::UnixLab object created for image noimage, address: b402944
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:create_vmhost_os_object(465)|VCL::Module::OS::Linux::UnixLab OS object created, address: b402944
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:create_provisioning_object(519)|VCL::Module::Provisioning::VMware::VMware module loaded
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:new(200)|VCL::Module::Provisioning::VMware::VMware object created for computer xp2, address: b41a4f4
> 2013-06-13 09:17:54|3661|6:6|image|VMware.pm:initialize(267)|initializing VCL::Module::Provisioning::VMware::VMware object
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(613)|computer ID argument was specified, retrieving data for computer ID: 3
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(637)|image ID argument was specified: 1, DataStructure object will contain image information for the production imagerevision of this image
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(668)|retrieved data for imagerevision ID: 1
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(684)|retrieved data for image ID: 1
> 2013-06-13 09:17:54|3661|6:6|image|VMware.pm:get_vmhost_datastructure(1392)|created DataStructure object for VM host: esxi4
> 2013-06-13 09:17:54|3661|6:6|image|VMware.pm:initialize(287)|VM profile assigned to esxi4: VMware ESXi - local storage
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(613)|computer ID argument was specified, retrieving data for computer ID: 3
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(637)|image ID argument was specified: 1, DataStructure object will contain image information for the production imagerevision of this image
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(668)|retrieved data for imagerevision ID: 1
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(684)|retrieved data for image ID: 1
> 2013-06-13 09:17:54|3661|6:6|image|VMware.pm:get_vmhost_datastructure(1392)|created DataStructure object for VM host: esxi4
> 2013-06-13 09:17:54|3661|6:6|image|VMware.pm:get_vmhost_api_object(1495)|attempting to load VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
> 2013-06-13 09:17:54|3661|6:6|image|VMware.pm:get_vmhost_api_object(1501)|loaded VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:new(200)|VCL::Module::Provisioning::VMware::vSphere_SDK object created for computer xp2, address: b74cf70
> 2013-06-13 09:17:54|3661|6:6|image|vSphere_SDK.pm:initialize(98)|vSphere SDK for Perl does not appear to be installed on this managment node, unable to load VMware vSphere SDK Perl modules, error:
> |3661|6:6|image| Can't locate VMware/VIRuntime.pm in @INC (@INC contains: /usr/local/vcl/bin/../../../.. /usr/local/vcl/bin/../.. /usr/local/vcl/bin/../../.. /usr/local/vcl/bin/../../../../.. /usr/local/vcl/bin/.. /usr/local/vcl/bin/../lib /usr/lib/perl5/site_perl/5.8.8/i386-linux-thread-multi /usr/lib/perl5/site_perl/5.8.8 /usr/lib/perl5/site_perl /usr/lib/perl5/vendor_perl/5.8.8/i386-linux-thread-multi /usr/lib/perl5/vendor_perl/5.8.8 /usr/lib/perl5/vendor_perl /usr/lib/perl5/5.8.8/i386-linux-thread-multi /usr/lib/perl5/5.8.8 .) at (eval 238) line 1.
> |3661|6:6|image| BEGIN failed--compilation aborted at (eval 238) line 1.
> 2013-06-13 09:17:54|3661|6:6|image|VMware.pm:get_vmhost_api_object(1515)|API object could not be created: VCL::Module::Provisioning::VMware::vSphere_SDK
> |3661|6:6|image| ---- WARNING ----
> |3661|6:6|image| 2013-06-13 09:18:05|3661|6:6|image|utils.pm:nmap_port(2454)|error occurred running nmap command: '/usr/bin/nmap esxi4 -P0 -p 22 -T Aggressive', output:
> |3661|6:6|image| Starting Nmap 4.11 ( http://www.insecure.org/nmap/ ) at 2013-06-13 09:17 CST
> |3661|6:6|image| Failed to resolve given hostname/IP: esxi4. Note that you can't use '/mask' AND '1-4,7,100-' style IP ranges
> |3661|6:6|image| WARNING: No targets were specified, so 0 hosts scanned.
> |3661|6:6|image| Nmap finished: 0 IP addresses (0 hosts up) scanned in 10.125 seconds
> |3661|6:6|image| ( 0) utils.pm, nmap_port (line: 2454)
> |3661|6:6|image| (-1) OS.pm, is_ssh_responding (line: 612)
> |3661|6:6|image| (-2) VMware.pm, initialize (line: 303)
> |3661|6:6|image| (-3) Module.pm, new (line: 207)
> |3661|6:6|image| (-4) Module.pm, create_provisioning_object (line: 522)
> |3661|6:6|image| (-5) State.pm, initialize (line: 136)
> |3661|6:6|image| ---- WARNING ----
> |3661|6:6|image| 2013-06-13 09:18:15|3661|6:6|image|utils.pm:nmap_port(2454)|error occurred running nmap command: '/usr/bin/nmap esxi4 -P0 -p 24 -T Aggressive', output:
> |3661|6:6|image| Starting Nmap 4.11 ( http://www.insecure.org/nmap/ ) at 2013-06-13 09:18 CST
> |3661|6:6|image| Failed to resolve given hostname/IP: esxi4. Note that you can't use '/mask' AND '1-4,7,100-' style IP ranges
> |3661|6:6|image| WARNING: No targets were specified, so 0 hosts scanned.
> |3661|6:6|image| Nmap finished: 0 IP addresses (0 hosts up) scanned in 10.001 seconds
> |3661|6:6|image| ( 0) utils.pm, nmap_port (line: 2454)
> |3661|6:6|image| (-1) OS.pm, is_ssh_responding (line: 613)
> |3661|6:6|image| (-2) VMware.pm, initialize (line: 303)
> |3661|6:6|image| (-3) Module.pm, new (line: 207)
> |3661|6:6|image| (-4) Module.pm, create_provisioning_object (line: 522)
> |3661|6:6|image| (-5) State.pm, initialize (line: 136)
> 2013-06-13 09:18:15|3661|6:6|image|OS.pm:is_ssh_responding(615)|esxi4 is NOT responding to SSH, ports 22 or 24 are both closed
> 2013-06-13 09:18:15|3661|6:6|image|VMware.pm:initialize(307)|unable to control OS of VM host esxi4 using VCL::Module::OS::Linux::UnixLab OS object because VM host is not responding to SSH
> |3661|6:6|image| ---- WARNING ----
> |3661|6:6|image| 2013-06-13 09:18:15|3661|6:6|image|Module.pm:create_provisioning_object(530)|provisioning object could not be created, returning 0
> |3661|6:6|image| ( 0) Module.pm, create_provisioning_object (line: 530)
> |3661|6:6|image| (-1) State.pm, initialize (line: 136)
> |3661|6:6|image| (-2) Module.pm, new (line: 207)
> |3661|6:6|image| (-3) vcld, make_new_child (line: 567)
> |3661|6:6|image| (-4) vcld, main (line: 350)
> |3661|6:6|image| ---- WARNING ----
> |3661|6:6|image| 2013-06-13 09:18:15|3661|6:6|image|State.pm:initialize(145)|failed to create provisioning object
> |3661|6:6|image| ( 0) State.pm, initialize (line: 145)
> |3661|6:6|image| (-1) Module.pm, new (line: 207)
> |3661|6:6|image| (-2) vcld, make_new_child (line: 567)
> |3661|6:6|image| (-3) vcld, main (line: 350)
> 2013-06-13 09:18:15|3661|6:6|image|utils.pm:delete_computerloadlog_reservation(6429)|removing computerloadlog entries matching loadstate = begin
> 2013-06-13 09:18:15|3661|6:6|image|utils.pm:delete_computerloadlog_reservation(6476)|deleted rows from computerloadlog for reservation id=6
> 2013-06-13 09:18:15|3661|6:6|image|State.pm:DESTROY(929)|VCL::image process duration: 21 seconds
> 2013-06-13 09:18:15|3661|6:6|image|DataStructure.pm:get_computer_private_ip_address(1630)|attempting to retrieve private IP address for computer: xp2
> 2013-06-13 09:18:15|3661|6:6|image|DataStructure.pm:get_computer_private_ip_address(1634)|retrieved contents of /etc/hosts on this management node, contains 7 lines
> 2013-06-13 09:18:15|3661|6:6|image|DataStructure.pm:get_computer_private_ip_address(1673)|did not find any lines in /etc/hosts containing 'xp2', returning private IP address defined in the database: 192.168.72.152
> 2013-06-13 09:18:15|3661|6:6|image|utils.pm:getnewdbh(2512)|unable to use database handle stored in $ENV{dbh}
> 2013-06-13 09:18:15|3661|6:6|image|utils.pm:getnewdbh(2569)|database handle stored in $ENV{dbh}
> 2013-06-13 09:18:15|3661|6:6|image|utils.pm:is_inblockrequest(5793)|zero rows were returned from database select
> 2013-06-13 09:18:15|3661|6:6|image|DataStructure.pm:get_image_affiliation_name(2118)|image owner id: 1
> 2013-06-13 09:18:15|3661|6:6|image|DataStructure.pm:retrieve_user_data(1401)|attempting to retrieve and store data for user: user.id = '1'
> 2013-06-13 09:18:15|3661|6:6|image|DataStructure.pm:retrieve_user_data(1464)|data has been retrieved for user: admin (id: 1)
>
>
>
> My Environment :
>
> Hypervisor : ESXi 4.0.0
> Management Node : CentOS 5.9
> Image O.S : Window XP SP3
> VCL : 2.3
>
> if there were further information required , plz kindly let me know, thank you
> Best Regards,
> Vincent YA Chen 陳彥安 4F, 7 Song Ren Road
> <Mail Attachment.gif>
> I/T Specialist Taipei, 110
> End User Service Taiwan
> GTS Service Delivery, Taiwan
> Phone: +886-2-8723-9081
> Mobile: +886-911-227-378
> e-mail: yachen@tw.ibm.com
>
>
>
>
>
Re: Capture A Base Image problem
Posted by Vincent YA Chen <ya...@tw.ibm.com>.
Dear Sir
thank you for your kindly reply , yes , the management node could log in
both systems without password
[root@cent59 ~]# ssh -i /etc/vcl/vcl.key 192.168.72.150
Warning: Permanently added '192.168.72.150' (RSA) to the list of known
hosts.
You have activated Tech Support Mode.
The time and date of this activation have been sent to the system logs.
Tech Support Mode is not supported unless used in consultation
with VMware Tech Support.
VMware offers supported, powerful system administration tools. Please
see www.vmware.com/go/sysadmintools for details.
Tech Support Mode may be disabled by an administrative user.
Disabling requires a reboot of the system. Please consult the ESXi
Configuration Guide for additional important information.
~ #
[root@cent59 ~]# ssh -i /etc/vcl/vcl.key 192.168.72.152Warning:
Permanently added '192.168.72.152' (RSA) to the list of known hosts.
root@xp2 ~
$
Best Regards,
Vincent YA Chen 陳彥安
4F, 7 Song Ren Road
I/T Specialist
Taipei, 110
End User Service
Taiwan
GTS Service Delivery, Taiwan
Phone:
+886-2-8723-9081
Mobile:
+886-911-227-378
e-mail:
yachen@tw.ibm.com
From: "Pablo J. Rebollo Sosa" <pa...@upr.edu>
To: user@vcl.apache.org
Cc: Ken JB Yu/Taiwan/IBM@IBMTW
Date: 2013/06/13 下午 08:18
Subject: Re: Capture A Base Image problem
First of all, verify you can resolve the hypervisor and virtual machine to
capture names. Then try log into both systems without password with the
private/public key.
For example:
ssh -i /etc/vcl/vcl.key esxi4
ssh -i /etc/vcl/vcl.key xp2
Notice that the example don't use FQDN.
Pablo
On Jun 13, 2013, at 5:43 AM, Vincent YA Chen <ya...@tw.ibm.com> wrote:
Dears
Your kindly advise is appreciated .Now, I am evaluating VCL solution and
trying to build up a testing environment , but I encounter a problem on
image capture .
I follow the installation procedure (
https://cwiki.apache.org/VCL/vcl-23-installation.html ) to
install/configure all the components ( Database, Web Components,
Management Node Components) and
do image capture (https://cwiki.apache.org/VCL/capture-a-base-image.html )
; however , the management node always show below error msg (VCL::image
object could not be created and initialized)
VCL::image object could not be created and initialized
------------------------------------------------------------------------
time: 2013-06-13 09:18:15
caller: vcld:make_new_child(574)
( 0) vcld, make_new_child (line: 574)
(-1) vcld, main (line: 350)
------------------------------------------------------------------------
management node: cent59.ibm.demo
reservation PID: 3661
parent vcld PID: 21145
request ID: 6
reservation ID: 6
request state/laststate: image/image
request start time: 2013-06-13 09:17:49
request end time: 2013-06-13 10:17:49
for imaging: no
log ID: none
computer: xp2.ibm.demo
computer id: 4
computer type: virtualmachine
computer eth0 MAC address: 00:0c:29:36:ac:73
computer eth1 MAC address: 00:0c:29:36:ac:7d
computer private IP address: 192.168.72.152
computer public IP address: 172.16.1.152
computer in block allocation: no
provisioning module: VCL::Module::Provisioning::VMware::VMware
vm host: esxi4.ibm.demo
vm host ID: 2
vm host computer ID: 3
vm profile: VMware ESXi - local storage
vm profile VM path: /var/lib/vmware/runningvms
vm profile repository path: <undefined>
vm profile datastore path: /var/lib/vmware/images
vm profile disk type: dedicated
image: vmwarewinxp-xp217-v0
image display name: xp21
image ID: 7
image revision ID: 7
image size: 1450 MB
use Sysprep: no
root access: yes
image owner ID: 1
image owner affiliation: Local
image revision date created: 2013-06-13 09:17:49
image revision production: yes
OS module: VCL::Module::OS::Windows::Version_5::XP
user: admin
user name: vcl admin
user ID: 1
user affiliation: Local
------------------------------------------------------------------------
RECENT LOG ENTRIES FOR THIS PROCESS:
|3661|6:6|image| : "cent59"
2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_automethod(836)|data
structure updated, hash path:
$self->request_data->{reservation}{0}{computer}{SHORTNAME}, data
identifier: computer_short_name, data:
|3661|6:6|image| : "cent59"
2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_automethod(836)|data
structure updated, hash path:
$self->request_data->{reservation}{0}{computer}{IPaddress}, data
identifier: computer_ip_address, data:
|3661|6:6|image| : "192.168.72.200"
2013-06-13
09:17:54|3661|6:6|image|Module.pm:create_mn_os_object(381)|VCL::Module::OS::Linux::ManagementNode
OS object created, address: acc0bb8
2013-06-13 09:17:54|3661|6:6|image|Module.pm:new(192)|VCL::image object
created for state image, address: ab57c98
2013-06-13 09:17:54|3661|6:6|image|State.pm:initialize(88)|obtained a
database handle for this state process, stored as $ENV{dbh}
2013-06-13 09:17:54|3661|6:6|image|State.pm:check_image_os(790)|no
corrections need to be made to image OS: vmwarewinxp
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:is_parent_reservation(993)|returning
true: parent reservation ID for this request: 6
2013-06-13
09:17:54|3661|6:6|image|utils.pm:rename_vcld_process(6785)|reservation
count: 1
2013-06-13
09:17:54|3661|6:6|image|utils.pm:rename_vcld_process(6804)|PARENTIMAGE: 1
2013-06-13
09:17:54|3661|6:6|image|utils.pm:rename_vcld_process(6805)|SUBIMAGE: 0
2013-06-13
09:17:54|3661|6:6|image|utils.pm:rename_vcld_process(6823)|renamed process
to 'vcld 6:6 image xp2>esxi4.ibm.demo vmwarewinxp-xp217-v0 admin'
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:is_parent_reservation(993)|returning
true: parent reservation ID for this request: 6
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:is_parent_reservation(993)|returning
true: parent reservation ID for this request: 6
2013-06-13
09:17:54|3661|6:6|image|Module.pm:create_os_object(308)|VCL::Module::OS::Windows::Version_5::XP
module loaded
2013-06-13
09:17:54|3661|6:6|image|Module.pm:new(196)|VCL::Module::OS::Windows::Version_5::XP
object created for image vmwarewinxp-xp217-v0, address: b040f54
2013-06-13
09:17:54|3661|6:6|image|Module.pm:create_os_object(314)|VCL::Module::OS::Windows::Version_5::XP
OS object created, address: b040f54
2013-06-13 09:17:54|3661|6:6|image|State.pm:initialize(125)|computer is a
VM, attempting to create VM host OS object
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:_initialize(613)|computer ID
argument was specified, retrieving data for computer ID: 3
2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(637)|image
ID argument was specified: 1, DataStructure object will contain image
information for the production imagerevision of this image
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:_initialize(668)|retrieved data
for imagerevision ID: 1
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:_initialize(684)|retrieved data
for image ID: 1
2013-06-13
09:17:54|3661|6:6|image|Module.pm:create_vmhost_os_object(454)|attempting
to load VM host OS module: VCL::Module::OS::Linux::UnixLab (image: 1)
2013-06-13
09:17:54|3661|6:6|image|Module.pm:create_vmhost_os_object(460)|VM host OS
module loaded: VCL::Module::OS::Linux::UnixLab
2013-06-13
09:17:54|3661|6:6|image|Module.pm:new(196)|VCL::Module::OS::Linux::UnixLab
object created for image noimage, address: b402944
2013-06-13
09:17:54|3661|6:6|image|Module.pm:create_vmhost_os_object(465)|VCL::Module::OS::Linux::UnixLab
OS object created, address: b402944
2013-06-13
09:17:54|3661|6:6|image|Module.pm:create_provisioning_object(519)|VCL::Module::Provisioning::VMware::VMware
module loaded
2013-06-13
09:17:54|3661|6:6|image|Module.pm:new(200)|VCL::Module::Provisioning::VMware::VMware
object created for computer xp2, address: b41a4f4
2013-06-13 09:17:54|3661|6:6|image|VMware.pm:initialize(267)|initializing
VCL::Module::Provisioning::VMware::VMware object
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:_initialize(613)|computer ID
argument was specified, retrieving data for computer ID: 3
2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(637)|image
ID argument was specified: 1, DataStructure object will contain image
information for the production imagerevision of this image
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:_initialize(668)|retrieved data
for imagerevision ID: 1
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:_initialize(684)|retrieved data
for image ID: 1
2013-06-13
09:17:54|3661|6:6|image|VMware.pm:get_vmhost_datastructure(1392)|created
DataStructure object for VM host: esxi4
2013-06-13 09:17:54|3661|6:6|image|VMware.pm:initialize(287)|VM profile
assigned to esxi4: VMware ESXi - local storage
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:_initialize(613)|computer ID
argument was specified, retrieving data for computer ID: 3
2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(637)|image
ID argument was specified: 1, DataStructure object will contain image
information for the production imagerevision of this image
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:_initialize(668)|retrieved data
for imagerevision ID: 1
2013-06-13
09:17:54|3661|6:6|image|DataStructure.pm:_initialize(684)|retrieved data
for image ID: 1
2013-06-13
09:17:54|3661|6:6|image|VMware.pm:get_vmhost_datastructure(1392)|created
DataStructure object for VM host: esxi4
2013-06-13
09:17:54|3661|6:6|image|VMware.pm:get_vmhost_api_object(1495)|attempting
to load VMware control module:
VCL::Module::Provisioning::VMware::vSphere_SDK
2013-06-13
09:17:54|3661|6:6|image|VMware.pm:get_vmhost_api_object(1501)|loaded
VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
2013-06-13
09:17:54|3661|6:6|image|Module.pm:new(200)|VCL::Module::Provisioning::VMware::vSphere_SDK
object created for computer xp2, address: b74cf70
2013-06-13 09:17:54|3661|6:6|image|vSphere_SDK.pm:initialize(98)|vSphere
SDK for Perl does not appear to be installed on this managment node,
unable to load VMware vSphere SDK Perl modules, error:
|3661|6:6|image| Can't locate VMware/VIRuntime.pm in @INC (@INC contains:
/usr/local/vcl/bin/../../../.. /usr/local/vcl/bin/../..
/usr/local/vcl/bin/../../.. /usr/local/vcl/bin/../../../../..
/usr/local/vcl/bin/.. /usr/local/vcl/bin/../lib
/usr/lib/perl5/site_perl/5.8.8/i386-linux-thread-multi
/usr/lib/perl5/site_perl/5.8.8 /usr/lib/perl5/site_perl
/usr/lib/perl5/vendor_perl/5.8.8/i386-linux-thread-multi
/usr/lib/perl5/vendor_perl/5.8.8 /usr/lib/perl5/vendor_perl
/usr/lib/perl5/5.8.8/i386-linux-thread-multi /usr/lib/perl5/5.8.8 .) at
(eval 238) line 1.
|3661|6:6|image| BEGIN failed--compilation aborted at (eval 238) line 1.
2013-06-13
09:17:54|3661|6:6|image|VMware.pm:get_vmhost_api_object(1515)|API object
could not be created: VCL::Module::Provisioning::VMware::vSphere_SDK
|3661|6:6|image| ---- WARNING ----
|3661|6:6|image| 2013-06-13
09:18:05|3661|6:6|image|utils.pm:nmap_port(2454)|error occurred running
nmap command: '/usr/bin/nmap esxi4 -P0 -p 22 -T Aggressive', output:
|3661|6:6|image| Starting Nmap 4.11 ( http://www.insecure.org/nmap/ ) at
2013-06-13 09:17 CST
|3661|6:6|image| Failed to resolve given hostname/IP: esxi4. Note that
you can't use '/mask' AND '1-4,7,100-' style IP ranges
|3661|6:6|image| WARNING: No targets were specified, so 0 hosts scanned.
|3661|6:6|image| Nmap finished: 0 IP addresses (0 hosts up) scanned in
10.125 seconds
|3661|6:6|image| ( 0) utils.pm, nmap_port (line: 2454)
|3661|6:6|image| (-1) OS.pm, is_ssh_responding (line: 612)
|3661|6:6|image| (-2) VMware.pm, initialize (line: 303)
|3661|6:6|image| (-3) Module.pm, new (line: 207)
|3661|6:6|image| (-4) Module.pm, create_provisioning_object (line: 522)
|3661|6:6|image| (-5) State.pm, initialize (line: 136)
|3661|6:6|image| ---- WARNING ----
|3661|6:6|image| 2013-06-13
09:18:15|3661|6:6|image|utils.pm:nmap_port(2454)|error occurred running
nmap command: '/usr/bin/nmap esxi4 -P0 -p 24 -T Aggressive', output:
|3661|6:6|image| Starting Nmap 4.11 ( http://www.insecure.org/nmap/ ) at
2013-06-13 09:18 CST
|3661|6:6|image| Failed to resolve given hostname/IP: esxi4. Note that
you can't use '/mask' AND '1-4,7,100-' style IP ranges
|3661|6:6|image| WARNING: No targets were specified, so 0 hosts scanned.
|3661|6:6|image| Nmap finished: 0 IP addresses (0 hosts up) scanned in
10.001 seconds
|3661|6:6|image| ( 0) utils.pm, nmap_port (line: 2454)
|3661|6:6|image| (-1) OS.pm, is_ssh_responding (line: 613)
|3661|6:6|image| (-2) VMware.pm, initialize (line: 303)
|3661|6:6|image| (-3) Module.pm, new (line: 207)
|3661|6:6|image| (-4) Module.pm, create_provisioning_object (line: 522)
|3661|6:6|image| (-5) State.pm, initialize (line: 136)
2013-06-13 09:18:15|3661|6:6|image|OS.pm:is_ssh_responding(615)|esxi4 is
NOT responding to SSH, ports 22 or 24 are both closed
2013-06-13 09:18:15|3661|6:6|image|VMware.pm:initialize(307)|unable to
control OS of VM host esxi4 using VCL::Module::OS::Linux::UnixLab OS
object because VM host is not responding to SSH
|3661|6:6|image| ---- WARNING ----
|3661|6:6|image| 2013-06-13
09:18:15|3661|6:6|image|Module.pm:create_provisioning_object(530)|provisioning
object could not be created, returning 0
|3661|6:6|image| ( 0) Module.pm, create_provisioning_object (line: 530)
|3661|6:6|image| (-1) State.pm, initialize (line: 136)
|3661|6:6|image| (-2) Module.pm, new (line: 207)
|3661|6:6|image| (-3) vcld, make_new_child (line: 567)
|3661|6:6|image| (-4) vcld, main (line: 350)
|3661|6:6|image| ---- WARNING ----
|3661|6:6|image| 2013-06-13
09:18:15|3661|6:6|image|State.pm:initialize(145)|failed to create
provisioning object
|3661|6:6|image| ( 0) State.pm, initialize (line: 145)
|3661|6:6|image| (-1) Module.pm, new (line: 207)
|3661|6:6|image| (-2) vcld, make_new_child (line: 567)
|3661|6:6|image| (-3) vcld, main (line: 350)
2013-06-13
09:18:15|3661|6:6|image|utils.pm:delete_computerloadlog_reservation(6429)|removing
computerloadlog entries matching loadstate = begin
2013-06-13
09:18:15|3661|6:6|image|utils.pm:delete_computerloadlog_reservation(6476)|deleted
rows from computerloadlog for reservation id=6
2013-06-13 09:18:15|3661|6:6|image|State.pm:DESTROY(929)|VCL::image
process duration: 21 seconds
2013-06-13
09:18:15|3661|6:6|image|DataStructure.pm:get_computer_private_ip_address(1630)|attempting
to retrieve private IP address for computer: xp2
2013-06-13
09:18:15|3661|6:6|image|DataStructure.pm:get_computer_private_ip_address(1634)|retrieved
contents of /etc/hosts on this management node, contains 7 lines
2013-06-13
09:18:15|3661|6:6|image|DataStructure.pm:get_computer_private_ip_address(1673)|did
not find any lines in /etc/hosts containing 'xp2', returning private IP
address defined in the database: 192.168.72.152
2013-06-13 09:18:15|3661|6:6|image|utils.pm:getnewdbh(2512)|unable to use
database handle stored in $ENV{dbh}
2013-06-13 09:18:15|3661|6:6|image|utils.pm:getnewdbh(2569)|database
handle stored in $ENV{dbh}
2013-06-13 09:18:15|3661|6:6|image|utils.pm:is_inblockrequest(5793)|zero
rows were returned from database select
2013-06-13
09:18:15|3661|6:6|image|DataStructure.pm:get_image_affiliation_name(2118)|image
owner id: 1
2013-06-13
09:18:15|3661|6:6|image|DataStructure.pm:retrieve_user_data(1401)|attempting
to retrieve and store data for user: user.id = '1'
2013-06-13
09:18:15|3661|6:6|image|DataStructure.pm:retrieve_user_data(1464)|data has
been retrieved for user: admin (id: 1)
My Environment :
Hypervisor : ESXi 4.0.0
Management Node : CentOS 5.9
Image O.S : Window XP SP3
VCL : 2.3
if there were further information required , plz kindly let me know,
thank you
Best Regards,
Vincent YA Chen 陳彥安
4F, 7 Song Ren Road
<Mail Attachment.gif>
I/T Specialist
Taipei, 110
End User Service
Taiwan
GTS Service Delivery, Taiwan
Phone:
+886-2-8723-9081
Mobile:
+886-911-227-378
e-mail:
yachen@tw.ibm.com
Re: Capture A Base Image problem
Posted by "Pablo J. Rebollo Sosa" <pa...@upr.edu>.
First of all, verify you can resolve the hypervisor and virtual machine to capture names. Then try log into both systems without password with the private/public key.
For example:
ssh -i /etc/vcl/vcl.key esxi4
ssh -i /etc/vcl/vcl.key xp2
Notice that the example don't use FQDN.
Pablo
On Jun 13, 2013, at 5:43 AM, Vincent YA Chen <ya...@tw.ibm.com> wrote:
> Dears
>
> Your kindly advise is appreciated .Now, I am evaluating VCL solution and trying to build up a testing environment , but I encounter a problem on image capture .
> I follow the installation procedure (https://cwiki.apache.org/VCL/vcl-23-installation.html ) to install/configure all the components ( Database, Web Components, Management Node Components) and
> do image capture (https://cwiki.apache.org/VCL/capture-a-base-image.html ) ; however , the management node always show below error msg (VCL::image object could not be created and initialized)
>
>
>
> VCL::image object could not be created and initialized
> ------------------------------------------------------------------------
> time: 2013-06-13 09:18:15
> caller: vcld:make_new_child(574)
> ( 0) vcld, make_new_child (line: 574)
> (-1) vcld, main (line: 350)
> ------------------------------------------------------------------------
> management node: cent59.ibm.demo
> reservation PID: 3661
> parent vcld PID: 21145
>
> request ID: 6
> reservation ID: 6
> request state/laststate: image/image
> request start time: 2013-06-13 09:17:49
> request end time: 2013-06-13 10:17:49
> for imaging: no
> log ID: none
>
> computer: xp2.ibm.demo
> computer id: 4
> computer type: virtualmachine
> computer eth0 MAC address: 00:0c:29:36:ac:73
> computer eth1 MAC address: 00:0c:29:36:ac:7d
> computer private IP address: 192.168.72.152
> computer public IP address: 172.16.1.152
> computer in block allocation: no
> provisioning module: VCL::Module::Provisioning::VMware::VMware
>
> vm host: esxi4.ibm.demo
> vm host ID: 2
> vm host computer ID: 3
> vm profile: VMware ESXi - local storage
> vm profile VM path: /var/lib/vmware/runningvms
> vm profile repository path: <undefined>
> vm profile datastore path: /var/lib/vmware/images
> vm profile disk type: dedicated
>
> image: vmwarewinxp-xp217-v0
> image display name: xp21
> image ID: 7
> image revision ID: 7
> image size: 1450 MB
> use Sysprep: no
> root access: yes
> image owner ID: 1
> image owner affiliation: Local
> image revision date created: 2013-06-13 09:17:49
> image revision production: yes
> OS module: VCL::Module::OS::Windows::Version_5::XP
>
> user: admin
> user name: vcl admin
> user ID: 1
> user affiliation: Local
> ------------------------------------------------------------------------
> RECENT LOG ENTRIES FOR THIS PROCESS:
> |3661|6:6|image| : "cent59"
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_automethod(836)|data structure updated, hash path: $self->request_data->{reservation}{0}{computer}{SHORTNAME}, data identifier: computer_short_name, data:
> |3661|6:6|image| : "cent59"
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_automethod(836)|data structure updated, hash path: $self->request_data->{reservation}{0}{computer}{IPaddress}, data identifier: computer_ip_address, data:
> |3661|6:6|image| : "192.168.72.200"
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:create_mn_os_object(381)|VCL::Module::OS::Linux::ManagementNode OS object created, address: acc0bb8
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:new(192)|VCL::image object created for state image, address: ab57c98
> 2013-06-13 09:17:54|3661|6:6|image|State.pm:initialize(88)|obtained a database handle for this state process, stored as $ENV{dbh}
> 2013-06-13 09:17:54|3661|6:6|image|State.pm:check_image_os(790)|no corrections need to be made to image OS: vmwarewinxp
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:is_parent_reservation(993)|returning true: parent reservation ID for this request: 6
> 2013-06-13 09:17:54|3661|6:6|image|utils.pm:rename_vcld_process(6785)|reservation count: 1
> 2013-06-13 09:17:54|3661|6:6|image|utils.pm:rename_vcld_process(6804)|PARENTIMAGE: 1
> 2013-06-13 09:17:54|3661|6:6|image|utils.pm:rename_vcld_process(6805)|SUBIMAGE: 0
> 2013-06-13 09:17:54|3661|6:6|image|utils.pm:rename_vcld_process(6823)|renamed process to 'vcld 6:6 image xp2>esxi4.ibm.demo vmwarewinxp-xp217-v0 admin'
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:is_parent_reservation(993)|returning true: parent reservation ID for this request: 6
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:is_parent_reservation(993)|returning true: parent reservation ID for this request: 6
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:create_os_object(308)|VCL::Module::OS::Windows::Version_5::XP module loaded
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:new(196)|VCL::Module::OS::Windows::Version_5::XP object created for image vmwarewinxp-xp217-v0, address: b040f54
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:create_os_object(314)|VCL::Module::OS::Windows::Version_5::XP OS object created, address: b040f54
> 2013-06-13 09:17:54|3661|6:6|image|State.pm:initialize(125)|computer is a VM, attempting to create VM host OS object
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(613)|computer ID argument was specified, retrieving data for computer ID: 3
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(637)|image ID argument was specified: 1, DataStructure object will contain image information for the production imagerevision of this image
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(668)|retrieved data for imagerevision ID: 1
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(684)|retrieved data for image ID: 1
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:create_vmhost_os_object(454)|attempting to load VM host OS module: VCL::Module::OS::Linux::UnixLab (image: 1)
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:create_vmhost_os_object(460)|VM host OS module loaded: VCL::Module::OS::Linux::UnixLab
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:new(196)|VCL::Module::OS::Linux::UnixLab object created for image noimage, address: b402944
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:create_vmhost_os_object(465)|VCL::Module::OS::Linux::UnixLab OS object created, address: b402944
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:create_provisioning_object(519)|VCL::Module::Provisioning::VMware::VMware module loaded
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:new(200)|VCL::Module::Provisioning::VMware::VMware object created for computer xp2, address: b41a4f4
> 2013-06-13 09:17:54|3661|6:6|image|VMware.pm:initialize(267)|initializing VCL::Module::Provisioning::VMware::VMware object
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(613)|computer ID argument was specified, retrieving data for computer ID: 3
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(637)|image ID argument was specified: 1, DataStructure object will contain image information for the production imagerevision of this image
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(668)|retrieved data for imagerevision ID: 1
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(684)|retrieved data for image ID: 1
> 2013-06-13 09:17:54|3661|6:6|image|VMware.pm:get_vmhost_datastructure(1392)|created DataStructure object for VM host: esxi4
> 2013-06-13 09:17:54|3661|6:6|image|VMware.pm:initialize(287)|VM profile assigned to esxi4: VMware ESXi - local storage
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(613)|computer ID argument was specified, retrieving data for computer ID: 3
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(637)|image ID argument was specified: 1, DataStructure object will contain image information for the production imagerevision of this image
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(668)|retrieved data for imagerevision ID: 1
> 2013-06-13 09:17:54|3661|6:6|image|DataStructure.pm:_initialize(684)|retrieved data for image ID: 1
> 2013-06-13 09:17:54|3661|6:6|image|VMware.pm:get_vmhost_datastructure(1392)|created DataStructure object for VM host: esxi4
> 2013-06-13 09:17:54|3661|6:6|image|VMware.pm:get_vmhost_api_object(1495)|attempting to load VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
> 2013-06-13 09:17:54|3661|6:6|image|VMware.pm:get_vmhost_api_object(1501)|loaded VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
> 2013-06-13 09:17:54|3661|6:6|image|Module.pm:new(200)|VCL::Module::Provisioning::VMware::vSphere_SDK object created for computer xp2, address: b74cf70
> 2013-06-13 09:17:54|3661|6:6|image|vSphere_SDK.pm:initialize(98)|vSphere SDK for Perl does not appear to be installed on this managment node, unable to load VMware vSphere SDK Perl modules, error:
> |3661|6:6|image| Can't locate VMware/VIRuntime.pm in @INC (@INC contains: /usr/local/vcl/bin/../../../.. /usr/local/vcl/bin/../.. /usr/local/vcl/bin/../../.. /usr/local/vcl/bin/../../../../.. /usr/local/vcl/bin/.. /usr/local/vcl/bin/../lib /usr/lib/perl5/site_perl/5.8.8/i386-linux-thread-multi /usr/lib/perl5/site_perl/5.8.8 /usr/lib/perl5/site_perl /usr/lib/perl5/vendor_perl/5.8.8/i386-linux-thread-multi /usr/lib/perl5/vendor_perl/5.8.8 /usr/lib/perl5/vendor_perl /usr/lib/perl5/5.8.8/i386-linux-thread-multi /usr/lib/perl5/5.8.8 .) at (eval 238) line 1.
> |3661|6:6|image| BEGIN failed--compilation aborted at (eval 238) line 1.
> 2013-06-13 09:17:54|3661|6:6|image|VMware.pm:get_vmhost_api_object(1515)|API object could not be created: VCL::Module::Provisioning::VMware::vSphere_SDK
> |3661|6:6|image| ---- WARNING ----
> |3661|6:6|image| 2013-06-13 09:18:05|3661|6:6|image|utils.pm:nmap_port(2454)|error occurred running nmap command: '/usr/bin/nmap esxi4 -P0 -p 22 -T Aggressive', output:
> |3661|6:6|image| Starting Nmap 4.11 ( http://www.insecure.org/nmap/ ) at 2013-06-13 09:17 CST
> |3661|6:6|image| Failed to resolve given hostname/IP: esxi4. Note that you can't use '/mask' AND '1-4,7,100-' style IP ranges
> |3661|6:6|image| WARNING: No targets were specified, so 0 hosts scanned.
> |3661|6:6|image| Nmap finished: 0 IP addresses (0 hosts up) scanned in 10.125 seconds
> |3661|6:6|image| ( 0) utils.pm, nmap_port (line: 2454)
> |3661|6:6|image| (-1) OS.pm, is_ssh_responding (line: 612)
> |3661|6:6|image| (-2) VMware.pm, initialize (line: 303)
> |3661|6:6|image| (-3) Module.pm, new (line: 207)
> |3661|6:6|image| (-4) Module.pm, create_provisioning_object (line: 522)
> |3661|6:6|image| (-5) State.pm, initialize (line: 136)
> |3661|6:6|image| ---- WARNING ----
> |3661|6:6|image| 2013-06-13 09:18:15|3661|6:6|image|utils.pm:nmap_port(2454)|error occurred running nmap command: '/usr/bin/nmap esxi4 -P0 -p 24 -T Aggressive', output:
> |3661|6:6|image| Starting Nmap 4.11 ( http://www.insecure.org/nmap/ ) at 2013-06-13 09:18 CST
> |3661|6:6|image| Failed to resolve given hostname/IP: esxi4. Note that you can't use '/mask' AND '1-4,7,100-' style IP ranges
> |3661|6:6|image| WARNING: No targets were specified, so 0 hosts scanned.
> |3661|6:6|image| Nmap finished: 0 IP addresses (0 hosts up) scanned in 10.001 seconds
> |3661|6:6|image| ( 0) utils.pm, nmap_port (line: 2454)
> |3661|6:6|image| (-1) OS.pm, is_ssh_responding (line: 613)
> |3661|6:6|image| (-2) VMware.pm, initialize (line: 303)
> |3661|6:6|image| (-3) Module.pm, new (line: 207)
> |3661|6:6|image| (-4) Module.pm, create_provisioning_object (line: 522)
> |3661|6:6|image| (-5) State.pm, initialize (line: 136)
> 2013-06-13 09:18:15|3661|6:6|image|OS.pm:is_ssh_responding(615)|esxi4 is NOT responding to SSH, ports 22 or 24 are both closed
> 2013-06-13 09:18:15|3661|6:6|image|VMware.pm:initialize(307)|unable to control OS of VM host esxi4 using VCL::Module::OS::Linux::UnixLab OS object because VM host is not responding to SSH
> |3661|6:6|image| ---- WARNING ----
> |3661|6:6|image| 2013-06-13 09:18:15|3661|6:6|image|Module.pm:create_provisioning_object(530)|provisioning object could not be created, returning 0
> |3661|6:6|image| ( 0) Module.pm, create_provisioning_object (line: 530)
> |3661|6:6|image| (-1) State.pm, initialize (line: 136)
> |3661|6:6|image| (-2) Module.pm, new (line: 207)
> |3661|6:6|image| (-3) vcld, make_new_child (line: 567)
> |3661|6:6|image| (-4) vcld, main (line: 350)
> |3661|6:6|image| ---- WARNING ----
> |3661|6:6|image| 2013-06-13 09:18:15|3661|6:6|image|State.pm:initialize(145)|failed to create provisioning object
> |3661|6:6|image| ( 0) State.pm, initialize (line: 145)
> |3661|6:6|image| (-1) Module.pm, new (line: 207)
> |3661|6:6|image| (-2) vcld, make_new_child (line: 567)
> |3661|6:6|image| (-3) vcld, main (line: 350)
> 2013-06-13 09:18:15|3661|6:6|image|utils.pm:delete_computerloadlog_reservation(6429)|removing computerloadlog entries matching loadstate = begin
> 2013-06-13 09:18:15|3661|6:6|image|utils.pm:delete_computerloadlog_reservation(6476)|deleted rows from computerloadlog for reservation id=6
> 2013-06-13 09:18:15|3661|6:6|image|State.pm:DESTROY(929)|VCL::image process duration: 21 seconds
> 2013-06-13 09:18:15|3661|6:6|image|DataStructure.pm:get_computer_private_ip_address(1630)|attempting to retrieve private IP address for computer: xp2
> 2013-06-13 09:18:15|3661|6:6|image|DataStructure.pm:get_computer_private_ip_address(1634)|retrieved contents of /etc/hosts on this management node, contains 7 lines
> 2013-06-13 09:18:15|3661|6:6|image|DataStructure.pm:get_computer_private_ip_address(1673)|did not find any lines in /etc/hosts containing 'xp2', returning private IP address defined in the database: 192.168.72.152
> 2013-06-13 09:18:15|3661|6:6|image|utils.pm:getnewdbh(2512)|unable to use database handle stored in $ENV{dbh}
> 2013-06-13 09:18:15|3661|6:6|image|utils.pm:getnewdbh(2569)|database handle stored in $ENV{dbh}
> 2013-06-13 09:18:15|3661|6:6|image|utils.pm:is_inblockrequest(5793)|zero rows were returned from database select
> 2013-06-13 09:18:15|3661|6:6|image|DataStructure.pm:get_image_affiliation_name(2118)|image owner id: 1
> 2013-06-13 09:18:15|3661|6:6|image|DataStructure.pm:retrieve_user_data(1401)|attempting to retrieve and store data for user: user.id = '1'
> 2013-06-13 09:18:15|3661|6:6|image|DataStructure.pm:retrieve_user_data(1464)|data has been retrieved for user: admin (id: 1)
>
>
>
> My Environment :
>
> Hypervisor : ESXi 4.0.0
> Management Node : CentOS 5.9
> Image O.S : Window XP SP3
> VCL : 2.3
>
> if there were further information required , plz kindly let me know, thank you
>
> Best Regards,
> Vincent YA Chen 陳彥安 4F, 7 Song Ren Road
> <Mail Attachment.gif>
> I/T Specialist Taipei, 110
> End User Service Taiwan
> GTS Service Delivery, Taiwan
> Phone: +886-2-8723-9081
> Mobile: +886-911-227-378
> e-mail: yachen@tw.ibm.com
>
>
>