Greetings,

I am new to VCL and having a problem configuring a Fedora 15 machine running Apache VCL 2.2.1. This VCL project is being tested as a pilot project for the University I work for. My testing environment is a Dell PowerEdge running Fedora 15 and a Dell PowerEdge R710 running VMware ESXI 4.1.0. I have created a Windows 7 32 bit virtual machine using an ESXI client machine. I completed installing Cygwin SSHD and I'm attempting to run the vcld -setup command. My problem occurs in this step while creating a base image. I am able to get through all of the prompts and start the creation before the script crashes with no image creation occurring. I have checked the '/var/log/vcld.log' log file and this is a portion of the output:

16:25:34|2772|4:4|image|OS.pm:is_ssh_responding(386)|6vsphere is NOT responding to SSH, ports 22 or 24 are both closed 2012-01-24 16:25:34|2772|4:4|image|VMware.pm:initialize(257)|unable to control OS of VM host 6vsphere using VCL::Module::OS::Windows::Version_6::7 OS object because VM host is not responding to SSH

I have checked and am able to ssh between the management node and the virtual machines. I am thinking that my problem may be with how the virtual machines are configured in the Database but I can't be sure.

Please see the log file attached for more information.

Thanks,
Aaron Bryant
2012-01-24 17:01:17|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:01:17
2012-01-24 17:01:22|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:01:22
2012-01-24 17:01:27|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:01:27
2012-01-24 17:01:32|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:01:32
2012-01-24 17:01:37|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:01:37
2012-01-24 17:01:42|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:01:42
2012-01-24 17:01:48|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:01:47
2012-01-24 17:01:50|4603|vcld:setup_management_node(815)|created DataStructure 
object to be used for vcld setup
2012-01-24 17:01:50|4603|vcld:setup_management_node(827)|checking if setup() 
subroutine has been implemented by 'provisioning_xcat_21' module
2012-01-24 17:01:50|4603|xCAT.pm:initialize(110)|XCATROOT environment variable 
is not set, using /opt/xcat

|4603| ---- WARNING ---- 
|4603| 2012-01-24 17:01:50|4603|xCAT.pm:initialize(119)|unable to initialize 
xCAT module, /opt/xcat directory does not exist
|4603| ( 0) xCAT.pm, initialize (line: 119)
|4603| (-1) xCAT.pm, (eval) (line: 3239)
|4603| (-2) (eval 86), (eval) (line: 2)
|4603| (-3) base.pm, import (line: 91)
|4603| (-4) xCAT21.pm, BEGIN (line: 47)
|4603| (-5) xCAT.pm, (eval) (line: 0)

2012-01-24 17:01:50|4603|xCAT21.pm:initialize(110)|XCATROOT environment 
variable is not set, using /opt/xcat

|4603| ---- WARNING ---- 
|4603| 2012-01-24 17:01:50|4603|xCAT21.pm:initialize(119)|unable to initialize 
xCAT module, /opt/xcat directory does not exist
|4603| ( 0) xCAT21.pm, initialize (line: 119)
|4603| (-1) xCAT21.pm, (eval) (line: 2204)
|4603| (-2) (eval 85), BEGIN (line: 2)
|4603| (-3) xCAT21.pm, (eval) (line: 0)
|4603| (-4) xCAT21.pm, (eval) (line: 0)
|4603| (-5) vcld, setup_management_node (line: 830)

2012-01-24 17:01:50|4603|vcld:setup_management_node(827)|checking if setup() 
subroutine has been implemented by 'provisioning_vmware' module
2012-01-24 17:01:50|4603|vcld:setup_management_node(827)|checking if setup() 
subroutine has been implemented by 'os_winvista' module
2012-01-24 17:01:50|4603|vcld:setup_management_node(827)|checking if setup() 
subroutine has been implemented by 'os_win7' module
2012-01-24 17:01:50|4603|vcld:setup_management_node(827)|checking if setup() 
subroutine has been implemented by 'provisioning_vmware_1x' module
2012-01-24 17:01:50|4603|vcld:setup_management_node(827)|checking if setup() 
subroutine has been implemented by 'state_image' module
2012-01-24 
17:01:50|4603|Module.pm:create_mn_os_object(361)|VCL::Module::OS::Linux::ManagementNode
 module loaded
2012-01-24 
17:01:50|4603|Module.pm:new(196)|VCL::Module::OS::Linux::ManagementNode object 
created for image <not set>, address: b1aa768
2012-01-24 
17:01:50|4603|Module.pm:create_mn_os_object(366)|VCL::Module::OS::Linux::ManagementNode
 OS object created, address: b1aa768
2012-01-24 17:01:50|4603|Module.pm:new(192)|VCL::image object created for state 
<not set>, address: a9301d8
2012-01-24 17:01:50|4603|vcld:setup_management_node(827)|checking if setup() 
subroutine has been implemented by 'provisioning_xcat_13' module
2012-01-24 17:01:50|4603|vcld:setup_management_node(827)|checking if setup() 
subroutine has been implemented by 'base_module' module
2012-01-24 17:01:50|4603|Module.pm:create_mn_os_object(335)|management node OS 
object has already been created, address: b1aa768, returning 1
2012-01-24 17:01:50|4603|Module.pm:new(203)|VCL::Module object created, 
address: b1aa9c8
2012-01-24 17:01:50|4603|vcld:setup_management_node(827)|checking if setup() 
subroutine has been implemented by 'os_win2008' module
2012-01-24 17:01:50|4603|vcld:setup_management_node(827)|checking if setup() 
subroutine has been implemented by 'os_win2003' module
2012-01-24 17:01:50|4603|vcld:setup_management_node(827)|checking if setup() 
subroutine has been implemented by 'os_esxi' module
2012-01-24 17:01:50|4603|vcld:setup_management_node(827)|checking if setup() 
subroutine has been implemented by 'os_unix' module
2012-01-24 17:01:50|4603|vcld:setup_management_node(827)|checking if setup() 
subroutine has been implemented by 'provisioning_lab' module
2012-01-24 17:01:50|4603|vcld:setup_management_node(827)|checking if setup() 
subroutine has been implemented by 'predictive_level_1' module
2012-01-24 17:01:50|4603|vcld:setup_management_node(827)|checking if setup() 
subroutine has been implemented by 'os_winxp' module
2012-01-24 17:01:50|4603|vcld:setup_management_node(827)|checking if setup() 
subroutine has been implemented by 'provisioning_xCAT_2x' module
2012-01-24 17:01:50|4603|xCAT2.pm:initialize(110)|XCATROOT environment variable 
is not set, using /opt/xcat

|4603| ---- WARNING ---- 
|4603| 2012-01-24 17:01:50|4603|xCAT2.pm:initialize(119)|unable to initialize 
xCAT module, /opt/xcat directory does not exist
|4603| ( 0) xCAT2.pm, initialize (line: 119)
|4603| (-1) xCAT2.pm, (eval) (line: 2178)
|4603| (-2) (eval 116), BEGIN (line: 2)
|4603| (-3) xCAT2.pm, (eval) (line: 0)
|4603| (-4) xCAT2.pm, (eval) (line: 0)
|4603| (-5) vcld, setup_management_node (line: 830)

