Re: vmware 6.7 certifications test，“Dual_Host_Test...

092711 · ‎12-25-2018

I tried do vmware 6.7 certifications test， found “Dual_Host_Test::IMPI_ILO_Tests::hostopsupdateipmiPos003-IPMI_iLO” test failed， please check the test log . thanks！

2018-12-25 08:52:34 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:52:34.048Z INFO c.v.v.v.Task [monitorTask:495] [main] - Monitoring task end

2018-12-25 08:52:34 UTC [ DPMLAUNCHE] [0] INFO: ###### Monitoring task end #######

2018-12-25 08:52:34 UTC

2018-12-25 08:52:34 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:52:34.237Z INFO c.v.v.v.HostSystem [isHostConnected:2531] [main] - Is host in lockdown mode?: false

2018-12-25 08:52:34 UTC [ DPMLAUNCHE] [0] INFO: ###### Is host in lockdown mode?: false #######

2018-12-25 08:52:34 UTC

2018-12-25 08:52:34 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:52:34.237Z INFO c.v.v.v.HostSystem [isHostConnected:2534] [main] - Checking if host is accessible via SSH

2018-12-25 08:52:34 UTC [ DPMLAUNCHE] [0] INFO: ###### Checking if host is accessible via SSH #######

2018-12-25 08:52:34 UTC

2018-12-25 08:52:34 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:52:34.795Z INFO c.v.v.u.SSHUtil [getSSHConnection:136] [main] - Successfully connected to the remote ssh host: 172.16.33.104

2018-12-25 08:52:34 UTC [ DPMLAUNCHE] [0] INFO: ###### Successfully connected to the remote ssh host: 172.16.33.104 #######

2018-12-25 08:52:34 UTC

2018-12-25 08:52:34 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:52:34.795Z INFO c.v.v.v.HostSystem [isHostConnected:2551] [main] - HostSystemConnectionState is connected?: true

2018-12-25 08:52:34 UTC [ DPMLAUNCHE] [0] INFO: ###### HostSystemConnectionState is connected?: true #######

2018-12-25 08:52:35 UTC

2018-12-25 08:52:35 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:52:34.970Z INFO c.v.v.v.h.NetworkSystem [getNetworkSystem:128] [main] - HostConfigManager object properties

2018-12-25 08:52:35 UTC [ DPMLAUNCHE] [0] INFO: ###### HostConfigManager object properties #######

2018-12-25 08:52:35 UTC

2018-12-25 08:52:35 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:52:34.971Z INFO c.v.v.v.h.NetworkSystem [getNetworkSystem:129] [main] - Memory manager : com.vmware.vc.ManagedObjectReference@fa973b01

2018-12-25 08:52:35 UTC [ DPMLAUNCHE] [0] INFO: ###### Memory manager : com.vmware.vc.ManagedObjectReference@fa973b01 #######

2018-12-25 08:52:35 UTC

2018-12-25 08:52:35 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:52:34.971Z INFO c.v.v.v.h.NetworkSystem [getNetworkSystem:130] [main] - Storage system : com.vmware.vc.ManagedObjectReference@e62834fd

2018-12-25 08:52:35 UTC [ DPMLAUNCHE] [0] INFO: ###### Storage system : com.vmware.vc.ManagedObjectReference@e62834fd #######

2018-12-25 08:52:35 UTC

2018-12-25 08:52:35 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:52:34.971Z INFO c.v.v.v.h.NetworkSystem [getNetworkSystem:131] [main] - Network system : com.vmware.vc.ManagedObjectReference@c28f2d17

2018-12-25 08:52:35 UTC [ DPMLAUNCHE] [0] INFO: ###### Network system : com.vmware.vc.ManagedObjectReference@c28f2d17 #######

2018-12-25 08:52:35 UTC

2018-12-25 08:52:35 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:52:34.971Z INFO c.v.v.v.HostSystem [isHostConnectedToAnyDVS:5477] [main] - Refreshing the network system of the host

2018-12-25 08:52:35 UTC [ DPMLAUNCHE] [0] INFO: ###### Refreshing the network system of the host #######

2018-12-25 08:52:35 UTC

2018-12-25 08:52:35 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:52:34.972Z INFO c.v.v.GenericConnectAnchor$3 [handleMessage:292] [main] - Operation ID for the operation - RefreshNetworkSystem:: OpId-1545727954972

