4 Replies Latest reply on Oct 31, 2007 11:59 AM by pbrewer_uk

jBPM timer doesnt fire

pbrewer_uk Oct 31, 2007 7:34 AM

I'm trying to get a simple jbpm timer to fire in JBoss 4.2.1GA, Seam 1.2.1.GA (using jbpm 3.1.4) with JSF RI 1.2 and RichFaces 3.1.1:

 <task-node name="timerTest">
 <event type="node-enter">
 <action expression="#{timerTestWorkflow.logNodeEnter}" />
 </event>
 <event type="node-leave">
 <action expression="#{timerTestWorkflow.logNodeLeave}" />
 </event>
 <task name="timerTestTask" description="TimerTestTask">
 <assignment actor-id="admin" />
 <event type="task-create">
 <action expression="#{timerTestWorkflow.logTaskCreate}" />
 </event>
 <event type="timer-create">
 <action expression="#{timerTestWorkflow.logTimerCreate}" />
 </event>
 <timer duedate="1 minute" transition="finished">
 <action expression="#{timerTestWorkflow.logTimerFired}" />
 </timer>
 </task>
 <transition name="finished" to="end" />
 </task-node>

When running the process, everything appears to work except for the firing of the timer. I can see a record in the JBPM_TIMER table with a duedate scheduled for a minutes time, but the minute passes without a log message, the task doesn't close and there's no exception in the logs.

Here is the log:

