Hello, I am installing VCL (Standalone system). When trying to create the Base image, it throws up a few errors and also pops up an OpenSSH box and asks me to put the password for 'vcluser'. Could anyone help with this?
2011-04-23 01:56:00|14840|utils.pm:insert_request(8443)|inserted new reload request into request table, request id=13 2011-04-23 01:56:00|14840|utils.pm:insert_request(8474)|inserted new reload request into reservation table, reservation id=13 2011-04-23 01:56:01|5088|13:13|image|utils.pm:reservation_being_processed(9010)|computerloadlog 'begin' entry does NOT exist for reservation 13 2011-04-23 01:56:01|5088|13:13|image|utils.pm:run_command(9082)|executed command: pgrep -fl 'vcld [0-9]+:13 ', pid: 14929, exit status: 1, output: 2011-04-23 01:56:01|5088|13:13|image|utils.pm:is_management_node_process_running(9259)|process is NOT running, identifier: 'vcld [0-9]+:13 ' 2011-04-23 01:56:01|5088|13:13|image|utils.pm:reservation_being_processed(9031)|reservation is NOT currently being processed 2011-04-23 01:56:01|5088|13:13|image|vcld:main(277)|reservation 13 is NOT already being processed 2011-04-23 01:56:01|5088|13:13|image|utils.pm:get_request_info(4589)|standalone affiliation found: Local 2011-04-23 01:56:01|5088|13:13|image|vcld:main(282)|retrieved request information from database 2011-04-23 01:56:01|5088|13:13|image|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 13 2011-04-23 01:56:01|5088|13:13|image|utils.pm:update_request_state(2049)|request 13 state updated to: pending, laststate to: image 2011-04-23 01:56:01|5088|13:13|image|utils.pm:insertloadlog(3933)|inserted computer=6, begin, beginning to process, state is image 2011-04-23 01:56:01|5088|13:13|image|vcld:make_new_child(510)|loaded VCL::image module 2011-04-23 01:56:01|5088|13:13|image|vcld:make_new_child(567)|current number of forked kids: 1 2011-04-23 01:56:01|14944|13:13|image|vcld:make_new_child(583)|vcld environment variable set to 0 for this process 2011-04-23 01:56:01|14944|13:13|image|Module.pm:new(134)|constructor called, class=VCL::image 2011-04-23 01:56:01|14944|13:13|image|Module.pm:new(156)|VCL::image object created 2011-04-23 01:56:01|14944|13:13|image|State.pm:initialize(85)|obtained a database handle for this state process, stored as $ENV{dbh} 2011-04-23 01:56:01|14944|13:13|image|State.pm:check_image_os(836)|no corrections need to be made to image OS: vmwarelinux 2011-04-23 01:56:01|14944|13:13|image|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 13 2011-04-23 01:56:01|14944|13:13|image|utils.pm:rename_vcld_process(7183)|reservation count: 1 2011-04-23 01:56:01|14944|13:13|image|utils.pm:rename_vcld_process(7202)|PARENTIMAGE: 1 2011-04-23 01:56:01|14944|13:13|image|utils.pm:rename_vcld_process(7203)|SUBIMAGE: 0 2011-04-23 01:56:01|14944|13:13|image|utils.pm:rename_vcld_process(7221)|renamed process to 'vcld 13:13 image vmguest-1 vmwarelinux-1524-v0 admin' 2011-04-23 01:56:01|14944|13:13|image|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 13 2011-04-23 01:56:01|14944|13:13|image|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 13 2011-04-23 01:56:01|14944|13:13|image|State.pm:initialize(118)|attempting to load provisioning module: VCL::Module::Provisioning::VMware::VMware 2011-04-23 01:56:02|14944|13:13|image|State.pm:initialize(124)|VCL::Module::Provisioning::VMware::VMware module loaded 2011-04-23 01:56:02|14944|13:13|image|Module.pm:new(134)|constructor called, class=VCL::Module::Provisioning::VMware::VMware 2011-04-23 01:56:02|14944|13:13|image|Module.pm:new(156)|VCL::Module::Provisioning::VMware::VMware object created 2011-04-23 01:56:02|14944|13:13|image|DataStructure.pm:_initialize(594)|computer ID argument was specified, retrieving data for computer ID: 4 2011-04-23 01:56:02|14944|13:13|image|VMware.pm:get_vmhost_datastructure(923)|created DataStructure object for VM host: localvmhost 2011-04-23 01:56:02|14944|13:13|image|DataStructure.pm:_initialize(594)|computer ID argument was specified, retrieving data for computer ID: 4 2011-04-23 01:56:02|14944|13:13|image|VMware.pm:get_vmhost_datastructure(923)|created DataStructure object for VM host: localvmhost 2011-04-23 01:56:02|14944|13:13|image|VMware.pm:get_vmhost_api_object(1027)|attempting to load VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK 2011-04-23 01:56:04|14944|13:13|image|VMware.pm:get_vmhost_api_object(1033)|loaded VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK 2011-04-23 01:56:04|14944|13:13|image|Module.pm:new(134)|constructor called, class=VCL::Module::Provisioning::VMware::vSphere_SDK 2011-04-23 01:56:04|14944|13:13|image|Module.pm:new(156)|VCL::Module::Provisioning::VMware::vSphere_SDK object created 2011-04-23 01:56:04|14944|13:13|image|vSphere_SDK.pm:initialize(1816)|attempting to connect to VM host: https://localvmhost/sdk 2011-04-23 01:56:04|14944|13:13|image|vSphere_SDK.pm:initialize(1822)|unable to connect to VM host: https://localvmhost/sdk, username: 'vcluser', error: |14944|13:13|image| Can't locate HTTP/Config.pm in @INC (@INC contains: /usr/local/vcl/bin/../../../.. /usr/local/vcl/bin/../.. /usr/local/vcl/bin/.. /usr/local/vcl/bin/../lib /usr/lib64/perl5/site_perl/5.8.8/x86_64-linux-thread-multi /usr/lib/perl5/site_perl/5.8.8 /usr/lib/perl5/site_perl/5.8.5 /usr/lib/perl5/site_perl /usr/lib64/perl5/vendor_perl/5.8.8/x86_64-linux-thread-multi /usr/lib/perl5/vendor_perl/5.8.8 /usr/lib/perl5/vendor_perl /usr/lib64/perl5/5.8.8/x86_64-linux-thread-multi /usr/lib/perl5/5.8.8 .) at /usr/lib/perl5/site_perl/5.8.8/LWP/UserAgent.pm line 746. 2011-04-23 01:56:04|14944|13:13|image|vSphere_SDK.pm:initialize(1816)|attempting to connect to VM host: https://localvmhost:8333/sdk 2011-04-23 01:56:04|14944|13:13|image|vSphere_SDK.pm:initialize(1822)|unable to connect to VM host: https://localvmhost:8333/sdk, username: 'vcluser', error: |14944|13:13|image| Can't locate HTTP/Config.pm in @INC (@INC contains: /usr/local/vcl/bin/../../../.. /usr/local/vcl/bin/../.. /usr/local/vcl/bin/.. /usr/local/vcl/bin/../lib /usr/lib64/perl5/site_perl/5.8.8/x86_64-linux-thread-multi /usr/lib/perl5/site_perl/5.8.8 /usr/lib/perl5/site_perl/5.8.5 /usr/lib/perl5/site_perl /usr/lib64/perl5/vendor_perl/5.8.8/x86_64-linux-thread-multi /usr/lib/perl5/vendor_perl/5.8.8 /usr/lib/perl5/vendor_perl /usr/lib64/perl5/5.8.8/x86_64-linux-thread-multi /usr/lib/perl5/5.8.8 .) at /usr/lib/perl5/site_perl/5.8.8/LWP/UserAgent.pm line 746. |14944|13:13|image| ---- WARNING ---- |14944|13:13|image| 2011-04-23 01:56:04|14944|13:13|image|vSphere_SDK.pm:initialize(1831)|failed to connect to VM host: localvmhost |14944|13:13|image| ( 0) utils.pm, notify (line: 630) |14944|13:13|image| (-1) vSphere_SDK.pm, initialize (line: 1831) |14944|13:13|image| (-2) Module.pm, new (line: 159) |14944|13:13|image| (-3) VMware.pm, (eval) (line: 1037) |14944|13:13|image| (-4) VMware.pm, get_vmhost_api_object (line: 1037) |14944|13:13|image| (-5) VMware.pm, initialize (line: 224) |14944|13:13|image| (-6) Module.pm, new (line: 159) |14944|13:13|image| ---- WARNING ---- |14944|13:13|image| 2011-04-23 01:56:04|14944|13:13|image|VMware.pm:get_vmhost_api_object(1040)|API object could not be created: VCL::Module::Provisioning::VMware::vSphere_SDK, no eval error |14944|13:13|image| ( 0) utils.pm, notify (line: 630) |14944|13:13|image| (-1) VMware.pm, get_vmhost_api_object (line: 1040) |14944|13:13|image| (-2) VMware.pm, initialize (line: 224) |14944|13:13|image| (-3) Module.pm, new (line: 159) |14944|13:13|image| (-4) State.pm, initialize (line: 127) |14944|13:13|image| (-5) Module.pm, new (line: 159) |14944|13:13|image| (-6) vcld, make_new_child (line: 591) 2011-04-23 01:56:04|14944|13:13|image|VMware.pm:initialize(240)|attempting to create OS object for the image currently loaded on the VM host: localvmhost |14944|13:13|image| image name: noimage |14944|13:13|image| OS module: VCL::Module::OS::Linux::UnixLab 2011-04-23 01:56:04|14944|13:13|image|DataStructure.pm:_initialize(594)|computer ID argument was specified, retrieving data for computer ID: 4 2011-04-23 01:56:04|14944|13:13|image|VMware.pm:get_vmhost_datastructure(923)|created DataStructure object for VM host: localvmhost 2011-04-23 01:56:04|14944|13:13|image|VMware.pm:get_vmhost_os_object(965)|attempting to load VM host OS module: VCL::Module::OS::Linux::UnixLab 2011-04-23 01:56:05|14944|13:13|image|VMware.pm:get_vmhost_os_object(971)|VM host OS module loaded: VCL::Module::OS::Linux::UnixLab 2011-04-23 01:56:05|14944|13:13|image|Module.pm:new(134)|constructor called, class=VCL::Module::OS::Linux::UnixLab 2011-04-23 01:56:05|14944|13:13|image|Module.pm:new(156)|VCL::Module::OS::Linux::UnixLab object created 2011-04-23 01:56:05|14944|13:13|image|VMware.pm:get_vmhost_os_object(977)|VM host OS object created: VCL::Module::OS::Linux::UnixLab 2011-04-23 01:56:05|14944|13:13|image|VMware.pm:initialize(241)|created OS object to control the OS of VM host: localvmhost 2011-04-23 01:56:05|14944|13:13|image|utils.pm:nmap_port(2699)|port 22 is open on localvmhost 2011-04-23 01:56:05|14944|13:13|image|utils.pm:nmap_port(2707)|port 24 is closed on localvmhost 2011-04-23 01:56:13|14944|13:13|image|OS.pm:is_ssh_responding(430)|localvmhost is responding to SSH, port 22: open, port 24: closed 2011-04-23 01:56:13|14944|13:13|image|VMware.pm:initialize(250)|OS of VM host localvmhost will be controlled via SSH using OS object: VCL::Module::OS::Linux::UnixLab 2011-04-23 01:56:13|14944|13:13|image|DataStructure.pm:_initialize(594)|computer ID argument was specified, retrieving data for computer ID: 4 2011-04-23 01:56:13|14944|13:13|image|VMware.pm:get_vmhost_datastructure(923)|created DataStructure object for VM host: localvmhost 2011-04-23 01:56:13|14944|13:13|image|VMware.pm:get_vmhost_api_object(1027)|attempting to load VMware control module: VCL::Module::Provisioning::VMware::VIM_SSH 2011-04-23 01:56:13|14944|13:13|image|VMware.pm:get_vmhost_api_object(1033)|loaded VMware control module: VCL::Module::Provisioning::VMware::VIM_SSH 2011-04-23 01:56:13|14944|13:13|image|Module.pm:new(134)|constructor called, class=VCL::Module::Provisioning::VMware::VIM_SSH 2011-04-23 01:56:13|14944|13:13|image|Module.pm:new(156)|VCL::Module::Provisioning::VMware::VIM_SSH object created 2011-04-23 01:56:28|14944|13:13|image|VIM_SSH.pm:initialize(141)|VIM executable available on VM host: vmware-vim-cmd 2011-04-23 01:56:28|14944|13:13|image|VIM_SSH.pm:initialize(143)|VCL::Module::Provisioning::VMware::VIM_SSH object initialized 2011-04-23 01:56:28|14944|13:13|image|VMware.pm:get_vmhost_api_object(1046)|created API object: VCL::Module::Provisioning::VMware::VIM_SSH 2011-04-23 01:56:28|14944|13:13|image|VMware.pm:initialize(264)|VIM SSH command object will be used to control the VM: vmguest-1 2011-04-23 01:56:41|14944|13:13|image|VMware.pm:get_vmhost_product_name(4089)|VMware product being used on VM host localvmhost: 'VMware Server 2.0.2 build-203138' 2011-04-23 01:56:48|14944|13:13|image|VMware.pm:initialize(294)|VMware provisioning object initialized: |14944|13:13|image| VM host OS object type: VCL::Module::OS::Linux::UnixLab |14944|13:13|image| API object type: VCL::Module::Provisioning::VMware::VIM_SSH 2011-04-23 01:56:48|14944|13:13|image|State.pm:initialize(128)|VCL::Module::Provisioning::VMware::VMware provisioner object created 2011-04-23 01:56:48|14944|13:13|image|State.pm:initialize(142)|attempting to load OS module: VCL::Module::OS::Linux 2011-04-23 01:56:48|14944|13:13|image|State.pm:initialize(148)|VCL::Module::OS::Linux module loaded 2011-04-23 01:56:48|14944|13:13|image|Module.pm:new(134)|constructor called, class=VCL::Module::OS::Linux 2011-04-23 01:56:48|14944|13:13|image|Module.pm:new(156)|VCL::Module::OS::Linux object created 2011-04-23 01:56:48|14944|13:13|image|State.pm:initialize(151)|VCL::Module::OS::Linux OS object created 2011-04-23 01:56:48|14944|13:13|image|State.pm:initialize(166)|returning 1 2011-04-23 01:56:48|14944|13:13|image|vcld:make_new_child(592)|VCL::image object created and initialized 2011-04-23 01:56:50|14944|13:13|image|utils.pm:mail(1234)|SUCCESS -- Sending mail To: vishn...@gmail.com, VCL IMAGE Creation Started: vmwarelinux-1524-v0 2011-04-23 01:56:57|14944|13:13|image|Linux.pm:file_exists(1341)|file or directory does not exist on localvmhost: '/var/lib/vmware/Virtual Machines/vmwarelinux-1524-v0/vmwarelinux-1524-v0.vmdk' 2011-04-23 01:56:57|14944|13:13|image|VMware.pm:does_image_exist(2940)|image does not exist in the non-persistent directory on the VM host, checking the image repository 2011-04-23 01:56:57|14944|13:13|image|VMware.pm:get_repository_vmdk_base_directory_path(2654)|repository path is not set for the VM profile, using management node install path: /install/vmware_images 2011-04-23 01:56:57|14944|13:13|image|utils.pm:run_command(9082)|executed command: find "/install/vmware_images/vmwarelinux-1524-v0" -iname "vmwarelinux-1524-v0.vmdk", pid: 15154, exit status: 1, output: |14944|13:13|image| find: /install/vmware_images: No such file or directory 2011-04-23 01:56:57|14944|13:13|image|VMware.pm:does_image_exist(2967)|image does not exist in image repository: /install/vmware_images/vmwarelinux-1524-v0/vmwarelinux-1524-v0.vmdk 2011-04-23 01:56:57|14944|13:13|image|image.pm:process(148)|image vmwarelinux-1524-v0 does not exist in the repository 2011-04-23 01:56:57|14944|13:13|image|DataStructure.pm:_automethod(786)|data structure updated: $self->request_data->{reservation}{13}{image}{lastupdate} |14944|13:13|image| image_lastupdate = 2011-04-23 01:56:57 2011-04-23 01:56:57|14944|13:13|image|DataStructure.pm:_automethod(786)|data structure updated: $self->request_data->{reservation}{13}{imagerevision}{datecreated} |14944|13:13|image| imagerevision_date_created = 2011-04-23 01:56:57 2011-04-23 01:56:57|14944|13:13|image|image.pm:process(164)|calling provisioning module's capture() subroutine 2011-04-23 01:56:57|14944|13:13|image|utils.pm:nmap_port(2707)|port 22 is closed on vmguest-1 2011-04-23 01:56:58|14944|13:13|image|utils.pm:nmap_port(2707)|port 24 is closed on vmguest-1 2011-04-23 01:56:58|14944|13:13|image|OS.pm:is_ssh_responding(416)|vmguest-1 is NOT responding to SSH, ports 22 or 24 are both closed |14944|13:13|image| ---- WARNING ---- |14944|13:13|image| 2011-04-23 01:56:58|14944|13:13|image|VMware.pm:capture(403)|unable to capture image, VM vmguest-1 is not responding to SSH |14944|13:13|image| ( 0) utils.pm, notify (line: 630) |14944|13:13|image| (-1) VMware.pm, capture (line: 403) |14944|13:13|image| (-2) image.pm, process (line: 165) |14944|13:13|image| (-3) vcld, make_new_child (line: 595) |14944|13:13|image| (-4) vcld, main (line: 342) |14944|13:13|image| ---- WARNING ---- |14944|13:13|image| 2011-04-23 01:56:58|14944|13:13|image|image.pm:process(169)|vmwarelinux-1524-v0 image failed to be captured by provisioning module |14944|13:13|image| ( 0) utils.pm, notify (line: 630) |14944|13:13|image| (-1) image.pm, process (line: 169) |14944|13:13|image| (-2) vcld, make_new_child (line: 595) |14944|13:13|image| (-3) vcld, main (line: 342) 2011-04-23 01:56:59|14944|13:13|image|utils.pm:mail(1234)|SUCCESS -- Sending mail To: vishn...@gmail.com, PROBLEM -- image.pm |14944|13:13|image| ---- CRITICAL ---- |14944|13:13|image| 2011-04-23 01:56:58|14944|13:13|image|image.pm:reservation_failed(393)|vmwarelinux-1524-v0 image creation failed |14944|13:13|image| ( 0) utils.pm, notify (line: 630) |14944|13:13|image| (-1) image.pm, reservation_failed (line: 393) |14944|13:13|image| (-2) image.pm, process (line: 170) |14944|13:13|image| (-3) vcld, make_new_child (line: 595) |14944|13:13|image| (-4) vcld, main (line: 342) 2011-04-23 01:57:00|14944|13:13|image|utils.pm:mail(1234)|SUCCESS -- Sending mail To: root@localhost, VCL -- NOTICE DELAY Image Creation 15 2011-04-23 01:57:02|14944|13:13|image|utils.pm:mail(1234)|SUCCESS -- Sending mail To: vishn...@gmail.com, VCL -- NOTICE FAILED Image Creation 15 2011-04-23 01:57:02|14944|13:13|image|utils.pm:update_request_state(2049)|request 13 state updated to: maintenance, laststate to: image 2011-04-23 01:57:02|14944|13:13|image|image.pm:reservation_failed(445)|request state set to maintenance, laststate to image 2011-04-23 01:57:02|14944|13:13|image|utils.pm:update_computer_state(2091)|computer 6 state updated to: maintenance 2011-04-23 01:57:02|14944|13:13|image|image.pm:reservation_failed(453)|vmguest-1 state set to maintenance 2011-04-23 01:57:02|14944|13:13|image|image.pm: reservation_failed(460)|exiting 2011-04-23 01:57:02|14944|13:13|image|State.pm:DESTROY(902)|destructor called, ref($self)=VCL::image 2011-04-23 01:57:02|14944|13:13|image|utils.pm:delete_computerloadlog_reservation(6829)|removing computerloadlog entries matching loadstate = begin 2011-04-23 01:57:02|14944|13:13|image|utils.pm:delete_computerloadlog_reservation(6876)|deleted rows from computerloadlog for reservation id=13 2011-04-23 01:57:02|14944|13:13|image|State.pm:DESTROY(909)|removed computerloadlog rows with loadstate=begin for reservation 2011-04-23 01:57:02|14944|13:13|image|State.pm:DESTROY(921)|number of database handles state process created: 1 2011-04-23 01:57:02|14944|13:13|image|State.pm:DESTROY(930)|process has a database handle stored in $ENV{dbh}, attempting disconnect 2011-04-23 01:57:02|14944|13:13|image|State.pm:DESTROY(932)|$ENV{dbh}: database disconnect successful 2011-04-23 01:57:02|14944|13:13|image|State.pm:DESTROY(946)|VCL::image process 14944 exiting 2011-04-23 01:57:03|5088|vcld:REAPER(745)|VCL process exited for reservation 13, PID: 14944, signal: CHLD 2011-04-23 01:57:13|5088|vcld:main(166)|lastcheckin time updated for management node 1: 2011-04-23 01:57:13 2011-04-23 02:07:13|5088|vcl