2012-01-24 17:01:50|4603|vcld:setup_management_node(827)|checking if setup() 
subroutine has been implemented by 'os_linux_ubuntu' module
2012-01-24 17:01:50|4603|vcld:setup_management_node(827)|checking if setup() 
subroutine has been implemented by 'os_unix_lab' module
2012-01-24 17:01:50|4603|vcld:setup_management_node(827)|checking if setup() 
subroutine has been implemented by 'predictive_level_0' module
2012-01-24 17:01:50|4603|vcld:setup_management_node(827)|checking if setup() 
subroutine has been implemented by 'os_windows' module
2012-01-24 17:01:50|4603|Module.pm:create_mn_os_object(335)|management node OS 
object has already been created, address: b1aa768, returning 1
2012-01-24 17:01:50|4603|Module.pm:new(196)|VCL::Module::OS::Windows object 
created for image <not set>, address: b1aa808
2012-01-24 17:01:50|4603|vcld:setup_management_node(827)|checking if setup() 
subroutine has been implemented by 'provisioning_vbox' module
2012-01-24 17:01:50|4603|vcld:setup_management_node(827)|checking if setup() 
subroutine has been implemented by 'os_linux' module
2012-01-24 17:01:50|4603|utils.pm:setup_get_array_choice(9947)|choices argument:
|4603| VCL Base Module
|4603| VCL Image State Module
|4603| Windows OS Module
2012-01-24 17:01:53|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:01:53
2012-01-24 17:01:58|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:01:58
2012-01-24 17:02:03|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:02:03
2012-01-24 17:02:08|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:02:08
2012-01-24 17:02:13|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:02:13
2012-01-24 17:02:18|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:02:18
2012-01-24 17:02:23|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:02:23
2012-01-24 17:02:28|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:02:28
2012-01-24 17:02:33|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:02:33
2012-01-24 17:02:38|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:02:38
2012-01-24 17:02:43|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:02:43
2012-01-24 17:02:48|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:02:48
2012-01-24 17:02:53|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:02:53
2012-01-24 17:02:58|4603|utils.pm:setup_get_array_choice(9947)|choices argument:
|4603| Capture Base Image
2012-01-24 17:02:58|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:02:58
2012-01-24 
17:02:59|4603|utils.pm:get_management_node_id(8672)|management_node_id 
environment variable not set
2012-01-24 
17:02:59|4603|utils.pm:get_management_node_id(8678)|get_managementnode_info(): 1
2012-01-24 17:03:03|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:03:03
2012-01-24 17:03:08|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:03:08
2012-01-24 17:03:13|4603|utils.pm:get_computer_ids(8277)|found computers 
matching identifier: 192.168.0.106, IDs: 7
2012-01-24 17:03:13|4603|utils.pm:get_os_info(10153)|retrieved OS info:
|4603| : {
|4603| :   10 => {
|4603| :     "id" => 10,
|4603| :     "installtype" => "partimage",
|4603| :     "module" => {
|4603| :       "name" => "os_win2003",
|4603| :       "perlpackage" => "VCL::Module::OS::Windows::Version_5::2003",
|4603| :       "prettyname" => "Windows Server 2003 OS Module"
|4603| :     },
|4603| :     "moduleid" => 13,
|4603| :     "name" => "win2003",
|4603| :     "prettyname" => "Windows 2003 Server (Bare Metal)",
|4603| :     "sourcepath" => "image",
|4603| :     "type" => "windows"
|4603| :   },
|4603| :   11 => {
|4603| :     "id" => 11,
|4603| :     "installtype" => "partimage",
|4603| :     "module" => {
|4603| :       "name" => "os_linux",
|4603| :       "perlpackage" => "VCL::Module::OS::Linux",
|4603| :       "prettyname" => "Linux OS Module"
|4603| :     },
|4603| :     "moduleid" => 5,
|4603| :     "name" => "rh3image",
|4603| :     "prettyname" => "Red Hat Enterprise Linux 3 (Bare Metal)",
|4603| :     "sourcepath" => "image",
|4603| :     "type" => "linux"
|4603| :   },
|4603| :   12 => {
|4603| :     "id" => 12,
|4603| :     "installtype" => "kickstart",
|4603| :     "module" => {
|4603| :       "name" => "os_linux",
|4603| :       "perlpackage" => "VCL::Module::OS::Linux",
|4603| :       "prettyname" => "Linux OS Module"
|4603| :     },
|4603| :     "moduleid" => 5,
|4603| :     "name" => "rhel4",
|4603| :     "prettyname" => "Red Hat Enterprise Linux 4 (Kickstart)",
|4603| :     "sourcepath" => "rhas4",
|4603| :     "type" => "linux"
|4603| :   },
|4603| :   13 => {
|4603| :     "id" => 13,
|4603| :     "installtype" => "partimage",
|4603| :     "module" => {
|4603| :       "name" => "os_linux",
|4603| :       "perlpackage" => "VCL::Module::OS::Linux",
|4603| :       "prettyname" => "Linux OS Module"
|4603| :     },
|4603| :     "moduleid" => 5,
|4603| :     "name" => "rh4image",
|4603| :     "prettyname" => "Red Hat Enterprise Linux 4 (Bare Metal)",
|4603| :     "sourcepath" => "image",
|4603| :     "type" => "linux"
|4603| :   },
|4603| :   14 => {
|4603| :     "id" => 14,
|4603| :     "installtype" => "partimage",
|4603| :     "module" => {
|4603| :       "name" => "os_linux",
|4603| :       "perlpackage" => "VCL::Module::OS::Linux",
|4603| :       "prettyname" => "Linux OS Module"
|4603| :     },
|4603| :     "moduleid" => 5,
|4603| :     "name" => "fc5image",
|4603| :     "prettyname" => "Fedora Core 5 (Bare Metal)",
|4603| :     "sourcepath" => "image",
|4603| :     "type" => "linux"
|4603| :   },
|4603| :   15 => {
|4603| :     "id" => 15,
|4603| :     "installtype" => "kickstart",
|4603| :     "module" => {
|4603| :       "name" => "os_linux",
|4603| :       "perlpackage" => "VCL::Module::OS::Linux",
|4603| :       "prettyname" => "Linux OS Module"
|4603| :     },
|4603| :     "moduleid" => 5,
|4603| :     "name" => "rhfc5",
|4603| :     "prettyname" => "Fedora Core 5 (Kickstart)",
|4603| :     "sourcepath" => "rhfc5",
|4603| :     "type" => "linux"
|4603| :   },
|4603| :   16 => {
|4603| :     "id" => 16,
|4603| :     "installtype" => "vmware",
|4603| :     "module" => {
|4603| :       "name" => "os_winxp",
|4603| :       "perlpackage" => "VCL::Module::OS::Windows::Version_5::XP",
|4603| :       "prettyname" => "Windows XP OS Module"
|4603| :     },
|4603| :     "moduleid" => 12,
|4603| :     "name" => "vmwarewinxp",
|4603| :     "prettyname" => "Windows XP (VMware)",
|4603| :     "sourcepath" => "vmware_images",
|4603| :     "type" => "windows"
|4603| :   },
|4603| :   17 => {
|4603| :     "id" => 17,
|4603| :     "installtype" => "kickstart",
|4603| :     "module" => {
|4603| :       "name" => "os_linux",
|4603| :       "perlpackage" => "VCL::Module::OS::Linux",
|4603| :       "prettyname" => "Linux OS Module"
|4603| :     },
|4603| :     "moduleid" => 5,
|4603| :     "name" => "rhfc7",
|4603| :     "prettyname" => "Fedora Core 7 (Kickstart)",
|4603| :     "sourcepath" => "rhfc7",
|4603| :     "type" => "linux"
|4603| :   },
|4603| :   18 => {
|4603| :     "id" => 18,
|4603| :     "installtype" => "partimage",
|4603| :     "module" => {
|4603| :       "name" => "os_linux",
|4603| :       "perlpackage" => "VCL::Module::OS::Linux",
|4603| :       "prettyname" => "Linux OS Module"
|4603| :     },
|4603| :     "moduleid" => 5,
|4603| :     "name" => "fc7image",
|4603| :     "prettyname" => "Fedora Core 7 (Bare Metal)",
|4603| :     "sourcepath" => "image",
|4603| :     "type" => "linux"
|4603| :   },
|4603| :   19 => {
|4603| :     "id" => 19,
|4603| :     "installtype" => "kickstart",
|4603| :     "module" => {
|4603| :       "name" => "os_linux",
|4603| :       "perlpackage" => "VCL::Module::OS::Linux",
|4603| :       "prettyname" => "Linux OS Module"
|4603| :     },
|4603| :     "moduleid" => 5,
|4603| :     "name" => "rhel5",
|4603| :     "prettyname" => "Red Hat Enterprise Linux 5 (Kickstart)",
|4603| :     "sourcepath" => "rhas5",
|4603| :     "type" => "linux"
|4603| :   },
|4603| :   2 => {
|4603| :     "id" => 2,
|4603| :     "installtype" => "none",
|4603| :     "module" => {
|4603| :       "name" => "os_unix_lab",
|4603| :       "perlpackage" => "VCL::Module::OS::Linux::UnixLab",
|4603| :       "prettyname" => "Unix Lab OS Module"
|4603| :     },
|4603| :     "moduleid" => 15,
|4603| :     "name" => "sun4x_58",
|4603| :     "prettyname" => "Solaris 5.8 (Lab)",
|4603| :     "sourcepath" => undef,
|4603| :     "type" => "unix"
|4603| :   },
|4603| :   20 => {
|4603| :     "id" => 20,
|4603| :     "installtype" => "kickstart",
|4603| :     "module" => {
|4603| :       "name" => "os_linux",
|4603| :       "perlpackage" => "VCL::Module::OS::Linux",
|4603| :       "prettyname" => "Linux OS Module"
|4603| :     },
|4603| :     "moduleid" => 5,
|4603| :     "name" => "esx35",
|4603| :     "prettyname" => "VMware ESX 3.5 (Kickstart)",
|4603| :     "sourcepath" => "esx35",
|4603| :     "type" => "linux"
|4603| :   },
|4603| :   21 => {
|4603| :     "id" => 21,
|4603| :     "installtype" => "vmware",
|4603| :     "module" => {
|4603| :       "name" => "os_winxp",
|4603| :       "perlpackage" => "VCL::Module::OS::Windows::Version_5::XP",
|4603| :       "prettyname" => "Windows XP OS Module"
|4603| :     },
|4603| :     "moduleid" => 12,
|4603| :     "name" => "vmwareesxwinxp",
|4603| :     "prettyname" => "Windows XP (VMware ESX)",
|4603| :     "sourcepath" => "vmware_images",
|4603| :     "type" => "windows"
|4603| :   },
|4603| :   22 => {
|4603| :     "id" => 22,
|4603| :     "installtype" => "none",
|4603| :     "module" => {
|4603| :       "name" => "os_unix_lab",
|4603| :       "perlpackage" => "VCL::Module::OS::Linux::UnixLab",
|4603| :       "prettyname" => "Unix Lab OS Module"
|4603| :     },
|4603| :     "moduleid" => 15,
|4603| :     "name" => "realmrhel5",
|4603| :     "prettyname" => "Red Hat Enterprise Linux 5 (Lab)",
|4603| :     "sourcepath" => undef,
|4603| :     "type" => "linux"
|4603| :   },
|4603| :   23 => {
|4603| :     "id" => 23,
|4603| :     "installtype" => "none",
|4603| :     "module" => {
|4603| :       "name" => "os_unix_lab",
|4603| :       "perlpackage" => "VCL::Module::OS::Linux::UnixLab",
|4603| :       "prettyname" => "Unix Lab OS Module"
|4603| :     },
|4603| :     "moduleid" => 15,
|4603| :     "name" => "sun4x_510",
|4603| :     "prettyname" => "Solaris 10 (Lab)",
|4603| :     "sourcepath" => undef,
|4603| :     "type" => "unix"
|4603| :   },
|4603| :   24 => {
|4603| :     "id" => 24,
|4603| :     "installtype" => "kickstart",
|4603| :     "module" => {
|4603| :       "name" => "os_linux",
|4603| :       "perlpackage" => "VCL::Module::OS::Linux",
|4603| :       "prettyname" => "Linux OS Module"
|4603| :     },
|4603| :     "moduleid" => 5,
|4603| :     "name" => "centos5",
|4603| :     "prettyname" => "CentOS 5 (Kickstart)",
|4603| :     "sourcepath" => "centos5",
|4603| :     "type" => "linux"
|4603| :   },
|4603| :   25 => {
|4603| :     "id" => 25,
|4603| :     "installtype" => "partimage",
|4603| :     "module" => {
|4603| :       "name" => "os_linux",
|4603| :       "perlpackage" => "VCL::Module::OS::Linux",
|4603| :       "prettyname" => "Linux OS Module"
|4603| :     },
|4603| :     "moduleid" => 5,
|4603| :     "name" => "rh5image",
|4603| :     "prettyname" => "Red Hat Enterprise Linux 5 (Bare Metal)",
|4603| :     "sourcepath" => "image",
|4603| :     "type" => "linux"
|4603| :   },
|4603| :   26 => {
|4603| :     "id" => 26,
|4603| :     "installtype" => "kickstart",
|4603| :     "module" => {
|4603| :       "name" => "os_linux",
|4603| :       "perlpackage" => "VCL::Module::OS::Linux",
|4603| :       "prettyname" => "Linux OS Module"
|4603| :     },
|4603| :     "moduleid" => 5,
|4603| :     "name" => "rhfc9",
|4603| :     "prettyname" => "RedHat Fedora Core 9 (Kickstart)",
|4603| :     "sourcepath" => "rhfc9",
|4603| :     "type" => "linux"
|4603| :   },
|4603| :   27 => {
|4603| :     "id" => 27,
|4603| :     "installtype" => "partimage",
|4603| :     "module" => {
|4603| :       "name" => "os_linux",
|4603| :       "perlpackage" => "VCL::Module::OS::Linux",
|4603| :       "prettyname" => "Linux OS Module"
|4603| :     },
|4603| :     "moduleid" => 5,
|4603| :     "name" => "fc9image",
|4603| :     "prettyname" => "Red Hat Fedora Core 9 (Bare Metal)",
|4603| :     "sourcepath" => "image",
|4603| :     "type" => "linux"
|4603| :   },
|4603| :   28 => {
|4603| :     "id" => 28,
|4603| :     "installtype" => "partimage",
|4603| :     "module" => {
|4603| :       "name" => "os_winvista",
|4603| :       "perlpackage" => "VCL::Module::OS::Windows::Version_6::Vista",
|4603| :       "prettyname" => "Windows Vista OS Module"
|4603| :     },
|4603| :     "moduleid" => 7,
|4603| :     "name" => "winvista",
|4603| :     "prettyname" => "Windows Vista (Bare Metal)",
|4603| :     "sourcepath" => "image",
|4603| :     "type" => "windows"
|4603| :   },
|4603| :   29 => {
|4603| :     "id" => 29,
|4603| :     "installtype" => "partimage",
|4603| :     "module" => {
|4603| :       "name" => "os_linux",
|4603| :       "perlpackage" => "VCL::Module::OS::Linux",
|4603| :       "prettyname" => "Linux OS Module"
|4603| :     },
|4603| :     "moduleid" => 5,
|4603| :     "name" => "centos5image",
|4603| :     "prettyname" => "CentOS 5 (Bare Metal)",
|4603| :     "sourcepath" => "image",
|4603| :     "type" => "linux"
|4603| :   },
|4603| :   3 => {
|4603| :     "id" => 3,
|4603| :     "installtype" => "partimage",
|4603| :     "module" => {
|4603| :       "name" => "os_windows",
|4603| :       "perlpackage" => "VCL::Module::OS::Windows",
|4603| :       "prettyname" => "Windows OS Module"
|4603| :     },
|4603| :     "moduleid" => 4,
|4603| :     "name" => "win2k",
|4603| :     "prettyname" => "Windows 2000 (Bare Metal)",
|4603| :     "sourcepath" => "image",
|4603| :     "type" => "windows"
|4603| :   },
|4603| :   30 => {
|4603| :     "id" => 30,
|4603| :     "installtype" => "partimage",
|4603| :     "module" => {
|4603| :       "name" => "os_linux_ubuntu",
|4603| :       "perlpackage" => "VCL::Module::OS::Linux::Ubuntu",
|4603| :       "prettyname" => "Ubuntu Linux OS Module"
|4603| :     },
|4603| :     "moduleid" => 14,
|4603| :     "name" => "ubuntuimage",
|4603| :     "prettyname" => "Ubuntu (Bare Metal)",
|4603| :     "sourcepath" => "image",
|4603| :     "type" => "linux"
|4603| :   },
|4603| :   31 => {
|4603| :     "id" => 31,
|4603| :     "installtype" => "vmware",
|4603| :     "module" => {
|4603| :       "name" => "os_win2008",
|4603| :       "perlpackage" => "VCL::Module::OS::Windows::Version_6::2008",
|4603| :       "prettyname" => "Windows Server 2008 OS Module"
|4603| :     },
|4603| :     "moduleid" => 16,
|4603| :     "name" => "vmwarewin2008",
|4603| :     "prettyname" => "Windows Server 2008 (VMware)",
|4603| :     "sourcepath" => "vmware_images",
|4603| :     "type" => "windows"
|4603| :   },
|4603| :   32 => {
|4603| :     "id" => 32,
|4603| :     "installtype" => "partimage",
|4603| :     "module" => {
|4603| :       "name" => "os_win2008",
|4603| :       "perlpackage" => "VCL::Module::OS::Windows::Version_6::2008",
|4603| :       "prettyname" => "Windows Server 2008 OS Module"
|4603| :     },
|4603| :     "moduleid" => 16,
|4603| :     "name" => "win2008",
|4603| :     "prettyname" => "Windows Server 2008 (Bare Metal)",
|4603| :     "sourcepath" => "image",
|4603| :     "type" => "windows"
|4603| :   },
|4603| :   33 => {
|4603| :     "id" => 33,
|4603| :     "installtype" => "vmware",
|4603| :     "module" => {
|4603| :       "name" => "os_winvista",
|4603| :       "perlpackage" => "VCL::Module::OS::Windows::Version_6::Vista",
|4603| :       "prettyname" => "Windows Vista OS Module"
|4603| :     },
|4603| :     "moduleid" => 7,
|4603| :     "name" => "vmwarewinvista",
|4603| :     "prettyname" => "Windows Vista (VMware)",
|4603| :     "sourcepath" => "vmware_images",
|4603| :     "type" => "windows"
|4603| :   },
|4603| :   34 => {
|4603| :     "id" => 34,
|4603| :     "installtype" => "partimage",
|4603| :     "module" => {
|4603| :       "name" => "os_win7",
|4603| :       "perlpackage" => "VCL::Module::OS::Windows::Version_6::7",
|4603| :       "prettyname" => "Windows 7 OS Module"
|4603| :     },
|4603| :     "moduleid" => 17,
|4603| :     "name" => "win7",
|4603| :     "prettyname" => "Windows 7 (Bare Metal)",
|4603| :     "sourcepath" => "image",
|4603| :     "type" => "windows"
|4603| :   },
|4603| :   35 => {
|4603| :     "id" => 35,
|4603| :     "installtype" => "vmware",
|4603| :     "module" => {
|4603| :       "name" => "os_win7",
|4603| :       "perlpackage" => "VCL::Module::OS::Windows::Version_6::7",
|4603| :       "prettyname" => "Windows 7 OS Module"
|4603| :     },
|4603| :     "moduleid" => 17,
|4603| :     "name" => "vmwarewin7",
|4603| :     "prettyname" => "Windows 7 (VMware)",
|4603| :     "sourcepath" => "vmware_images",
|4603| :     "type" => "windows"
|4603| :   },
|4603| :   36 => {
|4603| :     "id" => 36,
|4603| :     "installtype" => "vmware",
|4603| :     "module" => {
|4603| :       "name" => "os_linux",
|4603| :       "perlpackage" => "VCL::Module::OS::Linux",
|4603| :       "prettyname" => "Linux OS Module"
|4603| :     },
|4603| :     "moduleid" => 5,
|4603| :     "name" => "vmwarelinux",
|4603| :     "prettyname" => "Generic Linux (VMware)",
|4603| :     "sourcepath" => "vmware_images",
|4603| :     "type" => "linux"
|4603| :   },
|4603| :   37 => {
|4603| :     "id" => 37,
|4603| :     "installtype" => "vmware",
|4603| :     "module" => {
|4603| :       "name" => "os_win2003",
|4603| :       "perlpackage" => "VCL::Module::OS::Windows::Version_5::2003",
|4603| :       "prettyname" => "Windows Server 2003 OS Module"
|4603| :     },
|4603| :     "moduleid" => 13,
|4603| :     "name" => "vmwarewin2003",
|4603| :     "prettyname" => "Windows 2003 Server (VMware)",
|4603| :     "sourcepath" => "vmware_images",
|4603| :     "type" => "windows"
|4603| :   },
|4603| :   38 => {
|4603| :     "id" => 38,
|4603| :     "installtype" => "kickstart",
|4603| :     "module" => {
|4603| :       "name" => "os_esxi",
|4603| :       "perlpackage" => "VCL::Module::OS::Linux::ESXi",
|4603| :       "prettyname" => "VMware ESXi OS Module"
|4603| :     },
|4603| :     "moduleid" => 25,
|4603| :     "name" => "esxi4.1",
|4603| :     "prettyname" => "VMware ESXi 4.1",
|4603| :     "sourcepath" => "esxi4.1",
|4603| :     "type" => "linux"
|4603| :   },
|4603| :   6 => {
|4603| :     "id" => 6,
|4603| :     "installtype" => "kickstart",
|4603| :     "module" => {
|4603| :       "name" => "os_linux",
|4603| :       "perlpackage" => "VCL::Module::OS::Linux",
|4603| :       "prettyname" => "Linux OS Module"
|4603| :     },
|4603| :     "moduleid" => 5,
|4603| :     "name" => "rhel3",
|4603| :     "prettyname" => "Red Hat Enterprise Linux 3 (Kickstart)",
|4603| :     "sourcepath" => "rhas3",
|4603| :     "type" => "linux"
|4603| :   },
|4603| :   7 => {
|4603| :     "id" => 7,
|4603| :     "installtype" => "partimage",
|4603| :     "module" => {
|4603| :       "name" => "os_winxp",
|4603| :       "perlpackage" => "VCL::Module::OS::Windows::Version_5::XP",
|4603| :       "prettyname" => "Windows XP OS Module"
|4603| :     },
|4603| :     "moduleid" => 12,
|4603| :     "name" => "winxp",
|4603| :     "prettyname" => "Windows XP (Bare Metal)",
|4603| :     "sourcepath" => "image",
|4603| :     "type" => "windows"
|4603| :   },
|4603| :   8 => {
|4603| :     "id" => 8,
|4603| :     "installtype" => "none",
|4603| :     "module" => {
|4603| :       "name" => "os_unix_lab",
|4603| :       "perlpackage" => "VCL::Module::OS::Linux::UnixLab",
|4603| :       "prettyname" => "Unix Lab OS Module"
|4603| :     },
|4603| :     "moduleid" => 15,
|4603| :     "name" => "realmrhel3",
|4603| :     "prettyname" => "Red Hat Enterprise Linux 3 (Lab)",
|4603| :     "sourcepath" => undef,
|4603| :     "type" => "linux"
|4603| :   },
|4603| :   9 => {
|4603| :     "id" => 9,
|4603| :     "installtype" => "none",
|4603| :     "module" => {
|4603| :       "name" => "os_unix_lab",
|4603| :       "perlpackage" => "VCL::Module::OS::Linux::UnixLab",
|4603| :       "prettyname" => "Unix Lab OS Module"
|4603| :     },
|4603| :     "moduleid" => 15,
|4603| :     "name" => "realmrhel4",
|4603| :     "prettyname" => "Red Hat Enterprise Linux 4 (Lab)",
|4603| :     "sourcepath" => undef,
|4603| :     "type" => "linux"
|4603| :   }
|4603| : }
2012-01-24 17:03:13|4603|utils.pm:setup_get_array_choice(9947)|choices argument:
|4603| Generic Linux (VMware)
|4603| Windows 2003 Server (VMware)
|4603| Windows 7 (VMware)
|4603| Windows Server 2008 (VMware)
|4603| Windows Vista (VMware)
|4603| Windows XP (VMware)
2012-01-24 17:03:13|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:03:13
2012-01-24 17:03:17|4603|utils.pm:setup_get_array_choice(9947)|choices argument:
|4603| x86
|4603| x86_64
2012-01-24 17:03:19|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:03:18
2012-01-24 17:03:19|4603|utils.pm:setup_get_array_choice(9947)|choices argument:
|4603| Yes
|4603| No
2012-01-24 17:03:24|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:03:24
2012-01-24 17:03:29|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:03:29
2012-01-24 17:03:29|4603|utils.pm:insert_request(8358)|inserted new reload 
request into request table, request id=5
2012-01-24 17:03:29|4603|utils.pm:insert_request(8389)|inserted new reload 
request into reservation table, reservation id=5
2012-01-24 17:03:34|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:03:34
2012-01-24 
17:03:34|28017|5:5|image|utils.pm:reservation_being_processed(8938)|computerloadlog
 'begin' entry does NOT exist for reservation 5
