Hello,
The code first attempts to run nmap to check if the SSH ports are even open. Based on your log output, this is where it is failing:
"vm2 is NOT responding to SSH, ports 22 or 24 are both closed"

Try running this command:
/usr/bin/nmap vm2 -P0 -p 22 -T Aggressive

If you get a "Failed to resolve given hostname/IP" error then there is a problem with your hosts file. Make sure vm2's private IP address has been added to /etc/hosts/. Run "host vm2". It should display:
vm2 has address xxx.xxx.xxx.xxx

If the SSH port is open you should see "1 host up". If this is the case, try running the following command:
/usr/bin/ssh -i /etc/vcl/vcl.key -l root -p 22 -x vm2 'echo testing'

Does this command succeed?

-Andy

On 3/8/2011 4:58 PM, Tyler Hardesty wrote:
Hey thanks!

adding those lines helped solve my permission denied problem but
unfortunately I still can't create the base image... It keeps telling me
that it is not responding to ssh (It also looks like Jay Diener-Brazelle
had this problem that he posted at the end of Feb 2011 but I don't see a
solution reply to his either)

management node:

[root@vcl vcl]# /usr/local/vcl/bin/vcld -setup
VCL Management Node Setup
----------------------------------------------------------------------------
Select a module to configure:
1. VCL Base Module
2. VCL Image State Module
3. Windows OS Module

[vcld]
Make a selection (1-3, 'c' to cancel): 2
----------------------------------------------------------------------------
Choose an operation:
1. Capture Base Image

[vcld/Image]
Make a selection (1, 'c' to cancel): 1

Enter the VCL login name or ID of the user who will own the image: [admin]:

User who will own the image: admin (ID: 1)

Enter the hostname or IP address of the computer to be captured: ('c' to
cancel): vm2

Computer to be captured: vm2 (ID: 3)
Provisioning module: provisioning_vmware
Install type: vmware

Select the OS to be captured (install type: vmware):
1. Generic Linux (VMware)
2. Windows 2003 Server (VMware)
3. Windows 7 (VMware)
4. Windows Server 2008 (VMware)
5. Windows Vista (VMware)
6. Windows XP (VMware)

[vcld/Image/Capture Base Image]
Make a selection (1-6, 'c' to cancel): 6

Selected OS: Windows XP (VMware)

Image architecture:
1. x86
2. x86_64

[vcld/Image/Capture Base Image]
Make a selection (1-2, 'c' to cancel): 1

Image architecture: x86

Use Sysprep:
1. Yes
2. No

[vcld/Image/Capture Base Image]
Make a selection (1-2, 'c' to cancel): 2

Use Sysprep: No

Enter the name of the image to be captured: ('c' to cancel): win_xp

Added new image to database: 'win_xp'
image.name <http://image.name>: vmwarewinxp-win_xp14-v0
image.id <http://image.id>: 14
imagerevision.id <http://imagerevision.id>: 14
imagemeta.id <http://imagemeta.id>: 12
resource.id <http://resource.id>: 24

----------------------------------------------------------------------------
Inserted imaging request to the database:
request ID: 10
reservation ID: 10

This process will now display the contents of the vcld.log file if the vcld
daemon is running. If you do not see many lines of additional output,
exit this
process, start the vcld daemon, and monitor the image capture process by
running
the command:
tail -f /var/log/vcld.log | grep '10:10'

