2021-11-23 12:26:22	
2021-11-23 11:26:22,039 DEBUG [org.apa.htt.wire] (TopicSubscriptionManager) http-outgoing-1 << "[{"activityId":"ServiceTaskSendToService","activityInstanceId":"ServiceTaskSendToService:2f847fff-4c50-11ec-8265-c2407b9df59e","errorMessage":null,"errorDetails":null,"executionId":"2f847ffe-4c50-11ec-8265-c2407b9df59e","id":"2f848000-4c50-11ec-8265-c2407b9df59e","lockExpirationTime":"2021-11-23T11:26:29.527+0000","processDefinitionId":"Finish:8:92f480b6-4c4e-11ec-be4c-8eb9870f75d1","processDefinitionKey":"Finish","processDefinitionVersionTag":null,"processInstanceId":"2f847ff8-4c50-11ec-8265-c2407b9df59e","retries":null,"suspended":false,"workerId":"app-ccb9d4fcc-r844be3d4cfc7-92bb-40c6-a2a5-f0db32614abc","topicName":"sendToService","tenantId":"app","variables":{"id":{"type":"String","value":"16376666421505482482","valueInfo":{}},"xxx":{"type":"String","value":"xxx","valueInfo":{}}},"priority":0,"businessKey":null,"extensionProperties":{}}]"
2021-11-23 12:26:22	
2021-11-23 11:26:22,667 INFO  [XXXXX.XXTaskHandler] (TopicSubscriptionManager) Currently handling external sendToService task 2f848000-4c50-11ec-8265-c2407b9df59e in process instance 2f847ff8-4c50-11ec-8265-c2407b9df59e
2021-11-23 12:26:38	
2021-11-23 11:26:38,191 DEBUG [org.apa.htt.wire] (TopicSubscriptionManager) http-outgoing-1 << "[{"activityId":"ServiceTaskSendToService","activityInstanceId":"ServiceTaskSendToService:2f847fff-4c50-11ec-8265-c2407b9df59e","errorMessage":null,"errorDetails":null,"executionId":"2f847ffe-4c50-11ec-8265-c2407b9df59e","id":"2f848000-4c50-11ec-8265-c2407b9df59e","lockExpirationTime":"2021-11-23T11:26:45.683+0000","processDefinitionId":"Finish:8:92f480b6-4c4e-11ec-be4c-8eb9870f75d1","processDefinitionKey":"Finish","processDefinitionVersionTag":null,"processInstanceId":"2f847ff8-4c50-11ec-8265-c2407b9df59e","retries":null,"suspended":false,"workerId":"app-ccb9d4fcc-ftdd698336fb0-b90e-4150-adac-af86cac89d78","topicName":"sendToService","tenantId":"app","variables":{"id":{"type":"String","value":"16376666421505482482","valueInfo":{}},"xxx":{"type":"String","value":"xxx","valueInfo":{}}},"priority":0,"businessKey":null,"extensionProperties":{}}]"
2021-11-23 12:26:38	
2021-11-23 11:26:38,413 INFO  [XXXXX.XXTaskHandler] (TopicSubscriptionManager) Currently handling external sendToService task 2f848000-4c50-11ec-8265-c2407b9df59e in process instance 2f847ff8-4c50-11ec-8265-c2407b9df59e
2021-11-23 12:26:42	
2021-11-23 11:26:42,556 DEBUG [org.apa.htt.imp.exe.MainClientExec] (TopicSubscriptionManager) Executing request POST /engine-rest/external-task/2f848000-4c50-11ec-8265-c2407b9df59e/complete HTTP/1.1
2021-11-23 12:26:42	
2021-11-23 11:26:42,556 DEBUG [org.apa.htt.headers] (TopicSubscriptionManager) http-outgoing-1 >> POST /engine-rest/external-task/2f848000-4c50-11ec-8265-c2407b9df59e/complete HTTP/1.1
2021-11-23 12:26:42	
2021-11-23 11:26:42,556 DEBUG [org.apa.htt.wire] (TopicSubscriptionManager) http-outgoing-1 >> "POST /engine-rest/external-task/2f848000-4c50-11ec-8265-c2407b9df59e/complete HTTP/1.1[\r][\n]"
2021-11-23 12:26:42	
2021-11-23 11:26:42,574 DEBUG [org.apa.htt.wire] (TopicSubscriptionManager) http-outgoing-1 << "{"type":"RestException","message":"External Task 2f848000-4c50-11ec-8265-c2407b9df59e cannot be completed by worker 'app-ccb9d4fcc-r844be3d4cfc7-92bb-40c6-a2a5-f0db32614abc'. It is locked by worker 'app-ccb9d4fcc-ftdd698336fb0-b90e-4150-adac-af86cac89d78'."}"
2021-11-23 12:26:42	
2021-11-23 11:26:42,629 DEBUG [org.apa.htt.imp.exe.MainClientExec] (TopicSubscriptionManager) Executing request POST /engine-rest/external-task/2f848000-4c50-11ec-8265-c2407b9df59e/failure HTTP/1.1
2021-11-23 12:26:42	
2021-11-23 11:26:42,630 DEBUG [org.apa.htt.headers] (TopicSubscriptionManager) http-outgoing-2 >> POST /engine-rest/external-task/2f848000-4c50-11ec-8265-c2407b9df59e/failure HTTP/1.1
2021-11-23 12:26:42	
2021-11-23 11:26:42,632 DEBUG [org.apa.htt.wire] (TopicSubscriptionManager) http-outgoing-2 >> "POST /engine-rest/external-task/2f848000-4c50-11ec-8265-c2407b9df59e/failure HTTP/1.1[\r][\n]"
2021-11-23 12:26:42	
2021-11-23 11:26:42,639 DEBUG [org.apa.htt.wire] (TopicSubscriptionManager) http-outgoing-2 << "{"type":"RestException","message":"Failure of External Task 2f848000-4c50-11ec-8265-c2407b9df59e cannot be reported by worker 'app-ccb9d4fcc-r844be3d4cfc7-92bb-40c6-a2a5-f0db32614abc'. It is locked by worker 'app-ccb9d4fcc-ftdd698336fb0-b90e-4150-adac-af86cac89d78'."}"
2021-11-23 12:26:42	
2021-11-23 11:26:42,634 DEBUG [org.apa.htt.wire] (TopicSubscriptionManager) http-outgoing-2 >> "{"workerId":"app-ccb9d4fcc-r844be3d4cfc7-92bb-40c6-a2a5-f0db32614abc","errorMessage":"Task failed","errorDetails":"org.camunda.bpm.client.exception.NotAcquiredException: TASK/CLIENT-01007 Exception while completing the external task: The task's most recent lock could not be acquired\n\tat org.camunda.bpm.client.impl.ExternalTaskClientLogger.externalTaskServiceException(ExternalTaskClientLogger.java:116)\n\tat org.camunda.bpm.client.task.impl.ExternalTaskServiceImpl.complete(ExternalTaskServiceImpl.java:68)\n\tat org.camunda.bpm.client.task.impl.ExternalTaskServiceImpl.complete(ExternalTaskServiceImpl.java:61)\n\tat org.camunda.bpm.client.task.impl.ExternalTaskServiceImpl.complete(ExternalTaskServiceImpl.java:51)\n\tat XXXXX.XXTaskHandler.execute(SendToServiceTaskHandler.java:43)\n\tat XXXXX.XXTaskHandler_Subclass.execute$$superforward1(SendToServiceTaskHandler_Subclass.zig:112)\n\tat XXXXX.XXTaskHandler_Subclass$$function$$1.apply(SendToServiceTaskHandler_Subclass$$function$$1.zig:41)\n\tat io.quarkus.arc.impl.AroundInvokeInvocationContext.proceed(AroundInvokeInvocationContext.java:54)\n\tat io.quarkus.narayana.jta.runtime.interceptor.TransactionalInterceptorBase.invokeInOurTx(TransactionalInterceptorBase.java:127)\n\tat io.quarkus.narayana.jta.runtime.interceptor.TransactionalInterceptorBase.invokeInOurTx(TransactionalInterceptorBase.java:100)\n\tat io.quarkus.narayana.jta.runtime.interceptor.TransactionalInterceptorRequired.doIntercept(TransactionalInterceptorRequired.java:32)\n\tat io.quarkus.narayana.jta.runtime.interceptor.TransactionalInterceptorBase.intercept(TransactionalInterceptorBase.java:53)\n\tat io.quarkus.narayana.jta.runtime.interceptor.TransactionalInterceptorRequired.intercept(TransactionalInterceptorRequired.java:26)\n\tat io.quarkus.narayana.jta.runtime.interceptor.TransactionalInterceptorRequired_Bean.intercept(TransactionalInterceptorRequired_Bean.zig:340)\n\tat io.quarkus.arc.impl.InterceptorInvocation.invoke(InterceptorInvocation.java:41)\n\tat io.quarkus.arc.impl.AroundInvokeInvocationContext.perform(AroundInvokeInvocationContext.java:41)\n\tat io.quarkus.arc.impl.InvocationContexts.performAroundInvoke(InvocationContexts.java:32)\n\tat XXXXX.XXTaskHandler_Subclass.execute(SendToServiceTaskHandler_Subclass.zig:182)\n\tat XXXXX.XXTaskHandler_ClientProxy.execute(SendToServiceTaskHandler_ClientProxy.zig:160)\n\tat org.camunda.bpm.client.topic.impl.TopicSubscriptionManager.handleExternalTask(TopicSubscriptionManager.java:152)\n\tat org.camunda.bpm.client.topic.impl.TopicSubscriptionManager.lambda$acquire$0(TopicSubscriptionManager.java:108)\n\tat java.base/java.util.Arrays$ArrayList.forEach(Arrays.java:4390)\n\tat org.camunda.bpm.client.topic.impl.TopicSubscriptionManager.acquire(TopicSubscriptionManager.java:103)\n\tat org.camunda.bpm.client.topic.impl.TopicSubscriptionManager.run(TopicSubscriptionManager.java:87)\n\tat java.base/java.lang.Thread.run(Thread.java:829)\n","retries":7,"retryTimeout":300000}"
2021-11-23 12:26:42	
2021-11-23 11:26:42,684 ERROR [org.cam.bpm.client] (TopicSubscriptionManager) TASK/CLIENT-03004 Exception on external task service method invocation for topic 'sendToService':: org.camunda.bpm.client.exception.NotAcquiredException: TASK/CLIENT-01007 Exception while notifying a failure: The task's most recent lock could not be acquired
2021-11-23 12:26:47	
2021-11-23 11:26:47,952 DEBUG [org.apa.htt.imp.exe.MainClientExec] (TopicSubscriptionManager) Executing request POST /engine-rest/external-task/2f848000-4c50-11ec-8265-c2407b9df59e/complete HTTP/1.1
2021-11-23 12:26:47	
2021-11-23 11:26:47,952 DEBUG [org.apa.htt.headers] (TopicSubscriptionManager) http-outgoing-1 >> POST /engine-rest/external-task/2f848000-4c50-11ec-8265-c2407b9df59e/complete HTTP/1.1
2021-11-23 12:26:47	
2021-11-23 11:26:47,952 DEBUG [org.apa.htt.wire] (TopicSubscriptionManager) http-outgoing-1 >> "POST /engine-rest/external-task/2f848000-4c50-11ec-8265-c2407b9df59e/complete HTTP/1.1[\r][\n]"
2021-11-23 12:26:47	
2021-11-23 11:26:47,981 INFO  [XXXXX.XXTaskHandler] (TopicSubscriptionManager) Successfully completed external sendToService task 2f848000-4c50-11ec-8265-c2407b9df59e in process instance 2f847ff8-4c50-11ec-8265-c2407b9df59e