2012-01-24 17:03:34|28017|5:5|image|utils.pm:run_command(9010)|executed 
command: pgrep -fl 'vcld [0-9]+:5 ', pid: 4705, exit status: 1, output:
2012-01-24 
17:03:34|28017|5:5|image|utils.pm:is_management_node_process_running(9192)|process
 is NOT running, identifier: 'vcld [0-9]+:5 '
2012-01-24 
17:03:34|28017|5:5|image|utils.pm:reservation_being_processed(8959)|reservation 
is NOT currently being processed
2012-01-24 17:03:34|28017|5:5|image|vcld:main(278)|reservation 5 is NOT already 
being processed
2012-01-24 17:03:34|28017|5:5|image|utils.pm:get_request_info(4520)|standalone 
affiliation found: Local
2012-01-24 17:03:34|28017|5:5|image|vcld:main(283)|retrieved request 
information from database
2012-01-24 
17:03:34|28017|5:5|image|DataStructure.pm:is_parent_reservation(991)|returning 
true: parent reservation ID for this request: 5
2012-01-24 17:03:34|28017|5:5|image|utils.pm:update_request_state(1991)|request 
5 state updated to: pending, laststate to: image
2012-01-24 17:03:34|28017|5:5|image|utils.pm:insertloadlog(3875)|inserted 
computer=7, begin, beginning to process, state is image
2012-01-24 17:03:34|28017|5:5|image|vcld:make_new_child(515)|loaded VCL::image 
module
2012-01-24 17:03:34|28017|5:5|image|vcld:make_new_child(539)|current number of 
forked kids: 1
2012-01-24 17:03:34|4719|5:5|image|vcld:make_new_child(555)|vcld environment 
variable set to 0 for this process
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'test' key for 
VCL::image object from arguments
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'forimaging' key for 
VCL::image object from arguments
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'reservation' key for 
VCL::image object from arguments
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'userid' key for 
VCL::image object from arguments
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'daterequested' key 
for VCL::image object from arguments
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'RESERVATIONID' key 
for VCL::image object from arguments
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'UPDATED' key for 
VCL::image object from arguments
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'SUBIMAGE' key for 
VCL::image object from arguments
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'CHECKTIME' key for 
VCL::image object from arguments
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'state' key for 
VCL::image object from arguments
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'laststate' key for 
VCL::image object from arguments
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'PRELOADONLY' key for 
VCL::image object from arguments
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'laststateid' key for 
VCL::image object from arguments
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'user' key for 
VCL::image object from arguments
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'id' key for 
VCL::image object from arguments
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'PID' key for 
VCL::image object from arguments
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'DURATION' key for 
VCL::image object from arguments
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'PPID' key for 
VCL::image object from arguments
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'datemodified' key 
for VCL::image object from arguments
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'RESERVATIONCOUNT' 
key for VCL::image object from arguments
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'end' key for 
VCL::image object from arguments
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'stateid' key for 
VCL::image object from arguments
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'PARENTIMAGE' key for 
VCL::image object from arguments
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'checkuser' key for 
VCL::image object from arguments
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'preload' key for 
VCL::image object from arguments
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'NOTICEINTERVAL' key 
for VCL::image object from arguments
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'start' key for 
VCL::image object from arguments
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'logid' key for 
VCL::image object from arguments
2012-01-24 
17:03:34|4719|5:5|image|Module.pm:create_mn_os_object(361)|VCL::Module::OS::Linux::ManagementNode
 module loaded