2018-12-25 08:52:35 UTC [ DPMLAUNCHE] [0] INFO: ###### 1545727954972 #######

2018-12-25 08:52:36 UTC

2018-12-25 08:52:36 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:52:36.077Z WARN c.v.v.v.HostSystem [isHostConnectedToAnyDVS:5513] [main] - Either the host network info is null or there are no proxy vswitches on the host

2018-12-25 08:52:36 UTC [ DPMLAUNCHE] [0] INFO: ###### Either the host network info is null or there are no proxy vswitches on the host #######

2018-12-25 08:52:36 UTC

2018-12-25 08:52:36 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:52:36.086Z INFO h.u.UpdateIpmiTestBase [clearIpmiInfo:265] [main] - Successfully blanked IPMI Info.

2018-12-25 08:52:36 UTC [ DPMLAUNCHE] [0] INFO: ###### Successfully blanked IPMI Info. #######

2018-12-25 08:52:36 UTC

2018-12-25 08:52:36 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:52:36.087Z INFO c.v.v.e.t.VmLogCollectionListener [beforeInvocation:131] [main] - VM log collection enabled.

2018-12-25 08:52:36 UTC [ DPMLAUNCHE] [0] INFO: ###### VM log collection enabled. #######

2018-12-25 08:52:36 UTC

2018-12-25 08:52:36 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:52:36.088Z INFO c.v.v.GenericConnectAnchor$3 [handleMessage:292] [main] - Operation ID for the operation - UpdateIpmi:: OpId-1545727956088

2018-12-25 08:52:36 UTC [ DPMLAUNCHE] [0] INFO: ###### 1545727956088 #######

2018-12-25 08:58:58 UTC

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:58:58.113Z INFO c.v.v.LogUtil [printDetailedObject:142] [main] - InvalidProperty = ipmiInfo

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: ###### InvalidProperty = ipmiInfo #######

2018-12-25 08:58:58 UTC

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:58:58.117Z INFO c.v.v.LogUtil [printDetailedObject:151] [main] - FaultMessage Collection [] size: 0

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:58:58.117Z INFO c.v.v.LogUtil [printDetailedObject:126] [main] - FaultCause = null

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: ###### FaultCause = null #######

2018-12-25 08:58:58 UTC

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:58:58.117Z INFO c.v.v.GenericConnectAnchor$3 [handleFault:317] [main] - Printing Method Fault:

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: ###### Printing Method Fault: #######

2018-12-25 08:58:58 UTC

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] com.vmware.vc.InvalidArgument@8000d22e

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:58:58.272Z ERROR c.v.v.e.OutcomePrinter [afterInvocation:40] [main] - exception thrown

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] javax.xml.ws.soap.SOAPFaultException: A specified parameter was not correct: ipmiInfo

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at com.sun.xml.ws.fault.SOAP11Fault.getProtocolException(SOAP11Fault.java:193) [jaxws-rt.jar:2.2.5]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at com.sun.xml.ws.fault.SOAPFaultBuilder.createException(SOAPFaultBuilder.java:134) [jaxws-rt.jar:2.2.5]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at com.sun.xml.ws.client.sei.SyncMethodHandler.invoke(SyncMethodHandler.java:123) [jaxws-rt.jar:2.2.5]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at com.sun.xml.ws.client.sei.SyncMethodHandler.invoke(SyncMethodHandler.java:93) [jaxws-rt.jar:2.2.5]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at com.sun.xml.ws.client.sei.SEIStub.invoke(SEIStub.java:144) [jaxws-rt.jar:2.2.5]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at com.sun.proxy.$Proxy36.updateIpmi(Unknown Source) [na:na]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at com.vmware.vcqa.vim.HostSystem.updateIpmi(HostSystem.java:5345) [vcqa.jar:na]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at hostops.updateipmi.Pos003.test(Pos003.java:91) [vctests.jar:na]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [na:1.8.0_162]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [na:1.8.0_162]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [na:1.8.0_162]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at java.lang.reflect.Method.invoke(Method.java:498) [na:1.8.0_162]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:80) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.internal.Invoker.invokeMethod(Invoker.java:714) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.internal.Invoker.invokeTestMethod(Invoker.java:901) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.internal.Invoker.invokeTestMethods(Invoker.java:1231) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:127) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:111) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.TestRunner.privateRun(TestRunner.java:767) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.TestRunner.run(TestRunner.java:617) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.SuiteRunner.runTest(SuiteRunner.java:334) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.SuiteRunner.runSequentially(SuiteRunner.java:329) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.SuiteRunner.privateRun(SuiteRunner.java:291) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.SuiteRunner.run(SuiteRunner.java:240) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:52) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:86) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.TestNG.runSuitesSequentially(TestNG.java:1198) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.TestNG.runSuitesLocally(TestNG.java:1123) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.TestNG.run(TestNG.java:1031) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.TestNG.privateMain(TestNG.java:1338) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.TestNG.main(TestNG.java:1307) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:58:58.273Z INFO c.v.v.e.OutcomePrinter [afterInvocation:47] [main] - OUTCOME:FAIL

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: ###### OUTCOME:FAIL #######

