Assignment using tasklistener is failing

[pratikdas]

I am try to assign a candidate user in a taskListener using the following code:
public class AssignmentHandler implements TaskListener {
  public void notify(DelegateTask delegateTask) {
    delegateTask.addCandidateGroup("bdu");   
  } 
}

But when I run my process instance, the task does not get assigned. I checked in debug logs, the process instance id and process definition id are set as null in the table ACT_RU_IDENTITYLINK.   The logs are given below. Any pointers will be helpful.

02:01:32,304 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.HistoricTaskInstanceEntity.insertHistoricTaskInstance  - ==>  Preparing: insert into ACT_HI_TASKINST ( ID_, PROC_DEF_ID_, PROC_INST_ID_, EXECUTION_ID_, NAME_, PARENT_TASK_ID_, DESCRIPTION_, OWNER_, ASSIGNEE_, START_TIME_, CLAIM_TIME_, END_TIME_, DURATION_, DELETE_REASON_, TASK_DEF_KEY_, FORM_KEY_, PRIORITY_, DUE_DATE_ ) values ( ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ? )
02:01:32,306 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.HistoricTaskInstanceEntity.insertHistoricTaskInstance  - ==> Parameters: 54119(String), approvalProcess:1:54082(String), 54111(String), 54111(String), Approval Failure Queue(String), null, null, null, null, 2013-06-04 14:01:32.25(Timestamp), null, null, null, null, usertask2(String), screen2(String), 50(Integer), null
02:01:32,307 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  - inserting: IdentityLinkEntity[54120]
02:01:32,307 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.IdentityLinkEntity.insertIdentityLink  - ooo Using Connection [Transaction-aware proxy for target Connection [oracle.jdbc.driver.T4CConnection@610f5193]]
02:01:32,308 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.IdentityLinkEntity.insertIdentityLink  - ==>  Preparing: insert into ACT_RU_IDENTITYLINK (ID_, REV_, TYPE_, USER_ID_, GROUP_ID_, TASK_ID_, PROC_INST_ID_, PROC_DEF_ID_) values (?, 1, ?, ?, ?, ?, ?, ?)
02:01:32,308 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.IdentityLinkEntity.insertIdentityLink  - ==> Parameters: 54120(String), candidate(String), null, bdu(String), 54119(String), null, null

thanks
Pratik

[frederikherema1]

On what event is the task-listener called (create/assignment)?

The process-instance ID should be null and proc-def id also, only the TASK-id matters. Keep in mind, adding a candidate group does NOT assign the task, rather it indicates the task can be claimed by user X instead. If you want to assign, just use setAssignee on the tasK

[pratikdas]

I am calling the task listener on assignment event. I have also tried calling it in the create event. From the logs I can see that the listener gets called in both cases. The statement delegateTask.addCandidateGroup("bdu"); also executes without throwing any exceptions. I want to assign the task to a group named 'bdu' (this will be actually be picked using an external REST call). Now when I fetch the list of candidate tasks for group 'bdu' by making this rest call: /activiti-rest/service/tasks?candidate-group=bdu ,  I do not see this task in the list. When I query the database using this task ID, I can see the group id populated with 'bdu' and the corresponding process instance id as null. Please throw some light on this.  I am giving below the full log from the time the process gets instantiated.