2012-01-24 
17:03:34|4719|5:5|image|Module.pm:new(196)|VCL::Module::OS::Linux::ManagementNode
 object created for image <not set>, address: a67a820
2012-01-24 17:03:34|4719|5:5|image|DataStructure.pm:_automethod(834)|data 
structure updated: $self->request_data->{reservation}{0}{computer}{hostname}
|4719|5:5|image| computer_hostname = vcl-server.upb.pitt.edu
2012-01-24 17:03:34|4719|5:5|image|DataStructure.pm:_automethod(834)|data 
structure updated: $self->request_data->{reservation}{0}{computer}{NODENAME}
|4719|5:5|image| computer_node_name = vcl-server
2012-01-24 17:03:34|4719|5:5|image|DataStructure.pm:_automethod(834)|data 
structure updated: $self->request_data->{reservation}{0}{computer}{SHORTNAME}
|4719|5:5|image| computer_short_name = vcl-server
2012-01-24 17:03:34|4719|5:5|image|DataStructure.pm:_automethod(834)|data 
structure updated: $self->request_data->{reservation}{0}{computer}{IPaddress}
|4719|5:5|image| computer_ip_address = 192.168.0.2
2012-01-24 
17:03:34|4719|5:5|image|Module.pm:create_mn_os_object(366)|VCL::Module::OS::Linux::ManagementNode
 OS object created, address: a67a820
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(192)|VCL::image object created 
for state image, address: a47b598
2012-01-24 17:03:34|4719|5:5|image|State.pm:initialize(86)|obtained a database 
handle for this state process, stored as $ENV{dbh}
2012-01-24 17:03:34|4719|5:5|image|State.pm:check_image_os(762)|no corrections 
need to be made to image OS: vmwarewin7
2012-01-24 
17:03:34|4719|5:5|image|DataStructure.pm:is_parent_reservation(991)|returning 
true: parent reservation ID for this request: 5
2012-01-24 
17:03:34|4719|5:5|image|utils.pm:rename_vcld_process(7098)|reservation count: 1
2012-01-24 
17:03:34|4719|5:5|image|utils.pm:rename_vcld_process(7117)|PARENTIMAGE: 1
2012-01-24 17:03:34|4719|5:5|image|utils.pm:rename_vcld_process(7118)|SUBIMAGE: 0
2012-01-24 17:03:34|4719|5:5|image|utils.pm:rename_vcld_process(7136)|renamed 
process to 'vcld 5:5 image 6vsphere vmwarewin7-Windows7TEST10-v0 admin'
2012-01-24 
17:03:34|4719|5:5|image|DataStructure.pm:is_parent_reservation(991)|returning 
true: parent reservation ID for this request: 5
2012-01-24 
17:03:34|4719|5:5|image|DataStructure.pm:is_parent_reservation(991)|returning 
true: parent reservation ID for this request: 5
2012-01-24 
17:03:34|4719|5:5|image|Module.pm:create_os_object(298)|VCL::Module::OS::Windows::Version_6::7
 module loaded