2018-12-25 08:58:58 UTC

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:58:58.275Z INFO c.v.v.e.t.VmLogCollectionListener [beforeInvocation:131] [main] - VM log collection enabled.

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: ###### VM log collection enabled. #######

2018-12-25 08:58:58 UTC

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:58:58.276Z INFO c.v.v.e.t.VmLogCollectionListener [beforeInvocation:131] [main] - VM log collection enabled.

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: ###### VM log collection enabled. #######

2018-12-25 08:58:58 UTC

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:58:58.282Z INFO c.v.v.v.VpxdConnectAnchor [createService:65] [main] - ConnectAnchor: Endpoint URL for Internal Vpxd Binding = https://172.16.33.157:443/sdk

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: ###### ConnectAnchor: Endpoint URL for Internal Vpxd Binding = https://172.16.33.157:443/sdk #######

2018-12-25 08:58:58 UTC

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:58:58.288Z INFO c.v.v.GenericConnectAnchor [setConnectionProperties:253] [main] - Trusted all certificates..

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: ###### Trusted all certificates.. #######

2018-12-25 08:58:58 UTC

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:58:58.288Z INFO c.v.v.v.VpxdConnectAnchor [createService:69] [main] - Creating new VPXD service...

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: ###### Creating new VPXD service... #######

2018-12-25 08:58:58 UTC

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:58:58.549Z INFO c.v.v.v.VpxdConnectAnchor [createService:77] [main] - Service Name: {urn:vpxd3Service}VpxdService

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: ###### Service Name: {urn:vpxd3Service}VpxdService #######

2018-12-25 08:58:58 UTC

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:58:58.550Z INFO c.v.v.v.VpxdConnectAnchor [createService:78] [main] - Service WSDL: jar:file:/opt/vmware/VTAF/server67-cert/VTAF/Test/Server/DPM/lib/vpxd.jar!/META-INF/vpxdService.wsdl