2007-10-31 11:11:45,364 DEBUG [org.jbpm.configuration.JbpmContextInfo] creating jbpm context with service factories '[message, scheduler, authentication, persistence, logging]'
2007-10-31 11:11:45,364 DEBUG [org.jbpm.JbpmContext] creating JbpmContext
2007-10-31 11:11:45,364 DEBUG [org.jbpm.configuration.JbpmContextInfo] creating jbpm context with service factories '[message, scheduler, authentication, persistence, logging]'
2007-10-31 11:11:45,364 DEBUG [org.jbpm.JbpmContext] creating JbpmContext
2007-10-31 11:11:45,364 DEBUG [org.jbpm.JbpmContext] closing JbpmContext
2007-10-31 11:11:45,364 DEBUG [org.jbpm.persistence.db.DbPersistenceServiceFactory] creating persistence service
2007-10-31 11:11:45,364 DEBUG [org.jbpm.persistence.db.DbPersistenceService] creating hibernate session
2007-10-31 11:11:45,411 DEBUG [org.jbpm.graph.def.GraphElement] event 'process-start' on 'ProcessDefinition(timerTest)' for 'Token(/)'
2007-10-31 11:11:45,411 DEBUG [org.jbpm.graph.def.GraphElement] event 'before-signal' on 'StartState(start)' for 'Token(/)'
2007-10-31 11:11:45,411 DEBUG [org.jbpm.graph.def.GraphElement] event 'node-leave' on 'StartState(start)' for 'Token(/)'
2007-10-31 11:11:45,411 DEBUG [org.jbpm.graph.def.GraphElement] event 'transition' on 'Transition()' for 'Token(/)'
2007-10-31 11:11:45,411 DEBUG [org.jbpm.graph.def.GraphElement] event 'node-enter' on 'TaskNode(timerTest)' for 'Token(/)'
2007-10-31 11:11:45,411 WARN [org.hibernate.engine.StatefulPersistenceContext.ProxyWarnLog] Narrowing proxy to class org.jbpm.graph.node.TaskNode - this operation breaks ==
2007-10-31 11:11:45,411 DEBUG [org.jbpm.graph.def.GraphElement] executing action '#{timerTestWorkflow.logNodeEnter}'
2007-10-31 11:11:45,411 DEBUG [org.jbpm.jpdl.el.impl.BeanMethod] invoking expression method 'logNodeEnter'
2007-10-31 11:11:45,411 INFO [uk.co.iblocks.midas.workflow.TimerTestWorkflow] logNodeEnter
2007-10-31 11:11:45,426 DEBUG [org.jbpm.graph.def.GraphElement] event 'task-create' on 'Task(timerTestTask)' for 'Token(/)'
2007-10-31 11:11:45,457 DEBUG [org.jbpm.graph.def.GraphElement] executing action 'CreateTimerAction(845640)'
2007-10-31 11:11:45,457 DEBUG [org.jbpm.graph.def.GraphElement] event 'timer-create' on 'Task(timerTestTask)' for 'Token(/)'
2007-10-31 11:11:45,457 DEBUG [org.jbpm.graph.def.GraphElement] executing action '#{timerTestWorkflow.logTimerCreate}'
2007-10-31 11:11:45,457 DEBUG [org.jbpm.jpdl.el.impl.BeanMethod] invoking expression method 'logTimerCreate'
2007-10-31 11:11:45,457 INFO [uk.co.iblocks.midas.workflow.TimerTestWorkflow] logTimerCreate
2007-10-31 11:11:45,457 DEBUG [org.jbpm.db.SchedulerSession] saving timer
2007-10-31 11:11:45,457 DEBUG [org.jbpm.graph.def.GraphElement] executing action '#{timerTestWorkflow.logTaskCreate}'
2007-10-31 11:11:45,457 DEBUG [org.jbpm.jpdl.el.impl.BeanMethod] invoking expression method 'logTaskCreate'
2007-10-31 11:11:45,457 INFO [uk.co.iblocks.midas.workflow.TimerTestWorkflow] logTaskCreate
2007-10-31 11:11:45,457 DEBUG [org.jbpm.graph.def.GraphElement] event 'task-assign' on 'Task(timerTestTask)' for 'Token(/)'
2007-10-31 11:11:45,457 DEBUG [org.jbpm.graph.def.GraphElement] event 'after-signal' on 'StartState(start)' for 'Token(/)'
2007-10-31 11:11:45,520 DEBUG [org.jbpm.JbpmContext] closing JbpmContext
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,520 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] executing default save operations
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.HibernateSaveOperation] saving process instance
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.SaveLogsOperation] flushing logs to logging service.
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.save.CascadeSaveOperation] cascading save of 'org.jbpm.graph.exe.ProcessInstance@dfd28b'
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] closing service 'persistence': org.jbpm.persistence.db.DbPersistenceService@1d90252
2007-10-31 11:11:45,535 DEBUG [org.jbpm.persistence.db.DbPersistenceService] flushing hibernate session
2007-10-31 11:11:45,535 DEBUG [org.jbpm.persistence.db.DbPersistenceService] closing hibernate session
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] closing service 'scheduler': org.jbpm.scheduler.db.DbSchedulerService@223279
2007-10-31 11:11:45,535 DEBUG [org.jbpm.svc.Services] closing service 'logging': org.jbpm.logging.db.DbLoggingService@11fa600

If you need any further information, please let me know e.g. config files etc

If anyone has any suggests or comments they would gratefully be received, this problem has been bugging me for ages!

Thanks in advance,
Pete.

1. Re: jBPM timer doesnt fire

pmuir Oct 31, 2007 7:43 AM (in response to pbrewer_uk)

Seam doesn't have support for JBPM timers in 1.2.1 and hence the EL expression won't call your Seam component. As to what the process does when the timer executes, thats a jbpm question.
Actions
2. Re: jBPM timer doesnt fire

pbrewer_uk Oct 31, 2007 8:43 AM (in response to pbrewer_uk)
Ah, ok thanks, I've changed the timer definition to:
<timer duedate="1 minute" transition="finished"> <action class="uk.co.iblocks.midas.workflow.TimerTestWorkflow" /> </timer>

which implements the ActionHandler and simply outputs a debug message. But the behaviour is the same: the timer is created but nothing happens when it's supposed to fire.

1. Are you saying this is something I should query with the jbpm forum, or is this a seam and jbpm configuration issue?

2. Will Seam 2.0 fully support timers?

Many thanks, Pete.
Actions
3. Re: jBPM timer doesnt fire