2012-01-24 
17:03:34|4719|5:5|image|Module.pm:create_mn_os_object(335)|management node OS 
object has already been created, address: a67a820, returning 1
2012-01-24 
17:03:34|4719|5:5|image|Module.pm:new(196)|VCL::Module::OS::Windows::Version_6::7
 object created for image vmwarewin7-Windows7TEST10-v0, address: a67b240
2012-01-24 
17:03:34|4719|5:5|image|Module.pm:create_os_object(304)|VCL::Module::OS::Windows::Version_6::7
 OS object created for vmwarewin7-Windows7TEST10-v0, address: a67b240
2012-01-24 
17:03:34|4719|5:5|image|Module.pm:create_provisioning_object(420)|VCL::Module::Provisioning::VMware::VMware
 module loaded
2012-01-24 
17:03:34|4719|5:5|image|Module.pm:create_mn_os_object(335)|management node OS 
object has already been created, address: a67a820, returning 1
2012-01-24 
17:03:34|4719|5:5|image|Module.pm:new(200)|VCL::Module::Provisioning::VMware::VMware
 object created for computer 6vsphere, address: a96c950
2012-01-24 17:03:34|4719|5:5|image|VMware.pm:initialize(230)|initializing 
VCL::Module::Provisioning::VMware::VMware object