----------------------------------------------------------------------------
2011-03-08 14:40:01|20476|utils.pm:insert_request(8343)|inserted new
reload request into request table, request id=10
2011-03-08 14:40:01|20476|utils.pm:insert_request(8374)|inserted new
reload request into reservation table, reservation id=10
2011-03-08
14:40:05|13551|10:10|image|utils.pm:reservation_being_processed(8923)|computerloadlog
'begin' entry does NOT exist for reservation 10
2011-03-08
14:40:05|13551|10:10|image|utils.pm:run_command(8995)|executed command:
pgrep -fl 'vcld [0-9]+:10 ', pid: 20517, exit status: 1, output:
2011-03-08
14:40:05|13551|10:10|image|utils.pm:is_management_node_process_running(9177)|process
is NOT running, identifier: 'vcld [0-9]+:10 '
2011-03-08
14:40:05|13551|10:10|image|utils.pm:reservation_being_processed(8944)|reservation
is NOT currently being processed
2011-03-08 14:40:05|13551|10:10|image|vcld:main(278)|reservation 10 is
NOT already being processed
2011-03-08
14:40:05|13551|10:10|image|utils.pm:get_request_info(4510)|standalone
affiliation found: Local
2011-03-08 14:40:05|13551|10:10|image|vcld:main(283)|retrieved request
information from database
2011-03-08
14:40:05|13551|10:10|image|DataStructure.pm:is_parent_reservation(992)|returning
true: parent reservation ID for this request: 10
2011-03-08
14:40:05|13551|10:10|image|utils.pm:update_request_state(1991)|request
10 state updated to: pending, laststate to: image
2011-03-08
14:40:05|13551|10:10|image|utils.pm:insertloadlog(3875)|inserted
computer=3, begin, beginning to process, state is image
2011-03-08 14:40:05|13551|10:10|image|vcld:make_new_child(515)|loaded
VCL::image module
2011-03-08 14:40:05|13551|10:10|image|vcld:make_new_child(539)|current
number of forked kids: 1
2011-03-08 14:40:05|20532|10:10|image|vcld:make_new_child(555)|vcld
environment variable set to 0 for this process
2011-03-08 14:40:05|20532|10:10|image|Module.pm:new(161)|VCL::image
object created for state image, address: 9a54b24
2011-03-08 14:40:05|20532|10:10|image|State.pm:initialize(86)|obtained a
database handle for this state process, stored as $ENV{dbh}
2011-03-08 14:40:05|20532|10:10|image|State.pm:check_image_os(772)|no
corrections need to be made to image OS: vmwarewinxp
2011-03-08
14:40:05|20532|10:10|image|DataStructure.pm:is_parent_reservation(992)|returning
true: parent reservation ID for this request: 10
2011-03-08
14:40:05|20532|10:10|image|utils.pm:rename_vcld_process(7082)|reservation count:
1
2011-03-08
14:40:05|20532|10:10|image|utils.pm:rename_vcld_process(7101)|PARENTIMAGE: 1
2011-03-08
14:40:05|20532|10:10|image|utils.pm:rename_vcld_process(7102)|SUBIMAGE: 0
2011-03-08
14:40:05|20532|10:10|image|utils.pm:rename_vcld_process(7120)|renamed
process to 'vcld 10:10 image vm2>localvmhost vmwarewinxp-win_xp14-v0 admin'
2011-03-08
14:40:05|20532|10:10|image|DataStructure.pm:is_parent_reservation(992)|returning
true: parent reservation ID for this request: 10
2011-03-08
14:40:05|20532|10:10|image|DataStructure.pm:is_parent_reservation(992)|returning
true: parent reservation ID for this request: 10
2011-03-08
14:40:05|20532|10:10|image|Module.pm:create_os_object(267)|VCL::Module::OS::Windows::Version_5::XP
module loaded
2011-03-08
14:40:05|20532|10:10|image|Module.pm:new(165)|VCL::Module::OS::Windows::Version_5::XP
object created for image vmwarewinxp-win_xp14-v0, address: 9e7bbdc
2011-03-08
14:40:05|20532|10:10|image|Module.pm:create_os_object(273)|VCL::Module::OS::Windows::Version_5::XP
OS object created for vmwarewinxp-win_xp14-v0, address: 9e7bbdc
2011-03-08
14:40:05|20532|10:10|image|Module.pm:create_mn_os_object(330)|VCL::Module::OS::Linux::ManagementNode
module loaded
2011-03-08
14:40:05|20532|10:10|image|Module.pm:new(165)|VCL::Module::OS::Linux::ManagementNode
object created for image <not set>, address: 9e7c074
2011-03-08
14:40:05|20532|10:10|image|DataStructure.pm:_automethod(835)|data
structure updated: $self->request_data->{reservation}{0}{computer}{hostname}
|20532|10:10|image| computer_hostname = vcl.tylerhardesty.info
<http://vcl.tylerhardesty.info>
2011-03-08
14:40:05|20532|10:10|image|DataStructure.pm:_automethod(835)|data
structure updated: $self->request_data->{reservation}{0}{computer}{NODENAME}
|20532|10:10|image| computer_node_name = vcl
2011-03-08
14:40:05|20532|10:10|image|DataStructure.pm:_automethod(835)|data
structure updated:
$self->request_data->{reservation}{0}{computer}{SHORTNAME}
|20532|10:10|image| computer_short_name = vcl
2011-03-08
14:40:05|20532|10:10|image|DataStructure.pm:_automethod(835)|data
structure updated:
$self->request_data->{reservation}{0}{computer}{IPaddress}
|20532|10:10|image| computer_ip_address = 144.38.205.249
2011-03-08
14:40:05|20532|10:10|image|Module.pm:create_mn_os_object(335)|VCL::Module::OS::Linux::ManagementNode
OS object created, address: 9e7c074
2011-03-08
14:40:05|20532|10:10|image|Module.pm:create_provisioning_object(389)|VCL::Module::Provisioning::VMware::VMware
module loaded
2011-03-08
14:40:05|20532|10:10|image|Module.pm:new(169)|VCL::Module::Provisioning::VMware::VMware
object created for computer vm2, address: 9f75548
2011-03-08
14:40:05|20532|10:10|image|VMware.pm:initialize(230)|initializing
VCL::Module::Provisioning::VMware::VMware object
2011-03-08
14:40:05|20532|10:10|image|DataStructure.pm:_initialize(614)|computer ID
argument was specified, retrieving data for computer ID: 1
2011-03-08
14:40:05|20532|10:10|image|DataStructure.pm:_initialize(644)|image ID
argument was specified: 4, DataStructure object will contain image
information for the production imagerevision of this image
2011-03-08
14:40:05|20532|10:10|image|DataStructure.pm:_initialize(661)|retrieved
data for imagerevision ID: 4
2011-03-08
14:40:05|20532|10:10|image|DataStructure.pm:_initialize(677)|retrieved
data for image ID: 4
2011-03-08
14:40:05|20532|10:10|image|VMware.pm:get_vmhost_datastructure(1187)|created
DataStructure object for VM host: localvmhost
2011-03-08
14:40:05|20532|10:10|image|VMware.pm:initialize(249)|attempting to
create OS object for the image currently loaded on the VM host: localvmhost
|20532|10:10|image| image name: noimage
|20532|10:10|image| OS module: VCL::Module::OS::Linux::UnixLab
2011-03-08
14:40:05|20532|10:10|image|DataStructure.pm:_initialize(614)|computer ID
argument was specified, retrieving data for computer ID: 1
2011-03-08
14:40:05|20532|10:10|image|DataStructure.pm:_initialize(644)|image ID
argument was specified: 4, DataStructure object will contain image
information for the production imagerevision of this image
2011-03-08
14:40:05|20532|10:10|image|DataStructure.pm:_initialize(661)|retrieved
data for imagerevision ID: 4
2011-03-08
14:40:05|20532|10:10|image|DataStructure.pm:_initialize(677)|retrieved
data for image ID: 4
2011-03-08
14:40:05|20532|10:10|image|VMware.pm:get_vmhost_datastructure(1187)|created
DataStructure object for VM host: localvmhost
2011-03-08
14:40:05|20532|10:10|image|VMware.pm:get_vmhost_os_object(1229)|attempting
to load VM host OS module: VCL::Module::OS::Linux::UnixLab
2011-03-08
14:40:05|20532|10:10|image|VMware.pm:get_vmhost_os_object(1235)|VM host
OS module loaded: VCL::Module::OS::Linux::UnixLab
2011-03-08
14:40:05|20532|10:10|image|Module.pm:new(165)|VCL::Module::OS::Linux::UnixLab
object created for image noimage, address: a18b8a8
2011-03-08
14:40:05|20532|10:10|image|VMware.pm:get_vmhost_os_object(1241)|VM host
OS object created: VCL::Module::OS::Linux::UnixLab
2011-03-08
14:40:05|20532|10:10|image|OS.pm:is_ssh_responding(401)|localvmhost is
responding to SSH, port 22: open, port 24: closed
2011-03-08 14:40:05|20532|10:10|image|VMware.pm:initialize(254)|OS on VM
host localvmhost will be controlled using a
VCL::Module::OS::Linux::UnixLab OS object
2011-03-08
14:40:05|20532|10:10|image|DataStructure.pm:_initialize(614)|computer ID
argument was specified, retrieving data for computer ID: 1
2011-03-08
14:40:05|20532|10:10|image|DataStructure.pm:_initialize(644)|image ID
argument was specified: 4, DataStructure object will contain image
information for the production imagerevision of this image
2011-03-08
14:40:05|20532|10:10|image|DataStructure.pm:_initialize(661)|retrieved
data for imagerevision ID: 4
2011-03-08
14:40:05|20532|10:10|image|DataStructure.pm:_initialize(677)|retrieved
data for image ID: 4
2011-03-08
14:40:05|20532|10:10|image|VMware.pm:get_vmhost_datastructure(1187)|created
DataStructure object for VM host: localvmhost
2011-03-08
14:40:05|20532|10:10|image|VMware.pm:get_vmhost_api_object(1290)|attempting
to load VMware control module:
VCL::Module::Provisioning::VMware::vSphere_SDK
2011-03-08
14:40:05|20532|10:10|image|VMware.pm:get_vmhost_api_object(1296)|loaded
VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
2011-03-08
14:40:05|20532|10:10|image|Module.pm:new(169)|VCL::Module::Provisioning::VMware::vSphere_SDK
object created for computer vm2, address: a18e41c
2011-03-08
14:40:05|20532|10:10|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-03-08
14:40:05|20532|10:10|image|VMware.pm:get_vmhost_api_object(1310)|API
object could not be created: VCL::Module::Provisioning::VMware::vSphere_SDK
2011-03-08
14:40:05|20532|10:10|image|DataStructure.pm:_initialize(614)|computer ID
argument was specified, retrieving data for computer ID: 1
2011-03-08
14:40:05|20532|10:10|image|DataStructure.pm:_initialize(644)|image ID
argument was specified: 4, DataStructure object will contain image
information for the production imagerevision of this image
2011-03-08
14:40:05|20532|10:10|image|DataStructure.pm:_initialize(661)|retrieved
data for imagerevision ID: 4
2011-03-08
14:40:05|20532|10:10|image|DataStructure.pm:_initialize(677)|retrieved
data for image ID: 4
2011-03-08
14:40:05|20532|10:10|image|VMware.pm:get_vmhost_datastructure(1187)|created
DataStructure object for VM host: localvmhost
2011-03-08
14:40:05|20532|10:10|image|VMware.pm:get_vmhost_api_object(1290)|attempting
to load VMware control module: VCL::Module::Provisioning::VMware::VIM_SSH
2011-03-08
14:40:05|20532|10:10|image|VMware.pm:get_vmhost_api_object(1296)|loaded
VMware control module: VCL::Module::Provisioning::VMware::VIM_SSH
2011-03-08
14:40:05|20532|10:10|image|Module.pm:new(169)|VCL::Module::Provisioning::VMware::VIM_SSH
object created for computer vm2, address: a1a0118
2011-03-08 14:40:06|20532|10:10|image|VIM_SSH.pm:initialize(138)|VIM
executable available on VM host: vmware-vim-cmd
2011-03-08
14:40:06|20532|10:10|image|VIM_SSH.pm:initialize(140)|VCL::Module::Provisioning::VMware::VIM_SSH
object initialized
2011-03-08
14:40:06|20532|10:10|image|VMware.pm:get_vmhost_api_object(1317)|created
API object: VCL::Module::Provisioning::VMware::VIM_SSH
2011-03-08 14:40:06|20532|10:10|image|VMware.pm:initialize(278)|VMware
on VM host localvmhost will be controlled using vim-cmd via SSH
2011-03-08 14:40:06|20532|10:10|image|VMware.pm:initialize(293)|VMware
OS and API objects created for VM host localvmhost:
|20532|10:10|image| VM host OS object type: VCL::Module::OS::Linux::UnixLab
|20532|10:10|image| VMware API object type:
VCL::Module::Provisioning::VMware::VIM_SSH
2011-03-08
14:40:08|20532|10:10|image|VMware.pm:get_vmhost_product_name(5374)|VMware 
product
being used on VM host localvmhost: 'VMware Server 2.0.2 build-203138'
2011-03-08 14:40:08|20532|10:10|image|VMware.pm:initialize(307)|product:
VMware Server 2.0.2 build-203138, OS object: VCL::Module::OS::Linux::UnixLab
2011-03-08
14:40:08|20532|10:10|image|VMware.pm:get_vmx_base_directory_path(2736)|determined
vmx base directory path: /var/lib/vmware/Virtual Machines
2011-03-08
14:40:08|20532|10:10|image|Linux.pm:file_exists(1382)|'/var/lib/vmware/Virtual
Machines' exists on localvmhost, files: 0, directories: 1, links: 0
2011-03-08 14:40:08|20532|10:10|image|VMware.pm:initialize(324)|not
checking if vmdk base directory exists because it is the same as the vmx
base directory: /var/lib/vmware/Virtual Machines
2011-03-08
14:40:08|20532|10:10|image|Module.pm:create_provisioning_object(395)|VCL::Module::Provisioning::VMware::VMware
provisioner object created for vm2, address: 9f75548
2011-03-08 14:40:08|20532|10:10|image|State.pm:initialize(136)|returning 1
2011-03-08
14:40:08|20532|10:10|image|vcld:make_new_child(565)|VCL::image object
created and initialized
2011-03-08 14:40:08|20532|10:10|image|utils.pm:mail(1268)|SUCCESS --
Sending mail To: tharde...@tylerhardesty.info
<mailto:tharde...@tylerhardesty.info>, VCL IMAGE Creation Started:
vmwarewinxp-win_xp14-v0
2011-03-08 14:40:08|20532|10:10|image|Linux.pm:file_exists(1368)|file or
directory does not exist on localvmhost: '/var/lib/vmware/Virtual
Machines/vmwarewinxp-win_xp14-v0/vmwarewinxp-win_xp14-v0.vmdk'
2011-03-08
14:40:08|20532|10:10|image|VMware.pm:does_image_exist(3906)|image does
not exist in the non-persistent directory on the VM host
2011-03-08
14:40:08|20532|10:10|image|Linux.pm:file_exists(1382)|'/var/lib/vmware/Virtual
Machines' exists on localvmhost, files: 0, directories: 1, links: 0
2011-03-08
14:40:08|20532|10:10|image|VMware.pm:is_repository_mounted_on_vmhost(5454)|image
repository is mounted on VM host localvmhost: /var/lib/vmware/Virtual
Machines
2011-03-08
14:40:08|20532|10:10|image|VMware.pm:does_image_exist(3917)|checking if
vmdk file exists in image repository mounted on VM host:
localvmhost:/var/lib/vmware/Virtual
Machines/vmwarewinxp-win_xp14-v0/vmwarewinxp-win_xp14-v0.vmdk
2011-03-08 14:40:09|20532|10:10|image|Linux.pm:file_exists(1368)|file or
directory does not exist on localvmhost: '/var/lib/vmware/Virtual
Machines/vmwarewinxp-win_xp14-v0/vmwarewinxp-win_xp14-v0.vmdk'
2011-03-08
14:40:09|20532|10:10|image|VMware.pm:does_image_exist(3923)|vmdk file
does not exist in image repository mounted on VM host:
localvmhost:/var/lib/vmware/Virtual
Machines/vmwarewinxp-win_xp14-v0/vmwarewinxp-win_xp14-v0.vmdk
2011-03-08 14:40:09|20532|10:10|image|image.pm:process(148)|image
vmwarewinxp-win_xp14-v0 does not exist in the repository
2011-03-08
14:40:09|20532|10:10|image|DataStructure.pm:_automethod(835)|data
structure updated: $self->request_data->{reservation}{10}{image}{lastupdate}
|20532|10:10|image| image_lastupdate = 2011-03-08 14:40:09
2011-03-08
14:40:09|20532|10:10|image|DataStructure.pm:_automethod(835)|data
structure updated:
$self->request_data->{reservation}{10}{imagerevision}{datecreated}
|20532|10:10|image| imagerevision_date_created = 2011-03-08 14:40:09
2011-03-08 14:40:09|20532|10:10|image|image.pm:process(164)|calling
provisioning module's capture() subroutine
2011-03-08 14:40:09|20532|10:10|image|OS.pm:is_ssh_responding(386)|vm2
is NOT responding to SSH, ports 22 or 24 are both closed
|20532|10:10|image| ---- WARNING ----
|20532|10:10|image| 2011-03-08
14:40:09|20532|10:10|image|VMware.pm:capture(462)|unable to capture
image, VM vm2 is not responding to SSH
|20532|10:10|image| ( 0) VMware.pm, capture (line: 462)
|20532|10:10|image| (-1) image.pm <http://image.pm>, process (line: 165)
|20532|10:10|image| (-2) vcld, make_new_child (line: 568)
|20532|10:10|image| (-3) vcld, main (line: 346)
|20532|10:10|image| ---- WARNING ----
|20532|10:10|image| 2011-03-08
14:40:09|20532|10:10|image|image.pm:process(169)|vmwarewinxp-win_xp14-v0
image failed to be captured by provisioning module
|20532|10:10|image| ( 0) image.pm <http://image.pm>, process (line: 169)
|20532|10:10|image| (-1) vcld, make_new_child (line: 568)
|20532|10:10|image| (-2) vcld, main (line: 346)
2011-03-08
14:40:09|20532|10:10|image|DataStructure.pm:get_computer_private_ip_address(1582)|attempting
to retrieve private IP address for computer: vm2
2011-03-08
14:40:09|20532|10:10|image|DataStructure.pm:get_computer_private_ip_address(1586)|retrieved
contents of /etc/hosts on this management node, contains 7 lines
2011-03-08
14:40:09|20532|10:10|image|DataStructure.pm:get_computer_private_ip_address(1639)|returning
IP address from /etc/hosts file: 192.168.1.1
2011-03-08
14:40:09|20532|10:10|image|utils.pm:is_inblockrequest(6147)|zero rows
were returned from database select
2011-03-08
14:40:09|20532|10:10|image|DataStructure.pm:get_image_affiliation_name(2029)|image
owner id: 1
2011-03-08 14:40:09|20532|10:10|image|utils.pm:getnewdbh(2709)|database
requested (information_schema) does not match handle stored in $ENV{dbh}
(vcl:127.0.0.1)
2011-03-08 14:40:09|20532|10:10|image|utils.pm:getnewdbh(2760)|database
handle stored in $ENV{dbh}
2011-03-08
14:40:09|20532|10:10|image|DataStructure.pm:retrieve_user_data(1353)|attempting
to retrieve and store data for user: user.id <http://user.id> = '1'
2011-03-08 14:40:09|20532|10:10|image|utils.pm:getnewdbh(2709)|database
requested (vcl) does not match handle stored in $ENV{dbh}
(information_schema:127.0.0.1)
2011-03-08 14:40:09|20532|10:10|image|utils.pm:getnewdbh(2760)|database
handle stored in $ENV{dbh}
2011-03-08
14:40:09|20532|10:10|image|DataStructure.pm:retrieve_user_data(1416)|data has
been retrieved for user: admin (id: 1)
2011-03-08 14:40:09|20532|10:10|image|utils.pm:mail(1268)|SUCCESS --
Sending mail To: tharde...@tylerhardesty.info
<mailto:tharde...@tylerhardesty.info>, PROBLEM -- 10:10|image|image.pm
<http://image.pm>|vm2>localvmhost|vmwarewinxp-win_xp14-v0|admin
|20532|10:10|image| ---- CRITICAL ----
|20532|10:10|image| 2011-03-08
14:40:09|20532|10:10|image|image.pm:reservation_failed(393)|vmwarewinxp-win_xp14-v0
image creation failed
|20532|10:10|image| ( 0) image.pm <http://image.pm>, reservation_failed
(line: 393)
|20532|10:10|image| (-1) image.pm <http://image.pm>, process (line: 170)
|20532|10:10|image| (-2) vcld, make_new_child (line: 568)
|20532|10:10|image| (-3) vcld, main (line: 346)
2011-03-08 14:40:09|20532|10:10|image|utils.pm:mail(1268)|SUCCESS --
Sending mail To: root@localhost, VCL -- NOTICE DELAY Image Creation win_xp
2011-03-08 14:40:09|20532|10:10|image|utils.pm:mail(1268)|SUCCESS --
Sending mail To: tharde...@tylerhardesty.info
<mailto:tharde...@tylerhardesty.info>, VCL -- NOTICE FAILED Image
Creation win_xp
2011-03-08
14:40:09|20532|10:10|image|utils.pm:update_request_state(1991)|request
10 state updated to: maintenance, laststate to: image
2011-03-08
14:40:09|20532|10:10|image|image.pm:reservation_failed(445)|request
state set to maintenance, laststate to image
2011-03-08
14:40:09|20532|10:10|image|utils.pm:update_computer_state(2033)|computer
3 state updated to: maintenance
2011-03-08
14:40:09|20532|10:10|image|image.pm:reservation_failed(453)|vm2 state
set to maintenance
2011-03-08
14:40:09|20532|10:10|image|image.pm:reservation_failed(460)|exiting
2011-03-08 14:40:09|20532|10:10|image|State.pm:DESTROY(839)|VCL::image
destructor called, address: 9a54b24
2011-03-08
14:40:09|20532|10:10|image|utils.pm:delete_computerloadlog_reservation(6726)|removing
computerloadlog entries matching loadstate = begin
2011-03-08
14:40:09|20532|10:10|image|utils.pm:delete_computerloadlog_reservation(6773)|deleted
rows from computerloadlog for reservation id=10
2011-03-08 14:40:09|20532|10:10|image|State.pm:DESTROY(858)|number of
database handles state process created: 3
2011-03-08 14:40:09|20532|10:10|image|State.pm:DESTROY(886)|VCL::image
process duration: 4 seconds
2011-03-08 14:40:09|13551|vcld:REAPER(718)|VCL process exited for
reservation 10, PID: 20532, signal: CHLD
2011-03-08 14:42:10|13551|vcld:main(167)|lastcheckin time updated for
management node 1: 2011-03-08 14:42:10


