VMware Cloud Community
Windspirit
Hot Shot
Hot Shot

vCD template import hangs at 1%

Hi all,

vCO 5.5.1-1617127

vCD 5.5.1-1654672

vCO vCD Plugin 5.5.0-1780005

Workflow: "add a vApp with a new virtual Machine"

When executing, the "uploadOVFEnverlope" Action fails with error "com.vmware.vcloud.api.rest.schema.ovf.EnvelopeType". The Workflow then does the "Delete a vApp template" Workflow...which then fails with "The operation encountered an unspecified error.  - The entity [vmname] is busy completing an operation.

The result in vCD is that the vApp template sits on import 1% for ever, if you cancel the task it takes some 20min until its finally fails.

I tested a manuel import via vCD (OVF template) that works fine.

The really stange stuff is that I can't rerun a workflow even if I go and change the VM name, I have to fully start the workflow again and then SOMETIMES it runs though only to be then getting an error :

No access to entity "com.vmware.vcloud.entity.vapptemplate:875a756b-e1fa-47f4-9f0e-c249c45e24c0".; majorErrorCode=403; minorErrorCode=ACCESS_TO_RESOURCE_IS_FORBIDDEN; vendorSpecificErrorCode=null; (Dynamic Script Module name : deleteVAppTemplate#1)

However the template and the catalog item dosnt show up until about 5min later when it stand again on import 1%.

Anyone?

Reply
0 Kudos
1 Reply
Windspirit
Hot Shot
Hot Shot

After finally getting to the logs I found THIS:

2014-05-28 10:00:38,755 | INFO     | pool-jetty-74             | VAlcServiceImpl                | [valc] deleteVAppTemplateBacking, vAppTemplateBackingId=urn:uuid:10a4f1e6-3970-4ca1-8253-7ff9e5fffb98 |
2014-05-28 10:00:38,757 | DEBUG    | contentLibraryActivityExecutor-pool-activity-7 | AuthorizationMethodInterceptor | Authorizing method: public abstract com.vmware.vcloud.api.presentation.entity.common.TaskSpec com.vmware.vcloud.api.presentation.service.TaskService.getTaskSpecWithRefresh(com.vmware.vcloud.api.presentation.entity.common.EntityRef). | activity=urn:uuid:5b098210-48d0-42a2-843a-c4d8a7d0b3a9
2014-05-28 10:00:38,767 | DEBUG    | pool-jetty-74             | AbstractResourceEntityService  | cmudResourceEntity() requested - operation:VDC_DELETE_TEMPLATE - params:true |
2014-05-28 10:00:38,767 | DEBUG    | pool-jetty-74             | AbstractEventBuilder           | Pre-update source object was null when constructing com/vmware/vcloud/event/vappTemplate/delete_request |
2014-05-28 10:00:38,767 | DEBUG    | pool-jetty-74             | AbstractEventBuilder           | Source object was null when constructing com/vmware/vcloud/event/vappTemplate/delete_request |
2014-05-28 10:00:38,767 | DEBUG    | pool-jetty-74             | AbstractEventBuilder           | Could not find property 'storageClass' in source object of type com.vmware.vcloud.api.presentation.entity.vapp.VAppTemplateSpec |
2014-05-28 10:00:38,772 | DEBUG    | pool-jetty-74             | JobString                      | Job object - Object : test4(com.vmware.vcloud.entity.vapptemplate:10a4f1e6-3970-4ca1-8253-7ff9e5fffb98) operation name: VDC_DELETE_TEMPLATE |
2014-05-28 10:00:38,775 | DEBUG    | pool-jetty-74             | CJob                           | Update last job       : [test4(com.vmware.vcloud.entity.vapptemplate:10a4f1e6-3970-4ca1-8253-7ff9e5fffb98)], status=[1], [null] |
2014-05-28 10:00:38,775 | DEBUG    | pool-jetty-74             | TaskServiceImpl                | Created new task with job ID '926a52bb-104b-467c-95cc-feaa56adc7c5' | [#926a52bb-104b-467c-95cc-feaa56adc7c5]
2014-05-28 10:00:38,783 | DEBUG    | pool-jetty-74             | BusyObjectServiceImpl          | Trying to set entities [test4(com.vmware.vcloud.entity.vapptemplate:10a4f1e6-3970-4ca1-8253-7ff9e5fffb98)] as busy for task ref VDC_DELETE_TEMPLATE(com.vmware.vcloud.entity.task:926a52bb-104b-467c-95cc-feaa56adc7c5) |
2014-05-28 10:00:38,785 | ERROR    | pool-jetty-74             | JDBCExceptionReporter          | Violation of PRIMARY KEY constraint 'busy_object_pk'. Cannot insert duplicate key in object 'dbo.busy_object'. The duplicate key value is (40, 0x10a4f1e639704ca182537ff9e5fffb98). |
2014-05-28 10:00:38,785 | ERROR    | pool-jetty-74             | AbstractFlushingEventListener  | Could not synchronize database state with session |
org.hibernate.exception.ConstraintViolationException: Could not execute JDBC batch update
Caused by: java.sql.BatchUpdateException: Violation of PRIMARY KEY constraint 'busy_object_pk'. Cannot insert duplicate key in object 'dbo.busy_object'. The duplicate key value is (40, 0x10a4f1e639704ca182537ff9e5fffb98).
        at net.sourceforge.jtds.jdbc.JtdsStatement.executeBatch(JtdsStatement.java:954)
        at org.hibernate.jdbc.BatchingBatcher.doExecuteBatch(BatchingBatcher.java:70)
        at org.hibernate.jdbc.AbstractBatcher.executeBatch(AbstractBatcher.java:268)
        ... 287 more
2014-05-28 10:00:38,790 | WARN     | pool-jetty-74             | BusyObjectServiceImpl          | Task VDC_DELETE_TEMPLATE(com.vmware.vcloud.entity.task:926a52bb-104b-467c-95cc-feaa56adc7c5) has busy lock on test4(com.vmware.vcloud.entity.vapptemplate:10a4f1e6-3970-4ca1-8253-7ff9e5fffb98). Operation: VDC_DELETE_TEMPLATE, jobId: 926a52bb-104b-467c-95cc-feaa56adc7c5 |


 

Reply
0 Kudos