02:01:32,238 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.ProcessDefinitionEntity.selectProcessDefinitionByDeploymentAndKey  - ==>  Preparing: select * from ACT_RE_PROCDEF where DEPLOYMENT_ID_ = ? and KEY_ = ?
02:01:32,238 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.ProcessDefinitionEntity.selectProcessDefinitionByDeploymentAndKey  - ==> Parameters: 54079(String), approvalProcess(String)
02:01:32,244 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.ExecutionEntity  - initializing ProcessInstance[54111]
02:01:32,244 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.IdentityLinkEntity.selectIdentityLinksByProcessInstance  - ooo Using Connection [Transaction-aware proxy for target Connection [oracle.jdbc.driver.T4CConnection@610f5193]]
02:01:32,244 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.IdentityLinkEntity.selectIdentityLinksByProcessInstance  - ==>  Preparing: select * from ACT_RU_IDENTITYLINK where PROC_INST_ID_ = ?
02:01:32,244 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.IdentityLinkEntity.selectIdentityLinksByProcessInstance  - ==> Parameters: 54111(String)
02:01:32,246 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.history.HistoryManager  - Current history level: AUDIT, level required: ACTIVITY
02:01:32,247 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.history.HistoryManager  - Current history level: AUDIT, level required: ACTIVITY
02:01:32,247 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.history.HistoryManager  - Current history level: AUDIT, level required: FULL
02:01:32,247 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.pvm.runtime.AtomicOperationActivityExecute  - ProcessInstance[54111] executes Activity(startevent1): org.activiti.engine.impl.bpmn.behavior.NoneStartEventActivityBehavior
02:01:32,247 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.bpmn.behavior.BpmnActivityBehavior  - Leaving activity 'startevent1'
02:01:32,247 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.history.HistoryManager  - Current history level: AUDIT, level required: ACTIVITY
02:01:32,247 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.pvm.runtime.AtomicOperationTransitionNotifyListenerTake  - ProcessInstance[54111] takes transition (startevent1)–flow8–>(servicetask1)
02:01:32,247 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.history.HistoryManager  - Current history level: AUDIT, level required: ACTIVITY
02:01:32,248 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.pvm.runtime.AtomicOperationActivityExecute  - ProcessInstance[54111] executes Activity(servicetask1): org.activiti.engine.impl.bpmn.helper.ClassDelegate
executing request ProcessInstance[54111]
02:01:32,248 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.history.HistoryManager  - Current history level: AUDIT, level required: ACTIVITY
02:01:32,248 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.history.HistoryManager  - Current history level: AUDIT, level required: FULL
02:01:32,248 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.bpmn.behavior.BpmnActivityBehavior  - Leaving activity 'servicetask1'
02:01:32,248 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.history.HistoryManager  - Current history level: AUDIT, level required: ACTIVITY
02:01:32,248 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.pvm.runtime.AtomicOperationTransitionNotifyListenerTake  - ProcessInstance[54111] takes transition (servicetask1)–flow9–>(exclusivegateway1)
02:01:32,248 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.history.HistoryManager  - Current history level: AUDIT, level required: ACTIVITY
02:01:32,249 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.pvm.runtime.AtomicOperationActivityExecute  - ProcessInstance[54111] executes Activity(exclusivegateway1): org.activiti.engine.impl.bpmn.behavior.ExclusiveGatewayActivityBehavior
02:01:32,249 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.bpmn.behavior.ExclusiveGatewayActivityBehavior  - Leaving activity 'exclusivegateway1'
02:01:32,249 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.bpmn.behavior.ExclusiveGatewayActivityBehavior  - Sequence flow 'flow7'selected as outgoing sequence flow.
02:01:32,249 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.history.HistoryManager  - Current history level: AUDIT, level required: ACTIVITY
02:01:32,249 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.pvm.runtime.AtomicOperationTransitionNotifyListenerTake  - ProcessInstance[54111] takes transition (exclusivegateway1)–flow7–>(usertask2)
02:01:32,250 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.history.HistoryManager  - Current history level: AUDIT, level required: ACTIVITY
02:01:32,250 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.pvm.runtime.AtomicOperationActivityExecute  - ProcessInstance[54111] executes Activity(usertask2): org.activiti.engine.impl.bpmn.behavior.UserTaskActivityBehavior
02:01:32,250 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.history.HistoryManager  - Current history level: AUDIT, level required: AUDIT
02:01:32,250 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.history.HistoryManager  - Current history level: AUDIT, level required: AUDIT
02:01:32,250 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.history.HistoryManager  - Current history level: AUDIT, level required: AUDIT
02:01:32,250 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.history.HistoryManager  - Current history level: AUDIT, level required: AUDIT
Jun 04, 2013 2:01:32 PM com.fgb.cop.listeners.AssignmentListener notify
INFO: Task name assignment:::Approval Failure Queue
Jun 04, 2013 2:01:32 PM com.fgb.cop.listeners.AssignmentListener notify
INFO: after adding candidate groupApproval Failure Queue
02:01:32,254 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.history.HistoryManager  - Current history level: AUDIT, level required: ACTIVITY
02:01:32,254 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  - flush summary:
02:01:32,254 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  -   insert ExecutionEntity[54111]
02:01:32,254 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  -   insert IdentityLinkEntity[54112]
02:01:32,254 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  -   insert HistoricProcessInstanceEntity[54111]
02:01:32,254 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  -   insert HistoricActivityInstanceEntity[54113]
02:01:32,254 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  -   insert VariableInstanceEntity[54114]
02:01:32,254 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  -   insert HistoricVariableInstanceEntity[54114]
02:01:32,255 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  -   insert HistoricActivityInstanceEntity[54115]
02:01:32,255 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  -   insert VariableInstanceEntity[54116]
02:01:32,255 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  -   insert HistoricVariableInstanceEntity[54116]
02:01:32,255 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  -   insert HistoricActivityInstanceEntity[54117]
02:01:32,255 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  -   insert HistoricActivityInstanceEntity[54118]
02:01:32,255 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  -   insert TaskEntity[54119]
02:01:32,255 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  -   insert HistoricTaskInstanceEntity[54119]
02:01:32,255 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  -   insert IdentityLinkEntity[54120]
02:01:32,255 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  - now executing flush…
02:01:32,255 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  - inserting: ExecutionEntity[54111]
02:01:32,257 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.ExecutionEntity.insertExecution  - ooo Using Connection [Transaction-aware proxy for target Connection [oracle.jdbc.driver.T4CConnection@610f5193]]
02:01:32,257 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.ExecutionEntity.insertExecution  - ==>  Preparing: insert into ACT_RU_EXECUTION (ID_, REV_, PROC_INST_ID_, BUSINESS_KEY_, PROC_DEF_ID_, ACT_ID_, IS_ACTIVE_, IS_CONCURRENT_, IS_SCOPE_,IS_EVENT_SCOPE_, PARENT_ID_, SUPER_EXEC_, SUSPENSION_STATE_, CACHED_ENT_STATE_) values ( ?, 1, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ? )
02:01:32,258 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.ExecutionEntity.insertExecution  - ==> Parameters: 54111(String), 54111(String), SRT085898(String), approvalProcess:1:54082(String), usertask2(String), true(Boolean), false(Boolean), true(Boolean), false(Boolean), null, null, 1(Integer), 2(Integer)
02:01:32,264 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  - inserting: IdentityLinkEntity[54112]
02:01:32,265 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.IdentityLinkEntity.insertIdentityLink  - ooo Using Connection [Transaction-aware proxy for target Connection [oracle.jdbc.driver.T4CConnection@610f5193]]
02:01:32,265 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.IdentityLinkEntity.insertIdentityLink  - ==>  Preparing: insert into ACT_RU_IDENTITYLINK (ID_, REV_, TYPE_, USER_ID_, GROUP_ID_, TASK_ID_, PROC_INST_ID_, PROC_DEF_ID_) values (?, 1, ?, ?, ?, ?, ?, ?)
02:01:32,266 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.IdentityLinkEntity.insertIdentityLink  - ==> Parameters: 54112(String), starter(String), kermit(String), null, null, 54111(String), null
02:01:32,268 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  - inserting: HistoricProcessInstanceEntity[54111]
02:01:32,269 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.HistoricProcessInstanceEntity.insertHistoricProcessInstance  - ooo Using Connection [Transaction-aware proxy for target Connection [oracle.jdbc.driver.T4CConnection@610f5193]]
02:01:32,269 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.HistoricProcessInstanceEntity.insertHistoricProcessInstance  - ==>  Preparing: insert into ACT_HI_PROCINST ( ID_, PROC_INST_ID_, BUSINESS_KEY_, PROC_DEF_ID_, START_TIME_, END_TIME_, DURATION_, START_USER_ID_, START_ACT_ID_, END_ACT_ID_, SUPER_PROCESS_INSTANCE_ID_, DELETE_REASON_ ) values ( ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ? )
02:01:32,270 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.HistoricProcessInstanceEntity.insertHistoricProcessInstance  - ==> Parameters: 54111(String), 54111(String), SRT085898(String), approvalProcess:1:54082(String), 2013-06-04 14:01:32.247(Timestamp), null, null, kermit(String), startevent1(String), null, null, null
02:01:32,272 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  - inserting: HistoricActivityInstanceEntity[54113]
02:01:32,272 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.HistoricActivityInstanceEntity.insertHistoricActivityInstance  - ooo Using Connection [Transaction-aware proxy for target Connection [oracle.jdbc.driver.T4CConnection@610f5193]]
02:01:32,273 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.HistoricActivityInstanceEntity.insertHistoricActivityInstance  - ==>  Preparing: insert into ACT_HI_ACTINST ( ID_, PROC_DEF_ID_, PROC_INST_ID_, EXECUTION_ID_, ACT_ID_, TASK_ID_, CALL_PROC_INST_ID_, ACT_NAME_, ACT_TYPE_, ASSIGNEE_, START_TIME_, END_TIME_, DURATION_ ) values ( ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ? )
02:01:32,273 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.HistoricActivityInstanceEntity.insertHistoricActivityInstance  - ==> Parameters: 54113(String), approvalProcess:1:54082(String), 54111(String), 54111(String), startevent1(String), null, null, Start(String), startEvent(String), null, 2013-06-04 14:01:32.247(Timestamp), 2013-06-04 14:01:32.247(Timestamp), 0(Long)
02:01:32,275 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  - inserting: VariableInstanceEntity[54114]
02:01:32,276 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.VariableInstanceEntity.insertVariableInstance  - ooo Using Connection [Transaction-aware proxy for target Connection [oracle.jdbc.driver.T4CConnection@610f5193]]
02:01:32,276 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.VariableInstanceEntity.insertVariableInstance  - ==>  Preparing: insert into ACT_RU_VARIABLE (ID_, REV_, TYPE_, NAME_, PROC_INST_ID_, EXECUTION_ID_, TASK_ID_, BYTEARRAY_ID_, DOUBLE_, LONG_ , TEXT_, TEXT2_) values ( ?, 1, ?, ?, ?, ?, ?, ?, ?, ?, ?, ? )
02:01:32,276 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.VariableInstanceEntity.insertVariableInstance  - ==> Parameters: 54114(String), string(String), srID(String), 54111(String), 54111(String), null, null, null, null, SRT085898(String), null
02:01:32,279 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  - inserting: HistoricVariableInstanceEntity[54114]
02:01:32,280 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.HistoricVariableInstanceEntity.insertHistoricVariableInstance  - ooo Using Connection [Transaction-aware proxy for target Connection [oracle.jdbc.driver.T4CConnection@610f5193]]
02:01:32,280 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.HistoricVariableInstanceEntity.insertHistoricVariableInstance  - ==>  Preparing: insert into ACT_HI_VARINST (ID_, PROC_INST_ID_, EXECUTION_ID_, TASK_ID_, NAME_, REV_, VAR_TYPE_, BYTEARRAY_ID_, DOUBLE_, LONG_ , TEXT_, TEXT2_) values ( ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ? )
02:01:32,280 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.HistoricVariableInstanceEntity.insertHistoricVariableInstance  - ==> Parameters: 54114(String), 54111(String), 54111(String), null, srID(String), 0(Integer), string(String), null, null, null, SRT085898(String), null
02:01:32,282 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  - inserting: HistoricActivityInstanceEntity[54115]
02:01:32,283 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.HistoricActivityInstanceEntity.insertHistoricActivityInstance  - ooo Using Connection [Transaction-aware proxy for target Connection [oracle.jdbc.driver.T4CConnection@610f5193]]
02:01:32,283 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.HistoricActivityInstanceEntity.insertHistoricActivityInstance  - ==>  Preparing: insert into ACT_HI_ACTINST ( ID_, PROC_DEF_ID_, PROC_INST_ID_, EXECUTION_ID_, ACT_ID_, TASK_ID_, CALL_PROC_INST_ID_, ACT_NAME_, ACT_TYPE_, ASSIGNEE_, START_TIME_, END_TIME_, DURATION_ ) values ( ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ? )
02:01:32,284 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.HistoricActivityInstanceEntity.insertHistoricActivityInstance  - ==> Parameters: 54115(String), approvalProcess:1:54082(String), 54111(String), 54111(String), servicetask1(String), null, null, Business rule task(String), serviceTask(String), null, 2013-06-04 14:01:32.248(Timestamp), 2013-06-04 14:01:32.248(Timestamp), 0(Long)
02:01:32,285 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  - inserting: VariableInstanceEntity[54116]
02:01:32,286 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.VariableInstanceEntity.insertVariableInstance  - ooo Using Connection [Transaction-aware proxy for target Connection [oracle.jdbc.driver.T4CConnection@610f5193]]
02:01:32,286 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.VariableInstanceEntity.insertVariableInstance  - ==>  Preparing: insert into ACT_RU_VARIABLE (ID_, REV_, TYPE_, NAME_, PROC_INST_ID_, EXECUTION_ID_, TASK_ID_, BYTEARRAY_ID_, DOUBLE_, LONG_ , TEXT_, TEXT2_) values ( ?, 1, ?, ?, ?, ?, ?, ?, ?, ?, ?, ? )
02:01:32,287 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.VariableInstanceEntity.insertVariableInstance  - ==> Parameters: 54116(String), string(String), outcome(String), 54111(String), 54111(String), null, null, null, null, failure(String), null
02:01:32,289 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  - inserting: HistoricVariableInstanceEntity[54116]
02:01:32,289 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.HistoricVariableInstanceEntity.insertHistoricVariableInstance  - ooo Using Connection [Transaction-aware proxy for target Connection [oracle.jdbc.driver.T4CConnection@610f5193]]
02:01:32,289 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.HistoricVariableInstanceEntity.insertHistoricVariableInstance  - ==>  Preparing: insert into ACT_HI_VARINST (ID_, PROC_INST_ID_, EXECUTION_ID_, TASK_ID_, NAME_, REV_, VAR_TYPE_, BYTEARRAY_ID_, DOUBLE_, LONG_ , TEXT_, TEXT2_) values ( ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ? )
02:01:32,290 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.HistoricVariableInstanceEntity.insertHistoricVariableInstance  - ==> Parameters: 54116(String), 54111(String), 54111(String), null, outcome(String), 0(Integer), string(String), null, null, null, failure(String), null
02:01:32,291 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  - inserting: HistoricActivityInstanceEntity[54117]
02:01:32,292 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.HistoricActivityInstanceEntity.insertHistoricActivityInstance  - ooo Using Connection [Transaction-aware proxy for target Connection [oracle.jdbc.driver.T4CConnection@610f5193]]
02:01:32,292 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.HistoricActivityInstanceEntity.insertHistoricActivityInstance  - ==>  Preparing: insert into ACT_HI_ACTINST ( ID_, PROC_DEF_ID_, PROC_INST_ID_, EXECUTION_ID_, ACT_ID_, TASK_ID_, CALL_PROC_INST_ID_, ACT_NAME_, ACT_TYPE_, ASSIGNEE_, START_TIME_, END_TIME_, DURATION_ ) values ( ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ? )
02:01:32,294 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.HistoricActivityInstanceEntity.insertHistoricActivityInstance  - ==> Parameters: 54117(String), approvalProcess:1:54082(String), 54111(String), 54111(String), exclusivegateway1(String), null, null, Exclusive Gateway(String), exclusiveGateway(String), null, 2013-06-04 14:01:32.249(Timestamp), 2013-06-04 14:01:32.249(Timestamp), 0(Long)
02:01:32,295 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  - inserting: HistoricActivityInstanceEntity[54118]
02:01:32,296 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.HistoricActivityInstanceEntity.insertHistoricActivityInstance  - ooo Using Connection [Transaction-aware proxy for target Connection [oracle.jdbc.driver.T4CConnection@610f5193]]
02:01:32,297 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.HistoricActivityInstanceEntity.insertHistoricActivityInstance  - ==>  Preparing: insert into ACT_HI_ACTINST ( ID_, PROC_DEF_ID_, PROC_INST_ID_, EXECUTION_ID_, ACT_ID_, TASK_ID_, CALL_PROC_INST_ID_, ACT_NAME_, ACT_TYPE_, ASSIGNEE_, START_TIME_, END_TIME_, DURATION_ ) values ( ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ? )
02:01:32,297 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.HistoricActivityInstanceEntity.insertHistoricActivityInstance  - ==> Parameters: 54118(String), approvalProcess:1:54082(String), 54111(String), 54111(String), usertask2(String), 54119(String), null, Approval Failure Queue(String), userTask(String), null, 2013-06-04 14:01:32.25(Timestamp), null, null
02:01:32,299 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  - inserting: TaskEntity[54119]
02:01:32,300 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.TaskEntity.insertTask  - ooo Using Connection [Transaction-aware proxy for target Connection [oracle.jdbc.driver.T4CConnection@610f5193]]
02:01:32,300 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.TaskEntity.insertTask  - ==>  Preparing: insert into ACT_RU_TASK (ID_, REV_, NAME_, PARENT_TASK_ID_, DESCRIPTION_, PRIORITY_, CREATE_TIME_, OWNER_, ASSIGNEE_, DELEGATION_, EXECUTION_ID_, PROC_INST_ID_, PROC_DEF_ID_, TASK_DEF_KEY_, DUE_DATE_, SUSPENSION_STATE_) values (?, 1, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ? )
02:01:32,301 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.TaskEntity.insertTask  - ==> Parameters: 54119(String), Approval Failure Queue(String), null, null, 50(Integer), 2013-06-04 14:01:32.25(Timestamp), null, null, null, 54111(String), 54111(String), approvalProcess:1:54082(String), usertask2(String), null, 1(Integer)
02:01:32,303 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  - inserting: HistoricTaskInstanceEntity[54119]
02:01:32,304 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.HistoricTaskInstanceEntity.insertHistoricTaskInstance  - ooo Using Connection [Transaction-aware proxy for target Connection [oracle.jdbc.driver.T4CConnection@610f5193]]
02:01:32,304 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.HistoricTaskInstanceEntity.insertHistoricTaskInstance  - ==>  Preparing: insert into ACT_HI_TASKINST ( ID_, PROC_DEF_ID_, PROC_INST_ID_, EXECUTION_ID_, NAME_, PARENT_TASK_ID_, DESCRIPTION_, OWNER_, ASSIGNEE_, START_TIME_, CLAIM_TIME_, END_TIME_, DURATION_, DELETE_REASON_, TASK_DEF_KEY_, FORM_KEY_, PRIORITY_, DUE_DATE_ ) values ( ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ? )
02:01:32,306 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.HistoricTaskInstanceEntity.insertHistoricTaskInstance  - ==> Parameters: 54119(String), approvalProcess:1:54082(String), 54111(String), 54111(String), Approval Failure Queue(String), null, null, null, null, 2013-06-04 14:01:32.25(Timestamp), null, null, null, null, usertask2(String), screen2(String), 50(Integer), null
02:01:32,307 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.db.DbSqlSession  - inserting: IdentityLinkEntity[54120]
02:01:32,307 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.IdentityLinkEntity.insertIdentityLink  - ooo Using Connection [Transaction-aware proxy for target Connection [oracle.jdbc.driver.T4CConnection@610f5193]]
02:01:32,308 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.IdentityLinkEntity.insertIdentityLink  - ==>  Preparing: insert into ACT_RU_IDENTITYLINK (ID_, REV_, TYPE_, USER_ID_, GROUP_ID_, TASK_ID_, PROC_INST_ID_, PROC_DEF_ID_) values (?, 1, ?, ?, ?, ?, ?, ?)
02:01:32,308 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.persistence.entity.IdentityLinkEntity.insertIdentityLink  - ==> Parameters: 54120(String), candidate(String), null, bdu(String), 54119(String), null, null
02:01:32,309 [http-bio-8080-exec-1] DEBUG org.apache.ibatis.transaction.managed.ManagedTransaction  - Closing JDBC Connection [Transaction-aware proxy for target Connection [oracle.jdbc.driver.T4CConnection@610f5193]]
02:01:32,309 [http-bio-8080-exec-1] DEBUG org.springframework.jdbc.datasource.DataSourceTransactionManager  - Initiating transaction commit
02:01:32,309 [http-bio-8080-exec-1] DEBUG org.springframework.jdbc.datasource.DataSourceTransactionManager  - Committing JDBC transaction on Connection [oracle.jdbc.driver.T4CConnection@610f5193]
02:01:32,318 [http-bio-8080-exec-1] DEBUG org.springframework.jdbc.datasource.DataSourceTransactionManager  - Releasing JDBC Connection [oracle.jdbc.driver.T4CConnection@610f5193] after transaction
02:01:32,318 [http-bio-8080-exec-1] DEBUG org.springframework.jdbc.datasource.DataSourceUtils  - Returning JDBC Connection to DataSource
02:01:32,320 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.interceptor.LogInterceptor  - — StartProcessInstanceCmd finished ——————————————————–
02:01:32,320 [http-bio-8080-exec-1] DEBUG org.activiti.engine.impl.interceptor.LogInterceptor  -


thanks
Pratik

[frederikherema1]

AFAIK, the process-id should be NULL and the taskId should be filled in in order for the group to be a candidate for the task.

What do you get when you use the Java API (taskQuery.candidateUser("…")?