Hello, I am getting an error when I try to capture a linux base image in vcl. I am following the instructions, but perhaps some parts of these may have been misinterpreted.
My VCL server is at 10.0.0.1. My Vmware based virtual machine is at 10.0.0.2. I can ssh without passwords using keys from the vcl server to the VM. The computer has been added to the database as hostname redhat64base, although I have no DNS entry to resolve that name, so I use it's private IP of 10.0.0.2. Below is the result of vcld trying to capture the computer to create a new base image….Any ideas about what could be wrong ? Thanks, Al Quiros VCL::image object could not be created and initialized ------------------------------------------------------------------------ time: 2011-10-25 08:58:38 caller: vcld:make_new_child(571) ( 0) vcld, make_new_child (line: 571) (-1) vcld, main (line: 346) ------------------------------------------------------------------------ management node: vcltst.fiu.edu reservation PID: 29609 parent vcld PID: 15838 request ID: 2 reservation ID: 2 request state/laststate: image/image request start time: 2011-10-25 08:58:37 request end time: 2011-10-25 09:58:37 for imaging: no log ID: none computer: redhat64base computer id: 12 computer type: blade computer eth0 MAC address: <undefined> computer eth1 MAC address: <undefined> computer private IP address: <undefined> computer public IP address: 10.0.0.2 computer in block allocation: no provisioning module: VCL::Module::Provisioning::VMware::VMware image: vmwarelinux-redhat64linux8-v0 image display name: redhat64linux image ID: 8 image revision ID: 6 image size: 1450 MB use Sysprep: yes root access: yes image owner ID: 1 image owner affiliation: Local image revision date created: 2011-10-25 08:58:37 image revision production: yes OS module: VCL::Module::OS::Linux user: admin user name: vcl admin user ID: 1 user affiliation: Local ------------------------------------------------------------------------ RECENT LOG ENTRIES FOR THIS PROCESS: 2011-10-25 08:58:38|29609|2:2|image|VMware.pm:get_vmhost_os_object(1238)|VM host OS module loaded: VCL::Module::OS::Linux 2011-10-25 08:58:38|29609|2:2|image|Module.pm:create_mn_os_object(335)|management node OS object has already been created, address: 1fbe730, returning 1 2011-10-25 08:58:38|29609|2:2|image|Module.pm:new(196)|VCL::Module::OS::Linux object created for image vmwarelinux-redhat64linux8-v0, address: 24f12f0 2011-10-25 08:58:38|29609|2:2|image|VMware.pm:get_vmhost_os_object(1244)|VM host OS object created: VCL::Module::OS::Linux 2011-10-25 08:58:38|29609|2:2|image|utils.pm:run_command(8998)|$? is set to -1, setting exit status to 0, Perl bug likely encountered |29609|2:2|image| ---- WARNING ---- |29609|2:2|image| 2011-10-25 08:58:38|29609|2:2|image|utils.pm:nmap_port(2645)|error occurred running nmap command: '/usr/bin/nmap redhat64base -P0 -p 22 -T Aggressive', output: |29609|2:2|image| Starting Nmap 5.21 ( http://nmap.org<http://nmap.org/> ) at 2011-10-25 08:58 EDT |29609|2:2|image| Failed to resolve given hostname/IP: redhat64base. Note that you can't use '/mask' AND '1-4,7,100-' style IP ranges |29609|2:2|image| WARNING: No targets were specified, so 0 hosts scanned. |29609|2:2|image| Nmap done: 0 IP addresses (0 hosts up) scanned in 0.05 seconds |29609|2:2|image| ( 0) utils.pm, nmap_port (line: 2645) |29609|2:2|image| (-1) OS.pm, is_ssh_responding (line: 383) |29609|2:2|image| (-2) VMware.pm, initialize (line: 252) |29609|2:2|image| (-3) Module.pm, new (line: 207) |29609|2:2|image| (-4) Module.pm, create_provisioning_object (line: 423) |29609|2:2|image| (-5) State.pm, initialize (line: 117) |29609|2:2|image| ---- WARNING ---- |29609|2:2|image| 2011-10-25 08:58:38|29609|2:2|image|utils.pm:nmap_port(2645)|error occurred running nmap command: '/usr/bin/nmap redhat64base -P0 -p 24 -T Aggressive', output: |29609|2:2|image| Starting Nmap 5.21 ( http://nmap.org<http://nmap.org/> ) at 2011-10-25 08:58 EDT |29609|2:2|image| Failed to resolve given hostname/IP: redhat64base. Note that you can't use '/mask' AND '1-4,7,100-' style IP ranges |29609|2:2|image| WARNING: No targets were specified, so 0 hosts scanned. |29609|2:2|image| Nmap done: 0 IP addresses (0 hosts up) scanned in 0.05 seconds |29609|2:2|image| ( 0) utils.pm, nmap_port (line: 2645) |29609|2:2|image| (-1) OS.pm, is_ssh_responding (line: 384) |29609|2:2|image| (-2) VMware.pm, initialize (line: 252) |29609|2:2|image| (-3) Module.pm, new (line: 207) |29609|2:2|image| (-4) Module.pm, create_provisioning_object (line: 423) |29609|2:2|image| (-5) State.pm, initialize (line: 117) 2011-10-25 08:58:38|29609|2:2|image|OS.pm:is_ssh_responding(386)|redhat64base is NOT responding to SSH, ports 22 or 24 are both closed 2011-10-25 08:58:38|29609|2:2|image|VMware.pm:initialize(257)|unable to control OS of VM host redhat64base using VCL::Module::OS::Linux OS object because VM host is not responding to SSH |29609|2:2|image| ---- WARNING ---- |29609|2:2|image| 2011-10-25 08:58:38|29609|2:2|image|DataStructure.pm:_automethod(812)|corresponding data has not been initialized for get_vmhost_computer_id: $self->request_data->{reservation}{2}{computer}{vmhost}{computerid} |29609|2:2|image| ( 0) DataStructure.pm, _automethod (line: 812) |29609|2:2|image| (-1) Autoload.pm, __ANON__ (line: 80) |29609|2:2|image| (-2) VMware.pm, get_vmhost_datastructure (line: 1161) |29609|2:2|image| (-3) VMware.pm, get_vmhost_api_object (line: 1282) |29609|2:2|image| (-4) VMware.pm, initialize (line: 265) |29609|2:2|image| (-5) Module.pm, new (line: 207) |29609|2:2|image| ---- WARNING ---- |29609|2:2|image| 2011-10-25 08:58:38|29609|2:2|image|DataStructure.pm:_automethod(812)|corresponding data has not been initialized for get_vmhost_profile_image_id: $self->request_data->{reservation}{2}{computer}{vmhost}{vmprofile}{imageid} |29609|2:2|image| ( 0) DataStructure.pm, _automethod (line: 812) |29609|2:2|image| (-1) Autoload.pm, __ANON__ (line: 80) |29609|2:2|image| (-2) VMware.pm, get_vmhost_datastructure (line: 1162) |29609|2:2|image| (-3) VMware.pm, get_vmhost_api_object (line: 1282) |29609|2:2|image| (-4) VMware.pm, initialize (line: 265) |29609|2:2|image| (-5) Module.pm, new (line: 207) 2011-10-25 08:58:38|29609|2:2|image|VMware.pm:get_vmhost_datastructure(1190)|created DataStructure object for VM host: redhat64base 2011-10-25 08:58:38|29609|2:2|image|VMware.pm:get_vmhost_api_object(1293)|attempting to load VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK 2011-10-25 08:58:38|29609|2:2|image|VMware.pm:get_vmhost_api_object(1299)|loaded VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK 2011-10-25 08:58:38|29609|2:2|image|Module.pm:new(172)|set 'vmhost_data' key for VCL::Module::Provisioning::VMware::vSphere_SDK object from arguments 2011-10-25 08:58:38|29609|2:2|image|Module.pm:new(172)|set 'vmhost_os' key for VCL::Module::Provisioning::VMware::vSphere_SDK object from arguments 2011-10-25 08:58:38|29609|2:2|image|Module.pm:create_mn_os_object(335)|management node OS object has already been created, address: 1fbe730, returning 1 2011-10-25 08:58:38|29609|2:2|image|Module.pm:new(200)|VCL::Module::Provisioning::VMware::vSphere_SDK object created for computer redhat64base, address: 2508cf8 2011-10-25 08:58:38|29609|2:2|image|vSphere_SDK.pm:initialize(1826)|vSphere SDK for Perl does not appear to be installed on this managment node, unable to load VMware vSphere SDK Perl modules 2011-10-25 08:58:38|29609|2:2|image|VMware.pm:get_vmhost_api_object(1313)|API object could not be created: VCL::Module::Provisioning::VMware::vSphere_SDK |29609|2:2|image| ---- WARNING ---- |29609|2:2|image| 2011-10-25 08:58:38|29609|2:2|image|VMware.pm:initialize(273)|no methods are available to control VM host redhat64base, the vSphere SDK cannot be used to control the VM host and the host OS cannot be controlled via SSH |29609|2:2|image| ( 0) VMware.pm, initialize (line: 273) |29609|2:2|image| (-1) Module.pm, new (line: 207) |29609|2:2|image| (-2) Module.pm, create_provisioning_object (line: 423) |29609|2:2|image| (-3) State.pm, initialize (line: 117) |29609|2:2|image| (-4) Module.pm, new (line: 207) |29609|2:2|image| (-5) vcld, make_new_child (line: 564) |29609|2:2|image| ---- WARNING ---- |29609|2:2|image| 2011-10-25 08:58:38|29609|2:2|image|Module.pm:create_provisioning_object(431)|provisioning object could not be created, returning 0 |29609|2:2|image| ( 0) Module.pm, create_provisioning_object (line: 431) |29609|2:2|image| (-1) State.pm, initialize (line: 117) |29609|2:2|image| (-2) Module.pm, new (line: 207) |29609|2:2|image| (-3) vcld, make_new_child (line: 564) |29609|2:2|image| (-4) vcld, main (line: 346) |29609|2:2|image| ---- WARNING ---- |29609|2:2|image| 2011-10-25 08:58:38|29609|2:2|image|State.pm:initialize(118)|failed to create provisioning object |29609|2:2|image| ( 0) State.pm, initialize (line: 118) |29609|2:2|image| (-1) Module.pm, new (line: 207) |29609|2:2|image| (-2) vcld, make_new_child (line: 564) |29609|2:2|image| (-3) vcld, main (line: 346) 2011-10-25 08:58:38|29609|2:2|image|State.pm:DESTROY(829)|VCL::image destructor called, address: 1e52a60 2011-10-25 08:58:38|29609|2:2|image|utils.pm:delete_computerloadlog_reservation(6742)|removing computerloadlog entries matching loadstate = begin 2011-10-25 08:58:38|29609|2:2|image|utils.pm:delete_computerloadlog_reservation(6789)|deleted rows from computerloadlog for reservation id=2 2011-10-25 08:58:38|29609|2:2|image|State.pm:DESTROY(848)|number of database handles state process created: 1 2011-10-25 08:58:38|29609|2:2|image|State.pm:DESTROY(876)|VCL::image process duration: 0 seconds 2011-10-25 08:58:38|29609|2:2|image|DataStructure.pm:get_computer_private_ip_address(1581)|attempting to retrieve private IP address for computer: redhat64base 2011-10-25 08:58:38|29609|2:2|image|DataStructure.pm:get_computer_private_ip_address(1585)|retrieved contents of /etc/hosts on this management node, contains 8 lines |29609|2:2|image| ---- WARNING ---- |29609|2:2|image| 2011-10-25 08:58:38|29609|2:2|image|DataStructure.pm:get_computer_private_ip_address(1629)|did not find any lines in /etc/hosts containing 'redhat64base' and the private IP address is not defined in the database |29609|2:2|image| ( 0) DataStructure.pm, get_computer_private_ip_address (line: 1629) |29609|2:2|image| (-1) DataStructure.pm, get_reservation_info_string (line: 2419) |29609|2:2|image| (-3) vcld, make_new_child (line: 571) |29609|2:2|image| (-4) vcld, main (line: 346) 2011-10-25 08:58:38|29609|2:2|image|utils.pm:getnewdbh(2703)|unable to use database handle stored in $ENV{dbh} 2011-10-25 08:58:38|29609|2:2|image|utils.pm:getnewdbh(2760)|database handle stored in $ENV{dbh} 2011-10-25 08:58:38|29609|2:2|image|utils.pm:is_inblockrequest(6163)|zero rows were returned from database select 2011-10-25 08:58:38|29609|2:2|image|DataStructure.pm:get_image_affiliation_name(2035)|image owner id: 1 2011-10-25 08:58:38|29609|2:2|image|utils.pm:getnewdbh(2709)|database requested (information_schema) does not match handle stored in $ENV{dbh} (vcl:localhost) 2011-10-25 08:58:38|29609|2:2|image|utils.pm:getnewdbh(2760)|database handle stored in $ENV{dbh} 2011-10-25 08:58:38|29609|2:2|image|DataStructure.pm:retrieve_user_data(1352)|attempting to retrieve and store data for user: user.id = '1' 2011-10-25 08:58:38|29609|2:2|image|utils.pm:getnewdbh(2709)|database requested (vcl) does not match handle stored in $ENV{dbh} (information_schema:localhost) 2011-10-25 08:58:38|29609|2:2|image|utils.pm:getnewdbh(2760)|database handle stored in $ENV{dbh} 2011-10-25 08:58:38|29609|2:2|image|DataStructure.pm:retrieve_user_data(1415)|data has been retrieved for user: admin (id: 1)
