// 完成任务
@Test
public void completTask(){
// 获取引擎
ProcessEngine processEngine = ProcessEngines.getDefaultProcessEngine();
// 获取taskService
TaskService taskService = processEngine.getTaskService();
// 根据流程key 和 任务的负责人 查询任务
// 返回一个任务对象
Task task = taskService.createTaskQuery()
.processDefinitionKey("myLeave") //流程Key
.taskAssignee("financer") //要查询的负责人
.processInstanceId("75001")
.singleResult();
// 完成任务,参数:任务id
taskService.complete(task.getId());
}
2023-06-02 22:32:13,231 0 [ main] INFO activiti.engine.ProcessEngines - Initializing process engine using configuration 'file:/D:/workspace/20210614/ActivitiDemo/BasicDemo/target/classes/activiti.cfg.xml'
2023-06-02 22:32:13,233 2 [ main] INFO activiti.engine.ProcessEngines - initializing process engine for resource file:/D:/workspace/20210614/ActivitiDemo/BasicDemo/target/classes/activiti.cfg.xml
2023-06-02 22:32:13,525 294 [ main] DEBUG ry.xml.XmlBeanDefinitionReader - Loaded 2 bean definitions from InputStream resource [resource loaded through InputStream]
2023-06-02 22:32:13,528 297 [ main] DEBUG ort.DefaultListableBeanFactory - Creating shared instance of singleton bean 'processEngineConfiguration'
2023-06-02 22:32:13,796 565 [ main] DEBUG ort.DefaultListableBeanFactory - Creating shared instance of singleton bean 'dataSource'
2023-06-02 22:32:16,078 2847 [ main] DEBUG ProcessEngineConfigurationImpl - database product name: 'MySQL'
2023-06-02 22:32:16,078 2847 [ main] DEBUG ProcessEngineConfigurationImpl - using database type: mysql
2023-06-02 22:32:16,208 2977 [ main] DEBUG ache.ibatis.logging.LogFactory - Logging initialized using 'class org.apache.ibatis.logging.slf4j.Slf4jImpl' adapter.
WARNING: An illegal reflective access operation has occurred
WARNING: Illegal reflective access by org.apache.ibatis.reflection.Reflector (file:/D:/studysoftware/mavenRepository-gpidea/org/mybatis/mybatis/3.4.5/mybatis-3.4.5.jar) to method java.lang.Object.finalize()
WARNING: Please consider reporting this to the maintainers of org.apache.ibatis.reflection.Reflector
WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations
WARNING: All illegal access operations will be denied in a future release
2023-06-02 22:32:17,265 4034 [ main] DEBUG mpl.interceptor.LogInterceptor -
2023-06-02 22:32:17,265 4034 [ main] DEBUG mpl.interceptor.LogInterceptor - --- starting SchemaOperationsProcessEngineBuild --------------------------------------------------------
2023-06-02 22:32:17,268 4037 [ main] DEBUG da.DefaultActivitiEngineAgenda - Operation class org.activiti.engine.impl.interceptor.CommandInvoker$1 added to agenda
2023-06-02 22:32:17,274 4043 [ main] DEBUG ti.engine.impl.db.DbSqlSession - Executing performSchemaOperationsProcessEngineBuild with setting true
2023-06-02 22:32:17,274 4043 [ main] DEBUG ansaction.jdbc.JdbcTransaction - Opening JDBC Connection
2023-06-02 22:32:17,284 4053 [ main] DEBUG ansaction.jdbc.JdbcTransaction - Setting autocommit to false on JDBC Connection [jdbc:mysql://localhost:3306/activiti?serverTimezone=GMT%2B8, UserName=root@localhost, MySQL Connector/J]
2023-06-02 22:32:17,329 4098 [ main] DEBUG pertyEntityImpl.selectProperty - ==> Preparing: select * from ACT_GE_PROPERTY where NAME_ = ?
2023-06-02 22:32:17,347 4116 [ main] DEBUG pertyEntityImpl.selectProperty - ==> Parameters: schema.version(String)
2023-06-02 22:32:17,368 4137 [ main] DEBUG pertyEntityImpl.selectProperty - <== Total: 1
2023-06-02 22:32:17,387 4156 [ main] DEBUG ti.engine.impl.db.DbSqlSession - Flushing dbSqlSession
2023-06-02 22:32:17,387 4156 [ main] DEBUG ti.engine.impl.db.DbSqlSession - flush summary: 0 insert, 0 update, 0 delete.
2023-06-02 22:32:17,387 4156 [ main] DEBUG ti.engine.impl.db.DbSqlSession - now executing flush...
2023-06-02 22:32:17,388 4157 [ main] DEBUG aloneMybatisTransactionContext - firing event committing...
2023-06-02 22:32:17,388 4157 [ main] DEBUG aloneMybatisTransactionContext - committing the ibatis sql session...
2023-06-02 22:32:17,388 4157 [ main] DEBUG aloneMybatisTransactionContext - firing event committed...
2023-06-02 22:32:17,389 4158 [ main] DEBUG ansaction.jdbc.JdbcTransaction - Resetting autocommit to true on JDBC Connection [jdbc:mysql://localhost:3306/activiti?serverTimezone=GMT%2B8, UserName=root@localhost, MySQL Connector/J]
2023-06-02 22:32:17,390 4159 [ main] DEBUG ansaction.jdbc.JdbcTransaction - Closing JDBC Connection [jdbc:mysql://localhost:3306/activiti?serverTimezone=GMT%2B8, UserName=root@localhost, MySQL Connector/J]
2023-06-02 22:32:17,390 4159 [ main] DEBUG mpl.interceptor.LogInterceptor - --- SchemaOperationsProcessEngineBuild finished --------------------------------------------------------
2023-06-02 22:32:17,390 4159 [ main] DEBUG mpl.interceptor.LogInterceptor -
2023-06-02 22:32:17,390 4159 [ main] INFO .engine.impl.ProcessEngineImpl - ProcessEngine default created
2023-06-02 22:32:17,397 4166 [ main] DEBUG mpl.interceptor.LogInterceptor -
2023-06-02 22:32:17,397 4166 [ main] DEBUG mpl.interceptor.LogInterceptor - --- starting ValidateExecutionRelatedEntityCountCfgCmd --------------------------------------------------------
2023-06-02 22:32:17,397 4166 [ main] DEBUG da.DefaultActivitiEngineAgenda - Operation class org.activiti.engine.impl.interceptor.CommandInvoker$1 added to agenda
2023-06-02 22:32:17,397 4166 [ main] DEBUG ansaction.jdbc.JdbcTransaction - Opening JDBC Connection
2023-06-02 22:32:17,398 4167 [ main] DEBUG ansaction.jdbc.JdbcTransaction - Setting autocommit to false on JDBC Connection [jdbc:mysql://localhost:3306/activiti?serverTimezone=GMT%2B8, UserName=root@localhost, MySQL Connector/J]
2023-06-02 22:32:17,398 4167 [ main] DEBUG pertyEntityImpl.selectProperty - ==> Preparing: select * from ACT_GE_PROPERTY where NAME_ = ?
2023-06-02 22:32:17,398 4167 [ main] DEBUG pertyEntityImpl.selectProperty - ==> Parameters: cfg.execution-related-entities-count(String)
2023-06-02 22:32:17,399 4168 [ main] DEBUG pertyEntityImpl.selectProperty - <== Total: 1
2023-06-02 22:32:17,399 4168 [ main] DEBUG ti.engine.impl.db.DbSqlSession - Flushing dbSqlSession
2023-06-02 22:32:17,399 4168 [ main] DEBUG ti.engine.impl.db.DbSqlSession - flush summary: 0 insert, 0 update, 0 delete.
2023-06-02 22:32:17,400 4169 [ main] DEBUG ti.engine.impl.db.DbSqlSession - now executing flush...
2023-06-02 22:32:17,400 4169 [ main] DEBUG aloneMybatisTransactionContext - firing event committing...
2023-06-02 22:32:17,400 4169 [ main] DEBUG aloneMybatisTransactionContext - committing the ibatis sql session...
2023-06-02 22:32:17,400 4169 [ main] DEBUG aloneMybatisTransactionContext - firing event committed...
2023-06-02 22:32:17,400 4169 [ main] DEBUG ansaction.jdbc.JdbcTransaction - Resetting autocommit to true on JDBC Connection [jdbc:mysql://localhost:3306/activiti?serverTimezone=GMT%2B8, UserName=root@localhost, MySQL Connector/J]
2023-06-02 22:32:17,401 4170 [ main] DEBUG ansaction.jdbc.JdbcTransaction - Closing JDBC Connection [jdbc:mysql://localhost:3306/activiti?serverTimezone=GMT%2B8, UserName=root@localhost, MySQL Connector/J]
2023-06-02 22:32:17,401 4170 [ main] DEBUG mpl.interceptor.LogInterceptor - --- ValidateExecutionRelatedEntityCountCfgCmd finished --------------------------------------------------------
2023-06-02 22:32:17,401 4170 [ main] DEBUG mpl.interceptor.LogInterceptor -
2023-06-02 22:32:17,401 4170 [ main] INFO activiti.engine.ProcessEngines - initialised process engine default
2023-06-02 22:32:17,403 4172 [ main] DEBUG mpl.interceptor.LogInterceptor -
2023-06-02 22:32:17,403 4172 [ main] DEBUG mpl.interceptor.LogInterceptor - --- starting TaskQueryImpl --------------------------------------------------------
2023-06-02 22:32:17,403 4172 [ main] DEBUG da.DefaultActivitiEngineAgenda - Operation class org.activiti.engine.impl.interceptor.CommandInvoker$1 added to agenda
2023-06-02 22:32:17,449 4218 [ main] DEBUG ansaction.jdbc.JdbcTransaction - Opening JDBC Connection
2023-06-02 22:32:17,450 4219 [ main] DEBUG ansaction.jdbc.JdbcTransaction - Setting autocommit to false on JDBC Connection [jdbc:mysql://localhost:3306/activiti?serverTimezone=GMT%2B8, UserName=root@localhost, MySQL Connector/J]
2023-06-02 22:32:17,451 4220 [ main] DEBUG Impl.selectTaskByQueryCriteria - ==> Preparing: select distinct RES.* from ACT_RU_TASK RES inner join ACT_RE_PROCDEF D on RES.PROC_DEF_ID_ = D.ID_ WHERE RES.ASSIGNEE_ = ? and RES.PROC_INST_ID_ = ? and D.KEY_ = ? order by RES.ID_ asc LIMIT ? OFFSET ?
2023-06-02 22:32:17,451 4220 [ main] DEBUG Impl.selectTaskByQueryCriteria - ==> Parameters: financer(String), 75001(String), myLeave(String), 2147483647(Integer), 0(Integer)
2023-06-02 22:32:17,456 4225 [ main] DEBUG Impl.selectTaskByQueryCriteria - <== Total: 1
2023-06-02 22:32:17,456 4225 [ main] DEBUG ti.engine.impl.db.DbSqlSession - Flushing dbSqlSession
2023-06-02 22:32:17,456 4225 [ main] DEBUG ti.engine.impl.db.DbSqlSession - flush summary: 0 insert, 0 update, 0 delete.
2023-06-02 22:32:17,456 4225 [ main] DEBUG ti.engine.impl.db.DbSqlSession - now executing flush...
2023-06-02 22:32:17,456 4225 [ main] DEBUG aloneMybatisTransactionContext - firing event committing...
2023-06-02 22:32:17,456 4225 [ main] DEBUG aloneMybatisTransactionContext - committing the ibatis sql session...
2023-06-02 22:32:17,456 4225 [ main] DEBUG aloneMybatisTransactionContext - firing event committed...
2023-06-02 22:32:17,457 4226 [ main] DEBUG ansaction.jdbc.JdbcTransaction - Resetting autocommit to true on JDBC Connection [jdbc:mysql://localhost:3306/activiti?serverTimezone=GMT%2B8, UserName=root@localhost, MySQL Connector/J]
2023-06-02 22:32:17,458 4227 [ main] DEBUG ansaction.jdbc.JdbcTransaction - Closing JDBC Connection [jdbc:mysql://localhost:3306/activiti?serverTimezone=GMT%2B8, UserName=root@localhost, MySQL Connector/J]
2023-06-02 22:32:17,458 4227 [ main] DEBUG mpl.interceptor.LogInterceptor - --- TaskQueryImpl finished --------------------------------------------------------
2023-06-02 22:32:17,458 4227 [ main] DEBUG mpl.interceptor.LogInterceptor -
2023-06-02 22:32:17,460 4229 [ main] DEBUG mpl.interceptor.LogInterceptor -
2023-06-02 22:32:17,460 4229 [ main] DEBUG mpl.interceptor.LogInterceptor - --- starting CompleteTaskCmd --------------------------------------------------------
2023-06-02 22:32:17,460 4229 [ main] DEBUG da.DefaultActivitiEngineAgenda - Operation class org.activiti.engine.impl.interceptor.CommandInvoker$1 added to agenda
2023-06-02 22:32:17,460 4229 [ main] DEBUG ansaction.jdbc.JdbcTransaction - Opening JDBC Connection
2023-06-02 22:32:17,461 4230 [ main] DEBUG ansaction.jdbc.JdbcTransaction - Setting autocommit to false on JDBC Connection [jdbc:mysql://localhost:3306/activiti?serverTimezone=GMT%2B8, UserName=root@localhost, MySQL Connector/J]
2023-06-02 22:32:17,461 4230 [ main] DEBUG tity.TaskEntityImpl.selectTask - ==> Preparing: select * from ACT_RU_TASK where ID_ = ?
2023-06-02 22:32:17,461 4230 [ main] DEBUG tity.TaskEntityImpl.selectTask - ==> Parameters: 80002(String)
2023-06-02 22:32:17,463 4232 [ main] DEBUG tity.TaskEntityImpl.selectTask - <== Total: 1
2023-06-02 22:32:17,463 4232 [ main] DEBUG tyImpl.selectVariablesByTaskId - ==> Preparing: select * from ACT_RU_VARIABLE where TASK_ID_ = ?
2023-06-02 22:32:17,463 4232 [ main] DEBUG tyImpl.selectVariablesByTaskId - ==> Parameters: 80002(String)
2023-06-02 22:32:17,467 4236 [ main] DEBUG tyImpl.selectVariablesByTaskId - <== Total: 0
2023-06-02 22:32:17,469 4238 [ main] DEBUG tyImpl.selectProcessDefinition - ==> Preparing: select * from ACT_RE_PROCDEF where ID_ = ?
2023-06-02 22:32:17,469 4238 [ main] DEBUG tyImpl.selectProcessDefinition - ==> Parameters: myLeave:3:72504(String)
2023-06-02 22:32:17,471 4240 [ main] DEBUG tyImpl.selectProcessDefinition - <== Total: 1
2023-06-02 22:32:17,472 4241 [ main] DEBUG entEntityImpl.selectDeployment - ==> Preparing: select * from ACT_RE_DEPLOYMENT where ID_ = ?
2023-06-02 22:32:17,472 4241 [ main] DEBUG entEntityImpl.selectDeployment - ==> Parameters: 72501(String)
2023-06-02 22:32:17,479 4248 [ main] DEBUG entEntityImpl.selectDeployment - <== Total: 1
2023-06-02 22:32:17,479 4248 [ main] DEBUG mpl.bpmn.deployer.BpmnDeployer - Processing deployment ??????
2023-06-02 22:32:17,480 4249 [ main] DEBUG .selectResourcesByDeploymentId - ==> Preparing: select * from ACT_GE_BYTEARRAY where DEPLOYMENT_ID_ = ? order by NAME_ asc
2023-06-02 22:32:17,480 4249 [ main] DEBUG .selectResourcesByDeploymentId - ==> Parameters: 72501(String)
2023-06-02 22:32:17,490 4259 [ main] DEBUG .selectResourcesByDeploymentId - <== Total: 2
2023-06-02 22:32:17,491 4260 [ main] DEBUG ployer.ParsedDeploymentBuilder - Processing BPMN resource bpmn/Leave.bpmn
2023-06-02 22:32:17,557 4326 [ main] DEBUG er.handler.ProcessParseHandler - Parsing process myLeave
2023-06-02 22:32:17,561 4330 [ main] DEBUG ssDefinitionByDeploymentAndKey - ==> Preparing: select * from ACT_RE_PROCDEF where DEPLOYMENT_ID_ = ? and KEY_ = ? and (TENANT_ID_ = '' or TENANT_ID_ is null)
2023-06-02 22:32:17,562 4331 [ main] DEBUG ssDefinitionByDeploymentAndKey - ==> Parameters: 72501(String), myLeave(String)
2023-06-02 22:32:17,564 4333 [ main] DEBUG ssDefinitionByDeploymentAndKey - <== Total: 1
2023-06-02 22:32:17,565 4334 [ main] DEBUG mpl.interceptor.LogInterceptor -
2023-06-02 22:32:17,565 4334 [ main] DEBUG mpl.interceptor.LogInterceptor - --- starting GetProcessDefinitionInfoCmd --------------------------------------------------------
2023-06-02 22:32:17,565 4334 [ main] DEBUG ptor.CommandContextInterceptor - Valid context found. Reusing it for the current command 'org.activiti.engine.impl.cmd.GetProcessDefinitionInfoCmd'
2023-06-02 22:32:17,565 4334 [ main] DEBUG da.DefaultActivitiEngineAgenda - Operation class org.activiti.engine.impl.interceptor.CommandInvoker$1 added to agenda
2023-06-02 22:32:17,568 4337 [ main] DEBUG itionInfoByProcessDefinitionId - ==> Preparing: select * from ACT_PROCDEF_INFO where PROC_DEF_ID_ = ?
2023-06-02 22:32:17,568 4337 [ main] DEBUG itionInfoByProcessDefinitionId - ==> Parameters: myLeave:3:72504(String)
2023-06-02 22:32:17,572 4341 [ main] DEBUG itionInfoByProcessDefinitionId - <== Total: 0
2023-06-02 22:32:17,572 4341 [ main] DEBUG mpl.interceptor.LogInterceptor - --- GetProcessDefinitionInfoCmd finished --------------------------------------------------------
2023-06-02 22:32:17,572 4341 [ main] DEBUG mpl.interceptor.LogInterceptor -
2023-06-02 22:32:17,573 4342 [ main] DEBUG Impl.selectTasksByParentTaskId - ==> Preparing: select * from ACT_RU_TASK where PARENT_TASK_ID_ = ?
2023-06-02 22:32:17,573 4342 [ main] DEBUG Impl.selectTasksByParentTaskId - ==> Parameters: 80002(String)
2023-06-02 22:32:17,574 4343 [ main] DEBUG Impl.selectTasksByParentTaskId - <== Total: 0
2023-06-02 22:32:17,575 4344 [ main] DEBUG Impl.selectIdentityLinksByTask - ==> Preparing: select * from ACT_RU_IDENTITYLINK where TASK_ID_ = ?
2023-06-02 22:32:17,575 4344 [ main] DEBUG Impl.selectIdentityLinksByTask - ==> Parameters: 80002(String)
2023-06-02 22:32:17,578 4347 [ main] DEBUG Impl.selectIdentityLinksByTask - <== Total: 0
2023-06-02 22:32:17,579 4348 [ main] DEBUG .history.DefaultHistoryManager - Current history level: AUDIT, level required: AUDIT
2023-06-02 22:32:17,579 4348 [ main] DEBUG mpl.selectHistoricTaskInstance - ==> Preparing: select * from ACT_HI_TASKINST where ID_ = ?
2023-06-02 22:32:17,579 4348 [ main] DEBUG mpl.selectHistoricTaskInstance - ==> Parameters: 80002(String)
2023-06-02 22:32:17,584 4353 [ main] DEBUG mpl.selectHistoricTaskInstance - <== Total: 1
2023-06-02 22:32:17,584 4353 [ main] DEBUG tionEntityImpl.selectExecution - ==> Preparing: select E.*, S.PROC_INST_ID_ AS PARENT_PROC_INST_ID_ from ACT_RU_EXECUTION E LEFT OUTER JOIN ACT_RU_EXECUTION S ON E.SUPER_EXEC_ = S.ID_ where E.ID_ = ?
2023-06-02 22:32:17,585 4354 [ main] DEBUG tionEntityImpl.selectExecution - ==> Parameters: 75002(String)
2023-06-02 22:32:17,595 4364 [ main] DEBUG tionEntityImpl.selectExecution - <== Total: 1
2023-06-02 22:32:17,596 4365 [ main] DEBUG da.DefaultActivitiEngineAgenda - Operation class org.activiti.engine.impl.agenda.TriggerExecutionOperation added to agenda
2023-06-02 22:32:17,596 4365 [ main] DEBUG mpl.interceptor.CommandInvoker - Executing operation class org.activiti.engine.impl.agenda.TriggerExecutionOperation
2023-06-02 22:32:17,597 4366 [ main] DEBUG yImpl.selectTasksByExecutionId - ==> Preparing: select distinct T.* from ACT_RU_TASK T where T.EXECUTION_ID_ = ?
2023-06-02 22:32:17,597 4366 [ main] DEBUG yImpl.selectTasksByExecutionId - ==> Parameters: 75002(String)
2023-06-02 22:32:17,598 4367 [ main] DEBUG yImpl.selectTasksByExecutionId - <== Total: 1
2023-06-02 22:32:17,599 4368 [ main] DEBUG tionEntityImpl.selectExecution - ==> Preparing: select E.*, S.PROC_INST_ID_ AS PARENT_PROC_INST_ID_ from ACT_RU_EXECUTION E LEFT OUTER JOIN ACT_RU_EXECUTION S ON E.SUPER_EXEC_ = S.ID_ where E.ID_ = ?
2023-06-02 22:32:17,600 4369 [ main] DEBUG tionEntityImpl.selectExecution - ==> Parameters: 75001(String)
2023-06-02 22:32:17,604 4373 [ main] DEBUG tionEntityImpl.selectExecution - <== Total: 1
2023-06-02 22:32:17,610 4379 [ main] DEBUG da.DefaultActivitiEngineAgenda - Operation class org.activiti.engine.impl.agenda.TakeOutgoingSequenceFlowsOperation added to agenda
2023-06-02 22:32:17,610 4379 [ main] DEBUG mpl.interceptor.CommandInvoker - Executing operation class org.activiti.engine.impl.agenda.TakeOutgoingSequenceFlowsOperation
2023-06-02 22:32:17,610 4379 [ main] DEBUG .history.DefaultHistoryManager - Current history level: AUDIT, level required: ACTIVITY
2023-06-02 22:32:17,614 4383 [ main] DEBUG stanceExecutionIdAndActivityId - ==> Preparing: select * from ACT_HI_ACTINST RES where EXECUTION_ID_ = ? and ACT_ID_ = ? and END_TIME_ is null
2023-06-02 22:32:17,615 4384 [ main] DEBUG stanceExecutionIdAndActivityId - ==> Parameters: 75002(String), _5(String)
2023-06-02 22:32:17,620 4389 [ main] DEBUG stanceExecutionIdAndActivityId - <== Total: 1
2023-06-02 22:32:17,621 4390 [ main] DEBUG OutgoingSequenceFlowsOperation - Leaving flow node class org.activiti.bpmn.model.UserTask with id '_5' by following it's 1 outgoing sequenceflow
2023-06-02 22:32:17,622 4391 [ main] DEBUG da.DefaultActivitiEngineAgenda - Operation class org.activiti.engine.impl.agenda.ContinueProcessOperation added to agenda
2023-06-02 22:32:17,622 4391 [ main] DEBUG mpl.interceptor.CommandInvoker - Executing operation class org.activiti.engine.impl.agenda.ContinueProcessOperation
2023-06-02 22:32:17,624 4393 [ main] DEBUG genda.ContinueProcessOperation - Sequence flow '_10' encountered. Continuing process by following it using execution 75002
2023-06-02 22:32:17,624 4393 [ main] DEBUG da.DefaultActivitiEngineAgenda - Operation class org.activiti.engine.impl.agenda.ContinueProcessOperation added to agenda
2023-06-02 22:32:17,624 4393 [ main] DEBUG mpl.interceptor.CommandInvoker - Executing operation class org.activiti.engine.impl.agenda.ContinueProcessOperation
2023-06-02 22:32:17,624 4393 [ main] DEBUG .history.DefaultHistoryManager - Current history level: AUDIT, level required: ACTIVITY
2023-06-02 22:32:17,625 4394 [ main] DEBUG mpl.interceptor.LogInterceptor -
2023-06-02 22:32:17,625 4394 [ main] DEBUG mpl.interceptor.LogInterceptor - --- starting GetNextIdBlockCmd --------------------------------------------------------
2023-06-02 22:32:17,626 4395 [ main] DEBUG da.DefaultActivitiEngineAgenda - Operation class org.activiti.engine.impl.interceptor.CommandInvoker$1 added to agenda
2023-06-02 22:32:17,626 4395 [ main] DEBUG ansaction.jdbc.JdbcTransaction - Opening JDBC Connection
2023-06-02 22:32:17,667 4436 [ main] DEBUG ansaction.jdbc.JdbcTransaction - Setting autocommit to false on JDBC Connection [jdbc:mysql://localhost:3306/activiti?serverTimezone=GMT%2B8, UserName=root@localhost, MySQL Connector/J]
2023-06-02 22:32:17,668 4437 [ main] DEBUG pertyEntityImpl.selectProperty - ==> Preparing: select * from ACT_GE_PROPERTY where NAME_ = ?
2023-06-02 22:32:17,668 4437 [ main] DEBUG pertyEntityImpl.selectProperty - ==> Parameters: next.dbid(String)
2023-06-02 22:32:17,673 4442 [ main] DEBUG pertyEntityImpl.selectProperty - <== Total: 1
2023-06-02 22:32:17,674 4443 [ main] DEBUG ti.engine.impl.db.DbSqlSession - Flushing dbSqlSession
2023-06-02 22:32:17,675 4444 [ main] DEBUG ti.engine.impl.db.DbSqlSession - update PropertyEntity[name=next.dbid, value=85001]
2023-06-02 22:32:17,675 4444 [ main] DEBUG ti.engine.impl.db.DbSqlSession - flush summary: 0 insert, 1 update, 0 delete.
2023-06-02 22:32:17,675 4444 [ main] DEBUG ti.engine.impl.db.DbSqlSession - now executing flush...
2023-06-02 22:32:17,675 4444 [ main] DEBUG ti.engine.impl.db.DbSqlSession - updating: PropertyEntity[name=next.dbid, value=85001]
2023-06-02 22:32:17,675 4444 [ main] DEBUG pertyEntityImpl.updateProperty - ==> Preparing: update ACT_GE_PROPERTY SET REV_ = ?, VALUE_ = ? where NAME_ = ? and REV_ = ?
2023-06-02 22:32:17,675 4444 [ main] DEBUG pertyEntityImpl.updateProperty - ==> Parameters: 35(Integer), 85001(String), next.dbid(String), 34(Integer)
2023-06-02 22:32:17,698 4467 [ main] DEBUG pertyEntityImpl.updateProperty - <== Updates: 1
2023-06-02 22:32:17,699 4468 [ main] DEBUG aloneMybatisTransactionContext - firing event committing...
2023-06-02 22:32:17,699 4468 [ main] DEBUG aloneMybatisTransactionContext - committing the ibatis sql session...
2023-06-02 22:32:17,699 4468 [ main] DEBUG ansaction.jdbc.JdbcTransaction - Committing JDBC Connection [jdbc:mysql://localhost:3306/activiti?serverTimezone=GMT%2B8, UserName=root@localhost, MySQL Connector/J]
2023-06-02 22:32:17,740 4509 [ main] DEBUG aloneMybatisTransactionContext - firing event committed...
2023-06-02 22:32:17,741 4510 [ main] DEBUG ansaction.jdbc.JdbcTransaction - Resetting autocommit to true on JDBC Connection [jdbc:mysql://localhost:3306/activiti?serverTimezone=GMT%2B8, UserName=root@localhost, MySQL Connector/J]
2023-06-02 22:32:17,742 4511 [ main] DEBUG ansaction.jdbc.JdbcTransaction - Closing JDBC Connection [jdbc:mysql://localhost:3306/activiti?serverTimezone=GMT%2B8, UserName=root@localhost, MySQL Connector/J]
2023-06-02 22:32:17,742 4511 [ main] DEBUG mpl.interceptor.LogInterceptor - --- GetNextIdBlockCmd finished --------------------------------------------------------
2023-06-02 22:32:17,742 4511 [ main] DEBUG mpl.interceptor.LogInterceptor -
2023-06-02 22:32:17,743 4512 [ main] DEBUG genda.ContinueProcessOperation - Executing activityBehavior class org.activiti.engine.impl.bpmn.behavior.NoneEndEventActivityBehavior on activity '_6' with execution 75002
2023-06-02 22:32:17,743 4512 [ main] DEBUG da.DefaultActivitiEngineAgenda - Operation class org.activiti.engine.impl.agenda.TakeOutgoingSequenceFlowsOperation added to agenda
2023-06-02 22:32:17,743 4512 [ main] DEBUG mpl.interceptor.CommandInvoker - Executing operation class org.activiti.engine.impl.agenda.TakeOutgoingSequenceFlowsOperation
2023-06-02 22:32:17,743 4512 [ main] DEBUG .history.DefaultHistoryManager - Current history level: AUDIT, level required: ACTIVITY
2023-06-02 22:32:17,743 4512 [ main] DEBUG OutgoingSequenceFlowsOperation - Leaving flow node class org.activiti.bpmn.model.EndEvent with id '_6' by following it's 0 outgoing sequenceflow
2023-06-02 22:32:17,743 4512 [ main] DEBUG OutgoingSequenceFlowsOperation - No outgoing sequence flow found for flow node '_6'.
2023-06-02 22:32:17,762 4531 [ main] DEBUG da.DefaultActivitiEngineAgenda - Operation class org.activiti.engine.impl.agenda.EndExecutionOperation added to agenda
2023-06-02 22:32:17,762 4531 [ main] DEBUG mpl.interceptor.CommandInvoker - Executing operation class org.activiti.engine.impl.agenda.EndExecutionOperation
2023-06-02 22:32:17,762 4531 [ main] DEBUG l.agenda.EndExecutionOperation - Ending execution 75002
2023-06-02 22:32:17,762 4531 [ main] DEBUG .history.DefaultHistoryManager - Current history level: AUDIT, level required: ACTIVITY
2023-06-02 22:32:17,763 4532 [ main] DEBUG stanceExecutionIdAndActivityId - ==> Preparing: select * from ACT_HI_ACTINST RES where EXECUTION_ID_ = ? and ACT_ID_ = ? and END_TIME_ is null
2023-06-02 22:32:17,763 4532 [ main] DEBUG stanceExecutionIdAndActivityId - ==> Parameters: 75002(String), _6(String)
2023-06-02 22:32:17,765 4534 [ main] DEBUG stanceExecutionIdAndActivityId - <== Total: 0
2023-06-02 22:32:17,766 4535 [ main] DEBUG l.selectVariablesByExecutionId - ==> Preparing: select * from ACT_RU_VARIABLE where EXECUTION_ID_ = ? and TASK_ID_ is null
2023-06-02 22:32:17,766 4535 [ main] DEBUG l.selectVariablesByExecutionId - ==> Parameters: 75002(String)
2023-06-02 22:32:17,776 4545 [ main] DEBUG l.selectVariablesByExecutionId - <== Total: 0
2023-06-02 22:32:17,776 4545 [ main] DEBUG l.selectTimerJobsByExecutionId - ==> Preparing: select * from ACT_RU_TIMER_JOB J where J.EXECUTION_ID_ = ?
2023-06-02 22:32:17,776 4545 [ main] DEBUG l.selectTimerJobsByExecutionId - ==> Parameters: 75002(String)
2023-06-02 22:32:17,793 4562 [ main] DEBUG l.selectTimerJobsByExecutionId - <== Total: 0
2023-06-02 22:32:17,794 4563 [ main] DEBUG tyImpl.selectJobsByExecutionId - ==> Preparing: select * from ACT_RU_JOB J where J.EXECUTION_ID_ = ?
2023-06-02 22:32:17,795 4564 [ main] DEBUG tyImpl.selectJobsByExecutionId - ==> Parameters: 75002(String)
2023-06-02 22:32:17,814 4583 [ main] DEBUG tyImpl.selectJobsByExecutionId - <== Total: 0
2023-06-02 22:32:17,814 4583 [ main] DEBUG lectSuspendedJobsByExecutionId - ==> Preparing: select * from ACT_RU_SUSPENDED_JOB J where J.EXECUTION_ID_ = ?
2023-06-02 22:32:17,814 4583 [ main] DEBUG lectSuspendedJobsByExecutionId - ==> Parameters: 75002(String)
2023-06-02 22:32:17,830 4599 [ main] DEBUG lectSuspendedJobsByExecutionId - <== Total: 0
2023-06-02 22:32:17,831 4600 [ main] DEBUG ectDeadLetterJobsByExecutionId - ==> Preparing: select * from ACT_RU_DEADLETTER_JOB J where J.EXECUTION_ID_ = ?
2023-06-02 22:32:17,831 4600 [ main] DEBUG ectDeadLetterJobsByExecutionId - ==> Parameters: 75002(String)
2023-06-02 22:32:17,851 4620 [ main] DEBUG ectDeadLetterJobsByExecutionId - <== Total: 0
2023-06-02 22:32:17,851 4620 [ main] DEBUG tEventSubscriptionsByExecution - ==> Preparing: select * from ACT_RU_EVENT_SUBSCR where (EXECUTION_ID_ = ?)
2023-06-02 22:32:17,851 4620 [ main] DEBUG tEventSubscriptionsByExecution - ==> Parameters: 75002(String)
2023-06-02 22:32:17,855 4624 [ main] DEBUG tEventSubscriptionsByExecution - <== Total: 0
2023-06-02 22:32:17,856 4625 [ main] DEBUG l.agenda.EndExecutionOperation - Parent execution found. Continuing process using execution 75001
2023-06-02 22:32:17,856 4625 [ main] DEBUG tExecutionsByParentExecutionId - ==> Preparing: select E.*, S.PROC_INST_ID_ AS PARENT_PROC_INST_ID_ from ACT_RU_EXECUTION E LEFT OUTER JOIN ACT_RU_EXECUTION S ON E.SUPER_EXEC_ = S.ID_ where E.PARENT_ID_ = ?
2023-06-02 22:32:17,856 4625 [ main] DEBUG tExecutionsByParentExecutionId - ==> Parameters: 75001(String)
2023-06-02 22:32:17,858 4627 [ main] DEBUG tExecutionsByParentExecutionId - <== Total: 1
2023-06-02 22:32:17,859 4628 [ main] DEBUG l.agenda.EndExecutionOperation - No parent execution found. Verifying if process instance 75001 can be stopped.
2023-06-02 22:32:17,859 4628 [ main] DEBUG dExecutionsByProcessInstanceId - ==> Preparing: select E.*, S.PROC_INST_ID_ AS PARENT_PROC_INST_ID_ from ACT_RU_EXECUTION E LEFT OUTER JOIN ACT_RU_EXECUTION S ON E.SUPER_EXEC_ = S.ID_ where E.PROC_INST_ID_ = ? and E.PARENT_ID_ is not null
2023-06-02 22:32:17,859 4628 [ main] DEBUG dExecutionsByProcessInstanceId - ==> Parameters: 75001(String)
2023-06-02 22:32:17,862 4631 [ main] DEBUG dExecutionsByProcessInstanceId - <== Total: 1
2023-06-02 22:32:17,862 4631 [ main] DEBUG l.agenda.EndExecutionOperation - No active executions found. Ending process instance 75001
2023-06-02 22:32:17,862 4631 [ main] DEBUG cessInstanceBySuperExecutionId - ==> Preparing: select * from ACT_RU_EXECUTION where SUPER_EXEC_ = ?
2023-06-02 22:32:17,863 4632 [ main] DEBUG cessInstanceBySuperExecutionId - ==> Parameters: 75001(String)
2023-06-02 22:32:17,864 4633 [ main] DEBUG cessInstanceBySuperExecutionId - <== Total: 0
2023-06-02 22:32:17,864 4633 [ main] DEBUG .history.DefaultHistoryManager - Current history level: AUDIT, level required: ACTIVITY
2023-06-02 22:32:17,864 4633 [ main] DEBUG IdentityLinksByProcessInstance - ==> Preparing: select * from ACT_RU_IDENTITYLINK where PROC_INST_ID_ = ?
2023-06-02 22:32:17,864 4633 [ main] DEBUG IdentityLinksByProcessInstance - ==> Parameters: 75001(String)
2023-06-02 22:32:17,867 4636 [ main] DEBUG IdentityLinksByProcessInstance - <== Total: 3
2023-06-02 22:32:17,867 4636 [ main] DEBUG l.selectVariablesByExecutionId - ==> Preparing: select * from ACT_RU_VARIABLE where EXECUTION_ID_ = ? and TASK_ID_ is null
2023-06-02 22:32:17,867 4636 [ main] DEBUG l.selectVariablesByExecutionId - ==> Parameters: 75001(String)
2023-06-02 22:32:17,868 4637 [ main] DEBUG l.selectVariablesByExecutionId - <== Total: 0
2023-06-02 22:32:17,868 4637 [ main] DEBUG l.selectTimerJobsByExecutionId - ==> Preparing: select * from ACT_RU_TIMER_JOB J where J.EXECUTION_ID_ = ?
2023-06-02 22:32:17,869 4638 [ main] DEBUG l.selectTimerJobsByExecutionId - ==> Parameters: 75001(String)
2023-06-02 22:32:17,870 4639 [ main] DEBUG l.selectTimerJobsByExecutionId - <== Total: 0
2023-06-02 22:32:17,870 4639 [ main] DEBUG tyImpl.selectJobsByExecutionId - ==> Preparing: select * from ACT_RU_JOB J where J.EXECUTION_ID_ = ?
2023-06-02 22:32:17,870 4639 [ main] DEBUG tyImpl.selectJobsByExecutionId - ==> Parameters: 75001(String)
2023-06-02 22:32:17,873 4642 [ main] DEBUG tyImpl.selectJobsByExecutionId - <== Total: 0
2023-06-02 22:32:17,874 4643 [ main] DEBUG lectSuspendedJobsByExecutionId - ==> Preparing: select * from ACT_RU_SUSPENDED_JOB J where J.EXECUTION_ID_ = ?
2023-06-02 22:32:17,875 4644 [ main] DEBUG lectSuspendedJobsByExecutionId - ==> Parameters: 75001(String)
2023-06-02 22:32:17,876 4645 [ main] DEBUG lectSuspendedJobsByExecutionId - <== Total: 0
2023-06-02 22:32:17,876 4645 [ main] DEBUG ectDeadLetterJobsByExecutionId - ==> Preparing: select * from ACT_RU_DEADLETTER_JOB J where J.EXECUTION_ID_ = ?
2023-06-02 22:32:17,877 4646 [ main] DEBUG ectDeadLetterJobsByExecutionId - ==> Parameters: 75001(String)
2023-06-02 22:32:17,878 4647 [ main] DEBUG ectDeadLetterJobsByExecutionId - <== Total: 0
2023-06-02 22:32:17,878 4647 [ main] DEBUG tEventSubscriptionsByExecution - ==> Preparing: select * from ACT_RU_EVENT_SUBSCR where (EXECUTION_ID_ = ?)
2023-06-02 22:32:17,878 4647 [ main] DEBUG tEventSubscriptionsByExecution - ==> Parameters: 75001(String)
2023-06-02 22:32:17,879 4648 [ main] DEBUG tEventSubscriptionsByExecution - <== Total: 0
2023-06-02 22:32:17,879 4648 [ main] DEBUG yImpl.selectTasksByExecutionId - ==> Preparing: select distinct T.* from ACT_RU_TASK T where T.EXECUTION_ID_ = ?
2023-06-02 22:32:17,879 4648 [ main] DEBUG yImpl.selectTasksByExecutionId - ==> Parameters: 75001(String)
2023-06-02 22:32:17,880 4649 [ main] DEBUG yImpl.selectTasksByExecutionId - <== Total: 0
2023-06-02 22:32:17,880 4649 [ main] DEBUG .history.DefaultHistoryManager - Current history level: AUDIT, level required: ACTIVITY
2023-06-02 22:32:17,880 4649 [ main] DEBUG .selectHistoricProcessInstance - ==> Preparing: select * from ACT_HI_PROCINST where PROC_INST_ID_ = ?
2023-06-02 22:32:17,880 4649 [ main] DEBUG .selectHistoricProcessInstance - ==> Parameters: 75001(String)
2023-06-02 22:32:17,888 4657 [ main] DEBUG .selectHistoricProcessInstance - <== Total: 1
2023-06-02 22:32:17,890 4659 [ main] DEBUG da.DefaultActivitiEngineAgenda - Operation class org.activiti.engine.impl.agenda.ExecuteInactiveBehaviorsOperation added to agenda
2023-06-02 22:32:17,890 4659 [ main] DEBUG mpl.interceptor.CommandInvoker - Executing operation class org.activiti.engine.impl.agenda.ExecuteInactiveBehaviorsOperation
2023-06-02 22:32:17,891 4660 [ main] DEBUG ti.engine.impl.db.DbSqlSession - Flushing dbSqlSession
2023-06-02 22:32:17,892 4661 [ main] DEBUG ti.engine.impl.db.DbSqlSession - insert HistoricActivityInstanceEntity[id=82501, activityId=_6, activityName=EndEvent]
2023-06-02 22:32:17,892 4661 [ main] DEBUG ti.engine.impl.db.DbSqlSession - update Execution[ id '75002' ] - activity '_6 - parent '75001'
2023-06-02 22:32:17,892 4661 [ main] DEBUG ti.engine.impl.db.DbSqlSession - update ProcessInstance[75001]
2023-06-02 22:32:17,892 4661 [ main] DEBUG ti.engine.impl.db.DbSqlSession - update HistoricProcessInstanceEntity[superProcessInstanceId=null]
2023-06-02 22:32:17,892 4661 [ main] DEBUG ti.engine.impl.db.DbSqlSession - update org.activiti.engine.impl.persistence.entity.HistoricTaskInstanceEntityImpl@6b6b3572
2023-06-02 22:32:17,892 4661 [ main] DEBUG ti.engine.impl.db.DbSqlSession - update HistoricActivityInstanceEntity[id=80001, activityId=_5, activityName=????]
2023-06-02 22:32:17,892 4661 [ main] DEBUG ti.engine.impl.db.DbSqlSession - delete Execution[ id '75002' ] - activity '_6 - parent '75001' with id 75002
2023-06-02 22:32:17,892 4661 [ main] DEBUG ti.engine.impl.db.DbSqlSession - delete ProcessInstance[75001] with id 75001
2023-06-02 22:32:17,892 4661 [ main] DEBUG ti.engine.impl.db.DbSqlSession - delete Task[id=80002, name=????] with id 80002
2023-06-02 22:32:17,892 4661 [ main] DEBUG ti.engine.impl.db.DbSqlSession - delete IdentityLinkEntity[id=77503, type=participant, userId=manager, processInstanceId=75001] with id 77503
2023-06-02 22:32:17,892 4661 [ main] DEBUG ti.engine.impl.db.DbSqlSession - delete IdentityLinkEntity[id=80003, type=participant, userId=financer, processInstanceId=75001] with id 80003
2023-06-02 22:32:17,892 4661 [ main] DEBUG ti.engine.impl.db.DbSqlSession - delete IdentityLinkEntity[id=75006, type=participant, userId=worker, processInstanceId=75001] with id 75006
2023-06-02 22:32:17,892 4661 [ main] DEBUG ti.engine.impl.db.DbSqlSession - flush summary: 1 insert, 5 update, 6 delete.
2023-06-02 22:32:17,892 4661 [ main] DEBUG ti.engine.impl.db.DbSqlSession - now executing flush...
2023-06-02 22:32:17,893 4662 [ main] DEBUG ti.engine.impl.db.DbSqlSession - inserting: HistoricActivityInstanceEntity[id=82501, activityId=_6, activityName=EndEvent]
2023-06-02 22:32:17,893 4662 [ main] DEBUG 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_, DELETE_REASON_, TENANT_ID_ ) values ( ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ? )
2023-06-02 22:32:17,897 4666 [ main] DEBUG insertHistoricActivityInstance - ==> Parameters: 82501(String), myLeave:3:72504(String), 75001(String), 75002(String), _6(String), null, null, EndEvent(String), endEvent(String), null, 2023-06-02 22:32:17.742(Timestamp), 2023-06-02 22:32:17.743(Timestamp), 1(Long), null, (String)
2023-06-02 22:32:17,918 4687 [ main] DEBUG insertHistoricActivityInstance - <== Updates: 1
2023-06-02 22:32:17,918 4687 [ main] DEBUG ti.engine.impl.db.DbSqlSession - updating: Execution[ id '75002' ] - activity '_6 - parent '75001'
2023-06-02 22:32:17,918 4687 [ main] DEBUG tionEntityImpl.updateExecution - ==> Preparing: update ACT_RU_EXECUTION set REV_ = ?, BUSINESS_KEY_ = ?, PROC_DEF_ID_ = ?, ACT_ID_ = ?, IS_ACTIVE_ = ?, IS_CONCURRENT_ = ?, IS_SCOPE_ = ?, IS_EVENT_SCOPE_ = ?, IS_MI_ROOT_ = ?, PARENT_ID_ = ?, SUPER_EXEC_ = ?, ROOT_PROC_INST_ID_ = ?, SUSPENSION_STATE_ = ?, NAME_ = ?, IS_COUNT_ENABLED_ = ?, EVT_SUBSCR_COUNT_ = ?, TASK_COUNT_ = ?, JOB_COUNT_ = ?, TIMER_JOB_COUNT_ = ?, SUSP_JOB_COUNT_ = ?, DEADLETTER_JOB_COUNT_ = ?, VAR_COUNT_ = ?, ID_LINK_COUNT_ = ?, APP_VERSION_ = ? where ID_ = ? and REV_ = ?
2023-06-02 22:32:17,920 4689 [ main] DEBUG tionEntityImpl.updateExecution - ==> Parameters: 4(Integer), null, myLeave:3:72504(String), _6(String), false(Boolean), false(Boolean), false(Boolean), false(Boolean), false(Boolean), 75001(String), null, 75001(String), 1(Integer), null, false(Boolean), 0(Integer), 0(Integer), 0(Integer), 0(Integer), 0(Integer), 0(Integer), 0(Integer), 0(Integer), null, 75002(String), 3(Integer)
2023-06-02 22:32:17,933 4702 [ main] DEBUG tionEntityImpl.updateExecution - <== Updates: 1
2023-06-02 22:32:17,934 4703 [ main] DEBUG ti.engine.impl.db.DbSqlSession - updating: ProcessInstance[75001]
2023-06-02 22:32:17,934 4703 [ main] DEBUG tionEntityImpl.updateExecution - ==> Preparing: update ACT_RU_EXECUTION set REV_ = ?, BUSINESS_KEY_ = ?, PROC_DEF_ID_ = ?, ACT_ID_ = ?, IS_ACTIVE_ = ?, IS_CONCURRENT_ = ?, IS_SCOPE_ = ?, IS_EVENT_SCOPE_ = ?, IS_MI_ROOT_ = ?, PARENT_ID_ = ?, SUPER_EXEC_ = ?, ROOT_PROC_INST_ID_ = ?, SUSPENSION_STATE_ = ?, NAME_ = ?, IS_COUNT_ENABLED_ = ?, EVT_SUBSCR_COUNT_ = ?, TASK_COUNT_ = ?, JOB_COUNT_ = ?, TIMER_JOB_COUNT_ = ?, SUSP_JOB_COUNT_ = ?, DEADLETTER_JOB_COUNT_ = ?, VAR_COUNT_ = ?, ID_LINK_COUNT_ = ?, APP_VERSION_ = ? where ID_ = ? and REV_ = ?
2023-06-02 22:32:17,935 4704 [ main] DEBUG tionEntityImpl.updateExecution - ==> Parameters: 2(Integer), null, myLeave:3:72504(String), null, false(Boolean), false(Boolean), true(Boolean), false(Boolean), false(Boolean), null, null, 75001(String), 1(Integer), null, false(Boolean), 0(Integer), 0(Integer), 0(Integer), 0(Integer), 0(Integer), 0(Integer), 0(Integer), 0(Integer), null, 75001(String), 1(Integer)
2023-06-02 22:32:17,938 4707 [ main] DEBUG tionEntityImpl.updateExecution - <== Updates: 1
2023-06-02 22:32:17,938 4707 [ main] DEBUG ti.engine.impl.db.DbSqlSession - updating: HistoricProcessInstanceEntity[superProcessInstanceId=null]
2023-06-02 22:32:17,938 4707 [ main] DEBUG .updateHistoricProcessInstance - ==> Preparing: update ACT_HI_PROCINST set PROC_DEF_ID_ = ?, BUSINESS_KEY_ = ?, START_TIME_ = ?, END_TIME_ = ?, DURATION_ = ?, END_ACT_ID_ = ?, DELETE_REASON_ = ?, NAME_ = ? where ID_ = ?
2023-06-02 22:32:17,939 4708 [ main] DEBUG .updateHistoricProcessInstance - ==> Parameters: myLeave:3:72504(String), null, 2023-06-02 21:54:10.077(Timestamp), 2023-06-02 22:32:17.889(Timestamp), 2287812(Long), _6(String), null, null, 75001(String)
2023-06-02 22:32:17,941 4710 [ main] DEBUG .updateHistoricProcessInstance - <== Updates: 1
2023-06-02 22:32:17,941 4710 [ main] DEBUG ti.engine.impl.db.DbSqlSession - updating: org.activiti.engine.impl.persistence.entity.HistoricTaskInstanceEntityImpl@6b6b3572
2023-06-02 22:32:17,941 4710 [ main] DEBUG mpl.updateHistoricTaskInstance - ==> Preparing: update ACT_HI_TASKINST set PROC_DEF_ID_ = ?, EXECUTION_ID_ = ?, NAME_ = ?, PARENT_TASK_ID_ = ?, DESCRIPTION_ = ?, OWNER_ = ?, ASSIGNEE_ = ?, CLAIM_TIME_ = ?, END_TIME_ = ?, DURATION_ = ?, DELETE_REASON_ = ?, TASK_DEF_KEY_ = ?, FORM_KEY_ = ?, PRIORITY_ = ?, DUE_DATE_ = ?, CATEGORY_ = ? where ID_ = ?
2023-06-02 22:32:17,942 4711 [ main] DEBUG mpl.updateHistoricTaskInstance - ==> Parameters: myLeave:3:72504(String), 75002(String), ????(String), null, null, null, financer(String), null, 2023-06-02 22:32:17.584(Timestamp), 276650(Long), null, _5(String), null, 50(Integer), null, null, 80002(String)
2023-06-02 22:32:17,943 4712 [ main] DEBUG mpl.updateHistoricTaskInstance - <== Updates: 1
2023-06-02 22:32:17,943 4712 [ main] DEBUG ti.engine.impl.db.DbSqlSession - updating: HistoricActivityInstanceEntity[id=80001, activityId=_5, activityName=????]
2023-06-02 22:32:17,943 4712 [ main] DEBUG updateHistoricActivityInstance - ==> Preparing: update ACT_HI_ACTINST set EXECUTION_ID_ = ?, ASSIGNEE_ = ?, END_TIME_ = ?, DURATION_ = ?, DELETE_REASON_ = ? where ID_ = ?
2023-06-02 22:32:17,944 4713 [ main] DEBUG updateHistoricActivityInstance - ==> Parameters: 75002(String), financer(String), 2023-06-02 22:32:17.62(Timestamp), 276709(Long), null, 80001(String)
2023-06-02 22:32:17,945 4714 [ main] DEBUG updateHistoricActivityInstance - <== Updates: 1
2023-06-02 22:32:17,945 4714 [ main] DEBUG kEntityImpl.deleteIdentityLink - ==> Preparing: delete from ACT_RU_IDENTITYLINK where ID_ = ?
2023-06-02 22:32:17,945 4714 [ main] DEBUG kEntityImpl.deleteIdentityLink - ==> Parameters: 77503(String)
2023-06-02 22:32:17,947 4716 [ main] DEBUG kEntityImpl.deleteIdentityLink - <== Updates: 1
2023-06-02 22:32:17,947 4716 [ main] DEBUG kEntityImpl.deleteIdentityLink - ==> Preparing: delete from ACT_RU_IDENTITYLINK where ID_ = ?
2023-06-02 22:32:17,948 4717 [ main] DEBUG kEntityImpl.deleteIdentityLink - ==> Parameters: 80003(String)
2023-06-02 22:32:17,949 4718 [ main] DEBUG kEntityImpl.deleteIdentityLink - <== Updates: 1
2023-06-02 22:32:17,949 4718 [ main] DEBUG kEntityImpl.deleteIdentityLink - ==> Preparing: delete from ACT_RU_IDENTITYLINK where ID_ = ?
2023-06-02 22:32:17,949 4718 [ main] DEBUG kEntityImpl.deleteIdentityLink - ==> Parameters: 75006(String)
2023-06-02 22:32:17,951 4720 [ main] DEBUG kEntityImpl.deleteIdentityLink - <== Updates: 1
2023-06-02 22:32:17,952 4721 [ main] DEBUG tity.TaskEntityImpl.deleteTask - ==> Preparing: delete from ACT_RU_TASK where ID_ = ? and REV_ = ?
2023-06-02 22:32:17,952 4721 [ main] DEBUG tity.TaskEntityImpl.deleteTask - ==> Parameters: 80002(String), 1(Integer)
2023-06-02 22:32:18,081 4850 [ main] DEBUG tity.TaskEntityImpl.deleteTask - <== Updates: 1
2023-06-02 22:32:18,081 4850 [ main] DEBUG tionEntityImpl.deleteExecution - ==> Preparing: delete from ACT_RU_EXECUTION where ID_ = ? and REV_ = ?
2023-06-02 22:32:18,081 4850 [ main] DEBUG tionEntityImpl.deleteExecution - ==> Parameters: 75002(String), 4(Integer)
2023-06-02 22:32:18,187 4956 [ main] DEBUG tionEntityImpl.deleteExecution - <== Updates: 1
2023-06-02 22:32:18,188 4957 [ main] DEBUG tionEntityImpl.deleteExecution - ==> Preparing: delete from ACT_RU_EXECUTION where ID_ = ? and REV_ = ?
2023-06-02 22:32:18,188 4957 [ main] DEBUG tionEntityImpl.deleteExecution - ==> Parameters: 75001(String), 2(Integer)
2023-06-02 22:32:18,290 5059 [ main] DEBUG tionEntityImpl.deleteExecution - <== Updates: 1
2023-06-02 22:32:18,290 5059 [ main] DEBUG aloneMybatisTransactionContext - firing event committing...
2023-06-02 22:32:18,290 5059 [ main] DEBUG aloneMybatisTransactionContext - committing the ibatis sql session...
2023-06-02 22:32:18,291 5060 [ main] DEBUG ansaction.jdbc.JdbcTransaction - Committing JDBC Connection [jdbc:mysql://localhost:3306/activiti?serverTimezone=GMT%2B8, UserName=root@localhost, MySQL Connector/J]
2023-06-02 22:32:18,317 5086 [ main] DEBUG aloneMybatisTransactionContext - firing event committed...
2023-06-02 22:32:18,318 5087 [ main] DEBUG ansaction.jdbc.JdbcTransaction - Resetting autocommit to true on JDBC Connection [jdbc:mysql://localhost:3306/activiti?serverTimezone=GMT%2B8, UserName=root@localhost, MySQL Connector/J]
2023-06-02 22:32:18,320 5089 [ main] DEBUG ansaction.jdbc.JdbcTransaction - Closing JDBC Connection [jdbc:mysql://localhost:3306/activiti?serverTimezone=GMT%2B8, UserName=root@localhost, MySQL Connector/J]
2023-06-02 22:32:18,322 5091 [ main] DEBUG mpl.interceptor.LogInterceptor - --- CompleteTaskCmd finished --------------------------------------------------------
2023-06-02 22:32:18,322 5091 [ main] DEBUG mpl.interceptor.LogInterceptor -
Process finished with exit code 0