topic JBPM Workflow in Alfresco 4.0 fails silently @ task-create in Alfresco Archive https://connect.hyland.com/t5/alfresco-archive/jbpm-workflow-in-alfresco-4-0-fails-silently-task-create/m-p/273556#M226686 <HTML><HEAD></HEAD><BODY><SPAN>I have an advanced JBPM workflow that I am trying to run in Alfresco 4.0.1. It runs without error in Alfresco 3.4.3 and 3.4.5.</SPAN><BR /><BR /><SPAN>I am able to run JBPM workflows after adding </SPAN><PRE class="language-none line-numbers"><CODE>system.workflow.engine.jbpm.enabled=true<BR />system.workflow.engine.jbpm.definitions.visible=true<SPAN class="line-numbers-rows"><SPAN>‍</SPAN><SPAN>‍</SPAN></SPAN></CODE></PRE><SPAN> to alfresco-global.properties.</SPAN><BR /><BR /><SPAN>In Alfresco 4, this workflow fails "silently" after JBPM hits any "task-create" action other than the one for the start task. By "fails silently," I mean that no error messages are printed anywhere, and setting </SPAN><PRE class="language-none line-numbers"><CODE>log4j.logger.org.jbpm=debug<BR />log4j.logger.org.alfresco.repo.workflow=debug<SPAN class="line-numbers-rows"><SPAN>‍</SPAN><SPAN>‍</SPAN></SPAN></CODE></PRE><SPAN> doesn't produce any useful information about WHY the workflow is failing. </SPAN><BR /><BR /><SPAN>Starting the workflow from Alfresco Share simply pops up a box informing me that the "Workflow could not be started" with no extra information.</SPAN><BR /><BR /><SPAN>I have another, much simpler "hello world" advanced JBPM workflow that also worked without error in 3.4.x, which works just fine in Alfresco 4.0, and it does not have any problems with task-create.</SPAN><BR /><BR /><SPAN>This suggests to me that the problem must lie somewhere in the first, problematic workflow, either in its process definition, its model, or the stuff it does while it runs.</SPAN><BR /><BR /><SPAN>First, here's a snippet of what the FAILING workflow outputs to the log file as it tries to create a task:</SPAN><BR /><PRE class="language-none line-numbers"><CODE>2012-08-03 15:09:11,258&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-2] update variable 'has_folders' in 'TokenVariableMap[/]' to value 'no'<BR /> 2012-08-03 15:09:11,258&nbsp; DEBUG [graph.exe.Token] [http-8081-2] token[4571] is unlocked by token[4571]<BR /> 2012-08-03 15:09:11,336&nbsp; DEBUG [graph.node.Decision] [http-8081-2] decision didn't select transition, taking default Transition(no_folders)<BR /> 2012-08-03 15:09:11,336&nbsp; DEBUG [graph.node.Decision] [http-8081-2] decision check_folders is taking 'Transition(no_folders)'<BR /> 2012-08-03 15:09:11,336&nbsp; DEBUG [graph.def.GraphElement] [http-8081-2] event 'node-leave' on 'Decision(check_folders)' for 'Token(/)'<BR /> 2012-08-03 15:09:11,336&nbsp; DEBUG [graph.def.GraphElement] [http-8081-2] event 'transition' on 'Transition(no_folders)' for 'Token(/)'<BR /> 2012-08-03 15:09:11,340&nbsp; DEBUG [graph.def.GraphElement] [http-8081-2] event 'node-enter' on 'TaskNode(need_folders)' for 'Token(/)'<BR /> 2012-08-03 15:09:11,345&nbsp; DEBUG [graph.def.GraphElement] [http-8081-2] event 'task-create' on 'Task(docusignwf:requesting_folders)' for 'Token(/)'<BR /> 2012-08-03 15:09:11,425&nbsp; DEBUG [org.jbpm.JbpmContext] [http-8081-2] closing jbpmContext org.jbpm.JbpmContext@738f23<BR /> 2012-08-03 15:09:11,425&nbsp; DEBUG [jbpm.svc.Services] [http-8081-2] closing service 'persistence': org.jbpm.persistence.db.DbPersistenceService@68662676<BR /> 2012-08-03 15:09:11,425&nbsp; DEBUG [jbpm.svc.Services] [http-8081-2] closing service 'tx': org.jbpm.tx.TxService@a674286<BR /> 2012-08-03 15:09:11,425&nbsp; DEBUG [jbpm.svc.Services] [http-8081-2] closing service 'logging': org.jbpm.logging.db.DbLoggingService@14070c0<BR /> 2012-08-03 15:09:11,425&nbsp; DEBUG [jbpm.svc.Services] [http-8081-2] closing service 'authentication': org.jbpm.security.authentication.DefaultAuthenticationService@2daa4de4<BR /> 2012-08-03 15:09:11,425&nbsp; DEBUG [alfresco.repo.workflow] [http-8081-2] Detached (rollback) JBPM Context from transaction 1c83f695-9336-4067-8c6a-aa58f71e48b7<SPAN class="line-numbers-rows"><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN></SPAN></CODE></PRE><BR /><SPAN>By comparision, here's what the WORKING workflow prints to the log as it tries to create a task:</SPAN><BR /><PRE class="language-none line-numbers"><CODE> 2012-08-03 15:35:56,060&nbsp; DEBUG [graph.def.GraphElement] [http-8081-5] event 'node-leave' on 'StartState(start)' for 'Token(/)'<BR /> 2012-08-03 15:35:56,060&nbsp; DEBUG [graph.def.GraphElement] [http-8081-5] event 'transition' on 'Transition(to_hello)' for 'Token(/)'<BR /> 2012-08-03 15:35:56,064&nbsp; DEBUG [graph.def.GraphElement] [http-8081-5] event 'node-enter' on 'TaskNode(hello)' for 'Token(/)'<BR /> 2012-08-03 15:35:56,068&nbsp; DEBUG [graph.def.GraphElement] [http-8081-5] event 'task-create' on 'Task(hw:are_you_sure)' for 'Token(/)'<BR /> 2012-08-03 15:35:56,072&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-5] create variable 'bpm_percentComplete' in 'TaskInstance(hw:are_you_sure)' with value '0'<BR /> 2012-08-03 15:35:56,072&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-5] create variable 'bpm_status' in 'TaskInstance(hw:are_you_sure)' with value 'Not Yet Started'<BR /> 2012-08-03 15:35:56,072&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-5] create variable 'bpm_reassignable' in 'TaskInstance(hw:are_you_sure)' with value 'true'<BR /> 2012-08-03 15:35:56,072&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-5] create variable 'bpm_hiddenTransitions' in 'TaskInstance(hw:are_you_sure)' with value ''<BR /> 2012-08-03 15:35:56,072&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-5] create variable 'bpm_packageActionGroup' in 'TaskInstance(hw:are_you_sure)' with value ''<BR /> 2012-08-03 15:35:56,072&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-5] create variable 'bpm_packageItemActionGroup' in 'TaskInstance(hw:are_you_sure)' with value 'read_package_item_actions'<BR /> 2012-08-03 15:35:56,072&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-5] assigning task 'hw:are_you_sure' to 'admin'<BR /> 2012-08-03 15:35:56,072&nbsp; DEBUG [graph.def.GraphElement] [http-8081-5] event 'task-assign' on 'Task(hw:are_you_sure)' for 'Token(/)'<BR /> 2012-08-03 15:35:56,072&nbsp; DEBUG [graph.def.GraphElement] [http-8081-5] event 'after-signal' on 'StartState(start)' for 'Token(/)'<BR /> 2012-08-03 15:35:56,072&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-5] create variable 'bpm_context' in 'TokenVariableMap[/]' with value 'null'<BR /> 2012-08-03 15:35:56,072&nbsp; DEBUG [jbpm.svc.Services] [http-8081-5] executing default save operations<BR /> 2012-08-03 15:35:56,074&nbsp; DEBUG [svc.save.HibernateSaveOperation] [http-8081-5] saving process instance<BR /> 2012-08-03 15:35:56,074&nbsp; DEBUG [svc.save.SaveLogsOperation] [http-8081-5] flushing logs to logging service.<BR /> 2012-08-03 15:35:56,093&nbsp; DEBUG [svc.save.CascadeSaveOperation] [http-8081-5] cascading save of 'ProcessInstance(36b584cf-5078-4be4-91d7-c4f68613c3d2)'<BR /> 2012-08-03 15:35:56,197&nbsp; DEBUG [org.jbpm.JbpmContext] [http-8081-5] closing jbpmContext org.jbpm.JbpmContext@46d3ddd8<BR /> 2012-08-03 15:35:56,197&nbsp; DEBUG [jbpm.svc.Services] [http-8081-5] closing service 'persistence': org.jbpm.persistence.db.DbPersistenceService@236afc22<BR /> 2012-08-03 15:35:56,197&nbsp; DEBUG [jbpm.svc.Services] [http-8081-5] closing service 'tx': org.jbpm.tx.TxService@44cf2e58<BR /> 2012-08-03 15:35:56,197&nbsp; DEBUG [jbpm.svc.Services] [http-8081-5] closing service 'logging': org.jbpm.logging.db.DbLoggingService@7debb6b2<BR /> 2012-08-03 15:35:56,197&nbsp; DEBUG [jbpm.svc.Services] [http-8081-5] closing service 'authentication': org.jbpm.security.authentication.DefaultAuthenticationService@7e27a0b3<BR /> 2012-08-03 15:35:56,197&nbsp; DEBUG [alfresco.repo.workflow] [http-8081-5] Detached (commit) JBPM Context from transaction ccf454c9-4e4a-40f9-8dc3-934a4ac0f6bd<BR /><SPAN class="line-numbers-rows"><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN></SPAN></CODE></PRE><BR /><SPAN>The XML from the process definition of the FAILING WORKFLOW that defines the task in question:</SPAN><BR /><PRE class="language-none line-numbers"><CODE>&lt;task-node name="need_folders"&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;task name="docusignwf:requesting_folders" swimlane="initiator" /&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;transition name="provided_folders" to="check_folders" &gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;script&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;!– input validation; never executes because workflow terminates on task-create, above –&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;/script&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;/transition&gt;<BR />&lt;/task-node&gt;<SPAN class="line-numbers-rows"><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN></SPAN></CODE></PRE><SPAN>The swimlane is the first child element of the &lt;process-definition …&gt; element, defined thusly:</SPAN><BR /><PRE class="language-none line-numbers"><CODE>&lt;swimlane name="initiator" /&gt;<SPAN class="line-numbers-rows"><SPAN>‍</SPAN></SPAN></CODE></PRE><BR /><SPAN>And in the FAILING WORKFLOW's model, the "requesting_folders" task's type is defined:</SPAN><BR /><PRE class="language-none line-numbers"><CODE>&lt;types&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;(…)&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;type name="docusignwf:requesting_folders"&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;parent&gt;bpm:workflowTask&lt;/parent&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;mandatory-aspects&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;aspect&gt;docusignwf:provides_folders&lt;/aspect&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;/mandatory-aspects&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;/type&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;type name="docusignwf:waiting_actions"&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;parent&gt;bpm:workflowTask&lt;/parent&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;/type&gt;<BR />&lt;/types&gt;<SPAN class="line-numbers-rows"><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN></SPAN></CODE></PRE><SPAN>I've left the definition of another task, "waiting_actions" in there. This workflow can head to either one of those tasks (each in its own task-node), depending on what the user provides when starting it. Both of those tasks experience the same silent failure - and "waiting actions" has no input, no properties, and no aspects. To me, this suggests that there's not a problem with "requesting_folders" having aspects/requiring input.</SPAN><BR /><BR /><SPAN>Now, here are snippets from the SUCCESSFUL WORKFLOW. First, the process definition. This one's short enough to where I can just post the whole thing:</SPAN><BR /><PRE class="language-none line-numbers"><CODE>&lt;?xml version="1.0" encoding="UTF-8"?&gt;<BR /><BR />&lt;process-definition xmlns="urn:jbpm.org:jpdl-3.1" name="hw:helloWorld"&gt;<BR /><BR />&nbsp;&nbsp;&nbsp;&lt;swimlane name="initiator" /&gt;<BR /><BR />&nbsp;&nbsp;&nbsp;&lt;start-state name="start"&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;task name="hw:cant_have_no_tasks" swimlane="initiator"/&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;transition name="to_hello" to="hello"&gt;&lt;/transition&gt;<BR />&nbsp;&nbsp;&nbsp;&lt;/start-state&gt;<BR /><BR />&nbsp;&nbsp;&nbsp;&lt;task-node name="hello"&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;task name="hw:are_you_sure" swimlane="initiator" /&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;transition name="to_end1" to="end1"&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;action class="org.alfresco.repo.workflow.jbpm.AlfrescoJavaScript"&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;script&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;logger.log("Hello World.");<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;/script&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;/action&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;/transition&gt;<BR />&nbsp;&nbsp;&nbsp;&lt;/task-node&gt;<BR /><BR />&nbsp;&nbsp;&nbsp;&lt;end-state name="end1"&gt;&lt;/end-state&gt;<BR /><BR />&lt;/process-definition&gt;<SPAN class="line-numbers-rows"><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN></SPAN></CODE></PRE><BR /><SPAN>As you can see, the swimlane definition and task-node definition and task definition are syntactically identical to the FAILING WORKFLOW.</SPAN><BR /><BR /><SPAN>Now, the SUCCEEDING WORKFLOW's task type definition, from its model:</SPAN><BR /><PRE class="language-none line-numbers"><CODE>&lt;types&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;type name="hw:cant_have_no_tasks"&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;parent&gt;bpm:startTask&lt;/parent&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;/type&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;type name="hw:are_you_sure"&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;parent&gt;bpm:workflowTask&lt;/parent&gt;<BR />&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&lt;/type&gt;<BR />&lt;/types&gt;<SPAN class="line-numbers-rows"><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN></SPAN></CODE></PRE><SPAN>No parameters or anything; the user just clicks a button for the transition to advance the workflow.</SPAN><BR /><BR /><SPAN>I note that the FAILING WORKFLOW succeeds up until it attempts to create a task; elements from its model are referenced and used, so the model has been loaded properly, and the workflow definition, too, has been loaded properly (else I wouldn't even be able to start the workflow).</SPAN><BR /><BR /><SPAN>COMPLETE trace for SUCCESSFUL WORKFLOW:</SPAN><PRE class="language-none line-numbers"><CODE> 2012-08-03 15:58:21,852&nbsp; DEBUG [jbpm.configuration.JbpmContextInfo] [http-8081-4] creating jbpm context with service factories '[message, tx, scheduler, authentication, persistence, logging]'<BR /> 2012-08-03 15:58:21,852&nbsp; DEBUG [org.jbpm.JbpmContext] [http-8081-4] creating org.jbpm.JbpmContext@4a814c0d<BR /> 2012-08-03 15:58:21,852&nbsp; DEBUG [alfresco.repo.workflow] [http-8081-4] Attached JBPM Context to transaction d437a7a6-8e63-404e-866c-3f15dc671272<BR /> 2012-08-03 15:58:21,852&nbsp; DEBUG [persistence.db.DbPersistenceServiceFactory] [http-8081-4] creating persistence service<BR /> 2012-08-03 15:58:21,852&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-4] injecting a session disables transaction<BR /> 2012-08-03 15:58:21,955&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-4] injecting a session disables transaction<BR /> 2012-08-03 15:58:21,957&nbsp; DEBUG [graph.def.GraphElement] [http-8081-4] event 'process-start' on 'ProcessDefinition(hw:helloWorld)' for 'Token(/)'<BR /> 2012-08-03 15:58:21,959&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'cancelled' in 'TokenVariableMap[/]' with value 'false'<BR /> 2012-08-03 15:58:21,961&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_package' in 'TokenVariableMap[/]' with value 'Node Type: {<A href="http://www.alfresco.org/model/bpm/1.0}package" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/bpm/1.0}package</A>, Node Aspects: [{<A href="http://www.alfresco.org/model/content/1.0}auditable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}auditable</A>, {<A href="http://www.alfresco.org/model/system/1.0}referenceable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}referenceable</A>, {<A href="http://www.alfresco.org/model/system/1.0}localized" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}localized</A>, {<A href="http://www.alfresco.org/model/bpm/1.0}workflowPackage" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/bpm/1.0}workflowPackage</A>]'<BR /> 2012-08-03 15:58:21,989&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'companyhome' in 'TokenVariableMap[/]' with value 'Node Type: {<A href="http://www.alfresco.org/model/content/1.0}folder" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}folder</A>, Node Aspects: [{<A href="http://www.alfresco.org/model/content/1.0}auditable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}auditable</A>, {<A href="http://www.alfresco.org/model/application/1.0}uifacets" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/application/1.0}uifacets</A>, {<A href="http://www.alfresco.org/model/system/1.0}referenceable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}referenceable</A>, {<A href="http://www.alfresco.org/model/content/1.0}titled" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}titled</A>, {<A href="http://www.alfresco.org/model/system/1.0}localized" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}localized</A>]'<BR /> 2012-08-03 15:58:21,990&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'initiator' in 'TokenVariableMap[/]' with value 'Node Type: {<A href="http://www.alfresco.org/model/content/1.0}person" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}person</A>, Node Aspects: [{<A href="http://www.alfresco.org/model/application/1.0}configurable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/application/1.0}configurable</A>, {<A href="http://www.alfresco.org/model/content/1.0}ownable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}ownable</A>, {<A href="http://www.alfresco.org/model/system/1.0}referenceable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}referenceable</A>, {<A href="http://www.alfresco.org/model/system/1.0}localized" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}localized</A>, {<A href="http://www.alfresco.org/model/content/1.0}preferences" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}preferences</A>]'<BR /> 2012-08-03 15:58:21,990&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'initiatorhome' in 'TokenVariableMap[/]' with value 'Node Type: {<A href="http://www.alfresco.org/model/content/1.0}folder" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}folder</A>, Node Aspects: [{<A href="http://www.alfresco.org/model/content/1.0}auditable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}auditable</A>, {<A href="http://www.alfresco.org/model/application/1.0}uifacets" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/application/1.0}uifacets</A>, {<A href="http://www.alfresco.org/model/system/1.0}referenceable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}referenceable</A>, {<A href="http://www.alfresco.org/model/content/1.0}titled" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}titled</A>, {<A href="http://www.alfresco.org/model/system/1.0}localized" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}localized</A>]'<BR /> 2012-08-03 15:58:21,992&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'workflowinstanceid' in 'TokenVariableMap[/]' with value 'jbpm$5090'<BR /> 2012-08-03 15:58:22,002&nbsp; DEBUG [graph.def.GraphElement] [http-8081-4] event 'task-create' on 'Task(hw:cant_have_no_tasks)' for 'Token(/)'<BR /> 2012-08-03 15:58:22,004&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_percentComplete' in 'TaskInstance(hw:cant_have_no_tasks)' with value '0'<BR /> 2012-08-03 15:58:22,004&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_status' in 'TaskInstance(hw:cant_have_no_tasks)' with value 'Not Yet Started'<BR /> 2012-08-03 15:58:22,004&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_sendEMailNotifications' in 'TaskInstance(hw:cant_have_no_tasks)' with value 'false'<BR /> 2012-08-03 15:58:22,004&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_reassignable' in 'TaskInstance(hw:cant_have_no_tasks)' with value 'true'<BR /> 2012-08-03 15:58:22,004&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_hiddenTransitions' in 'TaskInstance(hw:cant_have_no_tasks)' with value ''<BR /> 2012-08-03 15:58:22,004&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_workflowPriority' in 'TaskInstance(hw:cant_have_no_tasks)' with value '2'<BR /> 2012-08-03 15:58:22,004&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_packageActionGroup' in 'TaskInstance(hw:cant_have_no_tasks)' with value 'add_package_item_actions'<BR /> 2012-08-03 15:58:22,004&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_packageItemActionGroup' in 'TaskInstance(hw:cant_have_no_tasks)' with value 'start_package_item_actions'<BR /> 2012-08-03 15:58:22,008&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-4] assigning task 'hw:cant_have_no_tasks' to 'admin'<BR /> 2012-08-03 15:58:22,008&nbsp; DEBUG [graph.def.GraphElement] [http-8081-4] event 'task-assign' on 'Task(hw:cant_have_no_tasks)' for 'Token(/)'<BR /> 2012-08-03 15:58:22,008&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] update variable 'bpm_percentComplete' in 'TaskInstance(hw:cant_have_no_tasks)' to value '0'<BR /> 2012-08-03 15:58:22,008&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] update variable 'bpm_sendEMailNotifications' in 'TaskInstance(hw:cant_have_no_tasks)' to value 'false'<BR /> 2012-08-03 15:58:22,008&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] update variable 'bpm_status' in 'TaskInstance(hw:cant_have_no_tasks)' to value 'Not Yet Started'<BR /> 2012-08-03 15:58:22,010&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_package' in 'TaskInstance(hw:cant_have_no_tasks)' with value 'Node Type: {<A href="http://www.alfresco.org/model/bpm/1.0}package" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/bpm/1.0}package</A>, Node Aspects: [{<A href="http://www.alfresco.org/model/content/1.0}auditable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}auditable</A>, {<A href="http://www.alfresco.org/model/system/1.0}referenceable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}referenceable</A>, {<A href="http://www.alfresco.org/model/system/1.0}localized" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}localized</A>, {<A href="http://www.alfresco.org/model/bpm/1.0}workflowPackage" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/bpm/1.0}workflowPackage</A>]'<BR /> 2012-08-03 15:58:22,010&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_workflowDescription' in 'TaskInstance(hw:cant_have_no_tasks)' with value ''<BR /> 2012-08-03 15:58:22,010&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] update variable 'bpm_workflowPriority' in 'TaskInstance(hw:cant_have_no_tasks)' to value '2'<BR /> 2012-08-03 15:58:22,010&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_workflowDueDate' in 'TaskInstance(hw:cant_have_no_tasks)' with value 'null'<BR /> 2012-08-03 15:58:22,010&nbsp; DEBUG [jbpm.svc.Services] [http-8081-4] executing default save operations<BR /> 2012-08-03 15:58:22,010&nbsp; DEBUG [svc.save.HibernateSaveOperation] [http-8081-4] saving process instance<BR /> 2012-08-03 15:58:22,010&nbsp; DEBUG [svc.save.SaveLogsOperation] [http-8081-4] flushing logs to logging service.<BR /> 2012-08-03 15:58:22,030&nbsp; DEBUG [svc.save.CascadeSaveOperation] [http-8081-4] cascading save of 'ProcessInstance(b88e6c2e-900c-4702-89d7-743e1f991a5e)'<BR /> 2012-08-03 15:58:22,057&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-4] injecting a session disables transaction<BR /> 2012-08-03 15:58:22,149&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-4] injecting a session disables transaction<BR /> 2012-08-03 15:58:22,149&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] update variable 'bpm_status' in 'TaskInstance(hw:cant_have_no_tasks)' to value 'Completed'<BR /> 2012-08-03 15:58:22,149&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_outcome' in 'TaskInstance(hw:cant_have_no_tasks)' with value 'to_hello'<BR /> 2012-08-03 15:58:22,149&nbsp; DEBUG [graph.def.GraphElement] [http-8081-4] event 'task-end' on 'Task(hw:cant_have_no_tasks)' for 'Token(/)'<BR /> 2012-08-03 15:58:22,149&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-4] flushing variable 'bpm_workflowDueDate' from task 'hw:cant_have_no_tasks' to process variables<BR /> 2012-08-03 15:58:22,149&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_workflowDueDate' in 'TokenVariableMap[/]' with value 'null'<BR /> 2012-08-03 15:58:22,149&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-4] flushing variable 'bpm_workflowDescription' from task 'hw:cant_have_no_tasks' to process variables<BR /> 2012-08-03 15:58:22,149&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_workflowDescription' in 'TokenVariableMap[/]' with value ''<BR /> 2012-08-03 15:58:22,149&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-4] flushing variable 'bpm_percentComplete' from task 'hw:cant_have_no_tasks' to process variables<BR /> 2012-08-03 15:58:22,149&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_percentComplete' in 'TokenVariableMap[/]' with value '0'<BR /> 2012-08-03 15:58:22,151&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-4] flushing variable 'bpm_status' from task 'hw:cant_have_no_tasks' to process variables<BR /> 2012-08-03 15:58:22,151&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_status' in 'TokenVariableMap[/]' with value 'Completed'<BR /> 2012-08-03 15:58:22,151&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-4] flushing variable 'bpm_sendEMailNotifications' from task 'hw:cant_have_no_tasks' to process variables<BR /> 2012-08-03 15:58:22,151&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_sendEMailNotifications' in 'TokenVariableMap[/]' with value 'false'<BR /> 2012-08-03 15:58:22,151&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-4] flushing variable 'bpm_packageActionGroup' from task 'hw:cant_have_no_tasks' to process variables<BR /> 2012-08-03 15:58:22,151&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_packageActionGroup' in 'TokenVariableMap[/]' with value 'add_package_item_actions'<BR /> 2012-08-03 15:58:22,151&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-4] flushing variable 'bpm_hiddenTransitions' from task 'hw:cant_have_no_tasks' to process variables<BR /> 2012-08-03 15:58:22,151&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_hiddenTransitions' in 'TokenVariableMap[/]' with value ''<BR /> 2012-08-03 15:58:22,151&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-4] flushing variable 'bpm_package' from task 'hw:cant_have_no_tasks' to process variables<BR /> 2012-08-03 15:58:22,151&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] update variable 'bpm_package' in 'TokenVariableMap[/]' to value 'Node Type: {<A href="http://www.alfresco.org/model/bpm/1.0}package" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/bpm/1.0}package</A>, Node Aspects: [{<A href="http://www.alfresco.org/model/content/1.0}auditable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}auditable</A>, {<A href="http://www.alfresco.org/model/system/1.0}referenceable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}referenceable</A>, {<A href="http://www.alfresco.org/model/system/1.0}localized" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}localized</A>, {<A href="http://www.alfresco.org/model/bpm/1.0}workflowPackage" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/bpm/1.0}workflowPackage</A>]'<BR /> 2012-08-03 15:58:22,151&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-4] flushing variable 'bpm_packageItemActionGroup' from task 'hw:cant_have_no_tasks' to process variables<BR /> 2012-08-03 15:58:22,151&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_packageItemActionGroup' in 'TokenVariableMap[/]' with value 'start_package_item_actions'<BR /> 2012-08-03 15:58:22,151&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-4] flushing variable 'bpm_outcome' from task 'hw:cant_have_no_tasks' to process variables<BR /> 2012-08-03 15:58:22,151&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_outcome' in 'TokenVariableMap[/]' with value 'to_hello'<BR /> 2012-08-03 15:58:22,151&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-4] flushing variable 'bpm_workflowPriority' from task 'hw:cant_have_no_tasks' to process variables<BR /> 2012-08-03 15:58:22,151&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_workflowPriority' in 'TokenVariableMap[/]' with value '2'<BR /> 2012-08-03 15:58:22,151&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-4] flushing variable 'bpm_reassignable' from task 'hw:cant_have_no_tasks' to process variables<BR /> 2012-08-03 15:58:22,151&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_reassignable' in 'TokenVariableMap[/]' with value 'true'<BR /> 2012-08-03 15:58:22,151&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-4] completion of task 'hw:cant_have_no_tasks' results in taking the default transition<BR /> 2012-08-03 15:58:22,153&nbsp; DEBUG [graph.def.GraphElement] [http-8081-4] event 'before-signal' on 'StartState(start)' for 'Token(/)'<BR /> 2012-08-03 15:58:22,153&nbsp; DEBUG [graph.def.GraphElement] [http-8081-4] event 'node-leave' on 'StartState(start)' for 'Token(/)'<BR /> 2012-08-03 15:58:22,153&nbsp; DEBUG [graph.def.GraphElement] [http-8081-4] event 'transition' on 'Transition(to_hello)' for 'Token(/)'<BR /> 2012-08-03 15:58:22,155&nbsp; DEBUG [graph.def.GraphElement] [http-8081-4] event 'node-enter' on 'TaskNode(hello)' for 'Token(/)'<BR /> 2012-08-03 15:58:22,190&nbsp; DEBUG [graph.def.GraphElement] [http-8081-4] event 'task-create' on 'Task(hw:are_you_sure)' for 'Token(/)'<BR /> 2012-08-03 15:58:22,194&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_percentComplete' in 'TaskInstance(hw:are_you_sure)' with value '0'<BR /> 2012-08-03 15:58:22,196&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_status' in 'TaskInstance(hw:are_you_sure)' with value 'Not Yet Started'<BR /> 2012-08-03 15:58:22,196&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_reassignable' in 'TaskInstance(hw:are_you_sure)' with value 'true'<BR /> 2012-08-03 15:58:22,196&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_hiddenTransitions' in 'TaskInstance(hw:are_you_sure)' with value ''<BR /> 2012-08-03 15:58:22,196&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_packageActionGroup' in 'TaskInstance(hw:are_you_sure)' with value ''<BR /> 2012-08-03 15:58:22,196&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_packageItemActionGroup' in 'TaskInstance(hw:are_you_sure)' with value 'read_package_item_actions'<BR /> 2012-08-03 15:58:22,196&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-4] assigning task 'hw:are_you_sure' to 'admin'<BR /> 2012-08-03 15:58:22,196&nbsp; DEBUG [graph.def.GraphElement] [http-8081-4] event 'task-assign' on 'Task(hw:are_you_sure)' for 'Token(/)'<BR /> 2012-08-03 15:58:22,196&nbsp; DEBUG [graph.def.GraphElement] [http-8081-4] event 'after-signal' on 'StartState(start)' for 'Token(/)'<BR /> 2012-08-03 15:58:22,196&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_context' in 'TokenVariableMap[/]' with value 'null'<BR /> 2012-08-03 15:58:22,196&nbsp; DEBUG [jbpm.svc.Services] [http-8081-4] executing default save operations<BR /> 2012-08-03 15:58:22,196&nbsp; DEBUG [svc.save.HibernateSaveOperation] [http-8081-4] saving process instance<BR /> 2012-08-03 15:58:22,196&nbsp; DEBUG [svc.save.SaveLogsOperation] [http-8081-4] flushing logs to logging service.<BR /> 2012-08-03 15:58:22,219&nbsp; DEBUG [svc.save.CascadeSaveOperation] [http-8081-4] cascading save of 'ProcessInstance(b88e6c2e-900c-4702-89d7-743e1f991a5e)'<BR /> 2012-08-03 15:58:22,315&nbsp; DEBUG [org.jbpm.JbpmContext] [http-8081-4] closing jbpmContext org.jbpm.JbpmContext@4a814c0d<BR /> 2012-08-03 15:58:22,315&nbsp; DEBUG [jbpm.svc.Services] [http-8081-4] closing service 'persistence': org.jbpm.persistence.db.DbPersistenceService@33597ad5<BR /> 2012-08-03 15:58:22,315&nbsp; DEBUG [jbpm.svc.Services] [http-8081-4] closing service 'tx': org.jbpm.tx.TxService@378f5049<BR /> 2012-08-03 15:58:22,315&nbsp; DEBUG [jbpm.svc.Services] [http-8081-4] closing service 'logging': org.jbpm.logging.db.DbLoggingService@21e0051e<BR /> 2012-08-03 15:58:22,315&nbsp; DEBUG [jbpm.svc.Services] [http-8081-4] closing service 'authentication': org.jbpm.security.authentication.DefaultAuthenticationService@7a7005f1<BR /> 2012-08-03 15:58:22,315&nbsp; DEBUG [alfresco.repo.workflow] [http-8081-4] Detached (commit) JBPM Context from transaction d437a7a6-8e63-404e-866c-3f15dc671272<BR /> 2012-08-03 15:58:22,504&nbsp; DEBUG [jbpm.configuration.JbpmContextInfo] [http-8081-4] creating jbpm context with service factories '[message, tx, scheduler, authentication, persistence, logging]'<BR /> 2012-08-03 15:58:22,504&nbsp; DEBUG [org.jbpm.JbpmContext] [http-8081-4] creating org.jbpm.JbpmContext@2c8446f7<BR /> 2012-08-03 15:58:22,504&nbsp; DEBUG [alfresco.repo.workflow] [http-8081-4] Attached JBPM Context to transaction ee96cf7b-651c-48ed-87b9-3b9ec317d3d5<BR /> 2012-08-03 15:58:22,504&nbsp; DEBUG [persistence.db.DbPersistenceServiceFactory] [http-8081-4] creating persistence service<BR /> 2012-08-03 15:58:22,504&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-4] injecting a session disables transaction<BR /> 2012-08-03 15:58:22,526&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-4] injecting a session disables transaction<BR /> 2012-08-03 15:58:22,551&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-4] injecting a session disables transaction<BR /> 2012-08-03 15:58:22,606&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-4] injecting a session disables transaction<BR /> 2012-08-03 15:58:22,670&nbsp; DEBUG [org.jbpm.JbpmContext] [http-8081-4] closing jbpmContext org.jbpm.JbpmContext@2c8446f7<BR /> 2012-08-03 15:58:22,670&nbsp; DEBUG [jbpm.svc.Services] [http-8081-4] closing service 'persistence': org.jbpm.persistence.db.DbPersistenceService@6df5044a<BR /> 2012-08-03 15:58:22,670&nbsp; DEBUG [jbpm.svc.Services] [http-8081-4] closing service 'tx': org.jbpm.tx.TxService@70ecceab<BR /> 2012-08-03 15:58:22,670&nbsp; DEBUG [alfresco.repo.workflow] [http-8081-4] Detached (commit) JBPM Context from transaction ee96cf7b-651c-48ed-87b9-3b9ec317d3d5<BR /> 2012-08-03 15:58:23,203&nbsp; DEBUG [jbpm.configuration.JbpmContextInfo] [http-8081-4] creating jbpm context with service factories '[message, tx, scheduler, authentication, persistence, logging]'<BR /> 2012-08-03 15:58:23,203&nbsp; DEBUG [org.jbpm.JbpmContext] [http-8081-4] creating org.jbpm.JbpmContext@32ddb0c<BR /> 2012-08-03 15:58:23,203&nbsp; DEBUG [alfresco.repo.workflow] [http-8081-4] Attached JBPM Context to transaction 6cdc2ced-c63a-422a-9724-1feaa2a0d455<BR /> 2012-08-03 15:58:23,203&nbsp; DEBUG [persistence.db.DbPersistenceServiceFactory] [http-8081-4] creating persistence service<BR /> 2012-08-03 15:58:23,203&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-4] injecting a session disables transaction<BR /> 2012-08-03 15:58:23,223&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-4] injecting a session disables transaction<BR /> 2012-08-03 15:58:23,233&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-4] injecting a session disables transaction<BR /> 2012-08-03 15:58:23,248&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-4] injecting a session disables transaction<BR /> 2012-08-03 15:58:23,289&nbsp; DEBUG [org.jbpm.JbpmContext] [http-8081-4] closing jbpmContext org.jbpm.JbpmContext@32ddb0c<BR /> 2012-08-03 15:58:23,289&nbsp; DEBUG [jbpm.svc.Services] [http-8081-4] closing service 'persistence': org.jbpm.persistence.db.DbPersistenceService@2e6ede78<BR /> 2012-08-03 15:58:23,289&nbsp; DEBUG [jbpm.svc.Services] [http-8081-4] closing service 'tx': org.jbpm.tx.TxService@70cfb018<BR /> 2012-08-03 15:58:23,289&nbsp; DEBUG [alfresco.repo.workflow] [http-8081-4] Detached (commit) JBPM Context from transaction 6cdc2ced-c63a-422a-9724-1feaa2a0d455<BR /> 2012-08-03 15:58:26,926&nbsp; DEBUG [jbpm.configuration.JbpmContextInfo] [http-8081-1] creating jbpm context with service factories '[message, tx, scheduler, authentication, persistence, logging]'<BR /> 2012-08-03 15:58:26,926&nbsp; DEBUG [org.jbpm.JbpmContext] [http-8081-1] creating org.jbpm.JbpmContext@14c6f844<BR /> 2012-08-03 15:58:26,926&nbsp; DEBUG [alfresco.repo.workflow] [http-8081-1] Attached JBPM Context to transaction 317df49c-1149-4bc5-be83-ad1d87b07fe2<BR /> 2012-08-03 15:58:26,926&nbsp; DEBUG [persistence.db.DbPersistenceServiceFactory] [http-8081-1] creating persistence service<BR /> 2012-08-03 15:58:26,926&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-1] injecting a session disables transaction<BR /> 2012-08-03 15:58:26,978&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-1] injecting a session disables transaction<BR /> 2012-08-03 15:58:26,982&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-1] injecting a session disables transaction<BR /> 2012-08-03 15:58:26,985&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-1] injecting a session disables transaction<BR /> 2012-08-03 15:58:26,986&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-1] injecting a session disables transaction<BR /> 2012-08-03 15:58:26,987&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-1] injecting a session disables transaction<BR /> 2012-08-03 15:58:27,015&nbsp; DEBUG [org.jbpm.JbpmContext] [http-8081-1] closing jbpmContext org.jbpm.JbpmContext@14c6f844<BR /> 2012-08-03 15:58:27,015&nbsp; DEBUG [jbpm.svc.Services] [http-8081-1] closing service 'persistence': org.jbpm.persistence.db.DbPersistenceService@1365e36d<BR /> 2012-08-03 15:58:27,015&nbsp; DEBUG [jbpm.svc.Services] [http-8081-1] closing service 'tx': org.jbpm.tx.TxService@636130e<BR /> 2012-08-03 15:58:27,015&nbsp; DEBUG [alfresco.repo.workflow] [http-8081-1] Detached (commit) JBPM Context from transaction 317df49c-1149-4bc5-be83-ad1d87b07fe2<BR /> 2012-08-03 15:58:28,533&nbsp; DEBUG [jbpm.configuration.JbpmContextInfo] [http-8081-5] creating jbpm context with service factories '[message, tx, scheduler, authentication, persistence, logging]'<BR /> 2012-08-03 15:58:28,534&nbsp; DEBUG [org.jbpm.JbpmContext] [http-8081-5] creating org.jbpm.JbpmContext@6fc2a5bf<BR /> 2012-08-03 15:58:28,534&nbsp; DEBUG [alfresco.repo.workflow] [http-8081-5] Attached JBPM Context to transaction 57d77d5e-7b77-4e44-ab22-1ad2b6ee66ec<BR /> 2012-08-03 15:58:28,534&nbsp; DEBUG [persistence.db.DbPersistenceServiceFactory] [http-8081-5] creating persistence service<BR /> 2012-08-03 15:58:28,534&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-5] injecting a session disables transaction<BR /> 2012-08-03 15:58:28,560&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-5] injecting a session disables transaction<BR /> 2012-08-03 15:58:28,561&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-5] injecting a session disables transaction<BR /> 2012-08-03 15:58:28,562&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-5] injecting a session disables transaction<BR /> 2012-08-03 15:58:28,563&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-5] injecting a session disables transaction<BR /> 2012-08-03 15:58:28,595&nbsp; DEBUG [org.jbpm.JbpmContext] [http-8081-5] closing jbpmContext org.jbpm.JbpmContext@6fc2a5bf<BR /> 2012-08-03 15:58:28,595&nbsp; DEBUG [jbpm.svc.Services] [http-8081-5] closing service 'persistence': org.jbpm.persistence.db.DbPersistenceService@7a200513<BR /> 2012-08-03 15:58:28,595&nbsp; DEBUG [jbpm.svc.Services] [http-8081-5] closing service 'tx': org.jbpm.tx.TxService@4c2d6108<BR /> 2012-08-03 15:58:28,595&nbsp; DEBUG [alfresco.repo.workflow] [http-8081-5] Detached (commit) JBPM Context from transaction 57d77d5e-7b77-4e44-ab22-1ad2b6ee66ec<BR /> 2012-08-03 15:58:28,623&nbsp; DEBUG [jbpm.configuration.JbpmContextInfo] [http-8081-5] creating jbpm context with service factories '[message, tx, scheduler, authentication, persistence, logging]'<BR /> 2012-08-03 15:58:28,623&nbsp; DEBUG [org.jbpm.JbpmContext] [http-8081-5] creating org.jbpm.JbpmContext@373d7b4a<BR /> 2012-08-03 15:58:28,623&nbsp; DEBUG [alfresco.repo.workflow] [http-8081-5] Attached JBPM Context to transaction 96d8b5ab-98e6-42f6-b9d0-d53102480083<BR /> 2012-08-03 15:58:28,623&nbsp; DEBUG [persistence.db.DbPersistenceServiceFactory] [http-8081-5] creating persistence service<BR /> 2012-08-03 15:58:28,623&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-5] injecting a session disables transaction<BR /> 2012-08-03 15:58:28,691&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-5] injecting a session disables transaction<BR /> 2012-08-03 15:58:28,719&nbsp; DEBUG [org.jbpm.JbpmContext] [http-8081-5] closing jbpmContext org.jbpm.JbpmContext@373d7b4a<BR /> 2012-08-03 15:58:28,719&nbsp; DEBUG [jbpm.svc.Services] [http-8081-5] closing service 'persistence': org.jbpm.persistence.db.DbPersistenceService@5d8aef3b<BR /> 2012-08-03 15:58:28,719&nbsp; DEBUG [jbpm.svc.Services] [http-8081-5] closing service 'tx': org.jbpm.tx.TxService@4c603a77<BR /> 2012-08-03 15:58:28,719&nbsp; DEBUG [alfresco.repo.workflow] [http-8081-5] Detached (commit) JBPM Context from transaction 96d8b5ab-98e6-42f6-b9d0-d53102480083<BR /> 2012-08-03 15:58:29,329&nbsp; DEBUG [jbpm.configuration.JbpmContextInfo] [http-8081-6] creating jbpm context with service factories '[message, tx, scheduler, authentication, persistence, logging]'<BR /> 2012-08-03 15:58:29,329&nbsp; DEBUG [org.jbpm.JbpmContext] [http-8081-6] creating org.jbpm.JbpmContext@84a6af2<BR /> 2012-08-03 15:58:29,329&nbsp; DEBUG [alfresco.repo.workflow] [http-8081-6] Attached JBPM Context to transaction c6f101ec-68e1-40aa-9ec8-39bb74d98323<BR /> 2012-08-03 15:58:29,329&nbsp; DEBUG [persistence.db.DbPersistenceServiceFactory] [http-8081-6] creating persistence service<BR /> 2012-08-03 15:58:29,329&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-6] injecting a session disables transaction<BR /> 2012-08-03 15:58:29,479&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-6] injecting a session disables transaction<BR /> 2012-08-03 15:58:29,481&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-6] injecting a session disables transaction<BR /> 2012-08-03 15:58:29,481&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-6] injecting a session disables transaction<BR /> 2012-08-03 15:58:29,483&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-6] injecting a session disables transaction<BR /> 2012-08-03 15:58:29,499&nbsp; DEBUG [org.jbpm.JbpmContext] [http-8081-6] closing jbpmContext org.jbpm.JbpmContext@84a6af2<BR /> 2012-08-03 15:58:29,499&nbsp; DEBUG [jbpm.svc.Services] [http-8081-6] closing service 'persistence': org.jbpm.persistence.db.DbPersistenceService@163b66f7<BR /> 2012-08-03 15:58:29,499&nbsp; DEBUG [jbpm.svc.Services] [http-8081-6] closing service 'tx': org.jbpm.tx.TxService@15e4ed88<BR /> 2012-08-03 15:58:29,499&nbsp; DEBUG [alfresco.repo.workflow] [http-8081-6] Detached (commit) JBPM Context from transaction c6f101ec-68e1-40aa-9ec8-39bb74d98323<BR /> 2012-08-03 15:58:31,167&nbsp; DEBUG [jbpm.configuration.JbpmContextInfo] [http-8081-4] creating jbpm context with service factories '[message, tx, scheduler, authentication, persistence, logging]'<BR /> 2012-08-03 15:58:31,169&nbsp; DEBUG [org.jbpm.JbpmContext] [http-8081-4] creating org.jbpm.JbpmContext@ed979d0<BR /> 2012-08-03 15:58:31,169&nbsp; DEBUG [alfresco.repo.workflow] [http-8081-4] Attached JBPM Context to transaction 5289cdc5-05c7-4189-9bc9-eeee2412b4f5<BR /> 2012-08-03 15:58:31,169&nbsp; DEBUG [persistence.db.DbPersistenceServiceFactory] [http-8081-4] creating persistence service<BR /> 2012-08-03 15:58:31,169&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-4] injecting a session disables transaction<BR /> 2012-08-03 15:58:31,315&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-4] injecting a session disables transaction<BR /> 2012-08-03 15:58:31,344&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-4] injecting a session disables transaction<BR /> 2012-08-03 15:58:31,348&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-4] injecting a session disables transaction<BR /> 2012-08-03 15:58:31,350&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-4] injecting a session disables transaction<BR /> 2012-08-03 15:58:31,354&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-4] injecting a session disables transaction<BR /> 2012-08-03 15:58:31,354&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] update variable 'bpm_percentComplete' in 'TaskInstance(hw:are_you_sure)' to value '0'<BR /> 2012-08-03 15:58:31,354&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] update variable 'bpm_status' in 'TaskInstance(hw:are_you_sure)' to value 'Not Yet Started'<BR /> 2012-08-03 15:58:31,360&nbsp; DEBUG [jbpm.svc.Services] [http-8081-4] executing default save operations<BR /> 2012-08-03 15:58:31,360&nbsp; DEBUG [svc.save.HibernateSaveOperation] [http-8081-4] saving process instance<BR /> 2012-08-03 15:58:31,360&nbsp; DEBUG [svc.save.SaveLogsOperation] [http-8081-4] flushing logs to logging service.<BR /> 2012-08-03 15:58:31,360&nbsp; DEBUG [svc.save.CascadeSaveOperation] [http-8081-4] cascading save of 'ProcessInstance(b88e6c2e-900c-4702-89d7-743e1f991a5e)'<BR /> 2012-08-03 15:58:31,362&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-4] injecting a session disables transaction<BR /> 2012-08-03 15:58:31,362&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] update variable 'bpm_status' in 'TaskInstance(hw:are_you_sure)' to value 'Completed'<BR /> 2012-08-03 15:58:31,362&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] create variable 'bpm_outcome' in 'TaskInstance(hw:are_you_sure)' with value 'to_end1'<BR /> 2012-08-03 15:58:31,362&nbsp; DEBUG [graph.def.GraphElement] [http-8081-4] event 'task-end' on 'Task(hw:are_you_sure)' for 'Token(/)'<BR /> 2012-08-03 15:58:31,374&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-4] flushing variable 'bpm_percentComplete' from task 'hw:are_you_sure' to process variables<BR /> 2012-08-03 15:58:31,374&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] update variable 'bpm_percentComplete' in 'TokenVariableMap[/]' to value '0'<BR /> 2012-08-03 15:58:31,374&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-4] flushing variable 'bpm_status' from task 'hw:are_you_sure' to process variables<BR /> 2012-08-03 15:58:31,374&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] update variable 'bpm_status' in 'TokenVariableMap[/]' to value 'Completed'<BR /> 2012-08-03 15:58:31,374&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-4] flushing variable 'bpm_packageActionGroup' from task 'hw:are_you_sure' to process variables<BR /> 2012-08-03 15:58:31,374&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] update variable 'bpm_packageActionGroup' in 'TokenVariableMap[/]' to value ''<BR /> 2012-08-03 15:58:31,374&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-4] flushing variable 'bpm_hiddenTransitions' from task 'hw:are_you_sure' to process variables<BR /> 2012-08-03 15:58:31,374&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] update variable 'bpm_hiddenTransitions' in 'TokenVariableMap[/]' to value ''<BR /> 2012-08-03 15:58:31,374&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-4] flushing variable 'bpm_packageItemActionGroup' from task 'hw:are_you_sure' to process variables<BR /> 2012-08-03 15:58:31,374&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] update variable 'bpm_packageItemActionGroup' in 'TokenVariableMap[/]' to value 'read_package_item_actions'<BR /> 2012-08-03 15:58:31,374&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-4] flushing variable 'bpm_outcome' from task 'hw:are_you_sure' to process variables<BR /> 2012-08-03 15:58:31,374&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] update variable 'bpm_outcome' in 'TokenVariableMap[/]' to value 'to_end1'<BR /> 2012-08-03 15:58:31,374&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-4] flushing variable 'bpm_reassignable' from task 'hw:are_you_sure' to process variables<BR /> 2012-08-03 15:58:31,374&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-4] update variable 'bpm_reassignable' in 'TokenVariableMap[/]' to value 'true'<BR /> 2012-08-03 15:58:31,378&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-4] completion of task 'hw:are_you_sure' results in taking transition 'Transition(to_end1)'<BR /> 2012-08-03 15:58:31,380&nbsp; DEBUG [graph.def.GraphElement] [http-8081-4] event 'before-signal' on 'TaskNode(hello)' for 'Token(/)'<BR /> 2012-08-03 15:58:31,380&nbsp; DEBUG [graph.def.GraphElement] [http-8081-4] event 'node-leave' on 'TaskNode(hello)' for 'Token(/)'<BR /> 2012-08-03 15:58:31,380&nbsp; DEBUG [graph.def.GraphElement] [http-8081-4] event 'transition' on 'Transition(to_end1)' for 'Token(/)'<BR /> 2012-08-03 15:58:31,381&nbsp; DEBUG [graph.def.GraphElement] [http-8081-4] executing action 'Action(5f7808af)'<BR /> 2012-08-03 15:58:31,381&nbsp; DEBUG [graph.exe.Token] [http-8081-4] token[5091] is locked by token[5091]<BR /> 2012-08-03 15:58:31,391&nbsp; DEBUG [graph.exe.Token] [http-8081-4] token[5091] is unlocked by token[5091]<BR /> 2012-08-03 15:58:31,391&nbsp; DEBUG [graph.def.GraphElement] [http-8081-4] event 'node-enter' on 'EndState(end1)' for 'Token(/)'<BR /> 2012-08-03 15:58:31,399&nbsp; DEBUG [graph.def.GraphElement] [http-8081-4] event 'process-end' on 'ProcessDefinition(hw:helloWorld)' for 'Token(/)'<BR /> 2012-08-03 15:58:31,399&nbsp; DEBUG [msg.db.DbMessageService] [http-8081-4] saved job[5220, org.jbpm.job.CleanUpProcessJob]<BR /> 2012-08-03 15:58:31,415&nbsp; DEBUG [graph.def.GraphElement] [http-8081-4] event 'after-signal' on 'TaskNode(hello)' for 'Token(/)'<BR /> 2012-08-03 15:58:31,415&nbsp; DEBUG [jbpm.svc.Services] [http-8081-4] executing default save operations<BR /> 2012-08-03 15:58:31,415&nbsp; DEBUG [svc.save.HibernateSaveOperation] [http-8081-4] saving process instance<BR /> 2012-08-03 15:58:31,415&nbsp; DEBUG [svc.save.SaveLogsOperation] [http-8081-4] flushing logs to logging service.<BR /> 2012-08-03 15:58:31,438&nbsp; DEBUG [svc.save.CascadeSaveOperation] [http-8081-4] cascading save of 'ProcessInstance(b88e6c2e-900c-4702-89d7-743e1f991a5e)'<BR /> 2012-08-03 15:58:31,485&nbsp; DEBUG [org.jbpm.JbpmContext] [http-8081-4] closing jbpmContext org.jbpm.JbpmContext@ed979d0<BR /> 2012-08-03 15:58:31,485&nbsp; DEBUG [jbpm.svc.Services] [http-8081-4] closing service 'persistence': org.jbpm.persistence.db.DbPersistenceService@4d418fe4<BR /> 2012-08-03 15:58:31,485&nbsp; DEBUG [jbpm.svc.Services] [http-8081-4] closing service 'tx': org.jbpm.tx.TxService@b4de95c<BR /> 2012-08-03 15:58:31,485&nbsp; DEBUG [jbpm.svc.Services] [http-8081-4] closing service 'message': org.jbpm.msg.db.DbMessageService@28139cd0<BR /> 2012-08-03 15:58:31,487&nbsp; DEBUG [msg.db.DbMessageService] [http-8081-4] messages were produced, job executor will be signalled<BR /> 2012-08-03 15:58:31,487&nbsp; DEBUG [jbpm.svc.Services] [http-8081-4] closing service 'logging': org.jbpm.logging.db.DbLoggingService@1f9c303e<BR /> 2012-08-03 15:58:31,487&nbsp; DEBUG [jbpm.svc.Services] [http-8081-4] closing service 'authentication': org.jbpm.security.authentication.DefaultAuthenticationService@472346a8<BR /> 2012-08-03 15:58:31,487&nbsp; DEBUG [alfresco.repo.workflow] [http-8081-4] Detached (commit) JBPM Context from transaction 5289cdc5-05c7-4189-9bc9-eeee2412b4f5<BR /> 2012-08-03 15:58:31,499&nbsp; DEBUG [job.executor.JobExecutorThread] [AlfrescoJbpmJobExecutor:10.2.1.52:1] acquiring jobs for execution…<BR /> 2012-08-03 15:58:31,499&nbsp; DEBUG [jbpm.configuration.JbpmContextInfo] [AlfrescoJbpmJobExecutor:10.2.1.52:1] creating jbpm context with service factories '[message, tx, scheduler, authentication, persistence, logging]'<BR /> 2012-08-03 15:58:31,501&nbsp; DEBUG [org.jbpm.JbpmContext] [AlfrescoJbpmJobExecutor:10.2.1.52:1] creating org.jbpm.JbpmContext@5cf3e414<BR /> 2012-08-03 15:58:31,501&nbsp; DEBUG [persistence.db.DbPersistenceServiceFactory] [AlfrescoJbpmJobExecutor:10.2.1.52:1] creating persistence service<BR /> 2012-08-03 15:58:31,501&nbsp; DEBUG [persistence.db.DbPersistenceService] [AlfrescoJbpmJobExecutor:10.2.1.52:1] using current hibernate session<BR /> 2012-08-03 15:58:31,501&nbsp; DEBUG [job.executor.JobExecutorThread] [AlfrescoJbpmJobExecutor:10.2.1.52:1] querying for acquirable job…<BR /> 2012-08-03 15:58:31,534&nbsp; DEBUG [job.executor.JobExecutorThread] [AlfrescoJbpmJobExecutor:10.2.1.52:1] trying to obtain lock on job[5220]<BR /> 2012-08-03 15:58:31,534&nbsp; DEBUG [org.jbpm.JbpmContext] [AlfrescoJbpmJobExecutor:10.2.1.52:1] closing jbpmContext org.jbpm.JbpmContext@5cf3e414<BR /> 2012-08-03 15:58:31,534&nbsp; DEBUG [jbpm.svc.Services] [AlfrescoJbpmJobExecutor:10.2.1.52:1] closing service 'persistence': org.jbpm.persistence.db.DbPersistenceService@6b958bd3<BR /> 2012-08-03 15:58:31,534&nbsp; DEBUG [jbpm.svc.Services] [AlfrescoJbpmJobExecutor:10.2.1.52:1] closing service 'tx': org.jbpm.tx.TxService@270f00d3<BR /> 2012-08-03 15:58:31,534&nbsp; DEBUG [job.executor.JobExecutorThread] [AlfrescoJbpmJobExecutor:10.2.1.52:1] obtained lock on jobs: [job[5220]]<BR /> 2012-08-03 15:58:31,551&nbsp; DEBUG [workflow.jbpm.AlfrescoJobExecutorThread] [AlfrescoJbpmJobExecutor:10.2.1.52:1] acquired 1 job<BR /> 2012-08-03 15:58:31,555&nbsp; DEBUG [jbpm.configuration.JbpmContextInfo] [AlfrescoJbpmJobExecutor:10.2.1.52:1] creating jbpm context with service factories '[message, tx, scheduler, authentication, persistence, logging]'<BR /> 2012-08-03 15:58:31,555&nbsp; DEBUG [org.jbpm.JbpmContext] [AlfrescoJbpmJobExecutor:10.2.1.52:1] creating org.jbpm.JbpmContext@49ff30ad<BR /> 2012-08-03 15:58:31,555&nbsp; DEBUG [persistence.db.DbPersistenceServiceFactory] [AlfrescoJbpmJobExecutor:10.2.1.52:1] creating persistence service<BR /> 2012-08-03 15:58:31,555&nbsp; DEBUG [persistence.db.DbPersistenceService] [AlfrescoJbpmJobExecutor:10.2.1.52:1] using current hibernate session<BR /> 2012-08-03 15:58:31,559&nbsp; DEBUG [jbpm.db.JobSession] [AlfrescoJbpmJobExecutor:10.2.1.52:1] deleting timers for ProcessInstance(b88e6c2e-900c-4702-89d7-743e1f991a5e)<BR /> 2012-08-03 15:58:31,563&nbsp; DEBUG [jbpm.db.JobSession] [AlfrescoJbpmJobExecutor:10.2.1.52:1] 0 remaining timers for ProcessInstance(b88e6c2e-900c-4702-89d7-743e1f991a5e) were deleted<BR /> 2012-08-03 15:58:31,563&nbsp; DEBUG [jbpm.db.JobSession] [AlfrescoJbpmJobExecutor:10.2.1.52:1] deleting execute-node-jobs for ProcessInstance(b88e6c2e-900c-4702-89d7-743e1f991a5e)<BR /> 2012-08-03 15:58:31,563&nbsp; DEBUG [jbpm.db.JobSession] [AlfrescoJbpmJobExecutor:10.2.1.52:1] 0 remaining execute-node-jobs for ProcessInstance(b88e6c2e-900c-4702-89d7-743e1f991a5e) were deleted<BR /> 2012-08-03 15:58:31,563&nbsp; DEBUG [workflow.jbpm.AlfrescoJobExecutorThread] [AlfrescoJbpmJobExecutor:10.2.1.52:1] executed and deleted: job[5220]<BR /> 2012-08-03 15:58:31,563&nbsp; DEBUG [org.jbpm.JbpmContext] [AlfrescoJbpmJobExecutor:10.2.1.52:1] closing jbpmContext org.jbpm.JbpmContext@49ff30ad<BR /> 2012-08-03 15:58:31,563&nbsp; DEBUG [jbpm.svc.Services] [AlfrescoJbpmJobExecutor:10.2.1.52:1] closing service 'persistence': org.jbpm.persistence.db.DbPersistenceService@1d8268bd<BR /> 2012-08-03 15:58:31,563&nbsp; DEBUG [jbpm.svc.Services] [AlfrescoJbpmJobExecutor:10.2.1.52:1] closing service 'tx': org.jbpm.tx.TxService@5caa5f6d<BR /> 2012-08-03 15:58:31,565&nbsp; DEBUG [jbpm.svc.Services] [AlfrescoJbpmJobExecutor:10.2.1.52:1] closing service 'scheduler': org.jbpm.scheduler.db.DbSchedulerService@355f1ca2<BR /> 2012-08-03 15:58:31,678&nbsp; DEBUG [job.executor.JobExecutorThread] [AlfrescoJbpmJobExecutor:10.2.1.52:1] acquiring jobs for execution…<BR /> 2012-08-03 15:58:31,678&nbsp; DEBUG [jbpm.configuration.JbpmContextInfo] [AlfrescoJbpmJobExecutor:10.2.1.52:1] creating jbpm context with service factories '[message, tx, scheduler, authentication, persistence, logging]'<BR /> 2012-08-03 15:58:31,678&nbsp; DEBUG [org.jbpm.JbpmContext] [AlfrescoJbpmJobExecutor:10.2.1.52:1] creating org.jbpm.JbpmContext@4fe08d9<BR /> 2012-08-03 15:58:31,678&nbsp; DEBUG [persistence.db.DbPersistenceServiceFactory] [AlfrescoJbpmJobExecutor:10.2.1.52:1] creating persistence service<BR /> 2012-08-03 15:58:31,678&nbsp; DEBUG [persistence.db.DbPersistenceService] [AlfrescoJbpmJobExecutor:10.2.1.52:1] using current hibernate session<BR /> 2012-08-03 15:58:31,678&nbsp; DEBUG [job.executor.JobExecutorThread] [AlfrescoJbpmJobExecutor:10.2.1.52:1] querying for acquirable job…<BR /> 2012-08-03 15:58:31,991&nbsp; DEBUG [jbpm.configuration.JbpmContextInfo] [http-8081-6] creating jbpm context with service factories '[message, tx, scheduler, authentication, persistence, logging]'<BR /> 2012-08-03 15:58:31,991&nbsp; DEBUG [org.jbpm.JbpmContext] [http-8081-6] creating org.jbpm.JbpmContext@7ddaca36<BR /> 2012-08-03 15:58:31,991&nbsp; DEBUG [alfresco.repo.workflow] [http-8081-6] Attached JBPM Context to transaction 5227592b-e5f7-4d33-b449-a653db566777<BR /> 2012-08-03 15:58:31,991&nbsp; DEBUG [persistence.db.DbPersistenceServiceFactory] [http-8081-6] creating persistence service<BR /> 2012-08-03 15:58:31,991&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-6] injecting a session disables transaction<BR /> 2012-08-03 15:58:32,012&nbsp; DEBUG [job.executor.JobExecutorThread] [AlfrescoJbpmJobExecutor:10.2.1.52:1] no acquirable jobs in job table<BR /> 2012-08-03 15:58:32,012&nbsp; DEBUG [org.jbpm.JbpmContext] [AlfrescoJbpmJobExecutor:10.2.1.52:1] closing jbpmContext org.jbpm.JbpmContext@4fe08d9<BR /> 2012-08-03 15:58:32,012&nbsp; DEBUG [jbpm.svc.Services] [AlfrescoJbpmJobExecutor:10.2.1.52:1] closing service 'persistence': org.jbpm.persistence.db.DbPersistenceService@1f0a6709<BR /> 2012-08-03 15:58:32,012&nbsp; DEBUG [jbpm.svc.Services] [AlfrescoJbpmJobExecutor:10.2.1.52:1] closing service 'tx': org.jbpm.tx.TxService@63f28fca<BR /> 2012-08-03 15:58:32,012&nbsp; DEBUG [job.executor.JobExecutorThread] [AlfrescoJbpmJobExecutor:10.2.1.52:1] obtained lock on jobs: []<BR /> 2012-08-03 15:58:32,014&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-6] injecting a session disables transaction<BR /> 2012-08-03 15:58:32,032&nbsp; DEBUG [org.jbpm.JbpmContext] [http-8081-6] closing jbpmContext org.jbpm.JbpmContext@7ddaca36<BR /> 2012-08-03 15:58:32,032&nbsp; DEBUG [jbpm.svc.Services] [http-8081-6] closing service 'persistence': org.jbpm.persistence.db.DbPersistenceService@4d8493de<BR /> 2012-08-03 15:58:32,032&nbsp; DEBUG [jbpm.svc.Services] [http-8081-6] closing service 'tx': org.jbpm.tx.TxService@3b07fb94<BR /> 2012-08-03 15:58:32,032&nbsp; DEBUG [alfresco.repo.workflow] [http-8081-6] Detached (commit) JBPM Context from transaction 5227592b-e5f7-4d33-b449-a653db566777<SPAN class="line-numbers-rows"><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN></SPAN></CODE></PRE><BR /><BR /><SPAN>COMPLETE trace for FAILING WORKFLOW:</SPAN><PRE class="language-none line-numbers"><CODE> 2012-08-03 15:59:49,449&nbsp; DEBUG [jbpm.configuration.JbpmContextInfo] [http-8081-6] creating jbpm context with service factories '[message, tx, scheduler, authentication, persistence, logging]'<BR /> 2012-08-03 15:59:49,449&nbsp; DEBUG [org.jbpm.JbpmContext] [http-8081-6] creating org.jbpm.JbpmContext@53ec452c<BR /> 2012-08-03 15:59:49,449&nbsp; DEBUG [alfresco.repo.workflow] [http-8081-6] Attached JBPM Context to transaction 5bc0a306-603c-44f9-ae65-5641cacd2eab<BR /> 2012-08-03 15:59:49,449&nbsp; DEBUG [persistence.db.DbPersistenceServiceFactory] [http-8081-6] creating persistence service<BR /> 2012-08-03 15:59:49,449&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-6] injecting a session disables transaction<BR /> 2012-08-03 15:59:49,554&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-6] injecting a session disables transaction<BR /> 2012-08-03 15:59:49,556&nbsp; DEBUG [graph.def.GraphElement] [http-8081-6] event 'process-start' on 'ProcessDefinition(docusignwf:basic_workflow)' for 'Token(/)'<BR /> 2012-08-03 15:59:49,558&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'cancelled' in 'TokenVariableMap[/]' with value 'false'<BR /> 2012-08-03 15:59:49,560&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'bpm_package' in 'TokenVariableMap[/]' with value 'Node Type: {<A href="http://www.alfresco.org/model/bpm/1.0}package" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/bpm/1.0}package</A>, Node Aspects: [{<A href="http://www.alfresco.org/model/content/1.0}auditable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}auditable</A>, {<A href="http://www.alfresco.org/model/system/1.0}referenceable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}referenceable</A>, {<A href="http://www.alfresco.org/model/system/1.0}localized" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}localized</A>, {<A href="http://www.alfresco.org/model/bpm/1.0}workflowPackage" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/bpm/1.0}workflowPackage</A>]'<BR /> 2012-08-03 15:59:49,562&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'companyhome' in 'TokenVariableMap[/]' with value 'Node Type: {<A href="http://www.alfresco.org/model/content/1.0}folder" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}folder</A>, Node Aspects: [{<A href="http://www.alfresco.org/model/content/1.0}auditable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}auditable</A>, {<A href="http://www.alfresco.org/model/application/1.0}uifacets" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/application/1.0}uifacets</A>, {<A href="http://www.alfresco.org/model/system/1.0}referenceable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}referenceable</A>, {<A href="http://www.alfresco.org/model/content/1.0}titled" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}titled</A>, {<A href="http://www.alfresco.org/model/system/1.0}localized" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}localized</A>]'<BR /> 2012-08-03 15:59:49,564&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'initiator' in 'TokenVariableMap[/]' with value 'Node Type: {<A href="http://www.alfresco.org/model/content/1.0}person" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}person</A>, Node Aspects: [{<A href="http://www.alfresco.org/model/application/1.0}configurable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/application/1.0}configurable</A>, {<A href="http://www.alfresco.org/model/content/1.0}ownable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}ownable</A>, {<A href="http://www.alfresco.org/model/system/1.0}referenceable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}referenceable</A>, {<A href="http://www.alfresco.org/model/system/1.0}localized" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}localized</A>, {<A href="http://www.alfresco.org/model/content/1.0}preferences" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}preferences</A>]'<BR /> 2012-08-03 15:59:49,564&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'initiatorhome' in 'TokenVariableMap[/]' with value 'Node Type: {<A href="http://www.alfresco.org/model/content/1.0}folder" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}folder</A>, Node Aspects: [{<A href="http://www.alfresco.org/model/content/1.0}auditable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}auditable</A>, {<A href="http://www.alfresco.org/model/application/1.0}uifacets" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/application/1.0}uifacets</A>, {<A href="http://www.alfresco.org/model/system/1.0}referenceable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}referenceable</A>, {<A href="http://www.alfresco.org/model/content/1.0}titled" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}titled</A>, {<A href="http://www.alfresco.org/model/system/1.0}localized" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}localized</A>]'<BR /> 2012-08-03 15:59:49,566&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'workflowinstanceid' in 'TokenVariableMap[/]' with value 'jbpm$5239'<BR /> 2012-08-03 15:59:49,566&nbsp; DEBUG [graph.def.GraphElement] [http-8081-6] event 'task-create' on 'Task(docusignwf:workflow_init)' for 'Token(/)'<BR /> 2012-08-03 15:59:49,568&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'bpm_percentComplete' in 'TaskInstance(docusignwf:workflow_init)' with value '0'<BR /> 2012-08-03 15:59:49,570&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'bpm_status' in 'TaskInstance(docusignwf:workflow_init)' with value 'Not Yet Started'<BR /> 2012-08-03 15:59:49,570&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'bpm_sendEMailNotifications' in 'TaskInstance(docusignwf:workflow_init)' with value 'false'<BR /> 2012-08-03 15:59:49,570&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'bpm_reassignable' in 'TaskInstance(docusignwf:workflow_init)' with value 'true'<BR /> 2012-08-03 15:59:49,570&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'bpm_hiddenTransitions' in 'TaskInstance(docusignwf:workflow_init)' with value ''<BR /> 2012-08-03 15:59:49,570&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'bpm_workflowPriority' in 'TaskInstance(docusignwf:workflow_init)' with value '2'<BR /> 2012-08-03 15:59:49,570&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'bpm_packageActionGroup' in 'TaskInstance(docusignwf:workflow_init)' with value 'add_package_item_actions'<BR /> 2012-08-03 15:59:49,570&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'bpm_packageItemActionGroup' in 'TaskInstance(docusignwf:workflow_init)' with value 'start_package_item_actions'<BR /> 2012-08-03 15:59:49,572&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-6] assigning task 'docusignwf:workflow_init' to 'admin'<BR /> 2012-08-03 15:59:49,572&nbsp; DEBUG [graph.def.GraphElement] [http-8081-6] event 'task-assign' on 'Task(docusignwf:workflow_init)' for 'Token(/)'<BR /> 2012-08-03 15:59:49,572&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] update variable 'bpm_percentComplete' in 'TaskInstance(docusignwf:workflow_init)' to value '0'<BR /> 2012-08-03 15:59:49,572&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] update variable 'bpm_status' in 'TaskInstance(docusignwf:workflow_init)' to value 'Not Yet Started'<BR /> 2012-08-03 15:59:49,572&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] update variable 'bpm_sendEMailNotifications' in 'TaskInstance(docusignwf:workflow_init)' to value 'false'<BR /> 2012-08-03 15:59:49,574&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'bpm_package' in 'TaskInstance(docusignwf:workflow_init)' with value 'Node Type: {<A href="http://www.alfresco.org/model/bpm/1.0}package" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/bpm/1.0}package</A>, Node Aspects: [{<A href="http://www.alfresco.org/model/content/1.0}auditable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}auditable</A>, {<A href="http://www.alfresco.org/model/system/1.0}referenceable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}referenceable</A>, {<A href="http://www.alfresco.org/model/system/1.0}localized" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}localized</A>, {<A href="http://www.alfresco.org/model/bpm/1.0}workflowPackage" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/bpm/1.0}workflowPackage</A>]'<BR /> 2012-08-03 15:59:49,574&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'bpm_workflowDescription' in 'TaskInstance(docusignwf:workflow_init)' with value ''<BR /> 2012-08-03 15:59:49,574&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] update variable 'bpm_workflowPriority' in 'TaskInstance(docusignwf:workflow_init)' to value '2'<BR /> 2012-08-03 15:59:49,574&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'docusignwf_request_signature_from' in 'TaskInstance(docusignwf:workflow_init)' with value '(snip)'<BR /> 2012-08-03 15:59:49,574&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'bpm_workflowDueDate' in 'TaskInstance(docusignwf:workflow_init)' with value 'null'<BR /> 2012-08-03 15:59:49,574&nbsp; DEBUG [jbpm.svc.Services] [http-8081-6] executing default save operations<BR /> 2012-08-03 15:59:49,574&nbsp; DEBUG [svc.save.HibernateSaveOperation] [http-8081-6] saving process instance<BR /> 2012-08-03 15:59:49,574&nbsp; DEBUG [svc.save.SaveLogsOperation] [http-8081-6] flushing logs to logging service.<BR /> 2012-08-03 15:59:49,597&nbsp; DEBUG [svc.save.CascadeSaveOperation] [http-8081-6] cascading save of 'ProcessInstance(9a17c9cc-b4f1-47d5-b8a3-bdfdfb4aa0a0)'<BR /> 2012-08-03 15:59:49,609&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-6] injecting a session disables transaction<BR /> 2012-08-03 15:59:49,697&nbsp; DEBUG [persistence.db.DbPersistenceService] [http-8081-6] injecting a session disables transaction<BR /> 2012-08-03 15:59:49,697&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] update variable 'bpm_status' in 'TaskInstance(docusignwf:workflow_init)' to value 'Completed'<BR /> 2012-08-03 15:59:49,697&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'bpm_outcome' in 'TaskInstance(docusignwf:workflow_init)' with value 'setup'<BR /> 2012-08-03 15:59:49,697&nbsp; DEBUG [graph.def.GraphElement] [http-8081-6] event 'task-end' on 'Task(docusignwf:workflow_init)' for 'Token(/)'<BR /> 2012-08-03 15:59:49,697&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-6] flushing variable 'bpm_percentComplete' from task 'docusignwf:workflow_init' to process variables<BR /> 2012-08-03 15:59:49,697&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'bpm_percentComplete' in 'TokenVariableMap[/]' with value '0'<BR /> 2012-08-03 15:59:49,699&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-6] flushing variable 'bpm_sendEMailNotifications' from task 'docusignwf:workflow_init' to process variables<BR /> 2012-08-03 15:59:49,699&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'bpm_sendEMailNotifications' in 'TokenVariableMap[/]' with value 'false'<BR /> 2012-08-03 15:59:49,699&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-6] flushing variable 'bpm_hiddenTransitions' from task 'docusignwf:workflow_init' to process variables<BR /> 2012-08-03 15:59:49,699&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'bpm_hiddenTransitions' in 'TokenVariableMap[/]' with value ''<BR /> 2012-08-03 15:59:49,699&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-6] flushing variable 'bpm_package' from task 'docusignwf:workflow_init' to process variables<BR /> 2012-08-03 15:59:49,699&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] update variable 'bpm_package' in 'TokenVariableMap[/]' to value 'Node Type: {<A href="http://www.alfresco.org/model/bpm/1.0}package" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/bpm/1.0}package</A>, Node Aspects: [{<A href="http://www.alfresco.org/model/content/1.0}auditable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}auditable</A>, {<A href="http://www.alfresco.org/model/system/1.0}referenceable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}referenceable</A>, {<A href="http://www.alfresco.org/model/system/1.0}localized" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}localized</A>, {<A href="http://www.alfresco.org/model/bpm/1.0}workflowPackage" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/bpm/1.0}workflowPackage</A>]'<BR /> 2012-08-03 15:59:49,699&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-6] flushing variable 'bpm_reassignable' from task 'docusignwf:workflow_init' to process variables<BR /> 2012-08-03 15:59:49,699&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'bpm_reassignable' in 'TokenVariableMap[/]' with value 'true'<BR /> 2012-08-03 15:59:49,699&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-6] flushing variable 'bpm_workflowDescription' from task 'docusignwf:workflow_init' to process variables<BR /> 2012-08-03 15:59:49,699&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'bpm_workflowDescription' in 'TokenVariableMap[/]' with value ''<BR /> 2012-08-03 15:59:49,699&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-6] flushing variable 'bpm_workflowDueDate' from task 'docusignwf:workflow_init' to process variables<BR /> 2012-08-03 15:59:49,699&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'bpm_workflowDueDate' in 'TokenVariableMap[/]' with value 'null'<BR /> 2012-08-03 15:59:49,699&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-6] flushing variable 'bpm_status' from task 'docusignwf:workflow_init' to process variables<BR /> 2012-08-03 15:59:49,699&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'bpm_status' in 'TokenVariableMap[/]' with value 'Completed'<BR /> 2012-08-03 15:59:49,699&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-6] flushing variable 'bpm_packageActionGroup' from task 'docusignwf:workflow_init' to process variables<BR /> 2012-08-03 15:59:49,699&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'bpm_packageActionGroup' in 'TokenVariableMap[/]' with value 'add_package_item_actions'<BR /> 2012-08-03 15:59:49,699&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-6] flushing variable 'bpm_packageItemActionGroup' from task 'docusignwf:workflow_init' to process variables<BR /> 2012-08-03 15:59:49,699&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'bpm_packageItemActionGroup' in 'TokenVariableMap[/]' with value 'start_package_item_actions'<BR /> 2012-08-03 15:59:49,699&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-6] flushing variable 'bpm_workflowPriority' from task 'docusignwf:workflow_init' to process variables<BR /> 2012-08-03 15:59:49,699&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'bpm_workflowPriority' in 'TokenVariableMap[/]' with value '2'<BR /> 2012-08-03 15:59:49,699&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-6] flushing variable 'bpm_outcome' from task 'docusignwf:workflow_init' to process variables<BR /> 2012-08-03 15:59:49,701&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'bpm_outcome' in 'TokenVariableMap[/]' with value 'setup'<BR /> 2012-08-03 15:59:49,701&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-6] flushing variable 'docusignwf_request_signature_from' from task 'docusignwf:workflow_init' to process variables<BR /> 2012-08-03 15:59:49,701&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'docusignwf_request_signature_from' in 'TokenVariableMap[/]' with value '(snip)'<BR /> 2012-08-03 15:59:49,701&nbsp; DEBUG [taskmgmt.exe.TaskInstance] [http-8081-6] completion of task 'docusignwf:workflow_init' results in taking the default transition<BR /> 2012-08-03 15:59:49,701&nbsp; DEBUG [graph.def.GraphElement] [http-8081-6] event 'before-signal' on 'StartState(start)' for 'Token(/)'<BR /> 2012-08-03 15:59:49,701&nbsp; DEBUG [graph.def.GraphElement] [http-8081-6] event 'node-leave' on 'StartState(start)' for 'Token(/)'<BR /> 2012-08-03 15:59:49,701&nbsp; DEBUG [graph.def.GraphElement] [http-8081-6] event 'transition' on 'Transition(setup)' for 'Token(/)'<BR /> 2012-08-03 15:59:49,705&nbsp; DEBUG [graph.def.GraphElement] [http-8081-6] executing action 'Script(6b191295)'<BR /> 2012-08-03 15:59:49,705&nbsp; DEBUG [graph.exe.Token] [http-8081-6] token[5240] is locked by token[5240]<BR /> 2012-08-03 15:59:49,711&nbsp; DEBUG [graph.action.Script] [http-8081-6] script input: {bpm_percentComplete=0, bpm_sendEMailNotifications=false, task=null, bpm_hiddenTransitions=, bpm_package=Node Type: {<A href="http://www.alfresco.org/model/bpm/1.0}package" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/bpm/1.0}package</A>, Node Aspects: [{<A href="http://www.alfresco.org/model/content/1.0}auditable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}auditable</A>, {<A href="http://www.alfresco.org/model/system/1.0}referenceable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}referenceable</A>, {<A href="http://www.alfresco.org/model/system/1.0}localized" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}localized</A>, {<A href="http://www.alfresco.org/model/bpm/1.0}workflowPackage" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/bpm/1.0}workflowPackage</A>], cancelled=false, workflowinstanceid=jbpm$5239, initiatorhome=Node Type: {<A href="http://www.alfresco.org/model/content/1.0}folder" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}folder</A>, Node Aspects: [{<A href="http://www.alfresco.org/model/content/1.0}auditable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}auditable</A>, {<A href="http://www.alfresco.org/model/application/1.0}uifacets" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/application/1.0}uifacets</A>, {<A href="http://www.alfresco.org/model/system/1.0}referenceable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}referenceable</A>, {<A href="http://www.alfresco.org/model/content/1.0}titled" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}titled</A>, {<A href="http://www.alfresco.org/model/system/1.0}localized" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}localized</A>], bpm_reassignable=true, bpm_workflowDueDate=null, bpm_workflowDescription=, node=null, bpm_status=Completed, companyhome=Node Type: {<A href="http://www.alfresco.org/model/content/1.0}folder" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}folder</A>, Node Aspects: [{<A href="http://www.alfresco.org/model/content/1.0}auditable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}auditable</A>, {<A href="http://www.alfresco.org/model/application/1.0}uifacets" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/application/1.0}uifacets</A>, {<A href="http://www.alfresco.org/model/system/1.0}referenceable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}referenceable</A>, {<A href="http://www.alfresco.org/model/content/1.0}titled" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}titled</A>, {<A href="http://www.alfresco.org/model/system/1.0}localized" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}localized</A>], bpm_packageActionGroup=add_package_item_actions, initiator=Node Type: {<A href="http://www.alfresco.org/model/content/1.0}person" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}person</A>, Node Aspects: [{<A href="http://www.alfresco.org/model/application/1.0}configurable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/application/1.0}configurable</A>, {<A href="http://www.alfresco.org/model/content/1.0}ownable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}ownable</A>, {<A href="http://www.alfresco.org/model/system/1.0}referenceable" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}referenceable</A>, {<A href="http://www.alfresco.org/model/system/1.0}localized" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/system/1.0}localized</A>, {<A href="http://www.alfresco.org/model/content/1.0}preferences" rel="nofollow noopener noreferrer">http://www.alfresco.org/model/content/1.0}preferences</A>], token=Token(/), bpm_packageItemActionGroup=start_package_item_actions, bpm_outcome=setup, bpm_workflowPriority=2, executionContext=ExecutionContext[Token(/)], docusignwf_request_signature_from=(snip), taskInstance=null}<BR /> 2012-08-03 15:59:49,888&nbsp; DEBUG [graph.action.Script] [http-8081-6] script output: {has_folders=no, waiting_folder=null, integrator_key=(snip), signer_email=(snip), signed_folder=null, uuid=6822a43c-3b59-40a4-b074-5761a257d2f9}<BR /> 2012-08-03 15:59:49,888&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'has_folders' in 'TokenVariableMap[/]' with value 'no'<BR /> 2012-08-03 15:59:49,888&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'waiting_folder' in 'TokenVariableMap[/]' with value 'null'<BR /> 2012-08-03 15:59:49,888&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'integrator_key' in 'TokenVariableMap[/]' with value '(snip)'<BR /> 2012-08-03 15:59:49,888&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'signer_email' in 'TokenVariableMap[/]' with value '(snip)'<BR /> 2012-08-03 15:59:49,888&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'signed_folder' in 'TokenVariableMap[/]' with value 'null'<BR /> 2012-08-03 15:59:49,888&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] create variable 'uuid' in 'TokenVariableMap[/]' with value '6822a43c-3b59-40a4-b074-5761a257d2f9'<BR /> 2012-08-03 15:59:49,892&nbsp; DEBUG [jbpm.bytes.ByteBlockChopper] [http-8081-6] no need to chop 80 bytes<BR /> 2012-08-03 15:59:49,892&nbsp; DEBUG [graph.exe.Token] [http-8081-6] token[5240] is unlocked by token[5240]<BR /> 2012-08-03 15:59:49,894&nbsp; DEBUG [graph.def.GraphElement] [http-8081-6] event 'node-enter' on 'Decision(check_folders)' for 'Token(/)'<BR /> 2012-08-03 15:59:49,902&nbsp; DEBUG [graph.def.GraphElement] [http-8081-6] executing action 'Action(ece5b80)'<BR /> 2012-08-03 15:59:49,902&nbsp; DEBUG [graph.exe.Token] [http-8081-6] token[5240] is locked by token[5240]<BR /> Workflow did NOT provide folders.<BR />&nbsp;&nbsp;&nbsp;And a document didn't, either (wasn't signable). So we need some folders.<BR />2012-08-03 15:59:49,988&nbsp; DEBUG [context.exe.VariableContainer] [http-8081-6] update variable 'has_folders' in 'TokenVariableMap[/]' to value 'no'<BR /> 2012-08-03 15:59:49,988&nbsp; DEBUG [graph.exe.Token] [http-8081-6] token[5240] is unlocked by token[5240]<BR /> 2012-08-03 15:59:50,049&nbsp; DEBUG [graph.node.Decision] [http-8081-6] decision didn't select transition, taking default Transition(no_folders)<BR /> 2012-08-03 15:59:50,049&nbsp; DEBUG [graph.node.Decision] [http-8081-6] decision check_folders is taking 'Transition(no_folders)'<BR /> 2012-08-03 15:59:50,049&nbsp; DEBUG [graph.def.GraphElement] [http-8081-6] event 'node-leave' on 'Decision(check_folders)' for 'Token(/)'<BR /> 2012-08-03 15:59:50,049&nbsp; DEBUG [graph.def.GraphElement] [http-8081-6] event 'transition' on 'Transition(no_folders)' for 'Token(/)'<BR /> 2012-08-03 15:59:50,053&nbsp; DEBUG [graph.def.GraphElement] [http-8081-6] event 'node-enter' on 'TaskNode(need_folders)' for 'Token(/)'<BR /> 2012-08-03 15:59:50,058&nbsp; DEBUG [graph.def.GraphElement] [http-8081-6] event 'task-create' on 'Task(docusignwf:requesting_folders)' for 'Token(/)'<BR /> 2012-08-03 15:59:50,140&nbsp; DEBUG [org.jbpm.JbpmContext] [http-8081-6] closing jbpmContext org.jbpm.JbpmContext@53ec452c<BR /> 2012-08-03 15:59:50,142&nbsp; DEBUG [jbpm.svc.Services] [http-8081-6] closing service 'persistence': org.jbpm.persistence.db.DbPersistenceService@b49ca9<BR /> 2012-08-03 15:59:50,142&nbsp; DEBUG [jbpm.svc.Services] [http-8081-6] closing service 'tx': org.jbpm.tx.TxService@51991b9b<BR /> 2012-08-03 15:59:50,142&nbsp; DEBUG [jbpm.svc.Services] [http-8081-6] closing service 'logging': org.jbpm.logging.db.DbLoggingService@1ae386f7<BR /> 2012-08-03 15:59:50,142&nbsp; DEBUG [jbpm.svc.Services] [http-8081-6] closing service 'authentication': org.jbpm.security.authentication.DefaultAuthenticationService@4fb1cfeb<BR /> 2012-08-03 15:59:50,142&nbsp; DEBUG [alfresco.repo.workflow] [http-8081-6] Detached (rollback) JBPM Context from transaction 5bc0a306-603c-44f9-ae65-5641cacd2eab<SPAN class="line-numbers-rows"><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN><SPAN>‍</SPAN></SPAN></CODE></PRE><BR /><BR /><SPAN>I have a four primary questions:</SPAN><BR /><OL style="list-style-type:decimal;"><LI>(obviously) How do I get the FAILING WORKFLOW to start working?</LI><BR /><LI>How can I get more useful information about what actually happens at the point of failure?</LI><BR /><LI>Where should I start looking for the cause of this?</LI><BR /><LI>What other information would help people answer my first question?</LI></OL></BODY></HTML> Fri, 03 Aug 2012 21:05:29 GMT awbf 2012-08-03T21:05:29Z JBPM Workflow in Alfresco 4.0 fails silently @ task-create https://connect.hyland.com/t5/alfresco-archive/jbpm-workflow-in-alfresco-4-0-fails-silently-task-create/m-p/273556#M226686 I have an advanced JBPM workflow that I am trying to run in Alfresco 4.0.1. It runs without error in Alfresco 3.4.3 and 3.4.5.I am able to run JBPM workflows after adding system.workflow.engine.jbpm.enabled=truesystem.workflow.engine.jbpm.definitions.visible=true‍‍ to alfresco-global.properties.In A Fri, 03 Aug 2012 21:05:29 GMT https://connect.hyland.com/t5/alfresco-archive/jbpm-workflow-in-alfresco-4-0-fails-silently-task-create/m-p/273556#M226686 awbf 2012-08-03T21:05:29Z Re: JBPM Workflow in Alfresco 4.0 fails silently @ task-create https://connect.hyland.com/t5/alfresco-archive/jbpm-workflow-in-alfresco-4-0-fails-silently-task-create/m-p/273557#M226687 <HTML><HEAD></HEAD><BODY><SPAN>Hello,</SPAN><BR /><BR /><SPAN>not being able to find the necessary cause of an error is a common problem with workflows in Alfresco. For some reason, most of the information is dropped at the interface between Alfresco and the workflow engine without being logged ("some reason" = lack of consideration from a developer?).</SPAN><BR /><SPAN>From experience, your best option at this point is to activate the remote Java debugger of your choice and put a breakpoint in JBPMEngine.getStartWorkflowException() - then you will have access to the underlying exception. If your debugger supports executing expressions, you should try a "e.printStackTrace()" to have the information printed into the console / logs. That information may (!) then be sufficient to identify the cause or point you into a more detailed direction of investigation.</SPAN><BR /><BR /><SPAN>Regards</SPAN><BR /><SPAN>Axel</SPAN></BODY></HTML> Sat, 11 Aug 2012 16:26:37 GMT https://connect.hyland.com/t5/alfresco-archive/jbpm-workflow-in-alfresco-4-0-fails-silently-task-create/m-p/273557#M226687 afaust 2012-08-11T16:26:37Z