2 Replies Latest reply on Jan 17, 2010 9:36 AM by Dominic Umbeer

    Deploying JPDL files to jBPM v4.3 / JBoss 5.1

    James Nicolson Newbie

      Hi All,

      I have tried the following in v4.2 and v4.3, with no success. I have installed jBPM from the standard distribution into an existing JBoss 5.1.0 server (java 1.6.0 on macos 10.6.2). JBPM appears to start up correctly in JBoss (jbpm-console works, ProcessEngine is correctly bound, etc).

       

      To deploy a process to this server, the dev guide gives the following instructions:

       

            "In order to deploy a process archive simply copy it to $JBOSS_HOME/server/<config>/deploy:

            (1) cp OrderProcess.jpdl $JBOSS_HOME/server/default/deploy

            (2) less $JBOSS_HOME/server/default/log
            [...]
            2009-04-08 14:12:21,947 INFO  [org.jbpm.integration.jboss4.JBPMDeployer]
            Deploy file:/Users/hbraun/dev/prj/jboss/tags/JBoss_4_2_2_GA
            /build/output/jboss-4.2.2.GA/server/default/deploy/OrderProcess.jpdl"

      When I copy my jpdl file to JBoss, it is not picked up by JBoss (no messages appear in the JBoss log, and I don't see a new process in the jbpm-console).

       

      Could there be a reason why the deployer has not installed correctly? Any help will be greatly appreciated. I deployed jBPM to JBoss using the ant target install.jbpm.into.jboss. If it helps, I have given below the logs from JBoss startup:

       

      22:10:19,101 INFO  [ServerImpl] Starting JBoss (Microcontainer)...
      22:10:19,102 INFO  [ServerImpl] Release ID: JBoss [The Oracle] 5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221053)
      22:10:19,102 INFO  [ServerImpl] Bootstrap URL: null
      22:10:19,102 INFO  [ServerImpl] Home Dir: /Users/james/calabash/3rdparty/jboss-5.1.0.GA
      22:10:19,103 INFO  [ServerImpl] Home URL: file:/Users/james/calabash/3rdparty/jboss-5.1.0.GA/
      22:10:19,103 INFO  [ServerImpl] Library URL: file:/Users/james/calabash/3rdparty/jboss-5.1.0.GA/lib/
      22:10:19,104 INFO  [ServerImpl] Patch URL: null
      22:10:19,104 INFO  [ServerImpl] Common Base URL: file:/Users/james/calabash/3rdparty/jboss-5.1.0.GA/common/
      22:10:19,104 INFO  [ServerImpl] Common Library URL: file:/Users/james/calabash/3rdparty/jboss-5.1.0.GA/common/lib/
      22:10:19,104 INFO  [ServerImpl] Server Name: default
      22:10:19,104 INFO  [ServerImpl] Server Base Dir: /Users/james/calabash/3rdparty/jboss-5.1.0.GA/server
      22:10:19,104 INFO  [ServerImpl] Server Base URL: file:/Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/
      22:10:19,105 INFO  [ServerImpl] Server Config URL: file:/Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default/conf/
      22:10:19,105 INFO  [ServerImpl] Server Home Dir: /Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default
      22:10:19,105 INFO  [ServerImpl] Server Home URL: file:/Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default/
      22:10:19,105 INFO  [ServerImpl] Server Data Dir: /Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default/data
      22:10:19,105 INFO  [ServerImpl] Server Library URL: file:/Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default/lib/
      22:10:19,106 INFO  [ServerImpl] Server Log Dir: /Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default/log
      22:10:19,106 INFO  [ServerImpl] Server Native Dir: /Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default/tmp/native
      22:10:19,106 INFO  [ServerImpl] Server Temp Dir: /Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default/tmp
      22:10:19,106 INFO  [ServerImpl] Server Temp Deploy Dir: /Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default/tmp/deploy
      22:10:20,109 INFO  [ServerImpl] Starting Microcontainer, bootstrapURL=file:/Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default/conf/bootstrap.xml
      22:10:21,244 INFO  [VFSCacheFactory] Initializing VFSCache [org.jboss.virtual.plugins.cache.CombinedVFSCache]
      22:10:21,247 INFO  [VFSCacheFactory] Using VFSCache [CombinedVFSCache[real-cache: null]]
      22:10:21,573 INFO  [CopyMechanism] VFS temp dir: /Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default/tmp
      22:10:21,574 INFO  [ZipEntryContext] VFS force nested jars copy-mode is enabled.
      22:10:23,395 INFO  [ServerInfo] Java version: 1.6.0_17,Apple Inc.
      22:10:23,395 INFO  [ServerInfo] Java Runtime: Java(TM) SE Runtime Environment (build 1.6.0_17-b04-248-10M3025)
      22:10:23,395 INFO  [ServerInfo] Java VM: Java HotSpot(TM) 64-Bit Server VM 14.3-b01-101,Apple Inc.
      22:10:23,395 INFO  [ServerInfo] OS-System: Mac OS X 10.6.2,x86_64
      22:10:23,399 INFO  [ServerInfo] VM arguments: -Xserver -Dprogram.name=JBossTools: JBoss 5.1 Runtime -Xms256m -Xmx512m -XX:MaxPermSize=256m -Dsun.rmi.dgc.client.gcInterval=3600000 -Dsun.rmi.dgc.server.gcInterval=3600000 -Djava.endorsed.dirs=/Users/james/calabash/3rdparty/jboss-5.1.0.GA/lib/endorsed -Dfile.encoding=MacRoman
      22:10:23,435 INFO  [JMXKernel] Legacy JMX core initialized
      22:10:27,003 INFO  [ProfileServiceBootstrap] Loading profile: ProfileKey@5782b9b5[domain=default, server=default, name=default]
      22:10:30,475 INFO  [WebService] Using RMI server codebase: http://localhost:8083/
      22:10:36,528 ERROR [STDERR] [Deprecated] Xalan: org.apache.xml.serializer.XMLEntities
      22:10:39,531 INFO  [NativeServerConfig] JBoss Web Services - Stack Native Core
      22:10:39,531 INFO  [NativeServerConfig] 3.1.2.GA
      22:10:40,436 INFO  [AttributeCallbackItem] Owner callback not implemented.
      22:10:42,934 INFO  [LogNotificationListener] Adding notification listener for logging mbean "jboss.system:service=Logging,type=Log4jService" to server org.jboss.mx.server.MBeanServerImpl@3fe88b35[ defaultDomain='jboss' ]
      22:11:06,357 INFO  [ContainerDependencyMetaData] addJndiDependency, JndiDependencyMetaData@4f276412{queue/DLQ}
      22:11:18,160 INFO  [Ejb3DependenciesDeployer] Encountered deployment AbstractVFSDeploymentContext@372583398{vfsfile:/Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default/deploy/jbpm/jbpm-enterprise.jar/}
      22:11:18,366 INFO  [Ejb3DependenciesDeployer] Encountered deployment AbstractVFSDeploymentContext@372583398{vfsfile:/Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default/deploy/jbpm/jbpm-enterprise.jar/}
      22:11:18,368 INFO  [Ejb3DependenciesDeployer] Encountered deployment AbstractVFSDeploymentContext@372583398{vfsfile:/Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default/deploy/jbpm/jbpm-enterprise.jar/}
      22:11:18,369 INFO  [Ejb3DependenciesDeployer] Encountered deployment AbstractVFSDeploymentContext@1429010877{vfsfile:/Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default/deploy/profileservice-secured.jar/}
      22:11:18,370 INFO  [Ejb3DependenciesDeployer] Encountered deployment AbstractVFSDeploymentContext@1429010877{vfsfile:/Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default/deploy/profileservice-secured.jar/}
      22:11:18,370 INFO  [Ejb3DependenciesDeployer] Encountered deployment AbstractVFSDeploymentContext@1429010877{vfsfile:/Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default/deploy/profileservice-secured.jar/}
      22:11:18,371 INFO  [Ejb3DependenciesDeployer] Encountered deployment AbstractVFSDeploymentContext@1429010877{vfsfile:/Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default/deploy/profileservice-secured.jar/}
      22:11:20,627 INFO  [JBossASKernel] Created KernelDeployment for: freemarker.jar
      22:11:20,631 INFO  [JBossASKernel] installing bean: jboss.j2ee:ear=jbpm-service.sar,jar=freemarker.jar,name=freemarker,service=EJB3
      22:11:20,631 INFO  [JBossASKernel]   with dependencies:
      22:11:20,631 INFO  [JBossASKernel]   and demands:
      22:11:20,631 INFO  [JBossASKernel]   and supplies:
      22:11:20,631 INFO  [JBossASKernel] Added bean(jboss.j2ee:ear=jbpm-service.sar,jar=freemarker.jar,name=freemarker,service=EJB3) to KernelDeployment of: freemarker.jar
      22:11:20,634 INFO  [JBossASKernel] Created KernelDeployment for: juel.jar
      22:11:20,634 INFO  [JBossASKernel] installing bean: jboss.j2ee:ear=jbpm-service.sar,jar=juel.jar,name=juel,service=EJB3
      22:11:20,634 INFO  [JBossASKernel]   with dependencies:
      22:11:20,634 INFO  [JBossASKernel]   and demands:
      22:11:20,634 INFO  [JBossASKernel]   and supplies:
      22:11:20,634 INFO  [JBossASKernel] Added bean(jboss.j2ee:ear=jbpm-service.sar,jar=juel.jar,name=juel,service=EJB3) to KernelDeployment of: juel.jar
      22:11:20,638 INFO  [JBossASKernel] Created KernelDeployment for: mvel2.jar
      22:11:20,639 INFO  [JBossASKernel] installing bean: jboss.j2ee:ear=jbpm-service.sar,jar=mvel2.jar,name=mvel2,service=EJB3
      22:11:20,639 INFO  [JBossASKernel]   with dependencies:
      22:11:20,640 INFO  [JBossASKernel]   and demands:
      22:11:20,640 INFO  [JBossASKernel]   and supplies:
      22:11:20,640 INFO  [JBossASKernel] Added bean(jboss.j2ee:ear=jbpm-service.sar,jar=mvel2.jar,name=mvel2,service=EJB3) to KernelDeployment of: mvel2.jar
      22:11:22,283 INFO  [ClientENCInjectionContainer] STARTED CLIENT ENC CONTAINER: freemarker
      22:11:22,312 INFO  [ClientENCInjectionContainer] STARTED CLIENT ENC CONTAINER: juel
      22:11:22,346 INFO  [ClientENCInjectionContainer] STARTED CLIENT ENC CONTAINER: mvel2
      22:11:22,894 INFO  [JMXConnectorServerService] JMX Connector server: service:jmx:rmi://localhost/jndi/rmi://localhost:1090/jmxconnector
      22:11:23,318 INFO  [MailService] Mail Service bound to java:/Mail
      22:11:26,706 WARN  [JBossASSecurityMetadataStore] WARNING! POTENTIAL SECURITY RISK. It has been detected that the MessageSucker component which sucks messages from one node to another has not had its password changed from the installation default. Please see the JBoss Messaging user guide for instructions on how to do this.
      22:11:26,723 WARN  [AnnotationCreator] No ClassLoader provided, using TCCL: org.jboss.managed.api.annotation.ManagementComponent
      22:11:26,810 WARN  [AnnotationCreator] No ClassLoader provided, using TCCL: org.jboss.managed.api.annotation.ManagementComponent
      22:11:26,887 INFO  [TransactionManagerService] JBossTS Transaction Service (JTA version - tag:JBOSSTS_4_6_1_GA) - JBoss Inc.
      22:11:26,888 INFO  [TransactionManagerService] Setting up property manager MBean and JMX layer
      22:11:27,579 INFO  [TransactionManagerService] Initializing recovery manager
      22:11:27,740 INFO  [TransactionManagerService] Recovery manager configured
      22:11:27,740 INFO  [TransactionManagerService] Binding TransactionManager JNDI Reference
      22:11:27,786 INFO  [TransactionManagerService] Starting transaction recovery manager
      22:11:28,360 INFO  [AprLifecycleListener] The Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: .:/Library/Java/Extensions:/System/Library/Java/Extensions:/usr/lib/java
      22:11:28,437 INFO  [Http11Protocol] Initializing Coyote HTTP/1.1 on http-localhost%2F127.0.0.1-8080
      22:11:28,438 INFO  [AjpProtocol] Initializing Coyote AJP/1.3 on ajp-localhost%2F127.0.0.1-8009
      22:11:28,466 INFO  [StandardService] Starting service jboss.web
      22:11:28,469 INFO  [StandardEngine] Starting Servlet Engine: JBoss Web/2.1.3.GA
      22:11:28,559 INFO  [Catalina] Server startup in 120 ms
      22:11:28,587 INFO  [TomcatDeployment] deploy, ctxPath=/web-console
      22:11:30,045 INFO  [TomcatDeployment] deploy, ctxPath=/invoker
      22:11:30,099 INFO  [TomcatDeployment] deploy, ctxPath=/jbossws
      22:11:30,214 INFO  [RARDeployment] Required license terms exist, view vfszip:/Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default/deploy/jboss-local-jdbc.rar/META-INF/ra.xml
      22:11:30,233 INFO  [RARDeployment] Required license terms exist, view vfszip:/Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default/deploy/jboss-xa-jdbc.rar/META-INF/ra.xml
      22:11:30,272 INFO  [RARDeployment] Required license terms exist, view vfszip:/Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default/deploy/jms-ra.rar/META-INF/ra.xml
      22:11:30,515 INFO  [RARDeployment] Required license terms exist, view vfszip:/Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default/deploy/mail-ra.rar/META-INF/ra.xml
      22:11:30,553 INFO  [RARDeployment] Required license terms exist, view vfszip:/Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default/deploy/quartz-ra.rar/META-INF/ra.xml
      22:11:30,630 INFO  [SimpleThreadPool] Job execution threads will use class loader of thread: main
      22:11:30,709 INFO  [QuartzScheduler] Quartz Scheduler v.1.5.2 created.
      22:11:30,725 INFO  [RAMJobStore] RAMJobStore initialized.
      22:11:30,725 INFO  [StdSchedulerFactory] Quartz scheduler 'DefaultQuartzScheduler' initialized from default resource file in Quartz package: 'quartz.properties'
      22:11:30,725 INFO  [StdSchedulerFactory] Quartz scheduler version: 1.5.2
      22:11:30,726 INFO  [QuartzScheduler] Scheduler DefaultQuartzScheduler_$_NON_CLUSTERED started.
      22:11:31,025 INFO  [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=DataSourceBinding,name=JbpmDS' to JNDI name 'java:JbpmDS'
      22:11:32,334 INFO  [DispatcherThread] starting DispatcherThread
      22:11:32,455 INFO  [Environment] Hibernate 3.3.1.GA
      22:11:32,461 INFO  [Environment] hibernate.properties not found
      22:11:32,466 INFO  [Environment] Bytecode provider name : javassist
      22:11:32,476 INFO  [Environment] using JDK 1.4 java.sql.Timestamp handling
      22:11:32,587 INFO  [Configuration] configuring from resource: jbpm.hibernate.cfg.xml
      22:11:32,587 INFO  [Configuration] Configuration resource: jbpm.hibernate.cfg.xml
      22:11:32,595 INFO  [Configuration] Reading mappings from resource : jbpm.repository.hbm.xml
      22:11:32,692 INFO  [HbmBinder] Mapping class: org.jbpm.pvm.internal.repository.DeploymentImpl -> JBPM4_DEPLOYMENT
      22:11:32,745 INFO  [HbmBinder] Mapping class: org.jbpm.pvm.internal.repository.DeploymentProperty -> JBPM4_DEPLOYPROP
      22:11:32,844 INFO  [HbmBinder] Mapping class: org.jbpm.pvm.internal.id.PropertyImpl -> JBPM4_PROPERTY
      22:11:32,848 INFO  [Configuration] Reading mappings from resource : jbpm.execution.hbm.xml
      22:11:32,917 INFO  [HbmBinder] Mapping class: org.jbpm.pvm.internal.model.ExecutionImpl -> JBPM4_EXECUTION
      22:11:33,256 INFO  [HbmBinder] Mapping class: org.jbpm.pvm.internal.type.Variable -> JBPM4_VARIABLE
      22:11:33,315 INFO  [HbmBinder] Mapping subclass: org.jbpm.pvm.internal.type.variable.BlobVariable -> JBPM4_VARIABLE
      22:11:33,316 INFO  [HbmBinder] Mapping subclass: org.jbpm.pvm.internal.type.variable.DateVariable -> JBPM4_VARIABLE
      22:11:33,316 INFO  [HbmBinder] Mapping subclass: org.jbpm.pvm.internal.type.variable.DoubleVariable -> JBPM4_VARIABLE
      22:11:33,317 INFO  [HbmBinder] Mapping subclass: org.jbpm.pvm.internal.type.variable.HibernateLongVariable -> JBPM4_VARIABLE
      22:11:33,318 INFO  [HbmBinder] Mapping subclass: org.jbpm.pvm.internal.type.variable.HibernateStringVariable -> JBPM4_VARIABLE
      22:11:33,318 INFO  [HbmBinder] Mapping subclass: org.jbpm.pvm.internal.type.variable.LongVariable -> JBPM4_VARIABLE
      22:11:33,318 INFO  [HbmBinder] Mapping subclass: org.jbpm.pvm.internal.type.variable.NullVariable -> JBPM4_VARIABLE
      22:11:33,319 INFO  [HbmBinder] Mapping subclass: org.jbpm.pvm.internal.type.variable.StringVariable -> JBPM4_VARIABLE
      22:11:33,319 INFO  [HbmBinder] Mapping subclass: org.jbpm.pvm.internal.type.variable.TextVariable -> JBPM4_VARIABLE
      22:11:33,319 INFO  [HbmBinder] Mapping class: org.jbpm.pvm.internal.lob.Lob -> JBPM4_LOB
      22:11:33,324 INFO  [HbmBinder] Mapping class: org.jbpm.pvm.internal.job.JobImpl -> JBPM4_JOB
      22:11:33,328 INFO  [HbmBinder] Mapping subclass: org.jbpm.pvm.internal.job.MessageImpl -> JBPM4_JOB
      22:11:33,328 INFO  [HbmBinder] Mapping subclass: org.jbpm.pvm.internal.model.op.ExecuteActivityMessage -> JBPM4_JOB
      22:11:33,328 INFO  [HbmBinder] Mapping subclass: org.jbpm.pvm.internal.model.op.ExecuteEventListenerMessage -> JBPM4_JOB
      22:11:33,328 INFO  [HbmBinder] Mapping subclass: org.jbpm.pvm.internal.job.CommandMessage -> JBPM4_JOB
      22:11:33,329 INFO  [HbmBinder] Mapping subclass: org.jbpm.pvm.internal.job.TimerImpl -> JBPM4_JOB
      22:11:33,334 INFO  [Configuration] Reading mappings from resource : jbpm.history.hbm.xml
      22:11:33,387 INFO  [HbmBinder] Mapping class: org.jbpm.pvm.internal.history.model.HistoryProcessInstanceImpl -> JBPM4_HIST_PROCINST
      22:11:33,394 INFO  [HbmBinder] Mapping class: org.jbpm.pvm.internal.history.model.HistoryActivityInstanceImpl -> JBPM4_HIST_ACTINST
      22:11:33,398 INFO  [HbmBinder] Mapping subclass: org.jbpm.pvm.internal.history.model.HistoryAutomaticInstanceImpl -> JBPM4_HIST_ACTINST
      22:11:33,398 INFO  [HbmBinder] Mapping subclass: org.jbpm.pvm.internal.history.model.HistoryDecisionInstanceImpl -> JBPM4_HIST_ACTINST
      22:11:33,399 INFO  [HbmBinder] Mapping subclass: org.jbpm.pvm.internal.history.model.HistoryTaskInstanceImpl -> JBPM4_HIST_ACTINST
      22:11:33,399 INFO  [HbmBinder] Mapping class: org.jbpm.pvm.internal.history.model.HistoryTaskImpl -> JBPM4_HIST_TASK
      22:11:33,407 INFO  [HbmBinder] Mapping class: org.jbpm.pvm.internal.history.model.HistoryVariableImpl -> JBPM4_HIST_VAR
      22:11:33,410 INFO  [HbmBinder] Mapping class: org.jbpm.pvm.internal.history.model.HistoryDetailImpl -> JBPM4_HIST_DETAIL
      22:11:33,412 INFO  [HbmBinder] Mapping subclass: org.jbpm.pvm.internal.history.model.HistoryCommentImpl -> JBPM4_HIST_DETAIL
      22:11:33,412 INFO  [HbmBinder] Mapping subclass: org.jbpm.pvm.internal.history.model.HistoryProcessInstanceMigrationImpl -> JBPM4_HIST_DETAIL
      22:11:33,414 INFO  [HbmBinder] Mapping subclass: org.jbpm.pvm.internal.history.model.HistoryPriorityUpdateImpl -> JBPM4_HIST_DETAIL
      22:11:33,414 INFO  [HbmBinder] Mapping subclass: org.jbpm.pvm.internal.history.model.HistoryTaskAssignmentImpl -> JBPM4_HIST_DETAIL
      22:11:33,415 INFO  [HbmBinder] Mapping subclass: org.jbpm.pvm.internal.history.model.HistoryTaskDuedateUpdateImpl -> JBPM4_HIST_DETAIL
      22:11:33,415 INFO  [HbmBinder] Mapping subclass: org.jbpm.pvm.internal.history.model.HistoryVariableUpdateImpl -> JBPM4_HIST_DETAIL
      22:11:33,416 INFO  [Configuration] Reading mappings from resource : jbpm.task.hbm.xml
      22:11:33,458 INFO  [HbmBinder] Mapping class: org.jbpm.pvm.internal.task.TaskImpl -> JBPM4_TASK
      22:11:33,482 INFO  [HbmBinder] Mapping class: org.jbpm.pvm.internal.task.ParticipationImpl -> JBPM4_PARTICIPATION
      22:11:33,486 INFO  [HbmBinder] Mapping class: org.jbpm.pvm.internal.task.SwimlaneImpl -> JBPM4_SWIMLANE
      22:11:33,487 INFO  [Configuration] Reading mappings from resource : jbpm.identity.hbm.xml
      22:11:33,514 INFO  [HbmBinder] Mapping class: org.jbpm.pvm.internal.identity.impl.UserImpl -> JBPM4_ID_USER
      22:11:33,518 INFO  [HbmBinder] Mapping class: org.jbpm.pvm.internal.identity.impl.MembershipImpl -> JBPM4_ID_MEMBERSHIP
      22:11:33,520 INFO  [HbmBinder] Mapping class: org.jbpm.pvm.internal.identity.impl.GroupImpl -> JBPM4_ID_GROUP
      22:11:33,522 INFO  [Configuration] Configured SessionFactory: null
      22:11:33,523 INFO  [HbmBinder] Mapping collection: org.jbpm.pvm.internal.repository.DeploymentImpl.resources -> JBPM4_LOB
      22:11:33,524 INFO  [HbmBinder] Mapping collection: org.jbpm.pvm.internal.repository.DeploymentImpl.objectProperties -> JBPM4_DEPLOYPROP
      22:11:33,524 INFO  [HbmBinder] Mapping collection: org.jbpm.pvm.internal.model.ExecutionImpl.variables -> JBPM4_VARIABLE
      22:11:33,525 INFO  [HbmBinder] Mapping collection: org.jbpm.pvm.internal.model.ExecutionImpl.systemVariables -> JBPM4_VARIABLE
      22:11:33,525 INFO  [HbmBinder] Mapping collection: org.jbpm.pvm.internal.model.ExecutionImpl.executions -> JBPM4_EXECUTION
      22:11:33,526 INFO  [HbmBinder] Mapping collection: org.jbpm.pvm.internal.model.ExecutionImpl.swimlanes -> JBPM4_SWIMLANE
      22:11:33,526 INFO  [HbmBinder] Mapping collection: org.jbpm.pvm.internal.history.model.HistoryProcessInstanceImpl.historyActivityInstances -> JBPM4_HIST_ACTINST
      22:11:33,526 INFO  [HbmBinder] Mapping collection: org.jbpm.pvm.internal.history.model.HistoryProcessInstanceImpl.historyVariables -> JBPM4_HIST_VAR
      22:11:33,526 INFO  [HbmBinder] Mapping collection: org.jbpm.pvm.internal.history.model.HistoryProcessInstanceImpl.details -> JBPM4_HIST_DETAIL
      22:11:33,526 INFO  [HbmBinder] Mapping collection: org.jbpm.pvm.internal.history.model.HistoryActivityInstanceImpl.details -> JBPM4_HIST_DETAIL
      22:11:33,526 INFO  [HbmBinder] Mapping collection: org.jbpm.pvm.internal.history.model.HistoryTaskImpl.details -> JBPM4_HIST_DETAIL
      22:11:33,526 INFO  [HbmBinder] Mapping collection: org.jbpm.pvm.internal.history.model.HistoryTaskImpl.historyVariables -> JBPM4_HIST_VAR
      22:11:33,527 INFO  [HbmBinder] Mapping collection: org.jbpm.pvm.internal.history.model.HistoryTaskImpl.subTasks -> JBPM4_HIST_TASK
      22:11:33,527 INFO  [HbmBinder] Mapping collection: org.jbpm.pvm.internal.history.model.HistoryVariableImpl.details -> JBPM4_HIST_DETAIL
      22:11:33,527 INFO  [HbmBinder] Mapping collection: org.jbpm.pvm.internal.history.model.HistoryCommentImpl.replies -> JBPM4_HIST_DETAIL
      22:11:33,527 INFO  [HbmBinder] Mapping collection: org.jbpm.pvm.internal.task.TaskImpl.participations -> JBPM4_PARTICIPATION
      22:11:33,527 INFO  [HbmBinder] Mapping collection: org.jbpm.pvm.internal.task.TaskImpl.variables -> JBPM4_VARIABLE
      22:11:33,527 INFO  [HbmBinder] Mapping collection: org.jbpm.pvm.internal.task.TaskImpl.subTasks -> JBPM4_TASK
      22:11:33,527 INFO  [HbmBinder] Mapping collection: org.jbpm.pvm.internal.task.SwimlaneImpl.participations -> JBPM4_PARTICIPATION
      22:11:33,551 INFO  [NamingHelper] JNDI InitialContext properties:{}
      22:11:33,552 INFO  [DatasourceConnectionProvider] Using datasource: java:JbpmDS
      22:11:34,184 INFO  [SettingsFactory] RDBMS: MySQL, version: 5.1.39
      22:11:34,184 INFO  [SettingsFactory] JDBC driver: MySQL-AB JDBC Driver, version: mysql-connector-java-5.1.10 ( Revision: ${svn.Revision} )
      22:11:34,216 INFO  [Dialect] Using dialect: org.hibernate.dialect.MySQLInnoDBDialect
      22:11:34,224 INFO  [TransactionFactoryFactory] Transaction strategy: org.hibernate.transaction.JTATransactionFactory
      22:11:34,227 INFO  [NamingHelper] JNDI InitialContext properties:{}
      22:11:34,228 INFO  [TransactionManagerLookupFactory] instantiating TransactionManagerLookup: org.hibernate.transaction.JBossTransactionManagerLookup
      22:11:34,231 INFO  [TransactionManagerLookupFactory] instantiated TransactionManagerLookup
      22:11:34,231 INFO  [SettingsFactory] Automatic flush during beforeCompletion(): disabled
      22:11:34,231 INFO  [SettingsFactory] Automatic session close at end of transaction: disabled
      22:11:34,232 INFO  [SettingsFactory] JDBC batch size: 15
      22:11:34,232 INFO  [SettingsFactory] JDBC batch updates for versioned data: disabled
      22:11:34,233 INFO  [SettingsFactory] Scrollable result sets: enabled
      22:11:34,233 INFO  [SettingsFactory] JDBC3 getGeneratedKeys(): enabled
      22:11:34,233 INFO  [SettingsFactory] Connection release mode: auto
      22:11:34,235 INFO  [SettingsFactory] Maximum outer join fetch depth: 2
      22:11:34,235 INFO  [SettingsFactory] Default batch fetch size: 1
      22:11:34,235 INFO  [SettingsFactory] Generate SQL with comments: disabled
      22:11:34,235 INFO  [SettingsFactory] Order SQL updates by primary key: disabled
      22:11:34,236 INFO  [SettingsFactory] Order SQL inserts for batching: disabled
      22:11:34,236 INFO  [SettingsFactory] Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory
      22:11:34,240 INFO  [ASTQueryTranslatorFactory] Using ASTQueryTranslatorFactory
      22:11:34,240 INFO  [SettingsFactory] Query language substitutions: {}
      22:11:34,240 INFO  [SettingsFactory] JPA-QL strict compliance: disabled
      22:11:34,240 INFO  [SettingsFactory] Second-level cache: enabled
      22:11:34,241 INFO  [SettingsFactory] Query cache: disabled
      22:11:34,241 INFO  [SettingsFactory] Cache region factory : org.hibernate.cache.impl.NoCachingRegionFactory
      22:11:34,241 INFO  [SettingsFactory] Optimize cache for minimal puts: disabled
      22:11:34,241 INFO  [SettingsFactory] Structured second-level cache entries: disabled
      22:11:34,260 INFO  [SettingsFactory] Statistics: disabled
      22:11:34,260 INFO  [SettingsFactory] Deleted entity synthetic identifier rollback: disabled
      22:11:34,260 INFO  [SettingsFactory] Default entity-mode: pojo
      22:11:34,261 INFO  [SettingsFactory] Named query checking : enabled
      22:11:34,345 INFO  [SessionFactoryImpl] building session factory
      22:11:35,657 INFO  [SessionFactoryObjectFactory] Not binding factory to JNDI, no JNDI name configured
      22:11:35,658 INFO  [NamingHelper] JNDI InitialContext properties:{}
      22:11:36,488 INFO  [CheckDbCmd] jBPM version info: library[4.3], schema[4.3]
      22:11:36,491 INFO  [JbpmService] JbpmService started
      22:11:36,924 INFO  [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=DataSourceBinding,name=DefaultDS' to JNDI name 'java:DefaultDS'
      22:11:37,249 WARN  [JDBCPersistenceManager]

       

      JBoss Messaging Warning: DataSource connection transaction isolation should be READ_COMMITTED, but it is currently REPEATABLE_READ.
                               Using an isolation level less strict than READ_COMMITTED may lead to data consistency problems.
                               Using an isolation level more strict than READ_COMMITTED may lead to deadlock.

       

      22:11:37,541 INFO  [ServerPeer] JBoss Messaging 1.4.3.GA server [0] started
      22:11:37,717 INFO  [TopicService] Topic[/topic/CalabashObject] started, fullSize=200000, pageSize=2000, downCacheSize=2000
      22:11:37,799 INFO  [QueueService] Queue[/queue/DLQ] started, fullSize=200000, pageSize=2000, downCacheSize=2000
      22:11:37,996 INFO  [ConnectionFactory] Connector bisocket://localhost:4457 has leasing enabled, lease period 10000 milliseconds
      22:11:37,996 INFO  [ConnectionFactory] org.jboss.jms.server.connectionfactory.ConnectionFactory@5af33ce2 started
      22:11:38,004 INFO  [QueueService] Queue[/queue/JbpmCommandQueue] started, fullSize=200000, pageSize=2000, downCacheSize=2000
      22:11:38,008 INFO  [ConnectionFactoryJNDIMapper] supportsFailover attribute is true on connection factory: jboss.messaging.connectionfactory:service=ClusteredConnectionFactory but post office is non clustered. So connection factory will *not* support failover
      22:11:38,008 INFO  [ConnectionFactoryJNDIMapper] supportsLoadBalancing attribute is true on connection factory: jboss.messaging.connectionfactory:service=ClusteredConnectionFactory but post office is non clustered. So connection factory will *not* support load balancing
      22:11:38,009 INFO  [ConnectionFactory] Connector bisocket://localhost:4457 has leasing enabled, lease period 10000 milliseconds
      22:11:38,009 INFO  [ConnectionFactory] org.jboss.jms.server.connectionfactory.ConnectionFactory@422df3fe started
      22:11:38,012 INFO  [QueueService] Queue[/queue/ExpiryQueue] started, fullSize=200000, pageSize=2000, downCacheSize=2000
      22:11:38,015 INFO  [QueueService] Queue[/queue/Calabash] started, fullSize=200000, pageSize=2000, downCacheSize=2000
      22:11:38,016 INFO  [ConnectionFactory] Connector bisocket://localhost:4457 has leasing enabled, lease period 10000 milliseconds
      22:11:38,016 INFO  [ConnectionFactory] org.jboss.jms.server.connectionfactory.ConnectionFactory@64d53392 started
      22:11:39,558 INFO  [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=ConnectionFactoryBinding,name=JmsXA' to JNDI name 'java:JmsXA'
      22:11:39,705 INFO  [EjbDeployer] installing bean: ejb/#CommandExecutor,uid387290512
      22:11:39,706 INFO  [EjbDeployer]   with dependencies:
      22:11:39,706 INFO  [EjbDeployer]   and supplies:
      22:11:39,706 INFO  [EjbDeployer]     jndi:java:jbpm/CommandExecutor
      22:11:39,706 INFO  [EjbDeployer]     jndi:jbpm/CommandExecutor
      22:11:39,707 INFO  [EjbDeployer] installing bean: ejb/#CommandReceiver,uid905164828
      22:11:39,707 INFO  [EjbDeployer]   with dependencies:
      22:11:39,708 INFO  [EjbDeployer]   and supplies:
      22:11:39,708 INFO  [EjbDeployer]     jndi:null
      22:11:39,708 INFO  [EjbDeployer] installing bean: ejb/#Timer,uid331108848
      22:11:39,709 INFO  [EjbDeployer]   with dependencies:
      22:11:39,709 INFO  [EjbDeployer]   and supplies:
      22:11:39,709 INFO  [EjbDeployer]     jndi:java:jbpm/Timer
      22:11:39,709 INFO  [EjbDeployer]     jndi:Timer
      22:11:39,997 INFO  [EjbModule] Deploying CommandExecutor
      22:11:40,144 WARN  [EjbModule] EJB configured to bypass security. Please verify if this is intended. Bean=CommandExecutor Deployment=vfsfile:/Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default/deploy/jbpm/jbpm-enterprise.jar/
      22:11:40,192 INFO  [EjbModule] Deploying CommandReceiver
      22:11:40,199 WARN  [EjbModule] EJB configured to bypass security. Please verify if this is intended. Bean=CommandReceiver Deployment=vfsfile:/Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default/deploy/jbpm/jbpm-enterprise.jar/
      22:11:40,224 INFO  [EjbModule] Deploying Timer
      22:11:40,239 WARN  [EjbModule] EJB configured to bypass security. Please verify if this is intended. Bean=Timer Deployment=vfsfile:/Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default/deploy/jbpm/jbpm-enterprise.jar/
      22:11:42,171 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'CommandExecutor' to jndi 'java:jbpm/CommandExecutor'
      22:11:42,185 INFO  [ProxyFactory] Bound EJB Home 'CommandExecutor' to jndi 'jbpm/CommandExecutor'
      22:11:42,459 INFO  [BaseLocalProxyFactory] Bound EJB LocalHome 'Timer' to jndi 'java:jbpm/Timer'
      22:11:44,029 INFO  [JBossASKernel] Created KernelDeployment for: profileservice-secured.jar
      22:11:44,029 INFO  [JBossASKernel] installing bean: jboss.j2ee:jar=profileservice-secured.jar,name=SecureProfileService,service=EJB3
      22:11:44,029 INFO  [JBossASKernel]   with dependencies:
      22:11:44,030 INFO  [JBossASKernel]   and demands:
      22:11:44,030 INFO  [JBossASKernel]     jndi:SecureManagementView/remote-org.jboss.deployers.spi.management.ManagementView
      22:11:44,030 INFO  [JBossASKernel]     jboss.ejb:service=EJBTimerService
      22:11:44,030 INFO  [JBossASKernel]   and supplies:
      22:11:44,030 INFO  [JBossASKernel]     Class:org.jboss.profileservice.spi.ProfileService
      22:11:44,030 INFO  [JBossASKernel]     jndi:SecureProfileService/remote
      22:11:44,030 INFO  [JBossASKernel]     jndi:SecureProfileService/remote-org.jboss.profileservice.spi.ProfileService
      22:11:44,030 INFO  [JBossASKernel] Added bean(jboss.j2ee:jar=profileservice-secured.jar,name=SecureProfileService,service=EJB3) to KernelDeployment of: profileservice-secured.jar
      22:11:44,032 INFO  [JBossASKernel] installing bean: jboss.j2ee:jar=profileservice-secured.jar,name=SecureDeploymentManager,service=EJB3
      22:11:44,032 INFO  [JBossASKernel]   with dependencies:
      22:11:44,032 INFO  [JBossASKernel]   and demands:
      22:11:44,032 INFO  [JBossASKernel]     jboss.ejb:service=EJBTimerService
      22:11:44,032 INFO  [JBossASKernel]   and supplies:
      22:11:44,032 INFO  [JBossASKernel]     jndi:SecureDeploymentManager/remote-org.jboss.deployers.spi.management.deploy.DeploymentManager
      22:11:44,032 INFO  [JBossASKernel]     Class:org.jboss.deployers.spi.management.deploy.DeploymentManager
      22:11:44,032 INFO  [JBossASKernel]     jndi:SecureDeploymentManager/remote
      22:11:44,032 INFO  [JBossASKernel] Added bean(jboss.j2ee:jar=profileservice-secured.jar,name=SecureDeploymentManager,service=EJB3) to KernelDeployment of: profileservice-secured.jar
      22:11:44,033 INFO  [JBossASKernel] installing bean: jboss.j2ee:jar=profileservice-secured.jar,name=SecureManagementView,service=EJB3
      22:11:44,033 INFO  [JBossASKernel]   with dependencies:
      22:11:44,033 INFO  [JBossASKernel]   and demands:
      22:11:44,033 INFO  [JBossASKernel]     jboss.ejb:service=EJBTimerService
      22:11:44,033 INFO  [JBossASKernel]   and supplies:
      22:11:44,033 INFO  [JBossASKernel]     jndi:SecureManagementView/remote-org.jboss.deployers.spi.management.ManagementView
      22:11:44,033 INFO  [JBossASKernel]     Class:org.jboss.deployers.spi.management.ManagementView
      22:11:44,033 INFO  [JBossASKernel]     jndi:SecureManagementView/remote
      22:11:44,033 INFO  [JBossASKernel] Added bean(jboss.j2ee:jar=profileservice-secured.jar,name=SecureManagementView,service=EJB3) to KernelDeployment of: profileservice-secured.jar
      22:11:44,042 INFO  [EJB3EndpointDeployer] Deploy AbstractBeanMetaData@36cc28ae{name=jboss.j2ee:jar=profileservice-secured.jar,name=SecureProfileService,service=EJB3_endpoint bean=org.jboss.ejb3.endpoint.deployers.impl.EndpointImpl properties=[container] constructor=null autowireCandidate=true}
      22:11:44,072 INFO  [EJB3EndpointDeployer] Deploy AbstractBeanMetaData@5c750647{name=jboss.j2ee:jar=profileservice-secured.jar,name=SecureDeploymentManager,service=EJB3_endpoint bean=org.jboss.ejb3.endpoint.deployers.impl.EndpointImpl properties=[container] constructor=null autowireCandidate=true}
      22:11:44,072 INFO  [EJB3EndpointDeployer] Deploy AbstractBeanMetaData@491a5dd9{name=jboss.j2ee:jar=profileservice-secured.jar,name=SecureManagementView,service=EJB3_endpoint bean=org.jboss.ejb3.endpoint.deployers.impl.EndpointImpl properties=[container] constructor=null autowireCandidate=true}
      22:11:44,779 INFO  [SessionSpecContainer] Starting jboss.j2ee:jar=profileservice-secured.jar,name=SecureDeploymentManager,service=EJB3
      22:11:44,920 INFO  [EJBContainer] STARTED EJB: org.jboss.profileservice.ejb.SecureDeploymentManager ejbName: SecureDeploymentManager
      22:11:45,171 INFO  [JndiSessionRegistrarBase] Binding the following Entries in Global JNDI:

       

          SecureDeploymentManager/remote - EJB3.x Default Remote Business Interface
          SecureDeploymentManager/remote-org.jboss.deployers.spi.management.deploy.DeploymentManager - EJB3.x Remote Business Interface

       

      22:11:45,593 INFO  [SessionSpecContainer] Starting jboss.j2ee:jar=profileservice-secured.jar,name=SecureManagementView,service=EJB3
      22:11:45,594 INFO  [EJBContainer] STARTED EJB: org.jboss.profileservice.ejb.SecureManagementView ejbName: SecureManagementView
      22:11:45,635 INFO  [JndiSessionRegistrarBase] Binding the following Entries in Global JNDI:

       

          SecureManagementView/remote - EJB3.x Default Remote Business Interface
          SecureManagementView/remote-org.jboss.deployers.spi.management.ManagementView - EJB3.x Remote Business Interface

       

      22:11:45,994 INFO  [SessionSpecContainer] Starting jboss.j2ee:jar=profileservice-secured.jar,name=SecureProfileService,service=EJB3
      22:11:45,996 INFO  [EJBContainer] STARTED EJB: org.jboss.profileservice.ejb.SecureProfileServiceBean ejbName: SecureProfileService
      22:11:46,009 INFO  [JndiSessionRegistrarBase] Binding the following Entries in Global JNDI:

       

          SecureProfileService/remote - EJB3.x Default Remote Business Interface
          SecureProfileService/remote-org.jboss.profileservice.spi.ProfileService - EJB3.x Remote Business Interface

       

      22:11:46,340 INFO  [TomcatDeployment] deploy, ctxPath=/admin-console
      22:11:46,639 INFO  [config] Initializing Mojarra (1.2_12-b01-FCS) for context '/admin-console'
      22:11:51,948 INFO  [TomcatDeployment] deploy, ctxPath=/
      22:11:58,939 INFO  [TomcatDeployment] deploy, ctxPath=/jbpm-console
      22:12:00,495 INFO  [TomcatDeployment] deploy, ctxPath=/gwt-console-server
      22:12:01,035 WARN  [ResteasyBootstrap] The use of javax.ws.rs.core.Application is deprecated, please use javax.ws.rs.Application as a context-param instead
      22:12:01,036 INFO  [ResteasyBootstrap] Adding listed @Provider class org.jboss.bpm.report.util.FileWriter
      22:12:01,107 INFO  [providers] Added built in provider DataSourceProvider
      22:12:01,109 INFO  [providers] Added built in provider DefaultTextPlain
      22:12:01,110 INFO  [providers] Added built in provider org.jboss.resteasy.plugins.providers.StringTextStar
      22:12:01,111 INFO  [providers] Added built in provider org.jboss.resteasy.plugins.providers.InputStreamProvider
      22:12:01,112 INFO  [providers] Added built in provider org.jboss.resteasy.plugins.providers.ByteArrayProvider
      22:12:01,114 INFO  [providers] Added built in provider org.jboss.resteasy.plugins.providers.FormUrlEncodedProvider
      22:12:01,116 INFO  [providers] Added built in provider org.jboss.resteasy.plugins.providers.FormUrlEncodedProvider
      22:12:01,118 INFO  [providers] Added built in provider org.jboss.resteasy.plugins.providers.StreamingOutputProvider
      22:12:01,121 INFO  [providers] Adding built in provider org.jboss.resteasy.plugins.providers.multipart.MultipartReader
      22:12:01,131 INFO  [providers] Adding built in provider org.jboss.resteasy.plugins.providers.multipart.ListMultipartReader
      22:12:01,133 INFO  [providers] Adding built in provider org.jboss.resteasy.plugins.providers.multipart.MultipartFormDataReader
      22:12:01,135 INFO  [providers] Adding built in provider org.jboss.resteasy.plugins.providers.multipart.MapMultipartFormDataReader
      22:12:01,138 INFO  [providers] Adding built in providerorg.jboss.resteasy.plugins.providers.multipart.MultipartWriter
      22:12:01,142 INFO  [providers] Adding built in providerorg.jboss.resteasy.plugins.providers.multipart.MultipartFormDataWriter
      22:12:01,144 INFO  [providers] Adding built in providerorg.jboss.resteasy.plugins.providers.multipart.ListMultipartWriter
      22:12:01,146 INFO  [providers] Adding built in providerorg.jboss.resteasy.plugins.providers.multipart.MapMultipartFormDataWriter
      22:12:01,151 INFO  [providers] Adding built in provider org.jboss.resteasy.plugins.providers.multipart.MultipartFormAnnotationReader
      22:12:01,156 INFO  [providers] Adding built in providerorg.jboss.resteasy.plugins.providers.multipart.MultipartFormAnnotationWriter
      22:12:01,160 INFO  [providers] Adding built in provider org.jboss.resteasy.plugins.providers.IIOImageProvider
      22:12:01,167 INFO  [providers] Adding built in provider org.jboss.resteasy.plugins.providers.multipart.MimeMultipartProvider
      22:12:01,209 INFO  [ReportFacade] BIRT home: /Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default/data/birt/ReportEngine
      22:12:01,209 INFO  [ReportFacade] Output dir: /Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default/data/birt/output/
      22:12:01,209 INFO  [ReportFacade] Report dir: /Users/james/calabash/3rdparty/jboss-5.1.0.GA/server/default/data/birt/
      22:12:01,222 INFO  [BirtService] Creating BIRT service in the background
      22:12:01,225 INFO  [ResteasyBootstrap] Deploying javax.ws.rs.core.Application: class org.jboss.bpm.console.server.ConsoleServerApplication
      22:12:01,286 INFO  [ResteasyBootstrap] Adding singleton resource org.jboss.bpm.console.server.ProcessMgmtFacade from Application javax.ws.rs.core.Application
      22:12:01,320 INFO  [ResteasyBootstrap] Adding singleton resource org.jboss.bpm.console.server.EngineFacade from Application javax.ws.rs.core.Application
      22:12:01,323 INFO  [ResteasyBootstrap] Adding singleton resource org.jboss.bpm.console.server.FormProcessingFacade from Application javax.ws.rs.core.Application
      22:12:01,475 INFO  [ResteasyBootstrap] Adding singleton resource org.jboss.bpm.console.server.InfoFacade from Application javax.ws.rs.core.Application
      22:12:01,478 INFO  [ResteasyBootstrap] Adding singleton resource org.jboss.bpm.report.ReportFacade from Application javax.ws.rs.core.Application
      22:12:01,482 INFO  [ResteasyBootstrap] Adding singleton resource org.jboss.bpm.console.server.TaskListFacade from Application javax.ws.rs.core.Application
      22:12:01,484 INFO  [ResteasyBootstrap] Adding singleton resource org.jboss.bpm.console.server.UserMgmtFacade from Application javax.ws.rs.core.Application
      22:12:01,509 INFO  [ResteasyBootstrap] Adding singleton resource org.jboss.bpm.console.server.TaskMgmtFacade from Application javax.ws.rs.core.Application
      22:12:01,968 INFO  [TomcatDeployment] deploy, ctxPath=/jbpmeditor
      22:12:02,978 INFO  [EntryPoint] Initializing platform...
      22:12:02,994 INFO  [STDOUT] [INFO] Initializing Root Directory...
      22:12:02,999 INFO  [STDOUT] [INFO] Initialized Root Directory!
      22:12:03,691 INFO  [EntryPoint] Done initializing platform!
      22:12:03,695 INFO  [EncodingFilter] EncodingFilter initializing...
      22:12:03,695 INFO  [EncodingFilter] Using encoding: UTF-8
      22:12:03,846 WARN  [TomcatDeployment] Failed to setup clustering, clustering disabled. NoClassDefFoundError: org/jboss/cache/pojo/jmx/PojoCacheJmxWrapperMBean
      22:12:03,977 INFO  [TomcatDeployment] deploy, ctxPath=/jmx-console
      22:12:04,244 INFO  [Http11Protocol] Starting Coyote HTTP/1.1 on http-localhost%2F127.0.0.1-8080
      22:12:04,268 INFO  [AjpProtocol] Starting Coyote AJP/1.3 on ajp-localhost%2F127.0.0.1-8009
      22:12:04,280 INFO  [ServerImpl] JBoss (Microcontainer) [5.1.0.GA (build: SVNTag=JBoss_5_1_0_GA date=200905221053)] Started in 1m:45s:172ms
      22:12:06,741 INFO  [Ejb3DependenciesDeployer] Encountered deployment AbstractVFSDeploymentContext@687601313{vfsfile:/Users/james/calabash/calabash-trader/.metadata/.plugins/org.jboss.ide.eclipse.as.core/JBoss_5.1_Runtime_Server/deploy/com.clbsh.service.workflow.jar/}
      22:12:06,741 INFO  [Ejb3DependenciesDeployer] Encountered deployment AbstractVFSDeploymentContext@687601313{vfsfile:/Users/james/calabash/calabash-trader/.metadata/.plugins/org.jboss.ide.eclipse.as.core/JBoss_5.1_Runtime_Server/deploy/com.clbsh.service.workflow.jar/}
      22:12:06,742 INFO  [Ejb3DependenciesDeployer] Encountered deployment AbstractVFSDeploymentContext@687601313{vfsfile:/Users/james/calabash/calabash-trader/.metadata/.plugins/org.jboss.ide.eclipse.as.core/JBoss_5.1_Runtime_Server/deploy/com.clbsh.service.workflow.jar/}
      22:12:06,742 INFO  [Ejb3DependenciesDeployer] Encountered deployment AbstractVFSDeploymentContext@687601313{vfsfile:/Users/james/calabash/calabash-trader/.metadata/.plugins/org.jboss.ide.eclipse.as.core/JBoss_5.1_Runtime_Server/deploy/com.clbsh.service.workflow.jar/}
      22:12:06,998 INFO  [JBossASKernel] Created KernelDeployment for: com.clbsh.service.workflow.jar
      22:12:07,005 INFO  [JBossASKernel] installing bean: jboss.j2ee:jar=com.clbsh.service.workflow.jar,name=WorkflowMDB,service=EJB3
      22:12:07,005 INFO  [JBossASKernel]   with dependencies:
      22:12:07,005 INFO  [JBossASKernel]   and demands:
      22:12:07,005 INFO  [JBossASKernel]     jboss.ejb:service=EJBTimerService
      22:12:07,005 INFO  [JBossASKernel]   and supplies:
      22:12:07,005 INFO  [JBossASKernel]     jndi:null
      22:12:07,005 INFO  [JBossASKernel]     Class:javax.jms.MessageListener
      22:12:07,005 INFO  [JBossASKernel] Added bean(jboss.j2ee:jar=com.clbsh.service.workflow.jar,name=WorkflowMDB,service=EJB3) to KernelDeployment of: com.clbsh.service.workflow.jar
      22:12:07,008 INFO  [JBossASKernel] installing bean: jboss.j2ee:jar=com.clbsh.service.workflow.jar,name=WorkflowServiceMBean,service=EJB3
      22:12:07,008 INFO  [JBossASKernel]   with dependencies:
      22:12:07,008 INFO  [JBossASKernel]   and demands:
      22:12:07,008 INFO  [JBossASKernel]     jboss.ejb:service=EJBTimerService
      22:12:07,008 INFO  [JBossASKernel]   and supplies:
      22:12:07,009 INFO  [JBossASKernel]     jndi:WorkflowServiceMBean/remote
      22:12:07,009 INFO  [JBossASKernel]     Class:com.clbsh.service.workflow.WorkflowService
      22:12:07,009 INFO  [JBossASKernel] Added bean(jboss.j2ee:jar=com.clbsh.service.workflow.jar,name=WorkflowServiceMBean,service=EJB3) to KernelDeployment of: com.clbsh.service.workflow.jar
      22:12:07,209 INFO  [EJBContainer] STARTED EJB: com.clbsh.service.workflow.WorkflowMDB ejbName: WorkflowMDB
      22:12:07,523 INFO  [JBossASKernel] installing bean: com.clbsh:service=Workflow
      22:12:07,523 INFO  [JBossASKernel]   with dependencies:
      22:12:07,524 INFO  [JBossASKernel]   and demands:
      22:12:07,524 INFO  [JBossASKernel]     jboss.ejb:service=EJBTimerService
      22:12:07,524 INFO  [JBossASKernel]     jboss.j2ee:jar=com.clbsh.service.workflow.jar,name=WorkflowServiceMBean,service=EJB3
      22:12:07,524 INFO  [JBossASKernel]   and supplies:
      22:12:07,524 INFO  [JBossASKernel]     jndi:WorkflowServiceMBean/remote
      22:12:07,524 INFO  [JBossASKernel]     Class:com.clbsh.service.workflow.WorkflowService
      22:12:07,524 INFO  [JBossASKernel] Installing bean(com.clbsh:service=Workflow) into kernel
      22:12:07,556 INFO  [EJBContainer] STARTED EJB: com.clbsh.service.workflow.WorkflowServiceMBean ejbName: WorkflowServiceMBean
      22:12:07,556 INFO  [JndiSessionRegistrarBase] Binding the following Entries in Global JNDI:

       

      22:12:11,415 INFO  [StructRefPropertyType] The value of the structure property is a string
      22:12:11,458 INFO  [StructRefPropertyType] The value of the structure property is a string
      22:12:11,809 INFO  [StructRefPropertyType] The value of the structure property is a string
      22:12:11,866 INFO  [StructRefPropertyType] The value of the structure property is a string
      22:12:12,230 INFO  [BirtService] Service created: org.eclipse.birt.report.engine.api.impl.ReportEngine@ad3a810