pmuir Oct 31, 2007 9:09 AM (in response to pbrewer_uk)

1) Yes
Actions

4. Re: jBPM timer doesnt fire

pbrewer_uk Oct 31, 2007 11:59 AM (in response to pbrewer_uk)

I've discovered that I'm missing a scheduler service. jBPM 3.1.4 provides a SchedulerServlet that I had trouble getting to work out of the box, so I created a Seam component that starts the scheduler instead.

This helps to some extent with Seam 1.2.1.GA integration, but be aware that since there is no interception around timer executions you cannot use seam components in the workflow.

I think I'll wait for Seam 2 GA. For anyone that's interested, here's my seam component:

package uk.co.iblocks.iflow.jbpm;

import java.util.Date;
import java.util.LinkedList;
import java.util.List;

import org.jboss.seam.Component;
import org.jboss.seam.ScopeType;
import org.jboss.seam.annotations.Create;
import org.jboss.seam.annotations.Destroy;
import org.jboss.seam.annotations.Install;
import org.jboss.seam.annotations.Logger;
import org.jboss.seam.annotations.Name;
import org.jboss.seam.annotations.Scope;
import org.jboss.seam.annotations.Startup;
import org.jboss.seam.core.Jbpm;
import org.jboss.seam.log.Log;
import org.jboss.seam.log.Logging;
import org.jbpm.scheduler.exe.Timer;
import org.jbpm.scheduler.impl.SchedulerHistoryLog;
import org.jbpm.scheduler.impl.SchedulerListener;
import org.jbpm.scheduler.impl.SchedulerThread;

@Name("jbpmScheduler")
@Scope(ScopeType.APPLICATION)
@Startup(depends={"org.jboss.seam.core.jbpm"})
@Install(dependencies="org.jboss.seam.core.jbpm")
public class JbpmScheduler {

 private class HistoryListener implements SchedulerListener {

 private Log executionLog = Logging.getLog(getClass()) ;

 public void timerExecuted(Date date, Timer timer) {
 executionLog.debug("Executed timer: id=#0, task=#1", timer.getId(), timer.getName()) ;
 historyLogs.add(new SchedulerHistoryLog(date, timer));
 if (historyLogs.size()>historyMaxSize) {
 historyLogs.removeLast();
 }
 }
 }

 private SchedulerThread schedulerThread = null ;
 private LinkedList<SchedulerHistoryLog> historyLogs = new LinkedList<SchedulerHistoryLog>();
 private int interval = 5000;
 private int historyMaxSize = 50 ;

 @Logger
 private Log log ;

 @Create
 public void startup() {
 log.info("Starting the jBPM scheduler");
 Jbpm jbpm = (Jbpm) Component.getInstance("jbpm") ;
 schedulerThread = new SchedulerThread(jbpm.getJbpmConfiguration());
 schedulerThread.setInterval(interval);
 schedulerThread.addListener(new HistoryListener());
 schedulerThread.start();
 log.info("jBPM scheduler has started.");
 }

 @Destroy
 public void shutdown() {
 if (isRunning()) {
 log.info("Stopping the jBPM scheduler.");
 schedulerThread.quit() ;
 schedulerThread = null;
 } else {
 log.debug("jBPM Scheduler can't be stopped because it was not running.");
 }
 }

 public boolean isRunning() {
 return ( (schedulerThread!=null)
 && (schedulerThread.isAlive()) );
 }

 public List<SchedulerHistoryLog> getSchedulerHistoryLogs() {
 return historyLogs;
 }

 public void clearSchedulerHistoryLogs() {
 historyLogs.clear();
 }

 public int getHistoryMaxSize() {
 return historyMaxSize;
 }
 public void setHistoryMaxSize(int historyMaxSize) {
 this.historyMaxSize = historyMaxSize;
 }
 public int getInterval() {
 return interval;
 }
 public void setInterval(int interval) {
 this.interval = interval;
 }

 public SchedulerThread getSchedulerThread() {
 return schedulerThread;
 }

}

Cheers, Pete

Go to original post