2018-12-25 08:58:58 UTC [ DPMLAUNCHE] [0] INFO: ###### INF/vpxdService.wsdl #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.327Z INFO c.v.v.v.VpxdConnectAnchor [createService:82] [main] - Seting endpoint to Port...

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: ###### Seting endpoint to Port... #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.327Z INFO c.v.v.v.VpxdConnectAnchor [createService:92] [main] - Port Object : JAX-WS RI 2.2.5-b01 : Stub for https://172.16.33.157:443/sdk

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: ###### b01 : Stub for https://172.16.33.157:443/sdk #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.338Z INFO c.v.v.GenericConnectAnchor$3 [handleMessage:292] [main] - Operation ID for the operation - RetrieveServiceContent:: OpId-1545728344337

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: ###### 1545728344337 #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.397Z INFO c.v.v.v.VpxdConnectAnchor [createServiceContent:162] [main] - --------------------------------------------

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.397Z INFO c.v.v.v.VpxdConnectAnchor [createServiceContent:163] [main] - Vpxd ConnectAnchor: Connected Server Info :

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: ###### Vpxd ConnectAnchor: Connected Server Info : #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.397Z INFO c.v.v.LogUtil [printDetailedObject:142] [main] - FullName = VMware vCenter Server 6.7.0 build-11338799

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: ###### 11338799 #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.397Z INFO c.v.v.LogUtil [printDetailedObject:142] [main] - Version = 6.7.0

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: ###### Version = 6.7.0 #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.397Z INFO c.v.v.LogUtil [printDetailedObject:142] [main] - Build = 11338799

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: ###### Build = 11338799 #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.398Z INFO c.v.v.LogUtil [printDetailedObject:142] [main] - ApiType = VirtualCenter

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: ###### ApiType = VirtualCenter #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.398Z INFO c.v.v.LogUtil [printDetailedObject:142] [main] - ApiVersion = 6.7.1

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: ###### ApiVersion = 6.7.1 #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.398Z INFO c.v.v.LogUtil [printDetailedObject:142] [main] - Vendor = VMware, Inc.

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: ###### Vendor = VMware, Inc. #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.398Z INFO c.v.v.LogUtil [printDetailedObject:142] [main] - InstanceUuid = 4c01bc57-332f-4835-9bc8-b811704f407d

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: ###### b811704f407d #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.398Z INFO c.v.v.LogUtil [printDetailedObject:142] [main] - ProductLineId = vpx

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: ###### ProductLineId = vpx #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.398Z INFO c.v.v.LogUtil [printDetailedObject:142] [main] - LocaleVersion = INTL

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: ###### LocaleVersion = INTL #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.398Z INFO c.v.v.LogUtil [printDetailedObject:142] [main] - LocaleBuild = 000

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: ###### LocaleBuild = 000 #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.398Z INFO c.v.v.LogUtil [printDetailedObject:142] [main] - OsType = linux-x64

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: ###### x64 #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.398Z INFO c.v.v.LogUtil [printDetailedObject:142] [main] - LicenseProductName = VMware VirtualCenter Server

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: ###### LicenseProductName = VMware VirtualCenter Server #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.398Z INFO c.v.v.LogUtil [printDetailedObject:142] [main] - LicenseProductVersion = 6.0

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: ###### LicenseProductVersion = 6.0 #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.398Z INFO c.v.v.LogUtil [printDetailedObject:142] [main] - Name = VMware vCenter Server

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: ###### Name = VMware vCenter Server #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.399Z INFO c.v.v.v.VpxdConnectAnchor [createServiceContent:165] [main] - --------------------------------------------

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.399Z INFO c.v.v.v.VpxdLoginHelper [loginToVpxd:42] [main] - Login : MOR object : Type = SessionManager : Value = SessionManager

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: ###### Login : MOR object : Type = SessionManager : Value = SessionManager #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.408Z INFO c.v.v.GenericConnectAnchor$3 [handleMessage:292] [main] - Operation ID for the operation - Login:: OpId-1545728344408

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: ###### 1545728344408 #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] javax.xml.ws.soap.SOAPFaultException:

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] Expected <_this> tag not found

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] while parsing call information for method DebugFetchAlerts

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at line 1, column 226

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] while parsing SOAP body

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at line 1, column 218

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] while parsing SOAP envelope

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at line 1, column 38

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] while parsing HTTP request for method FetchAlerts

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] on object of type vpx.AlertManager

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at line 1, column 0

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at com.sun.xml.ws.fault.SOAP11Fault.getProtocolException(SOAP11Fault.java:193)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at com.sun.xml.ws.fault.SOAPFaultBuilder.createException(SOAPFaultBuilder.java:134)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at com.sun.xml.ws.client.sei.SyncMethodHandler.invoke(SyncMethodHandler.java:123)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at com.sun.xml.ws.client.sei.SyncMethodHandler.invoke(SyncMethodHandler.java:93)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at com.sun.xml.ws.client.sei.SEIStub.invoke(SEIStub.java:144)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at com.sun.proxy.$Proxy49.debugFetchAlerts(Unknown Source)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at com.vmware.vcqa.vpxd.AlertManager.fetchAlerts(AlertManager.java:76)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at com.vmware.vcqa.vpxd.SysAlertHelper.verifySysAlert(SysAlertHelper.java:57)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at java.lang.reflect.Method.invoke(Method.java:498)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at com.vmware.vcqa.TestBase.verifySysAlert(TestBase.java:544)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at java.lang.reflect.Method.invoke(Method.java:498)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:80)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.internal.Invoker.invokeConfigurationMethod(Invoker.java:564)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.internal.Invoker.invokeConfigurations(Invoker.java:213)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.internal.Invoker.invokeConfigurations(Invoker.java:138)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.internal.TestMethodWorker.invokeAfterClassMethods(TestMethodWorker.java:225)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:114)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.TestRunner.privateRun(TestRunner.java:767)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.TestRunner.run(TestRunner.java:617)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.SuiteRunner.runTest(SuiteRunner.java:334)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.SuiteRunner.runSequentially(SuiteRunner.java:329)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.SuiteRunner.privateRun(SuiteRunner.java:291)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.SuiteRunner.run(SuiteRunner.java:240)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:52)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:86)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.TestNG.runSuitesSequentially(TestNG.java:1198)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.TestNG.runSuitesLocally(TestNG.java:1123)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.TestNG.run(TestNG.java:1031)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.TestNG.privateMain(TestNG.java:1338)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.TestNG.main(TestNG.java:1307)

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.461Z INFO c.v.v.v.AlertManager [getAlertMgrMor:51] [main] - Retrieved debugManager Mor successfully.

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: ###### Retrieved debugManager Mor successfully. #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.468Z WARN c.v.v.v.VpxdManagedBase [getDynamicProperty:165] [main] - The propSet of the ObjectContent found null when queried for 'alertManager'

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] WARN: ###### The propSet of the ObjectContent found null when queried for 'alertManager' #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.468Z ERROR c.v.v.v.AlertManager [getAlertMgrMor:57] [main] - Failed to retrieve Alert Manager Mor.

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.470Z INFO c.v.v.GenericConnectAnchor$3 [handleMessage:292] [main] - Operation ID for the operation - DebugFetchAlerts:: OpId-1545728344469

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: ###### 1545728344469 #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.489Z INFO c.v.v.LogUtil [printDetailedObject:151] [main] - FaultMessage Collection [] size: 0

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.489Z INFO c.v.v.LogUtil [printDetailedObject:126] [main] - FaultCause = null

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: ###### FaultCause = null #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.494Z INFO c.v.v.GenericConnectAnchor$3 [handleFault:317] [main] - Printing Method Fault:

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: ###### Printing Method Fault: #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] com.vmware.vc.vpxd.InvalidRequest@559

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.502Z WARN c.v.v.u.TestUtil [getMethodFault:5382] [main] - No MethodFault Found in SOAPFaultException

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] WARN: ###### No MethodFault Found in SOAPFaultException #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.502Z INFO c.v.v.LogUtil [printMethodFault:244] [main] - ActualMethodFault :

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: ###### ActualMethodFault : #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.503Z ERROR c.v.v.u.TestUtil [handleException:4385] [main] - Caught Exception

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] javax.xml.ws.soap.SOAPFaultException:

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] Expected <_this> tag not found

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] while parsing call information for method DebugFetchAlerts

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at line 1, column 226

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] while parsing SOAP body

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at line 1, column 218

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] while parsing SOAP envelope

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at line 1, column 38

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] while parsing HTTP request for method FetchAlerts

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] on object of type vpx.AlertManager

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at line 1, column 0

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at com.sun.xml.ws.fault.SOAP11Fault.getProtocolException(SOAP11Fault.java:193) [jaxws-rt.jar:2.2.5]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at com.sun.xml.ws.fault.SOAPFaultBuilder.createException(SOAPFaultBuilder.java:134) [jaxws-rt.jar:2.2.5]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at com.sun.xml.ws.client.sei.SyncMethodHandler.invoke(SyncMethodHandler.java:123) [jaxws-rt.jar:2.2.5]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at com.sun.xml.ws.client.sei.SyncMethodHandler.invoke(SyncMethodHandler.java:93) [jaxws-rt.jar:2.2.5]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at com.sun.xml.ws.client.sei.SEIStub.invoke(SEIStub.java:144) [jaxws-rt.jar:2.2.5]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at com.sun.proxy.$Proxy49.debugFetchAlerts(Unknown Source) [na:na]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at com.vmware.vcqa.vpxd.AlertManager.fetchAlerts(AlertManager.java:76) [vcqa.jar:na]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at com.vmware.vcqa.vpxd.SysAlertHelper.verifySysAlert(SysAlertHelper.java:57) [vcqa.jar:na]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [na:1.8.0_162]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [na:1.8.0_162]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [na:1.8.0_162]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at java.lang.reflect.Method.invoke(Method.java:498) [na:1.8.0_162]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at com.vmware.vcqa.TestBase.verifySysAlert(TestBase.java:544) [vcqa.jar:na]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [na:1.8.0_162]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [na:1.8.0_162]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [na:1.8.0_162]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at java.lang.reflect.Method.invoke(Method.java:498) [na:1.8.0_162]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:80) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.internal.Invoker.invokeConfigurationMethod(Invoker.java:564) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.internal.Invoker.invokeConfigurations(Invoker.java:213) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.internal.Invoker.invokeConfigurations(Invoker.java:138) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.internal.TestMethodWorker.invokeAfterClassMethods(TestMethodWorker.java:225) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:114) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.TestRunner.privateRun(TestRunner.java:767) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.TestRunner.run(TestRunner.java:617) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.SuiteRunner.runTest(SuiteRunner.java:334) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.SuiteRunner.runSequentially(SuiteRunner.java:329) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.SuiteRunner.privateRun(SuiteRunner.java:291) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.SuiteRunner.run(SuiteRunner.java:240) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:52) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:86) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.TestNG.runSuitesSequentially(TestNG.java:1198) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.TestNG.runSuitesLocally(TestNG.java:1123) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.TestNG.run(TestNG.java:1031) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.TestNG.privateMain(TestNG.java:1338) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] at org.testng.TestNG.main(TestNG.java:1307) [testng-6.8-nobsh-guice.jar:6.8-201210030754]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.504Z INFO c.v.v.e.t.VmLogCollectionListener [beforeInvocation:131] [main] - VM log collection enabled.

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: ###### VM log collection enabled. #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.545Z INFO c.v.v.GenericConnectAnchor$3 [handleMessage:292] [main] - Operation ID for the operation - Logout:: OpId-1545728344545

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: ###### 1545728344545 #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.548Z INFO c.v.v.v.SessionManager [logout:265] [main] - Logout Succeeded

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: ###### Logout Succeeded #######