|4719|5:5|image| ---- WARNING ---- 
|4719|5:5|image| 2012-01-24 
17:03:34|4719|5:5|image|DataStructure.pm:_automethod(812)|corresponding data 
has not been initialized for get_vmhost_computer_id: 
$self->request_data->{reservation}{5}{computer}{vmhost}{computerid}
|4719|5:5|image| ( 0) DataStructure.pm, _automethod (line: 812)
|4719|5:5|image| (-1) Autoload.pm, __ANON__ (line: 80)
|4719|5:5|image| (-2) VMware.pm, get_vmhost_datastructure (line: 1161)
|4719|5:5|image| (-3) VMware.pm, initialize (line: 233)
|4719|5:5|image| (-4) Module.pm, new (line: 207)
|4719|5:5|image| (-5) Module.pm, create_provisioning_object (line: 423)


|4719|5:5|image| ---- WARNING ---- 
|4719|5:5|image| 2012-01-24 
17:03:34|4719|5:5|image|DataStructure.pm:_automethod(812)|corresponding data 
has not been initialized for get_vmhost_profile_image_id: 
$self->request_data->{reservation}{5}{computer}{vmhost}{vmprofile}{imageid}
|4719|5:5|image| ( 0) DataStructure.pm, _automethod (line: 812)
|4719|5:5|image| (-1) Autoload.pm, __ANON__ (line: 80)
|4719|5:5|image| (-2) VMware.pm, get_vmhost_datastructure (line: 1162)
|4719|5:5|image| (-3) VMware.pm, initialize (line: 233)
|4719|5:5|image| (-4) Module.pm, new (line: 207)
|4719|5:5|image| (-5) Module.pm, create_provisioning_object (line: 423)

2012-01-24 
17:03:34|4719|5:5|image|VMware.pm:get_vmhost_datastructure(1190)|created 
DataStructure object for VM host: 6vsphere
2012-01-24 17:03:34|4719|5:5|image|VMware.pm:initialize(249)|attempting to 
create OS object for the image currently loaded on the VM host: 6vsphere
|4719|5:5|image| image name: vmwarewin7-Windows7TEST10-v0
|4719|5:5|image| OS module: VCL::Module::OS::Windows::Version_6::7

|4719|5:5|image| ---- WARNING ---- 
|4719|5:5|image| 2012-01-24 
17:03:34|4719|5:5|image|DataStructure.pm:_automethod(812)|corresponding data 
has not been initialized for get_vmhost_computer_id: 
$self->request_data->{reservation}{5}{computer}{vmhost}{computerid}
|4719|5:5|image| ( 0) DataStructure.pm, _automethod (line: 812)
|4719|5:5|image| (-1) Autoload.pm, __ANON__ (line: 80)
|4719|5:5|image| (-2) VMware.pm, get_vmhost_datastructure (line: 1161)
|4719|5:5|image| (-3) VMware.pm, get_vmhost_os_object (line: 1219)
|4719|5:5|image| (-4) VMware.pm, initialize (line: 250)
|4719|5:5|image| (-5) Module.pm, new (line: 207)


|4719|5:5|image| ---- WARNING ---- 
|4719|5:5|image| 2012-01-24 
17:03:34|4719|5:5|image|DataStructure.pm:_automethod(812)|corresponding data 
has not been initialized for get_vmhost_profile_image_id: 
$self->request_data->{reservation}{5}{computer}{vmhost}{vmprofile}{imageid}
|4719|5:5|image| ( 0) DataStructure.pm, _automethod (line: 812)
|4719|5:5|image| (-1) Autoload.pm, __ANON__ (line: 80)
|4719|5:5|image| (-2) VMware.pm, get_vmhost_datastructure (line: 1162)
|4719|5:5|image| (-3) VMware.pm, get_vmhost_os_object (line: 1219)
|4719|5:5|image| (-4) VMware.pm, initialize (line: 250)
|4719|5:5|image| (-5) Module.pm, new (line: 207)

2012-01-24 
17:03:34|4719|5:5|image|VMware.pm:get_vmhost_datastructure(1190)|created 
DataStructure object for VM host: 6vsphere
2012-01-24 
17:03:34|4719|5:5|image|VMware.pm:get_vmhost_os_object(1232)|attempting to load 
VM host OS module: VCL::Module::OS::Windows::Version_6::7
2012-01-24 17:03:34|4719|5:5|image|VMware.pm:get_vmhost_os_object(1238)|VM host 
OS module loaded: VCL::Module::OS::Windows::Version_6::7
2012-01-24 
17:03:34|4719|5:5|image|Module.pm:create_mn_os_object(335)|management node OS 
object has already been created, address: a67a820, returning 1
2012-01-24 
17:03:34|4719|5:5|image|Module.pm:new(196)|VCL::Module::OS::Windows::Version_6::7
 object created for image vmwarewin7-Windows7TEST10-v0, address: ab568b0
