New commit detected on cfme/5.3.z: https://code.engineering.redhat.com/gerrit/gitweb?p=cfme.git;a=commitdiff;h=8721876feb3236032173143210a9e98a21c627b8 commit 8721876feb3236032173143210a9e98a21c627b8 Author: Bronagh Sorota <bsorota> AuthorDate: Wed Dec 10 12:56:49 2014 -0500 Commit: Bronagh Sorota <bsorota> CommitDate: Mon Jan 5 15:28:56 2015 -0500 SCVMM: Virtual DVD drive support fix https://bugzilla.redhat.com/show_bug.cgi?id=1178961 vmdb/app/models/ems_refresh/parsers/ps_scripts/get_inventory.ps1 | 2 ++ vmdb/app/models/ems_refresh/parsers/scvmm.rb | 5 ++++- 2 files changed, 6 insertions(+), 1 deletion(-)
Verification Failed. Verified in 5.3.3.0.1.20150127115148_446974b. Added SCVMM provider. Upon clicking the "Refresh Relationship and Power States" show following message in UI "Refresh Infrastructure Providers initiated for 1 Infrastructure Provider from the CFME Database", However throws error message in evm.log file. Also the Relationships are not updated. evm.log: ======== [----] E, [2015-02-04T11:27:27.950156 #32454:52d014] ERROR -- : <SCVMM> MIQ(Class#log_dos_error_results) #< CLIXML <Objs Version="1.1.0.1" xmlns="http://schemas.microsoft.com/powershell/2004/04"><Obj S="progress" RefId="0"><TN RefId="0"><T>System.Management.Automation.PSCustomObject</T><T>System.Object</T></TN><MS><I64 N="SourceId">1</I64><PR N="Record"><AV>Preparing modules for first use.</AV><AI>0</AI><Nil /><PI>-1</PI><PC>-1</PC><T>Completed</T><SR>-1</SR><SD> </SD></PR></MS></Obj><Obj S="progress" RefId="1"><TNRef RefId="0" /><MS><I64 N="SourceId">2</I64><PR N="Record"><AV>Preparing modules for first use.</AV><AI>0</AI><Nil /><PI>-1</PI><PC>-1</PC><T>Completed</T><SR>-1</SR><SD> </SD></PR></MS></Obj><S S="Error">Exception calling "GetTempFileName" with "0" argument(s): "There is not enough _x000D__x000A_</S><S S="Error">space on the disk._x000D__x000A_</S><S S="Error">"_x000D__x000A_</S><S S="Error">At line:69 char:1_x000D__x000A_</S><S S="Error">+ $file = [System.IO.Path]::GetTempFileName()_x000D__x000A_</S><S S="Error">+ ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~_x000D__x000A_</S><S S="Error"> + CategoryInfo : NotSpecified: (:) [], MethodInvocationException_x000D__x000A_</S><S S="Error"> + FullyQualifiedErrorId : IOException_x000D__x000A_</S><S S="Error"> _x000D__x000A_</S><S S="Error">Read-SCGuestInfo : Virtual machine rhel65 cannot be modified because Virtual _x000D__x000A_</S><S S="Error">Guest Services is not installed on the guest operating system or because the _x000D__x000A_</S><S S="Error">installed Virtual Guest Services does not support the Heartbeat and Data _x000D__x000A_</S><S S="Error">Exchange Integration Services in the current virtual machine status. (Error _x000D__x000A_</S><S S="Error">ID: 30101)_x000D__x000A_</S><S S="Error"> _x000D__x000A_</S><S S="Error">Verify the virtual machine is in a Running status, the Virtual Guest Services _x000D__x000A_</S><S S="Error">is installed, and the Heartbeat and Data Exchange Integration Services are _x000D__x000A_</S><S S="Error">enabled._x000D__x000A_</S><S S="Error">At line:14 char:16_x000D__x000A_</S><S S="Error">+ $networks = Read-SCGuestInfo -VM $_ -Key "NetworkAddressIPv4"_x000D__x000A_</S><S S="Error">+ ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~_x000D__x000A_</S><S S="Error"> + CategoryInfo : ReadError: (:) [Read-SCGuestInfo], CarmineExcept _x000D__x000A_</S><S S="Error"> ion_x000D__x000A_</S><S S="Error"> + FullyQualifiedErrorId : 30101,Microsoft.SystemCenter.VirtualMachineManag _x000D__x000A_</S><S S="Error"> er.Cmdlets.ReadScGuestInfoCmdlet_x000D__x000A_</S><S S="Error">Index operation failed; the array index evaluated to null._x000D__x000A_</S><S S="Error">At line:63 char:3_x000D__x000A_</S><S S="Error">+ $results[$_.ID] = $cluster_hash_x000D__x000A_</S><S S="Error">+ ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~_x000D__x000A_</S><S S="Error"> + CategoryInfo : InvalidOperation: (:) [], RuntimeException_x000D__x000A_</S><S S="Error"> + FullyQualifiedErrorId : NullArrayIndex_x000D__x000A_</S><S S="Error"> _x000D__x000A_</S><S S="Error">Export-Clixml : Cannot bind argument to parameter 'Path' because it is null._x000D__x000A_</S><S S="Error">At line:87 char:26_x000D__x000A_</S><S S="Error">+ $r | Export-CLIXML -path $file -encoding UTF8_x000D__x000A_</S><S S="Error">+ ~~~~~_x000D__x000A_</S><S S="Error"> + CategoryInfo : InvalidData: (:) [Export-Clixml], ParameterBindi _x000D__x000A_</S><S S="Error"> ngValidationException_x000D__x000A_</S><S S="Error"> + FullyQualifiedErrorId : ParameterArgumentValidationErrorNullNotAllowed,M _x000D__x000A_</S><S S="Error"> icrosoft.PowerShell.Commands.ExportClixmlCommand_x000D__x000A_</S><S S="Error"> _x000D__x000A_</S><S S="Error">Get-Content : Cannot bind argument to parameter 'Path' because it is null._x000D__x000A_</S><S S="Error">At line:88 char:13_x000D__x000A_</S><S S="Error">+ get-content $file_x000D__x000A_</S><S S="Error">+ ~~~~~_x000D__x000A_</S><S S="Error"> + CategoryInfo : InvalidData: (:) [Get-Content], ParameterBinding _x000D__x000A_</S><S S="Error"> ValidationException_x000D__x000A_</S><S S="Error"> + FullyQualifiedErrorId : ParameterArgumentValidationErrorNullNotAllowed,M _x000D__x000A_</S><S S="Error"> icrosoft.PowerShell.Commands.GetContentCommand_x000D__x000A_</S><S S="Error"> _x000D__x000A_</S></Objs> [----] E, [2015-02-04T11:27:27.956126 #32454:52d014] ERROR -- : MIQ(MiqQueue.deliver) Message id: [149321], Error: [undefined method `each_element' for nil:NilClass] [----] E, [2015-02-04T11:27:27.956402 #32454:52d014] ERROR -- : [NoMethodError]: undefined method `each_element' for nil:NilClass Method:[rescue in deliver] [----] E, [2015-02-04T11:27:27.956546 #32454:52d014] ERROR -- : /var/www/miq/lib/util/win32/miq-powershell.rb:212:in `process_root' /var/www/miq/lib/util/win32/miq-powershell.rb:203:in `to_h' /var/www/miq/vmdb/app/models/ems_microsoft/powershell.rb:34:in `powershell_xml_to_hash' /var/www/miq/vmdb/app/models/ems_microsoft/powershell.rb:25:in `powershell_results_to_hash' /var/www/miq/vmdb/app/models/ems_microsoft/powershell.rb:7:in `execute_powershell' /var/www/miq/vmdb/app/models/ems_refresh/parsers/scvmm.rb:22:in `ems_inv_to_hashes' /var/www/miq/vmdb/app/models/ems_refresh/parsers/scvmm.rb:8:in `ems_inv_to_hashes' /var/www/miq/vmdb/app/models/ems_refresh/refreshers/scvmm_refresher.rb:23:in `block in refresh' /var/www/miq/vmdb/app/models/ems_refresh/refreshers/scvmm_refresher.rb:12:in `each' /var/www/miq/vmdb/app/models/ems_refresh/refreshers/scvmm_refresher.rb:12:in `refresh' /var/www/miq/vmdb/app/models/ems_refresh/refreshers/base_refresher.rb:8:in `refresh' /var/www/miq/vmdb/app/models/ems_refresh.rb:76:in `block in refresh' /var/www/miq/vmdb/app/models/ems_refresh.rb:75:in `each' /var/www/miq/vmdb/app/models/ems_refresh.rb:75:in `refresh' /var/www/miq/vmdb/app/models/miq_queue.rb:361:in `block in deliver' /opt/rh/ruby193/root/usr/share/ruby/timeout.rb:69:in `timeout' /var/www/miq/vmdb/app/models/miq_queue.rb:357:in `deliver' /var/www/miq/vmdb/lib/workers/queue_worker_base.rb:107:in `deliver_queue_message' /var/www/miq/vmdb/lib/workers/queue_worker_base.rb:135:in `deliver_message' /var/www/miq/vmdb/lib/workers/queue_worker_base.rb:152:in `block in do_work' /var/www/miq/vmdb/lib/workers/queue_worker_base.rb:146:in `loop' /var/www/miq/vmdb/lib/workers/queue_worker_base.rb:146:in `do_work' /var/www/miq/vmdb/lib/workers/worker_base.rb:317:in `block in do_work_loop' /var/www/miq/vmdb/lib/workers/worker_base.rb:314:in `loop' /var/www/miq/vmdb/lib/workers/worker_base.rb:314:in `do_work_loop' /var/www/miq/vmdb/lib/workers/worker_base.rb:135:in `run' /var/www/miq/vmdb/lib/workers/worker_base.rb:123:in `start' /var/www/miq/vmdb/lib/workers/worker_base.rb:23:in `start_worker' /var/www/miq/vmdb/lib/workers/bin/worker.rb:5:in `<top (required)>' /opt/rh/ruby193/root/usr/share/gems/gems/railties-3.2.17/lib/rails/commands/runner.rb:52:in `eval' /opt/rh/ruby193/root/usr/share/gems/gems/railties-3.2.17/lib/rails/commands/runner.rb:52:in `<top (required)>' /opt/rh/ruby193/root/usr/share/gems/gems/railties-3.2.17/lib/rails/commands.rb:64:in `require' /opt/rh/ruby193/root/usr/share/gems/gems/railties-3.2.17/lib/rails/commands.rb:64:in `<top (required)>' script/rails:6:in `require' script/rails:6:in `<main>' [----] I, [2015-02-04T11:27:27.956936 #32454:52d014] INFO -- : MIQ(MiqQueue.delivered) Message id: [149321], State: [error], Delivered in [11.623263508] seconds [----] I, [2015-02-04T11:27:28.597603 #2017:9ac004] INFO -- : MIQ(MiqServer.heartbeat) Heartbeat [2015-02-04 11:27:28 UTC]... [----] I, [2015-02-04T11:27:28.606580 #2017:9ac004] INFO -- : MIQ(MiqServer.heartbeat) Heartbeat [2015-02-04 11:27:28 UTC]...Complete [----] I, [2015-02-04T11:27:29.207448 #2017:9ac004] INFO -- : MIQ(MiqServer.populate_queue_messages) Fetched 1 miq_queue rows for queue_name=ems_1, wcount=3, priority=200 [----] I, [2015-02-04T11:27:30.678660 #2336:cc400c] INFO -- : MIQ(ScheduleWorker.do_work) Number of scheduled items to be processed: 2. [----] I, [2015-02-04T11:27:30.687500 #2336:cc400c] INFO -- : MIQ(MiqQueue.put) Message id: [149325], id: [], Zone: [default], Role: [], Server: [15b61240-a79a-11e4-b90b-00505696ef76], Ident: [generic], Target id: [], Instance id: [], Task id: [], Command: [Session.check_session_timeout], Timeout: [600], Priority: [90], State: [ready], Deliver On: [], Data: [], Args: [] [----] I, [2015-02-04T11:27:30.697649 #2336:cc400c] INFO -- : MIQ(MiqQueue.put) Message id: [149326], id: [], Zone: [default], Role: [smartstate], Server: [], Ident: [generic], Target id: [], Instance id: [], Task id: [job_dispatcher], Command: [JobProxyDispatcher.dispatch], Timeout: [600], Priority: [20], State: [ready], Deliver On: [], Data: [], Args: []
This does not look like the same error. this looks like invalid data was returned. Can you try to determine what is going on in the environment? Try logging into the SCVMM server, open up a powershell prompt and see if data is being returned by running this cmdlet: Get-SCVirtualMachine thanks
Hi Bronagh, I am able to see the data after running the command "Get-SCVirtualMachine". Thanks, Ramesh
Verified in 5.3.3.2.20150217120931_a465215 against 5.3.1.10.20141112120709_c36c424 When adding a VM without DVD drive in SCVMM and then doing refresh, 5.3.1.10 showed exactly the same error as described in Comment 1 and the VM did not appear. The VM appeared in 5.3.3.2 without any error message.
Since the problem described in this bug report should be resolved in a recent advisory, it has been closed with a resolution of ERRATA. For information on the advisory, and where to find the updated files, follow the link below. If the solution does not work for you, open a new bug report. https://rhn.redhat.com/errata/RHBA-2015-0261.html