2018-12-25 08:59:04 UTC

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] ===============================================

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] SingleTestSuite

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] Total tests run: 1, Failures: 1, Skips: 0

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] ===============================================

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng]

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] [TestNG] Time taken by org.testng.reporters.XMLReporter@7c0e2abd: 53 ms

2018-12-25 08:59:04 UTC [ DPMLAUNCHE] [0] INFO: [testng] [TestNG] Time taken by org.uncommons.reportng.HTMLReporter@6ea12c19: 224 ms

2018-12-25 08:59:05 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.872Z INFO c.v.v.c.l.CommandExecutorCleanupListener [generateReport:22] [main] - Command Execution Cleanup Called..

2018-12-25 08:59:05 UTC [ DPMLAUNCHE] [0] INFO: ###### Command Execution Cleanup Called.. #######

2018-12-25 08:59:05 UTC

2018-12-25 08:59:05 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.891Z INFO c.v.v.c.CommandExecutorFactory [cleanup:63] [main] - Closing all SSH Connections. Starting..

2018-12-25 08:59:05 UTC [ DPMLAUNCHE] [0] INFO: ###### Closing all SSH Connections. Starting.. #######

2018-12-25 08:59:05 UTC

2018-12-25 08:59:05 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.905Z INFO c.v.v.c.CommandExecutorFactory [cleanup:65] [main] - Closing all SSH Connections. Done..