2012-01-24 17:03:34|4719|5:5|image|VMware.pm:get_vmhost_os_object(1244)|VM host 
OS object created: VCL::Module::OS::Windows::Version_6::7

|4719|5:5|image| ---- WARNING ---- 
|4719|5:5|image| 2012-01-24 
17:03:34|4719|5:5|image|utils.pm:nmap_port(2645)|error occurred running nmap 
command: '/usr/bin/nmap 6vsphere -P0 -p 22 -T Aggressive', output:
|4719|5:5|image| Starting Nmap 5.50 ( http://nmap.org ) at 2012-01-24 17:03 EST
|4719|5:5|image| Failed to resolve given hostname/IP: 6vsphere.  Note that you 
can't use '/mask' AND '1-4,7,100-' style IP ranges
|4719|5:5|image| WARNING: No targets were specified, so 0 hosts scanned.
|4719|5:5|image| Nmap done: 0 IP addresses (0 hosts up) scanned in 0.03 seconds
|4719|5:5|image| ( 0) utils.pm, nmap_port (line: 2645)
|4719|5:5|image| (-1) OS.pm, is_ssh_responding (line: 383)
|4719|5:5|image| (-2) VMware.pm, initialize (line: 252)
|4719|5:5|image| (-3) Module.pm, new (line: 207)
|4719|5:5|image| (-4) Module.pm, create_provisioning_object (line: 423)
|4719|5:5|image| (-5) State.pm, initialize (line: 117)


|4719|5:5|image| ---- WARNING ---- 
|4719|5:5|image| 2012-01-24 
17:03:34|4719|5:5|image|utils.pm:nmap_port(2645)|error occurred running nmap 
command: '/usr/bin/nmap 6vsphere -P0 -p 24 -T Aggressive', output:
|4719|5:5|image| Starting Nmap 5.50 ( http://nmap.org ) at 2012-01-24 17:03 EST
|4719|5:5|image| Failed to resolve given hostname/IP: 6vsphere.  Note that you 
can't use '/mask' AND '1-4,7,100-' style IP ranges
|4719|5:5|image| WARNING: No targets were specified, so 0 hosts scanned.
|4719|5:5|image| Nmap done: 0 IP addresses (0 hosts up) scanned in 0.03 seconds
|4719|5:5|image| ( 0) utils.pm, nmap_port (line: 2645)
|4719|5:5|image| (-1) OS.pm, is_ssh_responding (line: 384)
|4719|5:5|image| (-2) VMware.pm, initialize (line: 252)
|4719|5:5|image| (-3) Module.pm, new (line: 207)
|4719|5:5|image| (-4) Module.pm, create_provisioning_object (line: 423)
|4719|5:5|image| (-5) State.pm, initialize (line: 117)

2012-01-24 17:03:34|4719|5:5|image|OS.pm:is_ssh_responding(386)|6vsphere is NOT 
responding to SSH, ports 22 or 24 are both closed
2012-01-24 17:03:34|4719|5:5|image|VMware.pm:initialize(257)|unable to control 
OS of VM host 6vsphere using VCL::Module::OS::Windows::Version_6::7 OS object 
because VM host is not responding to SSH

|4719|5:5|image| ---- WARNING ---- 
|4719|5:5|image| 2012-01-24 
17:03:34|4719|5:5|image|DataStructure.pm:_automethod(812)|corresponding data 
has not been initialized for get_vmhost_computer_id: 
$self->request_data->{reservation}{5}{computer}{vmhost}{computerid}
|4719|5:5|image| ( 0) DataStructure.pm, _automethod (line: 812)
|4719|5:5|image| (-1) Autoload.pm, __ANON__ (line: 80)
|4719|5:5|image| (-2) VMware.pm, get_vmhost_datastructure (line: 1161)
|4719|5:5|image| (-3) VMware.pm, get_vmhost_api_object (line: 1282)
|4719|5:5|image| (-4) VMware.pm, initialize (line: 265)
|4719|5:5|image| (-5) Module.pm, new (line: 207)


|4719|5:5|image| ---- WARNING ---- 
|4719|5:5|image| 2012-01-24 
17:03:34|4719|5:5|image|DataStructure.pm:_automethod(812)|corresponding data 
has not been initialized for get_vmhost_profile_image_id: 
$self->request_data->{reservation}{5}{computer}{vmhost}{vmprofile}{imageid}
|4719|5:5|image| ( 0) DataStructure.pm, _automethod (line: 812)
|4719|5:5|image| (-1) Autoload.pm, __ANON__ (line: 80)
|4719|5:5|image| (-2) VMware.pm, get_vmhost_datastructure (line: 1162)
|4719|5:5|image| (-3) VMware.pm, get_vmhost_api_object (line: 1282)
|4719|5:5|image| (-4) VMware.pm, initialize (line: 265)
|4719|5:5|image| (-5) Module.pm, new (line: 207)

2012-01-24 
17:03:34|4719|5:5|image|VMware.pm:get_vmhost_datastructure(1190)|created 
DataStructure object for VM host: 6vsphere
2012-01-24 
17:03:34|4719|5:5|image|VMware.pm:get_vmhost_api_object(1293)|attempting to 
load VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
2012-01-24 17:03:34|4719|5:5|image|VMware.pm:get_vmhost_api_object(1299)|loaded 
VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'vmhost_data' key for 
VCL::Module::Provisioning::VMware::vSphere_SDK object from arguments
2012-01-24 17:03:34|4719|5:5|image|Module.pm:new(172)|set 'vmhost_os' key for 
VCL::Module::Provisioning::VMware::vSphere_SDK object from arguments
2012-01-24 
17:03:34|4719|5:5|image|Module.pm:create_mn_os_object(335)|management node OS 
object has already been created, address: a67a820, returning 1
2012-01-24 
17:03:34|4719|5:5|image|Module.pm:new(200)|VCL::Module::Provisioning::VMware::vSphere_SDK
 object created for computer 6vsphere, address: ab6c800
2012-01-24 17:03:34|4719|5:5|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
2012-01-24 17:03:34|4719|5:5|image|VMware.pm:get_vmhost_api_object(1313)|API 
object could not be created: VCL::Module::Provisioning::VMware::vSphere_SDK

|4719|5:5|image| ---- WARNING ---- 
|4719|5:5|image| 2012-01-24 
17:03:34|4719|5:5|image|VMware.pm:initialize(273)|no methods are available to 
control VM host 6vsphere, the vSphere SDK cannot be used to control the VM host 
and the host OS cannot be controlled via SSH
|4719|5:5|image| ( 0) VMware.pm, initialize (line: 273)
|4719|5:5|image| (-1) Module.pm, new (line: 207)
|4719|5:5|image| (-2) Module.pm, create_provisioning_object (line: 423)
|4719|5:5|image| (-3) State.pm, initialize (line: 117)
|4719|5:5|image| (-4) Module.pm, new (line: 207)
|4719|5:5|image| (-5) vcld, make_new_child (line: 564)


|4719|5:5|image| ---- WARNING ---- 
|4719|5:5|image| 2012-01-24 
17:03:34|4719|5:5|image|Module.pm:create_provisioning_object(431)|provisioning 
object could not be created, returning 0
|4719|5:5|image| ( 0) Module.pm, create_provisioning_object (line: 431)
|4719|5:5|image| (-1) State.pm, initialize (line: 117)
|4719|5:5|image| (-2) Module.pm, new (line: 207)
|4719|5:5|image| (-3) vcld, make_new_child (line: 564)
|4719|5:5|image| (-4) vcld, main (line: 346)


|4719|5:5|image| ---- WARNING ---- 
|4719|5:5|image| 2012-01-24 
17:03:34|4719|5:5|image|State.pm:initialize(118)|failed to create provisioning 
object
|4719|5:5|image| ( 0) State.pm, initialize (line: 118)
|4719|5:5|image| (-1) Module.pm, new (line: 207)
|4719|5:5|image| (-2) vcld, make_new_child (line: 564)
|4719|5:5|image| (-3) vcld, main (line: 346)

2012-01-24 17:03:34|4719|5:5|image|State.pm:DESTROY(829)|VCL::image destructor 
called, address: a47b598
2012-01-24 
17:03:34|4719|5:5|image|utils.pm:delete_computerloadlog_reservation(6742)|removing
 computerloadlog entries matching loadstate = begin
2012-01-24 
17:03:34|4719|5:5|image|utils.pm:delete_computerloadlog_reservation(6789)|deleted
 rows from computerloadlog for reservation id=5
2012-01-24 17:03:34|4719|5:5|image|State.pm:DESTROY(848)|number of database 
handles state process created: 1
2012-01-24 17:03:34|4719|5:5|image|State.pm:DESTROY(876)|VCL::image process 
duration: 0 seconds
2012-01-24 
17:03:34|4719|5:5|image|DataStructure.pm:get_computer_private_ip_address(1581)|attempting
 to retrieve private IP address for computer: 6vsphere
2012-01-24 17:03:34|4719|5:5|image|utils.pm:run_command(8998)|$? is set to -1, 
setting exit status to 0, Perl bug likely encountered
2012-01-24 
17:03:34|4719|5:5|image|DataStructure.pm:get_computer_private_ip_address(1585)|retrieved
 contents of /etc/hosts on this management node, contains 2 lines
2012-01-24 
17:03:34|4719|5:5|image|DataStructure.pm:get_computer_private_ip_address(1624)|did
 not find any lines in /etc/hosts containing '6vsphere', returning private IP 
address defined in the database: 192.168.0.106
2012-01-24 17:03:34|4719|5:5|image|utils.pm:getnewdbh(2703)|unable to use 
database handle stored in $ENV{dbh}
2012-01-24 17:03:34|4719|5:5|image|utils.pm:getnewdbh(2760)|database handle 
stored in $ENV{dbh}
2012-01-24 17:03:34|4719|5:5|image|utils.pm:is_inblockrequest(6163)|zero rows 
were returned from database select
2012-01-24 
17:03:34|4719|5:5|image|DataStructure.pm:get_image_affiliation_name(2035)|image 
owner id: 1
2012-01-24 17:03:34|4719|5:5|image|utils.pm:getnewdbh(2709)|database requested 
(information_schema) does not match handle stored in $ENV{dbh} (vcl:192.168.0.2)
2012-01-24 17:03:34|4719|5:5|image|utils.pm:getnewdbh(2760)|database handle 
stored in $ENV{dbh}
2012-01-24 
17:03:34|4719|5:5|image|DataStructure.pm:retrieve_user_data(1352)|attempting to 
retrieve and store data for user: user.id = '1'
2012-01-24 17:03:34|4719|5:5|image|utils.pm:getnewdbh(2709)|database requested 
(vcl) does not match handle stored in $ENV{dbh} (information_schema:192.168.0.2)
2012-01-24 17:03:34|4719|5:5|image|utils.pm:getnewdbh(2760)|database handle 
stored in $ENV{dbh}
2012-01-24 
17:03:34|4719|5:5|image|DataStructure.pm:retrieve_user_data(1415)|data has been 
retrieved for user: admin (id: 1)
2012-01-24 17:03:35|4719|5:5|image|utils.pm:mail(1268)|SUCCESS -- Sending mail 
To: amb...@pitt.edu, PROBLEM -- 
5:5|image|vcld|6vsphere|vmwarewin7-Windows7TEST10-v0|admin

|4719|5:5|image| ---- CRITICAL ---- 
|4719|5:5|image| 2012-01-24 
17:03:34|4719|5:5|image|vcld:make_new_child(571)|VCL::image object could not be 
created and initialized
|4719|5:5|image| ( 0) vcld, make_new_child (line: 571)
|4719|5:5|image| (-1) vcld, main (line: 346)

2012-01-24 17:03:35|4719|5:5|image|utils.pm:switch_state(7253)|called from 
VCL::vcld::make_new_child(572)
2012-01-24 17:03:35|4719|5:5|image|utils.pm:switch_state(7289)|parent: parent 
reservation ID for this request: 5
2012-01-24 17:03:35|4719|5:5|image|utils.pm:insertloadlog(3875)|inserted 
computer=7, info, VCL::vcld: switching request state to failed
2012-01-24 17:03:35|4719|5:5|image|utils.pm:update_request_state(1991)|request 
5 state updated to: failed, laststate to: image
2012-01-24 17:03:35|4719|5:5|image|utils.pm:switch_state(7313)|req=5: request 
state changed: image->failed, laststate: image->image
2012-01-24 17:03:35|4719|5:5|image|utils.pm:insertloadlog(3875)|inserted 
computer=7, info, VCL::vcld: request state changed to failed, laststate to image
2012-01-24 17:03:35|4719|5:5|image|utils.pm:switch_state(7323)|req=5: computer 
state not specified, 6vsphere state not changed
2012-01-24 17:03:35|4719|5:5|image|utils.pm:switch_state(7341)|req=5: log table 
id=0, ending set to failed
2012-01-24 17:03:35|4719|5:5|image|utils.pm:insertloadlog(3875)|inserted 
computer=7, info, VCL::vcld: process exiting
2012-01-24 17:03:35|4719|5:5|image|utils.pm:switch_state(7357)|req=5: process 
exiting
2012-01-24 17:03:35|28017|vcld:REAPER(718)|VCL process exited for reservation 
5, PID: 4719, signal: CHLD
2012-01-24 17:03:35|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:03:35
2012-01-24 17:03:35|28017|5:5|failed|vcld:main(252)|request deleted
2012-01-24 17:03:40|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:03:40
2012-01-24 17:03:45|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:03:45
2012-01-24 17:03:50|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:03:50
2012-01-24 17:03:55|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:03:55
2012-01-24 17:04:00|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:04:00
2012-01-24 17:04:05|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:04:05
2012-01-24 17:04:10|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:04:10
2012-01-24 17:04:15|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:04:15
2012-01-24 17:04:20|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:04:20
2012-01-24 17:04:25|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:04:25
2012-01-24 17:04:30|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:04:30
2012-01-24 17:04:35|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:04:35
2012-01-24 17:04:40|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:04:40
2012-01-24 17:04:46|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:04:45
2012-01-24 17:04:51|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:04:51
2012-01-24 17:04:56|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:04:56
2012-01-24 17:05:01|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:05:01
2012-01-24 17:05:06|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:05:06
2012-01-24 17:05:11|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:05:11
2012-01-24 17:05:16|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:05:16
2012-01-24 17:05:21|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:05:21
2012-01-24 17:05:26|28017|vcld:main(167)|lastcheckin time updated for 
management node 1: 2012-01-24 17:05:26

Reply via email to