You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@vcl.apache.org by James Patrick Sigmon <jp...@ncsu.edu> on 2011/01/02 22:34:01 UTC
Can't locate VMware/VIRuntime.pm
Hey guys,
I've been trying to make a reservation using the VCL 2.2 and I've been running into the following error:
"Can't locate VMware/VIRuntime.pm"
And if I look at up the vcld.log I notice this:
2011-01-02 16:11:43|23951|2:2|deleted|VMware.pm:get_vmhost_api_object(1027)|attempting to load VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
Now as far as I know, vSphere is used for ESX/ESXi, but in my VCL instance I'm using VMware server 2. I assume this to be the reason why I'm getting this error. My question is where and how can I fix this.
I have the vmhost profile set to : VMware Server 2.x - local storage.
Below is the full output for the error.
Thanks,
Patrick Sigmon
2011-01-02 15:22:02|6857|3:3|reload|utils.pm:reservation_being_processed(9010)|computerloadlog 'begin' entry does NOT exist for reservation 3
2011-01-02 15:22:02|6857|3:3|reload|utils.pm:run_command(9082)|executed command: pgrep -fl 'vcld [0-9]+:3 ', pid: 12243, exit status: 1, output:
2011-01-02 15:22:02|6857|3:3|reload|utils.pm:is_management_node_process_running(9259)|process is NOT running, identifier: 'vcld [0-9]+:3 '
2011-01-02 15:22:02|6857|3:3|reload|utils.pm:reservation_being_processed(9031)|reservation is NOT currently being processed
2011-01-02 15:22:02|6857|3:3|reload|vcld:main(277)|reservation 3 is NOT already being processed
2011-01-02 15:22:03|6857|3:3|reload|utils.pm:get_request_info(4589)|standalone affiliation found: Local
2011-01-02 15:22:03|6857|3:3|reload|utils.pm:get_request_info(4596)|found NULL uid setting standalone flag: vclreload, uid: NULL
2011-01-02 15:22:03|6857|3:3|reload|vcld:main(282)|retrieved request information from database
2011-01-02 15:22:03|6857|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
2011-01-02 15:22:03|6857|3:3|reload|utils.pm:update_request_state(2049)|request 3 state updated to: pending, laststate to: reload
2011-01-02 15:22:03|6857|3:3|reload|utils.pm:insertloadlog(3933)|inserted computer=2, begin, beginning to process, state is reload
2011-01-02 15:22:03|6857|3:3|reload|vcld:make_new_child(502)|request will be processed by new.pm
2011-01-02 15:22:03|6857|3:3|reload|vcld:make_new_child(510)|loaded VCL::new module
2011-01-02 15:22:03|12245|3:3|reload|vcld:make_new_child(583)|vcld environment variable set to 0 for this process
2011-01-02 15:22:03|12245|3:3|reload|Module.pm:new(134)|constructor called, class=VCL::new
2011-01-02 15:22:03|12245|3:3|reload|Module.pm:new(156)|VCL::new object created
2011-01-02 15:22:03|6857|3:3|reload|vcld:make_new_child(567)|current number of forked kids: 1
2011-01-02 15:22:04|12245|3:3|reload|State.pm:initialize(85)|obtained a database handle for this state process, stored as $ENV{dbh}
2011-01-02 15:22:04|12245|3:3|reload|State.pm:check_image_os(817)|no corrections need to be made, not an imaging request, returning 1
2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7183)|reservation count: 1
2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7202)|PARENTIMAGE: 1
2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7203)|SUBIMAGE: 0
2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7221)|renamed process to 'vcld 3:3 reload vmguest-1 vmwarelinux-CentOSBase-v0 vclreload'
2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
2011-01-02 15:22:04|12245|3:3|reload|State.pm:initialize(118)|attempting to load provisioning module: VCL::Module::Provisioning::VMware::VMware
2011-01-02 15:22:04|12245|3:3|reload|State.pm:initialize(124)|VCL::Module::Provisioning::VMware::VMware module loaded
2011-01-02 15:22:04|12245|3:3|reload|Module.pm:new(134)|constructor called, class=VCL::Module::Provisioning::VMware::VMware
2011-01-02 15:22:04|12245|3:3|reload|Module.pm:new(156)|VCL::Module::Provisioning::VMware::VMware object created
2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:_initialize(594)|computer ID argument was specified, retrieving data for computer ID: 3
2011-01-02 15:22:04|12245|3:3|reload|VMware.pm:get_vmhost_datastructure(923)|created DataStructure object for VM host: vcl
2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:_initialize(594)|computer ID argument was specified, retrieving data for computer ID: 3
2011-01-02 15:22:04|12245|3:3|reload|VMware.pm:get_vmhost_datastructure(923)|created DataStructure object for VM host: vcl
2011-01-02 15:22:04|12245|3:3|reload|VMware.pm:get_vmhost_api_object(1027)|attempting to load VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
2011-01-02 15:22:04|12245|3:3|reload|utils.pm:mail(1247)|SUCCESS -- Sending mail To: 0, PROBLEM -- vcld
|12245|3:3|reload| ---- CRITICAL ----
|12245|3:3|reload| 2011-01-02 15:22:04|12245|3:3|reload|vcld:die_handler(663)|Can't locate VMware/VIRuntime.pm in @INC (@INC contains: /usr/local/vcl/bin/../../../.. /usr/local/vcl/bin/../.. /usr/local/vcl/bin/.. /usr/local/vcl/bin/../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 /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/local/vcl/bin/../lib/VCL/Module/Provisioning/VMware/vSphere_SDK.pm line 64.
|12245|3:3|reload| ( 0) utils.pm, notify (line: 630)
|12245|3:3|reload| (-1) vcld, die_handler (line: 663)
|12245|3:3|reload| (-2) vSphere_SDK.pm, BEGIN (line: 64)
|12245|3:3|reload| (-3) VIRuntime.pm, (eval) (line: 64)
|12245|3:3|reload| (-4) VIRuntime.pm, (eval) (line: 64)
|12245|3:3|reload| (-5) (eval 166), BEGIN (line: 2)
|12245|3:3|reload| (-6) VIRuntime.pm, (eval) (line: 64)
2011-01-02 15:22:04|6857|vcld:REAPER(745)|VCL process exited for reservation 3, PID: 12245, signal: CHLD
Re: Can't locate VMware/VIRuntime.pm
Posted by James Patrick Sigmon <jp...@ncsu.edu>.
I finally have a lead as how to fix this.
I turns out when you run the command you not only have to specify the port, but also the hostname. So the following command worked without errors:
vmware-vim-cmd -H localhost -O 904 -U <USERNAME> -P <PASSWORD> vmsvc/getallvms
I ran a grep -r in the management node directory for vmware-vim-cmd and found these commands are being run from VIM.SHH.pm.
So I guess my new question is, how to I go about editing this and/or did I miss a database configuration that specifies the parameters I'm missing?
Kindest Regards,
Patrick Sigmon
On Jan 6, 2011, at 9:45 AM, Andy Kurth wrote:
> I'm aware of the issue where the reservation process will die if the VMware SDK isn't installed even if the VM host can be controlled via SSH/vim-cmd. I will fix this for 2.3. For now, in order to use the new VMware.pm module you must have the vSphere SDK installed on the management node.
>
> Patrick - did you attempt to run vim-cmd on the management node, VM host, or are they the same box? I'm not sure what localhost is referring to.
>
> -Andy
>
> On 1/4/2011 3:50 PM, James Patrick Sigmon wrote:
>> Hey Aaron,
>>
>> Version 4.1 didn't work (SOAP Fault) but 4.0 worked just fine. Thanks :)
>>
>> I've gotten to another bump in the road. This one I believe is a firewall issue.
>>
>> |23184|20:20|new| ---- WARNING ----
>> |23184|20:20|new| 2011-01-04 15:20:06|23184|20:20|new|Linux.pm:execute(1224)|failed to run command on localhost: vmware-vim-cmd vmsvc/getallvms
>> |23184|20:20|new| ( 0) utils.pm, notify (line: 630)
>> |23184|20:20|new| (-1) Linux.pm, execute (line: 1224)
>> |23184|20:20|new| (-2) VIM_SSH.pm, _run_vim_cmd (line: 182)
>> |23184|20:20|new| (-3) VIM_SSH.pm, _get_vm_list (line: 219)
>> |23184|20:20|new| (-4) VIM_SSH.pm, get_registered_vms (line: 772)
>> |23184|20:20|new| (-5) VMware.pm, remove_existing_vms (line: 1321)
>> |23184|20:20|new| (-6) VMware.pm, load (line: 362)
>>
>> When I run it manually I get:
>>
>> Failed to connect: Cannot connect to host localhost: Connection refused
>>
>> So I guess my question is, what port do I need to open for this to work?
>>
>> Thanks,
>>
>> Patrick
>>
>> On Jan 3, 2011, at 11:07 AM, Aaron Peeler wrote:
>>
>>> Hi Patrick,
>>>
>>> Make sure you have the vsphere SDK for perl toolkit installed on the management node. Version 4.1 should work well. This will get you past the module load failure.
>>>
>>> Aaron
>>>
>>> On 1/2/11 4:34 PM, James Patrick Sigmon wrote:
>>>> Hey guys,
>>>>
>>>> I've been trying to make a reservation using the VCL 2.2 and I've been running into the following error:
>>>>
>>>> "Can't locate VMware/VIRuntime.pm"
>>>>
>>>> And if I look at up the vcld.log I notice this:
>>>>
>>>> 2011-01-02 16:11:43|23951|2:2|deleted|VMware.pm:get_vmhost_api_object(1027)|attempting to load VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
>>>>
>>>> Now as far as I know, vSphere is used for ESX/ESXi, but in my VCL instance I'm using VMware server 2. I assume this to be the reason why I'm getting this error. My question is where and how can I fix this.
>>>>
>>>> I have the vmhost profile set to : VMware Server 2.x - local storage.
>>>>
>>>> Below is the full output for the error.
>>>>
>>>> Thanks,
>>>>
>>>> Patrick Sigmon
>>>>
>>>> 2011-01-02 15:22:02|6857|3:3|reload|utils.pm:reservation_being_processed(9010)|computerloadlog 'begin' entry does NOT exist for reservation 3
>>>> 2011-01-02 15:22:02|6857|3:3|reload|utils.pm:run_command(9082)|executed command: pgrep -fl 'vcld [0-9]+:3 ', pid: 12243, exit status: 1, output:
>>>> 2011-01-02 15:22:02|6857|3:3|reload|utils.pm:is_management_node_process_running(9259)|process is NOT running, identifier: 'vcld [0-9]+:3 '
>>>> 2011-01-02 15:22:02|6857|3:3|reload|utils.pm:reservation_being_processed(9031)|reservation is NOT currently being processed
>>>> 2011-01-02 15:22:02|6857|3:3|reload|vcld:main(277)|reservation 3 is NOT already being processed
>>>> 2011-01-02 15:22:03|6857|3:3|reload|utils.pm:get_request_info(4589)|standalone affiliation found: Local
>>>> 2011-01-02 15:22:03|6857|3:3|reload|utils.pm:get_request_info(4596)|found NULL uid setting standalone flag: vclreload, uid: NULL
>>>> 2011-01-02 15:22:03|6857|3:3|reload|vcld:main(282)|retrieved request information from database
>>>> 2011-01-02 15:22:03|6857|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
>>>> 2011-01-02 15:22:03|6857|3:3|reload|utils.pm:update_request_state(2049)|request 3 state updated to: pending, laststate to: reload
>>>> 2011-01-02 15:22:03|6857|3:3|reload|utils.pm:insertloadlog(3933)|inserted computer=2, begin, beginning to process, state is reload
>>>> 2011-01-02 15:22:03|6857|3:3|reload|vcld:make_new_child(502)|request will be processed by new.pm
>>>> 2011-01-02 15:22:03|6857|3:3|reload|vcld:make_new_child(510)|loaded VCL::new module
>>>> 2011-01-02 15:22:03|12245|3:3|reload|vcld:make_new_child(583)|vcld environment variable set to 0 for this process
>>>> 2011-01-02 15:22:03|12245|3:3|reload|Module.pm:new(134)|constructor called, class=VCL::new
>>>> 2011-01-02 15:22:03|12245|3:3|reload|Module.pm:new(156)|VCL::new object created
>>>> 2011-01-02 15:22:03|6857|3:3|reload|vcld:make_new_child(567)|current number of forked kids: 1
>>>> 2011-01-02 15:22:04|12245|3:3|reload|State.pm:initialize(85)|obtained a database handle for this state process, stored as $ENV{dbh}
>>>> 2011-01-02 15:22:04|12245|3:3|reload|State.pm:check_image_os(817)|no corrections need to be made, not an imaging request, returning 1
>>>> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
>>>> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7183)|reservation count: 1
>>>> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7202)|PARENTIMAGE: 1
>>>> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7203)|SUBIMAGE: 0
>>>> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7221)|renamed process to 'vcld 3:3 reload vmguest-1 vmwarelinux-CentOSBase-v0 vclreload'
>>>> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
>>>> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
>>>> 2011-01-02 15:22:04|12245|3:3|reload|State.pm:initialize(118)|attempting to load provisioning module: VCL::Module::Provisioning::VMware::VMware
>>>> 2011-01-02 15:22:04|12245|3:3|reload|State.pm:initialize(124)|VCL::Module::Provisioning::VMware::VMware module loaded
>>>> 2011-01-02 15:22:04|12245|3:3|reload|Module.pm:new(134)|constructor called, class=VCL::Module::Provisioning::VMware::VMware
>>>> 2011-01-02 15:22:04|12245|3:3|reload|Module.pm:new(156)|VCL::Module::Provisioning::VMware::VMware object created
>>>> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:_initialize(594)|computer ID argument was specified, retrieving data for computer ID: 3
>>>> 2011-01-02 15:22:04|12245|3:3|reload|VMware.pm:get_vmhost_datastructure(923)|created DataStructure object for VM host: vcl
>>>> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:_initialize(594)|computer ID argument was specified, retrieving data for computer ID: 3
>>>> 2011-01-02 15:22:04|12245|3:3|reload|VMware.pm:get_vmhost_datastructure(923)|created DataStructure object for VM host: vcl
>>>> 2011-01-02 15:22:04|12245|3:3|reload|VMware.pm:get_vmhost_api_object(1027)|attempting to load VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
>>>> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:mail(1247)|SUCCESS -- Sending mail To: 0, PROBLEM -- vcld
>>>>
>>>> |12245|3:3|reload| ---- CRITICAL ----
>>>> |12245|3:3|reload| 2011-01-02 15:22:04|12245|3:3|reload|vcld:die_handler(663)|Can't locate VMware/VIRuntime.pm in @INC (@INC contains: /usr/local/vcl/bin/../../../.. /usr/local/vcl/bin/../.. /usr/local/vcl/bin/.. /usr/local/vcl/bin/../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 /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/local/vcl/bin/../lib/VCL/Module/Provisioning/VMware/vSphere_SDK.pm line 64.
>>>> |12245|3:3|reload| ( 0) utils.pm, notify (line: 630)
>>>> |12245|3:3|reload| (-1) vcld, die_handler (line: 663)
>>>> |12245|3:3|reload| (-2) vSphere_SDK.pm, BEGIN (line: 64)
>>>> |12245|3:3|reload| (-3) VIRuntime.pm, (eval) (line: 64)
>>>> |12245|3:3|reload| (-4) VIRuntime.pm, (eval) (line: 64)
>>>> |12245|3:3|reload| (-5) (eval 166), BEGIN (line: 2)
>>>> |12245|3:3|reload| (-6) VIRuntime.pm, (eval) (line: 64)
>>>>
>>>> 2011-01-02 15:22:04|6857|vcld:REAPER(745)|VCL process exited for reservation 3, PID: 12245, signal: CHLD
>>>>
>>>
>>>
>>> --
>>>
>>> Aaron Peeler
>>> Program Manager
>>> Virtual Computing Lab
>>> NC State University
>>> aaron_peeler@ncsu.edu
>>> 919-513-4571
>>>
>>
Re: Can't locate VMware/VIRuntime.pm
Posted by James Patrick Sigmon <jp...@ncsu.edu>.
Hey Andy,
The management node and the VMhost are the same blade. vSphere 4.0 is installed on it.
Thanks,
Patrick
On Jan 6, 2011, at 9:45 AM, Andy Kurth wrote:
> I'm aware of the issue where the reservation process will die if the VMware SDK isn't installed even if the VM host can be controlled via SSH/vim-cmd. I will fix this for 2.3. For now, in order to use the new VMware.pm module you must have the vSphere SDK installed on the management node.
>
> Patrick - did you attempt to run vim-cmd on the management node, VM host, or are they the same box? I'm not sure what localhost is referring to.
>
> -Andy
>
> On 1/4/2011 3:50 PM, James Patrick Sigmon wrote:
>> Hey Aaron,
>>
>> Version 4.1 didn't work (SOAP Fault) but 4.0 worked just fine. Thanks :)
>>
>> I've gotten to another bump in the road. This one I believe is a firewall issue.
>>
>> |23184|20:20|new| ---- WARNING ----
>> |23184|20:20|new| 2011-01-04 15:20:06|23184|20:20|new|Linux.pm:execute(1224)|failed to run command on localhost: vmware-vim-cmd vmsvc/getallvms
>> |23184|20:20|new| ( 0) utils.pm, notify (line: 630)
>> |23184|20:20|new| (-1) Linux.pm, execute (line: 1224)
>> |23184|20:20|new| (-2) VIM_SSH.pm, _run_vim_cmd (line: 182)
>> |23184|20:20|new| (-3) VIM_SSH.pm, _get_vm_list (line: 219)
>> |23184|20:20|new| (-4) VIM_SSH.pm, get_registered_vms (line: 772)
>> |23184|20:20|new| (-5) VMware.pm, remove_existing_vms (line: 1321)
>> |23184|20:20|new| (-6) VMware.pm, load (line: 362)
>>
>> When I run it manually I get:
>>
>> Failed to connect: Cannot connect to host localhost: Connection refused
>>
>> So I guess my question is, what port do I need to open for this to work?
>>
>> Thanks,
>>
>> Patrick
>>
>> On Jan 3, 2011, at 11:07 AM, Aaron Peeler wrote:
>>
>>> Hi Patrick,
>>>
>>> Make sure you have the vsphere SDK for perl toolkit installed on the management node. Version 4.1 should work well. This will get you past the module load failure.
>>>
>>> Aaron
>>>
>>> On 1/2/11 4:34 PM, James Patrick Sigmon wrote:
>>>> Hey guys,
>>>>
>>>> I've been trying to make a reservation using the VCL 2.2 and I've been running into the following error:
>>>>
>>>> "Can't locate VMware/VIRuntime.pm"
>>>>
>>>> And if I look at up the vcld.log I notice this:
>>>>
>>>> 2011-01-02 16:11:43|23951|2:2|deleted|VMware.pm:get_vmhost_api_object(1027)|attempting to load VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
>>>>
>>>> Now as far as I know, vSphere is used for ESX/ESXi, but in my VCL instance I'm using VMware server 2. I assume this to be the reason why I'm getting this error. My question is where and how can I fix this.
>>>>
>>>> I have the vmhost profile set to : VMware Server 2.x - local storage.
>>>>
>>>> Below is the full output for the error.
>>>>
>>>> Thanks,
>>>>
>>>> Patrick Sigmon
>>>>
>>>> 2011-01-02 15:22:02|6857|3:3|reload|utils.pm:reservation_being_processed(9010)|computerloadlog 'begin' entry does NOT exist for reservation 3
>>>> 2011-01-02 15:22:02|6857|3:3|reload|utils.pm:run_command(9082)|executed command: pgrep -fl 'vcld [0-9]+:3 ', pid: 12243, exit status: 1, output:
>>>> 2011-01-02 15:22:02|6857|3:3|reload|utils.pm:is_management_node_process_running(9259)|process is NOT running, identifier: 'vcld [0-9]+:3 '
>>>> 2011-01-02 15:22:02|6857|3:3|reload|utils.pm:reservation_being_processed(9031)|reservation is NOT currently being processed
>>>> 2011-01-02 15:22:02|6857|3:3|reload|vcld:main(277)|reservation 3 is NOT already being processed
>>>> 2011-01-02 15:22:03|6857|3:3|reload|utils.pm:get_request_info(4589)|standalone affiliation found: Local
>>>> 2011-01-02 15:22:03|6857|3:3|reload|utils.pm:get_request_info(4596)|found NULL uid setting standalone flag: vclreload, uid: NULL
>>>> 2011-01-02 15:22:03|6857|3:3|reload|vcld:main(282)|retrieved request information from database
>>>> 2011-01-02 15:22:03|6857|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
>>>> 2011-01-02 15:22:03|6857|3:3|reload|utils.pm:update_request_state(2049)|request 3 state updated to: pending, laststate to: reload
>>>> 2011-01-02 15:22:03|6857|3:3|reload|utils.pm:insertloadlog(3933)|inserted computer=2, begin, beginning to process, state is reload
>>>> 2011-01-02 15:22:03|6857|3:3|reload|vcld:make_new_child(502)|request will be processed by new.pm
>>>> 2011-01-02 15:22:03|6857|3:3|reload|vcld:make_new_child(510)|loaded VCL::new module
>>>> 2011-01-02 15:22:03|12245|3:3|reload|vcld:make_new_child(583)|vcld environment variable set to 0 for this process
>>>> 2011-01-02 15:22:03|12245|3:3|reload|Module.pm:new(134)|constructor called, class=VCL::new
>>>> 2011-01-02 15:22:03|12245|3:3|reload|Module.pm:new(156)|VCL::new object created
>>>> 2011-01-02 15:22:03|6857|3:3|reload|vcld:make_new_child(567)|current number of forked kids: 1
>>>> 2011-01-02 15:22:04|12245|3:3|reload|State.pm:initialize(85)|obtained a database handle for this state process, stored as $ENV{dbh}
>>>> 2011-01-02 15:22:04|12245|3:3|reload|State.pm:check_image_os(817)|no corrections need to be made, not an imaging request, returning 1
>>>> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
>>>> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7183)|reservation count: 1
>>>> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7202)|PARENTIMAGE: 1
>>>> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7203)|SUBIMAGE: 0
>>>> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7221)|renamed process to 'vcld 3:3 reload vmguest-1 vmwarelinux-CentOSBase-v0 vclreload'
>>>> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
>>>> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
>>>> 2011-01-02 15:22:04|12245|3:3|reload|State.pm:initialize(118)|attempting to load provisioning module: VCL::Module::Provisioning::VMware::VMware
>>>> 2011-01-02 15:22:04|12245|3:3|reload|State.pm:initialize(124)|VCL::Module::Provisioning::VMware::VMware module loaded
>>>> 2011-01-02 15:22:04|12245|3:3|reload|Module.pm:new(134)|constructor called, class=VCL::Module::Provisioning::VMware::VMware
>>>> 2011-01-02 15:22:04|12245|3:3|reload|Module.pm:new(156)|VCL::Module::Provisioning::VMware::VMware object created
>>>> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:_initialize(594)|computer ID argument was specified, retrieving data for computer ID: 3
>>>> 2011-01-02 15:22:04|12245|3:3|reload|VMware.pm:get_vmhost_datastructure(923)|created DataStructure object for VM host: vcl
>>>> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:_initialize(594)|computer ID argument was specified, retrieving data for computer ID: 3
>>>> 2011-01-02 15:22:04|12245|3:3|reload|VMware.pm:get_vmhost_datastructure(923)|created DataStructure object for VM host: vcl
>>>> 2011-01-02 15:22:04|12245|3:3|reload|VMware.pm:get_vmhost_api_object(1027)|attempting to load VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
>>>> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:mail(1247)|SUCCESS -- Sending mail To: 0, PROBLEM -- vcld
>>>>
>>>> |12245|3:3|reload| ---- CRITICAL ----
>>>> |12245|3:3|reload| 2011-01-02 15:22:04|12245|3:3|reload|vcld:die_handler(663)|Can't locate VMware/VIRuntime.pm in @INC (@INC contains: /usr/local/vcl/bin/../../../.. /usr/local/vcl/bin/../.. /usr/local/vcl/bin/.. /usr/local/vcl/bin/../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 /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/local/vcl/bin/../lib/VCL/Module/Provisioning/VMware/vSphere_SDK.pm line 64.
>>>> |12245|3:3|reload| ( 0) utils.pm, notify (line: 630)
>>>> |12245|3:3|reload| (-1) vcld, die_handler (line: 663)
>>>> |12245|3:3|reload| (-2) vSphere_SDK.pm, BEGIN (line: 64)
>>>> |12245|3:3|reload| (-3) VIRuntime.pm, (eval) (line: 64)
>>>> |12245|3:3|reload| (-4) VIRuntime.pm, (eval) (line: 64)
>>>> |12245|3:3|reload| (-5) (eval 166), BEGIN (line: 2)
>>>> |12245|3:3|reload| (-6) VIRuntime.pm, (eval) (line: 64)
>>>>
>>>> 2011-01-02 15:22:04|6857|vcld:REAPER(745)|VCL process exited for reservation 3, PID: 12245, signal: CHLD
>>>>
>>>
>>>
>>> --
>>>
>>> Aaron Peeler
>>> Program Manager
>>> Virtual Computing Lab
>>> NC State University
>>> aaron_peeler@ncsu.edu
>>> 919-513-4571
>>>
>>
Re: Can't locate VMware/VIRuntime.pm
Posted by Andy Kurth <an...@ncsu.edu>.
I'm aware of the issue where the reservation process will die if the
VMware SDK isn't installed even if the VM host can be controlled via
SSH/vim-cmd. I will fix this for 2.3. For now, in order to use the new
VMware.pm module you must have the vSphere SDK installed on the
management node.
Patrick - did you attempt to run vim-cmd on the management node, VM
host, or are they the same box? I'm not sure what localhost is
referring to.
-Andy
On 1/4/2011 3:50 PM, James Patrick Sigmon wrote:
> Hey Aaron,
>
> Version 4.1 didn't work (SOAP Fault) but 4.0 worked just fine. Thanks :)
>
> I've gotten to another bump in the road. This one I believe is a firewall issue.
>
> |23184|20:20|new| ---- WARNING ----
> |23184|20:20|new| 2011-01-04 15:20:06|23184|20:20|new|Linux.pm:execute(1224)|failed to run command on localhost: vmware-vim-cmd vmsvc/getallvms
> |23184|20:20|new| ( 0) utils.pm, notify (line: 630)
> |23184|20:20|new| (-1) Linux.pm, execute (line: 1224)
> |23184|20:20|new| (-2) VIM_SSH.pm, _run_vim_cmd (line: 182)
> |23184|20:20|new| (-3) VIM_SSH.pm, _get_vm_list (line: 219)
> |23184|20:20|new| (-4) VIM_SSH.pm, get_registered_vms (line: 772)
> |23184|20:20|new| (-5) VMware.pm, remove_existing_vms (line: 1321)
> |23184|20:20|new| (-6) VMware.pm, load (line: 362)
>
> When I run it manually I get:
>
> Failed to connect: Cannot connect to host localhost: Connection refused
>
> So I guess my question is, what port do I need to open for this to work?
>
> Thanks,
>
> Patrick
>
> On Jan 3, 2011, at 11:07 AM, Aaron Peeler wrote:
>
>> Hi Patrick,
>>
>> Make sure you have the vsphere SDK for perl toolkit installed on the management node. Version 4.1 should work well. This will get you past the module load failure.
>>
>> Aaron
>>
>> On 1/2/11 4:34 PM, James Patrick Sigmon wrote:
>>> Hey guys,
>>>
>>> I've been trying to make a reservation using the VCL 2.2 and I've been running into the following error:
>>>
>>> "Can't locate VMware/VIRuntime.pm"
>>>
>>> And if I look at up the vcld.log I notice this:
>>>
>>> 2011-01-02 16:11:43|23951|2:2|deleted|VMware.pm:get_vmhost_api_object(1027)|attempting to load VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
>>>
>>> Now as far as I know, vSphere is used for ESX/ESXi, but in my VCL instance I'm using VMware server 2. I assume this to be the reason why I'm getting this error. My question is where and how can I fix this.
>>>
>>> I have the vmhost profile set to : VMware Server 2.x - local storage.
>>>
>>> Below is the full output for the error.
>>>
>>> Thanks,
>>>
>>> Patrick Sigmon
>>>
>>> 2011-01-02 15:22:02|6857|3:3|reload|utils.pm:reservation_being_processed(9010)|computerloadlog 'begin' entry does NOT exist for reservation 3
>>> 2011-01-02 15:22:02|6857|3:3|reload|utils.pm:run_command(9082)|executed command: pgrep -fl 'vcld [0-9]+:3 ', pid: 12243, exit status: 1, output:
>>> 2011-01-02 15:22:02|6857|3:3|reload|utils.pm:is_management_node_process_running(9259)|process is NOT running, identifier: 'vcld [0-9]+:3 '
>>> 2011-01-02 15:22:02|6857|3:3|reload|utils.pm:reservation_being_processed(9031)|reservation is NOT currently being processed
>>> 2011-01-02 15:22:02|6857|3:3|reload|vcld:main(277)|reservation 3 is NOT already being processed
>>> 2011-01-02 15:22:03|6857|3:3|reload|utils.pm:get_request_info(4589)|standalone affiliation found: Local
>>> 2011-01-02 15:22:03|6857|3:3|reload|utils.pm:get_request_info(4596)|found NULL uid setting standalone flag: vclreload, uid: NULL
>>> 2011-01-02 15:22:03|6857|3:3|reload|vcld:main(282)|retrieved request information from database
>>> 2011-01-02 15:22:03|6857|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
>>> 2011-01-02 15:22:03|6857|3:3|reload|utils.pm:update_request_state(2049)|request 3 state updated to: pending, laststate to: reload
>>> 2011-01-02 15:22:03|6857|3:3|reload|utils.pm:insertloadlog(3933)|inserted computer=2, begin, beginning to process, state is reload
>>> 2011-01-02 15:22:03|6857|3:3|reload|vcld:make_new_child(502)|request will be processed by new.pm
>>> 2011-01-02 15:22:03|6857|3:3|reload|vcld:make_new_child(510)|loaded VCL::new module
>>> 2011-01-02 15:22:03|12245|3:3|reload|vcld:make_new_child(583)|vcld environment variable set to 0 for this process
>>> 2011-01-02 15:22:03|12245|3:3|reload|Module.pm:new(134)|constructor called, class=VCL::new
>>> 2011-01-02 15:22:03|12245|3:3|reload|Module.pm:new(156)|VCL::new object created
>>> 2011-01-02 15:22:03|6857|3:3|reload|vcld:make_new_child(567)|current number of forked kids: 1
>>> 2011-01-02 15:22:04|12245|3:3|reload|State.pm:initialize(85)|obtained a database handle for this state process, stored as $ENV{dbh}
>>> 2011-01-02 15:22:04|12245|3:3|reload|State.pm:check_image_os(817)|no corrections need to be made, not an imaging request, returning 1
>>> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
>>> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7183)|reservation count: 1
>>> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7202)|PARENTIMAGE: 1
>>> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7203)|SUBIMAGE: 0
>>> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7221)|renamed process to 'vcld 3:3 reload vmguest-1 vmwarelinux-CentOSBase-v0 vclreload'
>>> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
>>> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
>>> 2011-01-02 15:22:04|12245|3:3|reload|State.pm:initialize(118)|attempting to load provisioning module: VCL::Module::Provisioning::VMware::VMware
>>> 2011-01-02 15:22:04|12245|3:3|reload|State.pm:initialize(124)|VCL::Module::Provisioning::VMware::VMware module loaded
>>> 2011-01-02 15:22:04|12245|3:3|reload|Module.pm:new(134)|constructor called, class=VCL::Module::Provisioning::VMware::VMware
>>> 2011-01-02 15:22:04|12245|3:3|reload|Module.pm:new(156)|VCL::Module::Provisioning::VMware::VMware object created
>>> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:_initialize(594)|computer ID argument was specified, retrieving data for computer ID: 3
>>> 2011-01-02 15:22:04|12245|3:3|reload|VMware.pm:get_vmhost_datastructure(923)|created DataStructure object for VM host: vcl
>>> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:_initialize(594)|computer ID argument was specified, retrieving data for computer ID: 3
>>> 2011-01-02 15:22:04|12245|3:3|reload|VMware.pm:get_vmhost_datastructure(923)|created DataStructure object for VM host: vcl
>>> 2011-01-02 15:22:04|12245|3:3|reload|VMware.pm:get_vmhost_api_object(1027)|attempting to load VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
>>> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:mail(1247)|SUCCESS -- Sending mail To: 0, PROBLEM -- vcld
>>>
>>> |12245|3:3|reload| ---- CRITICAL ----
>>> |12245|3:3|reload| 2011-01-02 15:22:04|12245|3:3|reload|vcld:die_handler(663)|Can't locate VMware/VIRuntime.pm in @INC (@INC contains: /usr/local/vcl/bin/../../../.. /usr/local/vcl/bin/../.. /usr/local/vcl/bin/.. /usr/local/vcl/bin/../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 /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/local/vcl/bin/../lib/VCL/Module/Provisioning/VMware/vSphere_SDK.pm line 64.
>>> |12245|3:3|reload| ( 0) utils.pm, notify (line: 630)
>>> |12245|3:3|reload| (-1) vcld, die_handler (line: 663)
>>> |12245|3:3|reload| (-2) vSphere_SDK.pm, BEGIN (line: 64)
>>> |12245|3:3|reload| (-3) VIRuntime.pm, (eval) (line: 64)
>>> |12245|3:3|reload| (-4) VIRuntime.pm, (eval) (line: 64)
>>> |12245|3:3|reload| (-5) (eval 166), BEGIN (line: 2)
>>> |12245|3:3|reload| (-6) VIRuntime.pm, (eval) (line: 64)
>>>
>>> 2011-01-02 15:22:04|6857|vcld:REAPER(745)|VCL process exited for reservation 3, PID: 12245, signal: CHLD
>>>
>>
>>
>> --
>>
>> Aaron Peeler
>> Program Manager
>> Virtual Computing Lab
>> NC State University
>> aaron_peeler@ncsu.edu
>> 919-513-4571
>>
>
Re: Can't locate VMware/VIRuntime.pm
Posted by James Patrick Sigmon <jp...@ncsu.edu>.
Hey Aaron,
Version 4.1 didn't work (SOAP Fault) but 4.0 worked just fine. Thanks :)
I've gotten to another bump in the road. This one I believe is a firewall issue.
|23184|20:20|new| ---- WARNING ----
|23184|20:20|new| 2011-01-04 15:20:06|23184|20:20|new|Linux.pm:execute(1224)|failed to run command on localhost: vmware-vim-cmd vmsvc/getallvms
|23184|20:20|new| ( 0) utils.pm, notify (line: 630)
|23184|20:20|new| (-1) Linux.pm, execute (line: 1224)
|23184|20:20|new| (-2) VIM_SSH.pm, _run_vim_cmd (line: 182)
|23184|20:20|new| (-3) VIM_SSH.pm, _get_vm_list (line: 219)
|23184|20:20|new| (-4) VIM_SSH.pm, get_registered_vms (line: 772)
|23184|20:20|new| (-5) VMware.pm, remove_existing_vms (line: 1321)
|23184|20:20|new| (-6) VMware.pm, load (line: 362)
When I run it manually I get:
Failed to connect: Cannot connect to host localhost: Connection refused
So I guess my question is, what port do I need to open for this to work?
Thanks,
Patrick
On Jan 3, 2011, at 11:07 AM, Aaron Peeler wrote:
> Hi Patrick,
>
> Make sure you have the vsphere SDK for perl toolkit installed on the management node. Version 4.1 should work well. This will get you past the module load failure.
>
> Aaron
>
> On 1/2/11 4:34 PM, James Patrick Sigmon wrote:
>> Hey guys,
>>
>> I've been trying to make a reservation using the VCL 2.2 and I've been running into the following error:
>>
>> "Can't locate VMware/VIRuntime.pm"
>>
>> And if I look at up the vcld.log I notice this:
>>
>> 2011-01-02 16:11:43|23951|2:2|deleted|VMware.pm:get_vmhost_api_object(1027)|attempting to load VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
>>
>> Now as far as I know, vSphere is used for ESX/ESXi, but in my VCL instance I'm using VMware server 2. I assume this to be the reason why I'm getting this error. My question is where and how can I fix this.
>>
>> I have the vmhost profile set to : VMware Server 2.x - local storage.
>>
>> Below is the full output for the error.
>>
>> Thanks,
>>
>> Patrick Sigmon
>>
>> 2011-01-02 15:22:02|6857|3:3|reload|utils.pm:reservation_being_processed(9010)|computerloadlog 'begin' entry does NOT exist for reservation 3
>> 2011-01-02 15:22:02|6857|3:3|reload|utils.pm:run_command(9082)|executed command: pgrep -fl 'vcld [0-9]+:3 ', pid: 12243, exit status: 1, output:
>> 2011-01-02 15:22:02|6857|3:3|reload|utils.pm:is_management_node_process_running(9259)|process is NOT running, identifier: 'vcld [0-9]+:3 '
>> 2011-01-02 15:22:02|6857|3:3|reload|utils.pm:reservation_being_processed(9031)|reservation is NOT currently being processed
>> 2011-01-02 15:22:02|6857|3:3|reload|vcld:main(277)|reservation 3 is NOT already being processed
>> 2011-01-02 15:22:03|6857|3:3|reload|utils.pm:get_request_info(4589)|standalone affiliation found: Local
>> 2011-01-02 15:22:03|6857|3:3|reload|utils.pm:get_request_info(4596)|found NULL uid setting standalone flag: vclreload, uid: NULL
>> 2011-01-02 15:22:03|6857|3:3|reload|vcld:main(282)|retrieved request information from database
>> 2011-01-02 15:22:03|6857|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
>> 2011-01-02 15:22:03|6857|3:3|reload|utils.pm:update_request_state(2049)|request 3 state updated to: pending, laststate to: reload
>> 2011-01-02 15:22:03|6857|3:3|reload|utils.pm:insertloadlog(3933)|inserted computer=2, begin, beginning to process, state is reload
>> 2011-01-02 15:22:03|6857|3:3|reload|vcld:make_new_child(502)|request will be processed by new.pm
>> 2011-01-02 15:22:03|6857|3:3|reload|vcld:make_new_child(510)|loaded VCL::new module
>> 2011-01-02 15:22:03|12245|3:3|reload|vcld:make_new_child(583)|vcld environment variable set to 0 for this process
>> 2011-01-02 15:22:03|12245|3:3|reload|Module.pm:new(134)|constructor called, class=VCL::new
>> 2011-01-02 15:22:03|12245|3:3|reload|Module.pm:new(156)|VCL::new object created
>> 2011-01-02 15:22:03|6857|3:3|reload|vcld:make_new_child(567)|current number of forked kids: 1
>> 2011-01-02 15:22:04|12245|3:3|reload|State.pm:initialize(85)|obtained a database handle for this state process, stored as $ENV{dbh}
>> 2011-01-02 15:22:04|12245|3:3|reload|State.pm:check_image_os(817)|no corrections need to be made, not an imaging request, returning 1
>> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
>> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7183)|reservation count: 1
>> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7202)|PARENTIMAGE: 1
>> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7203)|SUBIMAGE: 0
>> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7221)|renamed process to 'vcld 3:3 reload vmguest-1 vmwarelinux-CentOSBase-v0 vclreload'
>> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
>> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
>> 2011-01-02 15:22:04|12245|3:3|reload|State.pm:initialize(118)|attempting to load provisioning module: VCL::Module::Provisioning::VMware::VMware
>> 2011-01-02 15:22:04|12245|3:3|reload|State.pm:initialize(124)|VCL::Module::Provisioning::VMware::VMware module loaded
>> 2011-01-02 15:22:04|12245|3:3|reload|Module.pm:new(134)|constructor called, class=VCL::Module::Provisioning::VMware::VMware
>> 2011-01-02 15:22:04|12245|3:3|reload|Module.pm:new(156)|VCL::Module::Provisioning::VMware::VMware object created
>> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:_initialize(594)|computer ID argument was specified, retrieving data for computer ID: 3
>> 2011-01-02 15:22:04|12245|3:3|reload|VMware.pm:get_vmhost_datastructure(923)|created DataStructure object for VM host: vcl
>> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:_initialize(594)|computer ID argument was specified, retrieving data for computer ID: 3
>> 2011-01-02 15:22:04|12245|3:3|reload|VMware.pm:get_vmhost_datastructure(923)|created DataStructure object for VM host: vcl
>> 2011-01-02 15:22:04|12245|3:3|reload|VMware.pm:get_vmhost_api_object(1027)|attempting to load VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
>> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:mail(1247)|SUCCESS -- Sending mail To: 0, PROBLEM -- vcld
>>
>> |12245|3:3|reload| ---- CRITICAL ----
>> |12245|3:3|reload| 2011-01-02 15:22:04|12245|3:3|reload|vcld:die_handler(663)|Can't locate VMware/VIRuntime.pm in @INC (@INC contains: /usr/local/vcl/bin/../../../.. /usr/local/vcl/bin/../.. /usr/local/vcl/bin/.. /usr/local/vcl/bin/../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 /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/local/vcl/bin/../lib/VCL/Module/Provisioning/VMware/vSphere_SDK.pm line 64.
>> |12245|3:3|reload| ( 0) utils.pm, notify (line: 630)
>> |12245|3:3|reload| (-1) vcld, die_handler (line: 663)
>> |12245|3:3|reload| (-2) vSphere_SDK.pm, BEGIN (line: 64)
>> |12245|3:3|reload| (-3) VIRuntime.pm, (eval) (line: 64)
>> |12245|3:3|reload| (-4) VIRuntime.pm, (eval) (line: 64)
>> |12245|3:3|reload| (-5) (eval 166), BEGIN (line: 2)
>> |12245|3:3|reload| (-6) VIRuntime.pm, (eval) (line: 64)
>>
>> 2011-01-02 15:22:04|6857|vcld:REAPER(745)|VCL process exited for reservation 3, PID: 12245, signal: CHLD
>>
>
>
> --
>
> Aaron Peeler
> Program Manager
> Virtual Computing Lab
> NC State University
> aaron_peeler@ncsu.edu
> 919-513-4571
>
RE: Can't locate VMware/VIRuntime.pm
Posted by "Waldron, Michael H" <mw...@email.unc.edu>.
I was able to get around this problem by inserting an entry in the provisioning table on the 2.2 system that I have in my 2.1 system for VMware GSX:
| id | name | prettyname | moduleid |
| 2 | vmware_server_gsx | VMware Server GSX | 2 |
Then I set the provisioning engine option on the vmguest machine to use VMware Server GSX. This uses the vmware.pm module instead of VMware\VMware.pm module, which is what is failing with the absence of the vim-cmd and vmware-vim-cmd commands on the vmhost.
Mike
Mike Waldron
Systems Specialist
ITS Research Computing
University of North Carolina at Chapel Hill
CB #3420, ITS Manning, Rm 2509
919-962-9778
________________________________________
From: Waldron, Michael H [mwaldron@email.unc.edu]
Sent: Tuesday, January 04, 2011 8:42 AM
To: vcl-dev@incubator.apache.org
Subject: RE: Can't locate VMware/VIRuntime.pm
I encountered the same error in a VCL 2.2 test environment that I'm setting up, although I'm using VMware server 1.x since that's what we're using in our VCL 2.1 production environment. I'm trying to duplicate the problems we experienced in our production environment when we attempted to upgrade to 2.2. I'm using the procedure for creating a standalone VMware VCL environment that's on the VCL website.
I installed the vsphere SDK for perl toolkit as suggested, and it got past the module load error, however it fails shortly thereafter because it can't find the vim-cmd or vmware-vim-cmd commands on the VM host. From what I've read, these are part of a VI-toolkit package that supports VMware server 2.x. Any ideas how to get around this? The relevant log snippet is below.
2011-01-03 15:45:16|25618|2:2|new|State.pm:initialize(118)|attempting to load provisioning module: VCL::Module::Provisioning::VMware::VMware
2011-01-03 15:45:16|25618|2:2|new|State.pm:initialize(124)|VCL::Module::Provisioning::VMware::VMware module loaded
2011-01-03 15:45:16|25618|2:2|new|Module.pm:new(134)|constructor called, class=VCL::Module::Provisioning::VMware::VMware
2011-01-03 15:45:16|25618|2:2|new|Module.pm:new(156)|VCL::Module::Provisioning::VMware::VMware object created
2011-01-03 15:45:16|25618|2:2|new|DataStructure.pm:_initialize(594)|computer ID argument was specified, retrieving data for computer ID: 1
2011-01-03 15:45:16|25618|2:2|new|VMware.pm:get_vmhost_datastructure(923)|created DataStructure object for VM host: vmhost
2011-01-03 15:45:16|25618|2:2|new|DataStructure.pm:_initialize(594)|computer ID argument was specified, retrieving data for computer ID: 1
2011-01-03 15:45:16|25618|2:2|new|VMware.pm:get_vmhost_datastructure(923)|created DataStructure object for VM host: vmhost
2011-01-03 15:45:16|25618|2:2|new|VMware.pm:get_vmhost_api_object(1027)|attempting to load VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
2011-01-03 15:45:16|25618|2:2|new|VMware.pm:get_vmhost_api_object(1033)|loaded VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
2011-01-03 15:45:16|25618|2:2|new|Module.pm:new(134)|constructor called, class=VCL::Module::Provisioning::VMware::vSphere_SDK
2011-01-03 15:45:16|25618|2:2|new|Module.pm:new(156)|VCL::Module::Provisioning::VMware::vSphere_SDK object created
|25618|2:2|new| ---- WARNING ----
|25618|2:2|new| 2011-01-03 15:45:16|25618|2:2|new|vSphere_SDK.pm:initialize(1789)|VM host password is not configured in the database for the VM profile
|25618|2:2|new| ( 0) utils.pm, notify (line: 630)
|25618|2:2|new| (-1) vSphere_SDK.pm, initialize (line: 1789)
|25618|2:2|new| (-2) Module.pm, new (line: 159)
|25618|2:2|new| (-3) VMware.pm, (eval) (line: 1037)
|25618|2:2|new| (-4) VMware.pm, get_vmhost_api_object (line: 1037)
|25618|2:2|new| (-5) VMware.pm, initialize (line: 224)
|25618|2:2|new| (-6) Module.pm, new (line: 159)
|25618|2:2|new| ---- WARNING ----
|25618|2:2|new| 2011-01-03 15:45:16|25618|2:2|new|VMware.pm:get_vmhost_api_object(1040)|API object could not be created: VCL::Module::Provisioning::VMware::vSphere_SDK, no eval error
|25618|2:2|new| ( 0) utils.pm, notify (line: 630)
|25618|2:2|new| (-1) VMware.pm, get_vmhost_api_object (line: 1040)
|25618|2:2|new| (-2) VMware.pm, initialize (line: 224)
|25618|2:2|new| (-3) Module.pm, new (line: 159)
|25618|2:2|new| (-4) State.pm, initialize (line: 127)
|25618|2:2|new| (-5) Module.pm, new (line: 159)
|25618|2:2|new| (-6) vcld, make_new_child (line: 591)
2011-01-03 15:45:16|25618|2:2|new|VMware.pm:initialize(240)|attempting to create OS object for the image currently loaded on the VM host: vmhost
|25618|2:2|new| image name: noimage
|25618|2:2|new| OS module: VCL::Module::OS::Linux::UnixLab
2011-01-03 15:45:16|25618|2:2|new|DataStructure.pm:_initialize(594)|computer ID argument was specified, retrieving data for computer ID: 1
2011-01-03 15:45:16|25618|2:2|new|VMware.pm:get_vmhost_datastructure(923)|created DataStructure object for VM host: vmhost
2011-01-03 15:45:16|25618|2:2|new|VMware.pm:get_vmhost_os_object(965)|attempting to load VM host OS module: VCL::Module::OS::Linux::UnixLab
2011-01-03 15:45:16|25618|2:2|new|VMware.pm:get_vmhost_os_object(971)|VM host OS module loaded: VCL::Module::OS::Linux::UnixLab
2011-01-03 15:45:16|25618|2:2|new|Module.pm:new(134)|constructor called, class=VCL::Module::OS::Linux::UnixLab
2011-01-03 15:45:16|25618|2:2|new|Module.pm:new(156)|VCL::Module::OS::Linux::UnixLab object created
2011-01-03 15:45:16|25618|2:2|new|VMware.pm:get_vmhost_os_object(977)|VM host OS object created: VCL::Module::OS::Linux::UnixLab
2011-01-03 15:45:16|25618|2:2|new|VMware.pm:initialize(241)|created OS object to control the OS of VM host: vmhost
2011-01-03 15:45:16|25618|2:2|new|utils.pm:nmap_port(2708)|port 22 is open on vmhost
2011-01-03 15:45:16|25618|2:2|new|utils.pm:nmap_port(2716)|port 24 is closed on vmhost
2011-01-03 15:45:16|25618|2:2|new|OS.pm:is_ssh_responding(430)|vmhost is responding to SSH, port 22: open, port 24: closed
2011-01-03 15:45:16|25618|2:2|new|VMware.pm:initialize(250)|OS of VM host vmhost will be controlled via SSH using OS object: VCL::Module::OS::Linux::UnixLab
2011-01-03 15:45:16|25618|2:2|new|DataStructure.pm:_initialize(594)|computer ID argument was specified, retrieving data for computer ID: 1
2011-01-03 15:45:16|25618|2:2|new|VMware.pm:get_vmhost_datastructure(923)|created DataStructure object for VM host: vmhost
2011-01-03 15:45:16|25618|2:2|new|VMware.pm:get_vmhost_api_object(1027)|attempting to load VMware control module: VCL::Module::Provisioning::VMware::VIM_SSH
2011-01-03 15:45:16|25618|2:2|new|VMware.pm:get_vmhost_api_object(1033)|loaded VMware control module: VCL::Module::Provisioning::VMware::VIM_SSH
2011-01-03 15:45:16|25618|2:2|new|Module.pm:new(134)|constructor called, class=VCL::Module::Provisioning::VMware::VIM_SSH
2011-01-03 15:45:16|25618|2:2|new|Module.pm:new(156)|VCL::Module::Provisioning::VMware::VIM_SSH object created
2011-01-03 15:45:16|25618|2:2|new|VIM_SSH.pm:initialize(126)|failed to determine which VIM executable is available on the VM host, output:
|25618|2:2|new| bash: vim-cmd: command not found
|25618|2:2|new| bash: vmware-vim-cmd: command not found
|25618|2:2|new| ---- WARNING ----
|25618|2:2|new| 2011-01-03 15:45:16|25618|2:2|new|VMware.pm:get_vmhost_api_object(1040)|API object could not be created: VCL::Module::Provisioning::VMware::VIM_SSH, no eval error
|25618|2:2|new| ( 0) utils.pm, notify (line: 630)
|25618|2:2|new| (-1) VMware.pm, get_vmhost_api_object (line: 1040)
|25618|2:2|new| (-2) VMware.pm, initialize (line: 264)
|25618|2:2|new| (-3) Module.pm, new (line: 159)
|25618|2:2|new| (-4) State.pm, initialize (line: 127)
|25618|2:2|new| (-5) Module.pm, new (line: 159)
|25618|2:2|new| (-6) vcld, make_new_child (line: 591)
|25618|2:2|new| ---- WARNING ----
|25618|2:2|new| 2011-01-03 15:45:16|25618|2:2|new|VMware.pm:initialize(271)|failed to create an API object to control the VM: vmguest-1
|25618|2:2|new| ( 0) utils.pm, notify (line: 630)
|25618|2:2|new| (-1) VMware.pm, initialize (line: 271)
|25618|2:2|new| (-2) Module.pm, new (line: 159)
|25618|2:2|new| (-3) State.pm, initialize (line: 127)
|25618|2:2|new| (-4) Module.pm, new (line: 159)
|25618|2:2|new| (-5) vcld, make_new_child (line: 591)
|25618|2:2|new| (-6) vcld, main (line: 342)
|25618|2:2|new| ---- WARNING ----
|25618|2:2|new| 2011-01-03 15:45:16|25618|2:2|new|State.pm:initialize(132)|provisioning object could not be created, returning 0
|25618|2:2|new| ( 0) utils.pm, notify (line: 630)
|25618|2:2|new| (-1) State.pm, initialize (line: 132)
|25618|2:2|new| (-2) Module.pm, new (line: 159)
|25618|2:2|new| (-3) vcld, make_new_child (line: 591)
|25618|2:2|new| (-4) vcld, main (line: 342)
Mike Waldron
Systems Specialist
ITS Research Computing
University of North Carolina at Chapel Hill
CB #3420, ITS Manning, Rm 2509
919-962-9778
________________________________________
From: Aaron Peeler [aaron_peeler@ncsu.edu]
Sent: Monday, January 03, 2011 11:07 AM
To: vcl-dev@incubator.apache.org
Subject: Re: Can't locate VMware/VIRuntime.pm
Hi Patrick,
Make sure you have the vsphere SDK for perl toolkit installed on the
management node. Version 4.1 should work well. This will get you past
the module load failure.
Aaron
On 1/2/11 4:34 PM, James Patrick Sigmon wrote:
> Hey guys,
>
> I've been trying to make a reservation using the VCL 2.2 and I've been running into the following error:
>
> "Can't locate VMware/VIRuntime.pm"
>
> And if I look at up the vcld.log I notice this:
>
> 2011-01-02 16:11:43|23951|2:2|deleted|VMware.pm:get_vmhost_api_object(1027)|attempting to load VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
>
> Now as far as I know, vSphere is used for ESX/ESXi, but in my VCL instance I'm using VMware server 2. I assume this to be the reason why I'm getting this error. My question is where and how can I fix this.
>
> I have the vmhost profile set to : VMware Server 2.x - local storage.
>
> Below is the full output for the error.
>
> Thanks,
>
> Patrick Sigmon
>
> 2011-01-02 15:22:02|6857|3:3|reload|utils.pm:reservation_being_processed(9010)|computerloadlog 'begin' entry does NOT exist for reservation 3
> 2011-01-02 15:22:02|6857|3:3|reload|utils.pm:run_command(9082)|executed command: pgrep -fl 'vcld [0-9]+:3 ', pid: 12243, exit status: 1, output:
> 2011-01-02 15:22:02|6857|3:3|reload|utils.pm:is_management_node_process_running(9259)|process is NOT running, identifier: 'vcld [0-9]+:3 '
> 2011-01-02 15:22:02|6857|3:3|reload|utils.pm:reservation_being_processed(9031)|reservation is NOT currently being processed
> 2011-01-02 15:22:02|6857|3:3|reload|vcld:main(277)|reservation 3 is NOT already being processed
> 2011-01-02 15:22:03|6857|3:3|reload|utils.pm:get_request_info(4589)|standalone affiliation found: Local
> 2011-01-02 15:22:03|6857|3:3|reload|utils.pm:get_request_info(4596)|found NULL uid setting standalone flag: vclreload, uid: NULL
> 2011-01-02 15:22:03|6857|3:3|reload|vcld:main(282)|retrieved request information from database
> 2011-01-02 15:22:03|6857|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
> 2011-01-02 15:22:03|6857|3:3|reload|utils.pm:update_request_state(2049)|request 3 state updated to: pending, laststate to: reload
> 2011-01-02 15:22:03|6857|3:3|reload|utils.pm:insertloadlog(3933)|inserted computer=2, begin, beginning to process, state is reload
> 2011-01-02 15:22:03|6857|3:3|reload|vcld:make_new_child(502)|request will be processed by new.pm
> 2011-01-02 15:22:03|6857|3:3|reload|vcld:make_new_child(510)|loaded VCL::new module
> 2011-01-02 15:22:03|12245|3:3|reload|vcld:make_new_child(583)|vcld environment variable set to 0 for this process
> 2011-01-02 15:22:03|12245|3:3|reload|Module.pm:new(134)|constructor called, class=VCL::new
> 2011-01-02 15:22:03|12245|3:3|reload|Module.pm:new(156)|VCL::new object created
> 2011-01-02 15:22:03|6857|3:3|reload|vcld:make_new_child(567)|current number of forked kids: 1
> 2011-01-02 15:22:04|12245|3:3|reload|State.pm:initialize(85)|obtained a database handle for this state process, stored as $ENV{dbh}
> 2011-01-02 15:22:04|12245|3:3|reload|State.pm:check_image_os(817)|no corrections need to be made, not an imaging request, returning 1
> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7183)|reservation count: 1
> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7202)|PARENTIMAGE: 1
> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7203)|SUBIMAGE: 0
> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7221)|renamed process to 'vcld 3:3 reload vmguest-1 vmwarelinux-CentOSBase-v0 vclreload'
> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
> 2011-01-02 15:22:04|12245|3:3|reload|State.pm:initialize(118)|attempting to load provisioning module: VCL::Module::Provisioning::VMware::VMware
> 2011-01-02 15:22:04|12245|3:3|reload|State.pm:initialize(124)|VCL::Module::Provisioning::VMware::VMware module loaded
> 2011-01-02 15:22:04|12245|3:3|reload|Module.pm:new(134)|constructor called, class=VCL::Module::Provisioning::VMware::VMware
> 2011-01-02 15:22:04|12245|3:3|reload|Module.pm:new(156)|VCL::Module::Provisioning::VMware::VMware object created
> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:_initialize(594)|computer ID argument was specified, retrieving data for computer ID: 3
> 2011-01-02 15:22:04|12245|3:3|reload|VMware.pm:get_vmhost_datastructure(923)|created DataStructure object for VM host: vcl
> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:_initialize(594)|computer ID argument was specified, retrieving data for computer ID: 3
> 2011-01-02 15:22:04|12245|3:3|reload|VMware.pm:get_vmhost_datastructure(923)|created DataStructure object for VM host: vcl
> 2011-01-02 15:22:04|12245|3:3|reload|VMware.pm:get_vmhost_api_object(1027)|attempting to load VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:mail(1247)|SUCCESS -- Sending mail To: 0, PROBLEM -- vcld
>
> |12245|3:3|reload| ---- CRITICAL ----
> |12245|3:3|reload| 2011-01-02 15:22:04|12245|3:3|reload|vcld:die_handler(663)|Can't locate VMware/VIRuntime.pm in @INC (@INC contains: /usr/local/vcl/bin/../../../.. /usr/local/vcl/bin/../.. /usr/local/vcl/bin/.. /usr/local/vcl/bin/../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 /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/local/vcl/bin/../lib/VCL/Module/Provisioning/VMware/vSphere_SDK.pm line 64.
> |12245|3:3|reload| ( 0) utils.pm, notify (line: 630)
> |12245|3:3|reload| (-1) vcld, die_handler (line: 663)
> |12245|3:3|reload| (-2) vSphere_SDK.pm, BEGIN (line: 64)
> |12245|3:3|reload| (-3) VIRuntime.pm, (eval) (line: 64)
> |12245|3:3|reload| (-4) VIRuntime.pm, (eval) (line: 64)
> |12245|3:3|reload| (-5) (eval 166), BEGIN (line: 2)
> |12245|3:3|reload| (-6) VIRuntime.pm, (eval) (line: 64)
>
> 2011-01-02 15:22:04|6857|vcld:REAPER(745)|VCL process exited for reservation 3, PID: 12245, signal: CHLD
>
--
Aaron Peeler
Program Manager
Virtual Computing Lab
NC State University
aaron_peeler@ncsu.edu
919-513-4571
RE: Can't locate VMware/VIRuntime.pm
Posted by "Waldron, Michael H" <mw...@email.unc.edu>.
I encountered the same error in a VCL 2.2 test environment that I'm setting up, although I'm using VMware server 1.x since that's what we're using in our VCL 2.1 production environment. I'm trying to duplicate the problems we experienced in our production environment when we attempted to upgrade to 2.2. I'm using the procedure for creating a standalone VMware VCL environment that's on the VCL website.
I installed the vsphere SDK for perl toolkit as suggested, and it got past the module load error, however it fails shortly thereafter because it can't find the vim-cmd or vmware-vim-cmd commands on the VM host. From what I've read, these are part of a VI-toolkit package that supports VMware server 2.x. Any ideas how to get around this? The relevant log snippet is below.
2011-01-03 15:45:16|25618|2:2|new|State.pm:initialize(118)|attempting to load provisioning module: VCL::Module::Provisioning::VMware::VMware
2011-01-03 15:45:16|25618|2:2|new|State.pm:initialize(124)|VCL::Module::Provisioning::VMware::VMware module loaded
2011-01-03 15:45:16|25618|2:2|new|Module.pm:new(134)|constructor called, class=VCL::Module::Provisioning::VMware::VMware
2011-01-03 15:45:16|25618|2:2|new|Module.pm:new(156)|VCL::Module::Provisioning::VMware::VMware object created
2011-01-03 15:45:16|25618|2:2|new|DataStructure.pm:_initialize(594)|computer ID argument was specified, retrieving data for computer ID: 1
2011-01-03 15:45:16|25618|2:2|new|VMware.pm:get_vmhost_datastructure(923)|created DataStructure object for VM host: vmhost
2011-01-03 15:45:16|25618|2:2|new|DataStructure.pm:_initialize(594)|computer ID argument was specified, retrieving data for computer ID: 1
2011-01-03 15:45:16|25618|2:2|new|VMware.pm:get_vmhost_datastructure(923)|created DataStructure object for VM host: vmhost
2011-01-03 15:45:16|25618|2:2|new|VMware.pm:get_vmhost_api_object(1027)|attempting to load VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
2011-01-03 15:45:16|25618|2:2|new|VMware.pm:get_vmhost_api_object(1033)|loaded VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
2011-01-03 15:45:16|25618|2:2|new|Module.pm:new(134)|constructor called, class=VCL::Module::Provisioning::VMware::vSphere_SDK
2011-01-03 15:45:16|25618|2:2|new|Module.pm:new(156)|VCL::Module::Provisioning::VMware::vSphere_SDK object created
|25618|2:2|new| ---- WARNING ----
|25618|2:2|new| 2011-01-03 15:45:16|25618|2:2|new|vSphere_SDK.pm:initialize(1789)|VM host password is not configured in the database for the VM profile
|25618|2:2|new| ( 0) utils.pm, notify (line: 630)
|25618|2:2|new| (-1) vSphere_SDK.pm, initialize (line: 1789)
|25618|2:2|new| (-2) Module.pm, new (line: 159)
|25618|2:2|new| (-3) VMware.pm, (eval) (line: 1037)
|25618|2:2|new| (-4) VMware.pm, get_vmhost_api_object (line: 1037)
|25618|2:2|new| (-5) VMware.pm, initialize (line: 224)
|25618|2:2|new| (-6) Module.pm, new (line: 159)
|25618|2:2|new| ---- WARNING ----
|25618|2:2|new| 2011-01-03 15:45:16|25618|2:2|new|VMware.pm:get_vmhost_api_object(1040)|API object could not be created: VCL::Module::Provisioning::VMware::vSphere_SDK, no eval error
|25618|2:2|new| ( 0) utils.pm, notify (line: 630)
|25618|2:2|new| (-1) VMware.pm, get_vmhost_api_object (line: 1040)
|25618|2:2|new| (-2) VMware.pm, initialize (line: 224)
|25618|2:2|new| (-3) Module.pm, new (line: 159)
|25618|2:2|new| (-4) State.pm, initialize (line: 127)
|25618|2:2|new| (-5) Module.pm, new (line: 159)
|25618|2:2|new| (-6) vcld, make_new_child (line: 591)
2011-01-03 15:45:16|25618|2:2|new|VMware.pm:initialize(240)|attempting to create OS object for the image currently loaded on the VM host: vmhost
|25618|2:2|new| image name: noimage
|25618|2:2|new| OS module: VCL::Module::OS::Linux::UnixLab
2011-01-03 15:45:16|25618|2:2|new|DataStructure.pm:_initialize(594)|computer ID argument was specified, retrieving data for computer ID: 1
2011-01-03 15:45:16|25618|2:2|new|VMware.pm:get_vmhost_datastructure(923)|created DataStructure object for VM host: vmhost
2011-01-03 15:45:16|25618|2:2|new|VMware.pm:get_vmhost_os_object(965)|attempting to load VM host OS module: VCL::Module::OS::Linux::UnixLab
2011-01-03 15:45:16|25618|2:2|new|VMware.pm:get_vmhost_os_object(971)|VM host OS module loaded: VCL::Module::OS::Linux::UnixLab
2011-01-03 15:45:16|25618|2:2|new|Module.pm:new(134)|constructor called, class=VCL::Module::OS::Linux::UnixLab
2011-01-03 15:45:16|25618|2:2|new|Module.pm:new(156)|VCL::Module::OS::Linux::UnixLab object created
2011-01-03 15:45:16|25618|2:2|new|VMware.pm:get_vmhost_os_object(977)|VM host OS object created: VCL::Module::OS::Linux::UnixLab
2011-01-03 15:45:16|25618|2:2|new|VMware.pm:initialize(241)|created OS object to control the OS of VM host: vmhost
2011-01-03 15:45:16|25618|2:2|new|utils.pm:nmap_port(2708)|port 22 is open on vmhost
2011-01-03 15:45:16|25618|2:2|new|utils.pm:nmap_port(2716)|port 24 is closed on vmhost
2011-01-03 15:45:16|25618|2:2|new|OS.pm:is_ssh_responding(430)|vmhost is responding to SSH, port 22: open, port 24: closed
2011-01-03 15:45:16|25618|2:2|new|VMware.pm:initialize(250)|OS of VM host vmhost will be controlled via SSH using OS object: VCL::Module::OS::Linux::UnixLab
2011-01-03 15:45:16|25618|2:2|new|DataStructure.pm:_initialize(594)|computer ID argument was specified, retrieving data for computer ID: 1
2011-01-03 15:45:16|25618|2:2|new|VMware.pm:get_vmhost_datastructure(923)|created DataStructure object for VM host: vmhost
2011-01-03 15:45:16|25618|2:2|new|VMware.pm:get_vmhost_api_object(1027)|attempting to load VMware control module: VCL::Module::Provisioning::VMware::VIM_SSH
2011-01-03 15:45:16|25618|2:2|new|VMware.pm:get_vmhost_api_object(1033)|loaded VMware control module: VCL::Module::Provisioning::VMware::VIM_SSH
2011-01-03 15:45:16|25618|2:2|new|Module.pm:new(134)|constructor called, class=VCL::Module::Provisioning::VMware::VIM_SSH
2011-01-03 15:45:16|25618|2:2|new|Module.pm:new(156)|VCL::Module::Provisioning::VMware::VIM_SSH object created
2011-01-03 15:45:16|25618|2:2|new|VIM_SSH.pm:initialize(126)|failed to determine which VIM executable is available on the VM host, output:
|25618|2:2|new| bash: vim-cmd: command not found
|25618|2:2|new| bash: vmware-vim-cmd: command not found
|25618|2:2|new| ---- WARNING ----
|25618|2:2|new| 2011-01-03 15:45:16|25618|2:2|new|VMware.pm:get_vmhost_api_object(1040)|API object could not be created: VCL::Module::Provisioning::VMware::VIM_SSH, no eval error
|25618|2:2|new| ( 0) utils.pm, notify (line: 630)
|25618|2:2|new| (-1) VMware.pm, get_vmhost_api_object (line: 1040)
|25618|2:2|new| (-2) VMware.pm, initialize (line: 264)
|25618|2:2|new| (-3) Module.pm, new (line: 159)
|25618|2:2|new| (-4) State.pm, initialize (line: 127)
|25618|2:2|new| (-5) Module.pm, new (line: 159)
|25618|2:2|new| (-6) vcld, make_new_child (line: 591)
|25618|2:2|new| ---- WARNING ----
|25618|2:2|new| 2011-01-03 15:45:16|25618|2:2|new|VMware.pm:initialize(271)|failed to create an API object to control the VM: vmguest-1
|25618|2:2|new| ( 0) utils.pm, notify (line: 630)
|25618|2:2|new| (-1) VMware.pm, initialize (line: 271)
|25618|2:2|new| (-2) Module.pm, new (line: 159)
|25618|2:2|new| (-3) State.pm, initialize (line: 127)
|25618|2:2|new| (-4) Module.pm, new (line: 159)
|25618|2:2|new| (-5) vcld, make_new_child (line: 591)
|25618|2:2|new| (-6) vcld, main (line: 342)
|25618|2:2|new| ---- WARNING ----
|25618|2:2|new| 2011-01-03 15:45:16|25618|2:2|new|State.pm:initialize(132)|provisioning object could not be created, returning 0
|25618|2:2|new| ( 0) utils.pm, notify (line: 630)
|25618|2:2|new| (-1) State.pm, initialize (line: 132)
|25618|2:2|new| (-2) Module.pm, new (line: 159)
|25618|2:2|new| (-3) vcld, make_new_child (line: 591)
|25618|2:2|new| (-4) vcld, main (line: 342)
Mike Waldron
Systems Specialist
ITS Research Computing
University of North Carolina at Chapel Hill
CB #3420, ITS Manning, Rm 2509
919-962-9778
________________________________________
From: Aaron Peeler [aaron_peeler@ncsu.edu]
Sent: Monday, January 03, 2011 11:07 AM
To: vcl-dev@incubator.apache.org
Subject: Re: Can't locate VMware/VIRuntime.pm
Hi Patrick,
Make sure you have the vsphere SDK for perl toolkit installed on the
management node. Version 4.1 should work well. This will get you past
the module load failure.
Aaron
On 1/2/11 4:34 PM, James Patrick Sigmon wrote:
> Hey guys,
>
> I've been trying to make a reservation using the VCL 2.2 and I've been running into the following error:
>
> "Can't locate VMware/VIRuntime.pm"
>
> And if I look at up the vcld.log I notice this:
>
> 2011-01-02 16:11:43|23951|2:2|deleted|VMware.pm:get_vmhost_api_object(1027)|attempting to load VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
>
> Now as far as I know, vSphere is used for ESX/ESXi, but in my VCL instance I'm using VMware server 2. I assume this to be the reason why I'm getting this error. My question is where and how can I fix this.
>
> I have the vmhost profile set to : VMware Server 2.x - local storage.
>
> Below is the full output for the error.
>
> Thanks,
>
> Patrick Sigmon
>
> 2011-01-02 15:22:02|6857|3:3|reload|utils.pm:reservation_being_processed(9010)|computerloadlog 'begin' entry does NOT exist for reservation 3
> 2011-01-02 15:22:02|6857|3:3|reload|utils.pm:run_command(9082)|executed command: pgrep -fl 'vcld [0-9]+:3 ', pid: 12243, exit status: 1, output:
> 2011-01-02 15:22:02|6857|3:3|reload|utils.pm:is_management_node_process_running(9259)|process is NOT running, identifier: 'vcld [0-9]+:3 '
> 2011-01-02 15:22:02|6857|3:3|reload|utils.pm:reservation_being_processed(9031)|reservation is NOT currently being processed
> 2011-01-02 15:22:02|6857|3:3|reload|vcld:main(277)|reservation 3 is NOT already being processed
> 2011-01-02 15:22:03|6857|3:3|reload|utils.pm:get_request_info(4589)|standalone affiliation found: Local
> 2011-01-02 15:22:03|6857|3:3|reload|utils.pm:get_request_info(4596)|found NULL uid setting standalone flag: vclreload, uid: NULL
> 2011-01-02 15:22:03|6857|3:3|reload|vcld:main(282)|retrieved request information from database
> 2011-01-02 15:22:03|6857|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
> 2011-01-02 15:22:03|6857|3:3|reload|utils.pm:update_request_state(2049)|request 3 state updated to: pending, laststate to: reload
> 2011-01-02 15:22:03|6857|3:3|reload|utils.pm:insertloadlog(3933)|inserted computer=2, begin, beginning to process, state is reload
> 2011-01-02 15:22:03|6857|3:3|reload|vcld:make_new_child(502)|request will be processed by new.pm
> 2011-01-02 15:22:03|6857|3:3|reload|vcld:make_new_child(510)|loaded VCL::new module
> 2011-01-02 15:22:03|12245|3:3|reload|vcld:make_new_child(583)|vcld environment variable set to 0 for this process
> 2011-01-02 15:22:03|12245|3:3|reload|Module.pm:new(134)|constructor called, class=VCL::new
> 2011-01-02 15:22:03|12245|3:3|reload|Module.pm:new(156)|VCL::new object created
> 2011-01-02 15:22:03|6857|3:3|reload|vcld:make_new_child(567)|current number of forked kids: 1
> 2011-01-02 15:22:04|12245|3:3|reload|State.pm:initialize(85)|obtained a database handle for this state process, stored as $ENV{dbh}
> 2011-01-02 15:22:04|12245|3:3|reload|State.pm:check_image_os(817)|no corrections need to be made, not an imaging request, returning 1
> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7183)|reservation count: 1
> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7202)|PARENTIMAGE: 1
> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7203)|SUBIMAGE: 0
> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7221)|renamed process to 'vcld 3:3 reload vmguest-1 vmwarelinux-CentOSBase-v0 vclreload'
> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
> 2011-01-02 15:22:04|12245|3:3|reload|State.pm:initialize(118)|attempting to load provisioning module: VCL::Module::Provisioning::VMware::VMware
> 2011-01-02 15:22:04|12245|3:3|reload|State.pm:initialize(124)|VCL::Module::Provisioning::VMware::VMware module loaded
> 2011-01-02 15:22:04|12245|3:3|reload|Module.pm:new(134)|constructor called, class=VCL::Module::Provisioning::VMware::VMware
> 2011-01-02 15:22:04|12245|3:3|reload|Module.pm:new(156)|VCL::Module::Provisioning::VMware::VMware object created
> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:_initialize(594)|computer ID argument was specified, retrieving data for computer ID: 3
> 2011-01-02 15:22:04|12245|3:3|reload|VMware.pm:get_vmhost_datastructure(923)|created DataStructure object for VM host: vcl
> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:_initialize(594)|computer ID argument was specified, retrieving data for computer ID: 3
> 2011-01-02 15:22:04|12245|3:3|reload|VMware.pm:get_vmhost_datastructure(923)|created DataStructure object for VM host: vcl
> 2011-01-02 15:22:04|12245|3:3|reload|VMware.pm:get_vmhost_api_object(1027)|attempting to load VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:mail(1247)|SUCCESS -- Sending mail To: 0, PROBLEM -- vcld
>
> |12245|3:3|reload| ---- CRITICAL ----
> |12245|3:3|reload| 2011-01-02 15:22:04|12245|3:3|reload|vcld:die_handler(663)|Can't locate VMware/VIRuntime.pm in @INC (@INC contains: /usr/local/vcl/bin/../../../.. /usr/local/vcl/bin/../.. /usr/local/vcl/bin/.. /usr/local/vcl/bin/../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 /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/local/vcl/bin/../lib/VCL/Module/Provisioning/VMware/vSphere_SDK.pm line 64.
> |12245|3:3|reload| ( 0) utils.pm, notify (line: 630)
> |12245|3:3|reload| (-1) vcld, die_handler (line: 663)
> |12245|3:3|reload| (-2) vSphere_SDK.pm, BEGIN (line: 64)
> |12245|3:3|reload| (-3) VIRuntime.pm, (eval) (line: 64)
> |12245|3:3|reload| (-4) VIRuntime.pm, (eval) (line: 64)
> |12245|3:3|reload| (-5) (eval 166), BEGIN (line: 2)
> |12245|3:3|reload| (-6) VIRuntime.pm, (eval) (line: 64)
>
> 2011-01-02 15:22:04|6857|vcld:REAPER(745)|VCL process exited for reservation 3, PID: 12245, signal: CHLD
>
--
Aaron Peeler
Program Manager
Virtual Computing Lab
NC State University
aaron_peeler@ncsu.edu
919-513-4571
Re: Can't locate VMware/VIRuntime.pm
Posted by Aaron Peeler <aa...@ncsu.edu>.
Hi Patrick,
Make sure you have the vsphere SDK for perl toolkit installed on the
management node. Version 4.1 should work well. This will get you past
the module load failure.
Aaron
On 1/2/11 4:34 PM, James Patrick Sigmon wrote:
> Hey guys,
>
> I've been trying to make a reservation using the VCL 2.2 and I've been running into the following error:
>
> "Can't locate VMware/VIRuntime.pm"
>
> And if I look at up the vcld.log I notice this:
>
> 2011-01-02 16:11:43|23951|2:2|deleted|VMware.pm:get_vmhost_api_object(1027)|attempting to load VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
>
> Now as far as I know, vSphere is used for ESX/ESXi, but in my VCL instance I'm using VMware server 2. I assume this to be the reason why I'm getting this error. My question is where and how can I fix this.
>
> I have the vmhost profile set to : VMware Server 2.x - local storage.
>
> Below is the full output for the error.
>
> Thanks,
>
> Patrick Sigmon
>
> 2011-01-02 15:22:02|6857|3:3|reload|utils.pm:reservation_being_processed(9010)|computerloadlog 'begin' entry does NOT exist for reservation 3
> 2011-01-02 15:22:02|6857|3:3|reload|utils.pm:run_command(9082)|executed command: pgrep -fl 'vcld [0-9]+:3 ', pid: 12243, exit status: 1, output:
> 2011-01-02 15:22:02|6857|3:3|reload|utils.pm:is_management_node_process_running(9259)|process is NOT running, identifier: 'vcld [0-9]+:3 '
> 2011-01-02 15:22:02|6857|3:3|reload|utils.pm:reservation_being_processed(9031)|reservation is NOT currently being processed
> 2011-01-02 15:22:02|6857|3:3|reload|vcld:main(277)|reservation 3 is NOT already being processed
> 2011-01-02 15:22:03|6857|3:3|reload|utils.pm:get_request_info(4589)|standalone affiliation found: Local
> 2011-01-02 15:22:03|6857|3:3|reload|utils.pm:get_request_info(4596)|found NULL uid setting standalone flag: vclreload, uid: NULL
> 2011-01-02 15:22:03|6857|3:3|reload|vcld:main(282)|retrieved request information from database
> 2011-01-02 15:22:03|6857|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
> 2011-01-02 15:22:03|6857|3:3|reload|utils.pm:update_request_state(2049)|request 3 state updated to: pending, laststate to: reload
> 2011-01-02 15:22:03|6857|3:3|reload|utils.pm:insertloadlog(3933)|inserted computer=2, begin, beginning to process, state is reload
> 2011-01-02 15:22:03|6857|3:3|reload|vcld:make_new_child(502)|request will be processed by new.pm
> 2011-01-02 15:22:03|6857|3:3|reload|vcld:make_new_child(510)|loaded VCL::new module
> 2011-01-02 15:22:03|12245|3:3|reload|vcld:make_new_child(583)|vcld environment variable set to 0 for this process
> 2011-01-02 15:22:03|12245|3:3|reload|Module.pm:new(134)|constructor called, class=VCL::new
> 2011-01-02 15:22:03|12245|3:3|reload|Module.pm:new(156)|VCL::new object created
> 2011-01-02 15:22:03|6857|3:3|reload|vcld:make_new_child(567)|current number of forked kids: 1
> 2011-01-02 15:22:04|12245|3:3|reload|State.pm:initialize(85)|obtained a database handle for this state process, stored as $ENV{dbh}
> 2011-01-02 15:22:04|12245|3:3|reload|State.pm:check_image_os(817)|no corrections need to be made, not an imaging request, returning 1
> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7183)|reservation count: 1
> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7202)|PARENTIMAGE: 1
> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7203)|SUBIMAGE: 0
> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:rename_vcld_process(7221)|renamed process to 'vcld 3:3 reload vmguest-1 vmwarelinux-CentOSBase-v0 vclreload'
> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3
> 2011-01-02 15:22:04|12245|3:3|reload|State.pm:initialize(118)|attempting to load provisioning module: VCL::Module::Provisioning::VMware::VMware
> 2011-01-02 15:22:04|12245|3:3|reload|State.pm:initialize(124)|VCL::Module::Provisioning::VMware::VMware module loaded
> 2011-01-02 15:22:04|12245|3:3|reload|Module.pm:new(134)|constructor called, class=VCL::Module::Provisioning::VMware::VMware
> 2011-01-02 15:22:04|12245|3:3|reload|Module.pm:new(156)|VCL::Module::Provisioning::VMware::VMware object created
> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:_initialize(594)|computer ID argument was specified, retrieving data for computer ID: 3
> 2011-01-02 15:22:04|12245|3:3|reload|VMware.pm:get_vmhost_datastructure(923)|created DataStructure object for VM host: vcl
> 2011-01-02 15:22:04|12245|3:3|reload|DataStructure.pm:_initialize(594)|computer ID argument was specified, retrieving data for computer ID: 3
> 2011-01-02 15:22:04|12245|3:3|reload|VMware.pm:get_vmhost_datastructure(923)|created DataStructure object for VM host: vcl
> 2011-01-02 15:22:04|12245|3:3|reload|VMware.pm:get_vmhost_api_object(1027)|attempting to load VMware control module: VCL::Module::Provisioning::VMware::vSphere_SDK
> 2011-01-02 15:22:04|12245|3:3|reload|utils.pm:mail(1247)|SUCCESS -- Sending mail To: 0, PROBLEM -- vcld
>
> |12245|3:3|reload| ---- CRITICAL ----
> |12245|3:3|reload| 2011-01-02 15:22:04|12245|3:3|reload|vcld:die_handler(663)|Can't locate VMware/VIRuntime.pm in @INC (@INC contains: /usr/local/vcl/bin/../../../.. /usr/local/vcl/bin/../.. /usr/local/vcl/bin/.. /usr/local/vcl/bin/../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 /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/local/vcl/bin/../lib/VCL/Module/Provisioning/VMware/vSphere_SDK.pm line 64.
> |12245|3:3|reload| ( 0) utils.pm, notify (line: 630)
> |12245|3:3|reload| (-1) vcld, die_handler (line: 663)
> |12245|3:3|reload| (-2) vSphere_SDK.pm, BEGIN (line: 64)
> |12245|3:3|reload| (-3) VIRuntime.pm, (eval) (line: 64)
> |12245|3:3|reload| (-4) VIRuntime.pm, (eval) (line: 64)
> |12245|3:3|reload| (-5) (eval 166), BEGIN (line: 2)
> |12245|3:3|reload| (-6) VIRuntime.pm, (eval) (line: 64)
>
> 2011-01-02 15:22:04|6857|vcld:REAPER(745)|VCL process exited for reservation 3, PID: 12245, signal: CHLD
>
--
Aaron Peeler
Program Manager
Virtual Computing Lab
NC State University
aaron_peeler@ncsu.edu
919-513-4571