2018-12-25 08:59:05 UTC [ DPMLAUNCHE] [0] INFO: ###### Closing all SSH Connections. Done.. #######

2018-12-25 08:59:05 UTC

2018-12-25 08:59:05 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.905Z INFO c.v.v.c.CommandExecutorFactory [shutDownExecutorService:71] [main] - Shutting down executor service. Starting..

2018-12-25 08:59:05 UTC [ DPMLAUNCHE] [0] INFO: ###### Shutting down executor service. Starting.. #######

2018-12-25 08:59:05 UTC

2018-12-25 08:59:05 UTC [ DPMLAUNCHE] [0] INFO: [testng] 2018-12-25T08:59:04.905Z INFO c.v.v.c.CommandExecutorFactory [shutDownExecutorService:87] [main] - Shutting down executor service. Done.

2018-12-25 08:59:05 UTC [ DPMLAUNCHE] [0] INFO: ###### Shutting down executor service. Done. #######

2018-12-25 08:59:05 UTC

2018-12-25 08:59:05 UTC [ DPMLAUNCHE] [0] INFO: [testng] [TestNG] Time taken by com.vmware.vcqa.cmd.listeners.CommandExecutorCleanupListener@6107227e: 33 ms

2018-12-25 08:59:05 UTC [ DPMLAUNCHE] [0] INFO: [testng] The tests failed.

