topic having problem with LockFreeJobExecutor in Alfresco Archive https://connect.hyland.com/t5/alfresco-archive/having-problem-with-lockfreejobexecutor/m-p/208670#M161800 <HTML><HEAD></HEAD><BODY><SPAN>We are incubating activiti 5.16.4 in our dev environment with some regression testing for existed applications and also configured LockFreeJobExecutor implementation in activiti-context. During this process, I am facing a problem with LockfreeJobExecutor in parallel flow. </SPAN><BR /><BR /><SPAN>I am using a 2 way parallel flow implementation in my application. Each flow direction has its own human task and a serviceTask with timer and both are scheduled for same time. When serviceTask start executing, I will get 2 tasks at each parallel flow. To identify corresponding task, I passed taskDefKey as expression field to serviceTask. Here, I am getting taskDefKey expression value same for both service tasks.&nbsp; BTW, with default JobExecutor implementation, both service tasks does their job flawlessly. </SPAN><BR /><SPAN>Here is the log for the process. You can notice in below log for two job executor threads pool-1-thread-4, pool-1-thread-6.</SPAN><BR /><BR /><BR /><SPAN>09-Dec-2014[10:18:53.049]:<img id="smileyvery-happy" class="emoticon emoticon-smileyvery-happy" src="https://connect.hyland.com/i/smilies/16x16_smiley-very-happy.png" alt="Smiley Very Happy" title="Smiley Very Happy" />EBUG:<img id="smileytongue" class="emoticon emoticon-smileytongue" src="https://connect.hyland.com/i/smilies/16x16_smiley-tongue.png" alt="Smiley Tongue" title="Smiley Tongue" />ool-1-thread-4::c.u.n.w.t.e.s.EscalationServiceTask:38 - ExecutionId : 10e2616a-7fbf-11e4-8f2f-020030001d3c</SPAN><BR /><SPAN>09-Dec-2014[10:18:53.057]:<img id="smileyvery-happy" class="emoticon emoticon-smileyvery-happy" src="https://connect.hyland.com/i/smilies/16x16_smiley-very-happy.png" alt="Smiley Very Happy" title="Smiley Very Happy" />EBUG:<img id="smileytongue" class="emoticon emoticon-smileytongue" src="https://connect.hyland.com/i/smilies/16x16_smiley-tongue.png" alt="Smiley Tongue" title="Smiley Tongue" />ool-1-thread-6::c.u.n.w.t.e.s.EscalationServiceTask:38 - ExecutionId : 10e324bc-7fbf-11e4-8f2f-020030001d3c</SPAN><BR /><SPAN>09-Dec-2014[10:18:53.077]:<img id="smileyvery-happy" class="emoticon emoticon-smileyvery-happy" src="https://connect.hyland.com/i/smilies/16x16_smiley-very-happy.png" alt="Smiley Very Happy" title="Smiley Very Happy" />EBUG:<img id="smileytongue" class="emoticon emoticon-smileytongue" src="https://connect.hyland.com/i/smilies/16x16_smiley-tongue.png" alt="Smiley Tongue" title="Smiley Tongue" />ool-1-thread-4::c.u.n.w.t.e.s.EscalationServiceTask:51 - tasks size: 2</SPAN><BR /><SPAN>09-Dec-2014[10:18:53.078]:<img id="smileyvery-happy" class="emoticon emoticon-smileyvery-happy" src="https://connect.hyland.com/i/smilies/16x16_smiley-very-happy.png" alt="Smiley Very Happy" title="Smiley Very Happy" />EBUG:<img id="smileytongue" class="emoticon emoticon-smileytongue" src="https://connect.hyland.com/i/smilies/16x16_smiley-tongue.png" alt="Smiley Tongue" title="Smiley Tongue" />ool-1-thread-4::c.u.n.w.t.e.s.EscalationServiceTask:62 - taskDefKey Expression value: ParallelTask1</SPAN><BR /><SPAN>09-Dec-2014[10:18:53.079]:<img id="smileyvery-happy" class="emoticon emoticon-smileyvery-happy" src="https://connect.hyland.com/i/smilies/16x16_smiley-very-happy.png" alt="Smiley Very Happy" title="Smiley Very Happy" />EBUG:<img id="smileytongue" class="emoticon emoticon-smileytongue" src="https://connect.hyland.com/i/smilies/16x16_smiley-tongue.png" alt="Smiley Tongue" title="Smiley Tongue" />ool-1-thread-4::c.u.n.w.t.e.s.EscalationServiceTask:67 - returned taskItem getExpectedtTask: Task[id=0adaa609-7fbf-11e4-8f2f-020030001d3c, name=ParallelTask1]</SPAN><BR /><SPAN>09-Dec-2014[10:18:53.080]:<img id="smileyvery-happy" class="emoticon emoticon-smileyvery-happy" src="https://connect.hyland.com/i/smilies/16x16_smiley-very-happy.png" alt="Smiley Very Happy" title="Smiley Very Happy" />EBUG:<img id="smileytongue" class="emoticon emoticon-smileytongue" src="https://connect.hyland.com/i/smilies/16x16_smiley-tongue.png" alt="Smiley Tongue" title="Smiley Tongue" />ool-1-thread-4::c.u.n.w.t.e.s.EscalationServiceTask:43 - Task.execId : 0ad88323-7fbf-11e4-8f2f-020030001d3c</SPAN><BR /><SPAN>09-Dec-2014[10:18:53.084]:<img id="smileyvery-happy" class="emoticon emoticon-smileyvery-happy" src="https://connect.hyland.com/i/smilies/16x16_smiley-very-happy.png" alt="Smiley Very Happy" title="Smiley Very Happy" />EBUG:<img id="smileytongue" class="emoticon emoticon-smileytongue" src="https://connect.hyland.com/i/smilies/16x16_smiley-tongue.png" alt="Smiley Tongue" title="Smiley Tongue" />ool-1-thread-6::c.u.n.w.t.e.s.EscalationServiceTask:51 - tasks size: 2</SPAN><BR /><SPAN>09-Dec-2014[10:18:53.085]:<img id="smileyvery-happy" class="emoticon emoticon-smileyvery-happy" src="https://connect.hyland.com/i/smilies/16x16_smiley-very-happy.png" alt="Smiley Very Happy" title="Smiley Very Happy" />EBUG:<img id="smileytongue" class="emoticon emoticon-smileytongue" src="https://connect.hyland.com/i/smilies/16x16_smiley-tongue.png" alt="Smiley Tongue" title="Smiley Tongue" />ool-1-thread-6::c.u.n.w.t.e.s.EscalationServiceTask:62 - taskDefKey Expression value: ParallelTask1</SPAN><BR /><SPAN>09-Dec-2014[10:18:53.086]:<img id="smileyvery-happy" class="emoticon emoticon-smileyvery-happy" src="https://connect.hyland.com/i/smilies/16x16_smiley-very-happy.png" alt="Smiley Very Happy" title="Smiley Very Happy" />EBUG:<img id="smileytongue" class="emoticon emoticon-smileytongue" src="https://connect.hyland.com/i/smilies/16x16_smiley-tongue.png" alt="Smiley Tongue" title="Smiley Tongue" />ool-1-thread-6::c.u.n.w.t.e.s.EscalationServiceTask:67 - returned taskItem getExpectedtTask: Task[id=0adaa609-7fbf-11e4-8f2f-020030001d3c, name=ParallelTask1]</SPAN><BR /><SPAN>09-Dec-2014[10:18:53.087]:<img id="smileyvery-happy" class="emoticon emoticon-smileyvery-happy" src="https://connect.hyland.com/i/smilies/16x16_smiley-very-happy.png" alt="Smiley Very Happy" title="Smiley Very Happy" />EBUG:<img id="smileytongue" class="emoticon emoticon-smileytongue" src="https://connect.hyland.com/i/smilies/16x16_smiley-tongue.png" alt="Smiley Tongue" title="Smiley Tongue" />ool-1-thread-6::c.u.n.w.t.e.s.EscalationServiceTask:43 - Task.execId : 0ad88323-7fbf-11e4-8f2f-020030001d3c</SPAN><BR /><SPAN>09-Dec-2014[10:18:53.101]::INFO :<img id="smileytongue" class="emoticon emoticon-smileytongue" src="https://connect.hyland.com/i/smilies/16x16_smiley-tongue.png" alt="Smiley Tongue" title="Smiley Tongue" />ool-1-thread-6::c.u.n.w.t.e.s.EscalationServiceTask:82 - -&gt; EscalationServiceTask execute called with taskId : 0adaa609-7fbf-11e4-8f2f-020030001d3c</SPAN><BR /><SPAN>09-Dec-2014[10:18:53.102]::INFO :<img id="smileytongue" class="emoticon emoticon-smileytongue" src="https://connect.hyland.com/i/smilies/16x16_smiley-tongue.png" alt="Smiley Tongue" title="Smiley Tongue" />ool-1-thread-6::c.u.n.w.t.e.s.EscalationServiceTask:87 - -&gt; execute with parentProcessInstId : 0816a3aa-7fbf-11e4-8f2f-020030001d3c parentTaskId : 0adaa609-7fbf-11e4-8f2f-020030001d3c and parentTaskDefinition : ParallelTask1</SPAN><BR /><SPAN>09-Dec-2014[10:18:53.103]::INFO :<img id="smileytongue" class="emoticon emoticon-smileytongue" src="https://connect.hyland.com/i/smilies/16x16_smiley-tongue.png" alt="Smiley Tongue" title="Smiley Tongue" />ool-1-thread-4::c.u.n.w.t.e.s.EscalationServiceTask:82 - -&gt; EscalationServiceTask execute called with taskId : 0adaa609-7fbf-11e4-8f2f-020030001d3c</SPAN><BR /><SPAN>09-Dec-2014[10:18:53.104]::INFO :<img id="smileytongue" class="emoticon emoticon-smileytongue" src="https://connect.hyland.com/i/smilies/16x16_smiley-tongue.png" alt="Smiley Tongue" title="Smiley Tongue" />ool-1-thread-4::c.u.n.w.t.e.s.EscalationServiceTask:87 - -&gt; execute with parentProcessInstId : 0816a3aa-7fbf-11e4-8f2f-020030001d3c parentTaskId : 0adaa609-7fbf-11e4-8f2f-020030001d3c and parentTaskDefinition : ParallelTask1</SPAN><BR /><BR /><SPAN>and later, I am getting OptimisticLockingException as follows for one of the thread. pool-1-thread-6 won the race.</SPAN><BR /><SPAN>09-Dec-2014[10:18:53.404]::ERROR:<img id="smileytongue" class="emoticon emoticon-smileytongue" src="https://connect.hyland.com/i/smilies/16x16_smiley-tongue.png" alt="Smiley Tongue" title="Smiley Tongue" />ool-1-thread-4:<img id="smileysurprised" class="emoticon emoticon-smileysurprised" src="https://connect.hyland.com/i/smilies/16x16_smiley-surprised.png" alt="Smiley Surprised" title="Smiley Surprised" />rg.activiti.engine.impl.jobexecutor.ExecuteJobsRunnable:71 - exception during job execution: HistoricVariableInstanceEntity[id=081d5b0e-7fbf-11e4-8f2f-020030001d3c, name=notificationMessageContent, revision=0, type=string, textValue=blah blah blah] was updated by another transaction concurrently</SPAN><BR /><SPAN>org.activiti.engine.ActivitiOptimisticLockingException: HistoricVariableInstanceEntity[id=081d5b0e-7fbf-11e4-8f2f-020030001d3c, name=notificationMessageContent, revision=0, type=string, textValue=blah blah blah] was updated by another transaction concurrently</SPAN><BR /><SPAN>at org.activiti.engine.impl.db.DbSqlSession.flushUpdates(DbSqlSession.java:780)</SPAN><BR /><SPAN>at org.activiti.engine.impl.db.DbSqlSession.flush(DbSqlSession.java:591)</SPAN><BR /><SPAN>at org.activiti.engine.impl.interceptor.CommandContext.flushSessions(CommandContext.java:211)</SPAN><BR /><SPAN>at org.activiti.engine.impl.interceptor.CommandContext.close(CommandContext.java:137)</SPAN><BR /><SPAN>at org.activiti.engine.impl.interceptor.CommandContextInterceptor.execute(CommandContextInterceptor.java:66)</SPAN><BR /><SPAN>at org.activiti.spring.SpringTransactionInterceptor$1.doInTransaction(SpringTransactionInterceptor.java:47)</SPAN><BR /><SPAN>at org.springframework.transaction.support.TransactionTemplate.execute(TransactionTemplate.java:131)</SPAN><BR /><SPAN>at org.activiti.spring.SpringTransactionInterceptor.execute(SpringTransactionInterceptor.java:45)</SPAN><BR /><SPAN>at org.activiti.engine.impl.interceptor.LogInterceptor.execute(LogInterceptor.java:31)</SPAN><BR /><SPAN>at org.activiti.engine.impl.cfg.CommandExecutorImpl.execute(CommandExecutorImpl.java:40)</SPAN><BR /><SPAN>at org.activiti.engine.impl.cfg.CommandExecutorImpl.execute(CommandExecutorImpl.java:35)</SPAN><BR /><SPAN>at org.activiti.engine.impl.jobexecutor.ExecuteJobsRunnable.handleSingleJob(ExecuteJobsRunnable.java:69)</SPAN><BR /><SPAN>at org.activiti.engine.impl.jobexecutor.ExecuteJobsRunnable.run(ExecuteJobsRunnable.java:52)</SPAN><BR /><SPAN>at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)</SPAN><BR /><SPAN>at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)</SPAN><BR /><SPAN>at java.lang.Thread.run(Thread.java:745) </SPAN><BR /><BR /><SPAN>I am just wondering that serviceTask expressions are not thread safe it seems while using LockFreeJobExecutor implementation.&nbsp;&nbsp; &lt;b&gt; Is it a bug or any configuration required??&nbsp; &lt;/b&gt;</SPAN><BR /><SPAN>&nbsp; &lt;bean id="lockFreeJobExecutor" class="org.activiti.engine.impl.jobexecutor.LockFreeJobExecutor"&gt;</SPAN><BR /><SPAN>&nbsp;&nbsp;&nbsp; &lt;property name="queueSize" value="10" /&gt;</SPAN><BR /><SPAN>&nbsp;&nbsp;&nbsp; &lt;property name="corePoolSize" value="10" /&gt;</SPAN><BR /><SPAN>&nbsp;&nbsp;&nbsp; &lt;property name="maxPoolSize" value="50" /&gt;</SPAN><BR /><SPAN>&nbsp;&nbsp;&nbsp; &lt;property name="keepAliveTime" value="5000" /&gt;</SPAN><BR /><SPAN>&nbsp;&nbsp;&nbsp; &lt;property name="jobFetchBatchSize" value="200" /&gt;</SPAN><BR /><SPAN>&nbsp; &lt;/bean&gt; </SPAN><BR /><SPAN>Please suggest me some solution.</SPAN><BR /><BR /><SPAN>Thanks,</SPAN><BR /><SPAN>Swamy.</SPAN><BR /><BR /></BODY></HTML> Tue, 09 Dec 2014 17:27:01 GMT swamy2156 2014-12-09T17:27:01Z having problem with LockFreeJobExecutor https://connect.hyland.com/t5/alfresco-archive/having-problem-with-lockfreejobexecutor/m-p/208670#M161800 We are incubating activiti 5.16.4 in our dev environment with some regression testing for existed applications and also configured LockFreeJobExecutor implementation in activiti-context. During this process, I am facing a problem with LockfreeJobExecutor in parallel flow. I am using a 2 way parallel Tue, 09 Dec 2014 17:27:01 GMT https://connect.hyland.com/t5/alfresco-archive/having-problem-with-lockfreejobexecutor/m-p/208670#M161800 swamy2156 2014-12-09T17:27:01Z Re: having problem with LockFreeJobExecutor https://connect.hyland.com/t5/alfresco-archive/having-problem-with-lockfreejobexecutor/m-p/208671#M161801 <HTML><HEAD></HEAD><BODY><SPAN>The LockFreeJobExecutor was an early prototype. </SPAN><BR /><SPAN>It will be removed in the 5.17 release and superseded by the AsyncExecutor.</SPAN><BR /><BR /><SPAN>With 5.16.4, the recommended approach is the default Job Executor.</SPAN></BODY></HTML> Tue, 09 Dec 2014 18:16:58 GMT https://connect.hyland.com/t5/alfresco-archive/having-problem-with-lockfreejobexecutor/m-p/208671#M161801 jbarrez 2014-12-09T18:16:58Z Re: having problem with LockFreeJobExecutor https://connect.hyland.com/t5/alfresco-archive/having-problem-with-lockfreejobexecutor/m-p/208672#M161802 <HTML><HEAD></HEAD><BODY><SPAN>Thanks for the info joram. What is the tentative date for v5.17??</SPAN></BODY></HTML> Tue, 09 Dec 2014 18:23:29 GMT https://connect.hyland.com/t5/alfresco-archive/having-problem-with-lockfreejobexecutor/m-p/208672#M161802 swamy2156 2014-12-09T18:23:29Z