On Tue, Mar 8, 2011 at 2:00 PM, James O'Dell <jod...@fullerton.edu
<mailto:jod...@fullerton.edu>> wrote:

    -----BEGIN PGP SIGNED MESSAGE-----
    Hash: SHA1

    Hi,

    I've gone through and compared your ssh debug info with mine.

    It looks like your '/etc/ssh/ssh_config' is different than
    mine. I added the following to the end of the file when I built
    vcl:

     > IdentityFile /opt/vcl/etc/vcl/vcl.key
     > StrictHostKeyChecking no


    I think this reflects the problem. You get:
     > debug1: SSH2_MSG_SERVICE_ACCEPT received
     > debug2: key: /root/.ssh/identity ((nil))
     > debug2: key: /root/.ssh/id_rsa ((nil))
     > debug2: key: /root/.ssh/id_dsa ((nil))
     > debug1: Authentications that can continue:
    publickey,keyboard-interactive

    I get
     > debug1: SSH2_MSG_SERVICE_ACCEPT received
     > debug2: key: /opt/vcl/etc/vcl/vcl.key (0x2ad12fbccc30)
     > debug1: Authentications that can continue:
    publickey,keyboard-interactive


    Also, where you get
     > Warning: Permanently added '144.38.205.252' (RSA) to the list of
    known

    I get
     > debug1: Host 'vclvm010511' is known and matches the RSA host key.
     > debug1: Found key in /root/.ssh/known_hosts:856


    Here's where it really diverges. You have
     > debug1: Next authentication method: publickey
     > debug1: Trying private key: /root/.ssh/identity
     > debug3: no such identity: /root/.ssh/identity
     > debug1: Trying private key: /root/.ssh/id_rsa
     > debug3: no such identity: /root/.ssh/id_rsa
     > debug1: Trying private key: /root/.ssh/id_dsa
     > debug3: no such identity: /root/.ssh/id_dsa
     > debug2: we did not send a packet, disable method
     > debug3: authmethod_lookup keyboard-interactive
     > debug3: remaining preferred: password
     > debug3: authmethod_is_enabled keyboard-interactive
     > debug1: Next authentication method: keyboard-interactive
     > debug2: userauth_kbdint
     > debug2: we sent a keyboard-interactive packet, wait for reply
     > debug1: Authentications that can continue:
    publickey,keyboard-interactive
     > debug3: userauth_kbdint: disable: no info_req_seen
     > debug2: we did not send a packet, disable method
     > debug1: No more authentication methods to try.

    I have
     > debug1: Next authentication method: publickey
     > debug1: Offering public key: /opt/vcl/etc/vcl/vcl.key
     > debug3: send_pubkey_test
     > debug2: we sent a publickey packet, wait for reply
     > debug1: Server accepts key: pkalg ssh-rsa blen 149



    Hope this helps,

    __Jim

Reply via email to