2018-12-25 08:59:05 UTC [ DPMLAUNCHE] [0] INFO:

2018-12-25 08:59:05 UTC [ DPMLAUNCHE] [0] INFO: BUILD SUCCESSFUL

2018-12-25 08:59:05 UTC [ DPMLAUNCHE] [0] INFO: Total time: 7 minutes 40 seconds..

2018-12-25 08:59:05 UTC [ DPMLAUNCHE] [0] INFO: DPM::AnalyzeTestStep called...

2018-12-25 08:59:05 UTC [ TESTBASE ] [0] INFO: Test Result: FAIL

2018-12-25 08:59:14 UTC [ DPMLAUNCHE] [0] INFO: [05101011]:[DPM]:DPM::Cleanup called.........................................................................................................................

2018-12-25 08:59:14 UTC [ UTILITY ] [0] INFO: ----------------- Test Summary ----------------

2018-12-25 08:59:14 UTC [ UTILITY ] [0] INFO: EndTime : Dec 25 2018 08:59:14

2018-12-25 08:59:14 UTC [ UTILITY ] [0] INFO: ZipDirectory : /workspace/TestSessions/OR18-2.d/Dual_Host_Test::IMPI_ILO_Tests::hostopsupdateipmiPos003-IPMI_iLO/20181225085105/server67-cert/VTAF/Test/Server/DPM/hostopsupdateipmiPos003_Dec_25_2018_08.51.10_1203/zip/

2018-12-25 08:59:14 UTC [ UTILITY ] [0] INFO: LogDirectory : /workspace/TestSessions/OR18-2.d/Dual_Host_Test::IMPI_ILO_Tests::hostopsupdateipmiPos003-IPMI_iLO/20181225085105/server67-cert/VTAF/Test/Server/DPM/hostopsupdateipmiPos003_Dec_25_2018_08.51.10_1203/logs/

2018-12-25 08:59:14 UTC [ UTILITY ] [0] INFO: StartTime : Dec 25 2018 08:51:11

2018-12-25 08:59:14 UTC [ UTILITY ] [0] INFO: Duration : 0 day(s) 0 hr(s) 8 min(s) 3 secs

2018-12-25 08:59:14 UTC [ UTILITY ] [0] INFO: TestResult : FAIL

2018-12-25 08:59:14 UTC [ UTILITY ] [0] INFO: -----------------------------------------------..

2018-12-25 08:59:14 UTC [ RESULTHAND] [0] INFO: Preparing XML directory: /workspace/TestSessions/OR18-2.d/Dual_Host_Test::IMPI_ILO_Tests::hostopsupdateipmiPos003-IPMI_iLO/20181225085105/server67-cert/VTAF/Test/Server/DPM/hostopsupdateipmiPos003_Dec_25_2018_08.51.10_1203/xmls/ ...COMPLETE

2018-12-25 08:59:14 UTC [ RESULTHAND] [0] INFO: Saved XML file locates at /workspace/TestSessions/OR18-2.d/Dual_Host_Test::IMPI_ILO_Tests::hostopsupdateipmiPos003-IPMI_iLO/20181225085105/server67-cert/VTAF/Test/Server/DPM/hostopsupdateipmiPos003_Dec_25_2018_08.51.10_1203/xmls/hostopsupdateipmiPos003_Dec_25_2018_08.59.14_1203.xml..

2018-12-25 08:59:14 UTC [ MAIN ] [0] INFO: Completed execution of test /opt/vmware/VTAF/server67-cert/VTAF/Test/Server/DPM/hostopsupdateipmiPos003

2018-12-25 08:59:19 UTC Test FAILED

Boopalan90 · ‎05-09-2019

I am also facing the same issue. Can you anyone please help me to resolve this issue

All

vmware 6.7 certifications test，“Dual_Host_Test::IMPI_ILO_Tests::hostopsupdateipmiPos003-IPMI_iLO” test failed！