Attachment 889818 Details for Bug 1091458 – server log node two

server log node two

serverTwo.log (text/x-log), 245.65 KB, created by Radovan Synek on 2014-04-25 15:45:44 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Radovan Synek

Created: 2014-04-25 15:45:44 UTC

Size: 245.65 KB

patch

obsolete

>09:55:10,828 INFO  [org.jboss.modules] (main) JBoss Modules version 1.2.2.Final-redhat-1
>09:55:11,140 INFO  [org.jboss.msc] (main) JBoss MSC version 1.0.4.GA-redhat-1
>09:55:11,214 INFO  [org.jboss.as] (MSC service thread 1-7) JBAS015899: JBoss BPM Suite 6.0.2.GA (AS 7.2.1.Final-redhat-10) starting
>09:55:11,221 DEBUG [org.jboss.as.config] (MSC service thread 1-7) Configured system properties:
>	[Host Controller] = true
>	[Server:server-two] = 
>	awt.toolkit = sun.awt.X11.XToolkit
>	designerdataobjects = ${designerdataobjects:false}
>	file.encoding = UTF-8
>	file.encoding.pkg = sun.io
>	file.separator = /
>	java.awt.graphicsenv = sun.awt.X11GraphicsEnvironment
>	java.awt.printerjob = sun.print.PSPrinterJob
>	java.class.path = /mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/jboss-modules.jar
>	java.class.version = 51.0
>	java.endorsed.dirs = /qa/tools/opt/x86_64/jdk1.7.0_51/jre/lib/endorsed
>	java.ext.dirs = /qa/tools/opt/x86_64/jdk1.7.0_51/jre/lib/ext:/usr/java/packages/lib/ext
>	java.home = /qa/tools/opt/x86_64/jdk1.7.0_51/jre
>	java.io.tmpdir = /mnt/hudson_workspace/workspace/bpms-clustering-smoke/tmp
>	java.library.path = /qa/tools/opt/x86_64/jdk1.7.0_51/jre/lib/amd64/server:/qa/tools/opt/x86_64/jdk1.7.0_51/jre/lib/amd64:/qa/tools/opt/x86_64/jdk1.7.0_51/jre/../lib/amd64:/qa/tools/opt/x86_64/jdk1.6.0_45/jre/lib/amd64/server:/qa/tools/opt/x86_64/jdk1.6.0_45/jre/lib/amd64:/qa/tools/opt/x86_64/jdk1.6.0_45/jre/../lib/amd64:/usr/java/packages/lib/amd64:/usr/lib64:/lib64:/lib:/usr/lib
>	java.net.preferIPv4Stack = true
>	java.runtime.name = Java(TM) SE Runtime Environment
>	java.runtime.version = 1.7.0_51-b13
>	java.specification.name = Java Platform API Specification
>	java.specification.vendor = Oracle Corporation
>	java.specification.version = 1.7
>	java.util.logging.manager = org.jboss.logmanager.LogManager
>	java.vendor = Oracle Corporation
>	java.vendor.url = http://java.oracle.com/
>	java.vendor.url.bug = http://bugreport.sun.com/bugreport/
>	java.version = 1.7.0_51
>	java.vm.info = mixed mode
>	java.vm.name = Java HotSpot(TM) 64-Bit Server VM
>	java.vm.specification.name = Java Virtual Machine Specification
>	java.vm.specification.vendor = Oracle Corporation
>	java.vm.specification.version = 1.7
>	java.vm.vendor = Oracle Corporation
>	java.vm.version = 24.51-b03
>	javax.management.builder.initial = org.jboss.as.jmx.PluggableMBeanServerBuilder
>	javax.xml.datatype.DatatypeFactory = __redirected.__DatatypeFactory
>	javax.xml.parsers.DocumentBuilderFactory = __redirected.__DocumentBuilderFactory
>	javax.xml.parsers.SAXParserFactory = __redirected.__SAXParserFactory
>	javax.xml.stream.XMLEventFactory = __redirected.__XMLEventFactory
>	javax.xml.stream.XMLInputFactory = __redirected.__XMLInputFactory
>	javax.xml.stream.XMLOutputFactory = __redirected.__XMLOutputFactory
>	javax.xml.transform.TransformerFactory = __redirected.__TransformerFactory
>	javax.xml.validation.SchemaFactory:http://www.w3.org/2001/XMLSchema = __redirected.__SchemaFactory
>	javax.xml.xpath.XPathFactory:http://java.sun.com/jaxp/xpath/dom = __redirected.__XPathFactory
>	jboss.domain.base.dir = /mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain
>	jboss.domain.config.dir = /mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/configuration
>	jboss.home.dir = /mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1
>	jboss.host.name = brmsperf05
>	jboss.modules.dir = /mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/modules
>	jboss.node.name = master:server-two
>	jboss.qualified.host.name = brmsperf05
>	jboss.server.base.dir = /mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-two
>	jboss.server.config.dir = /mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-two/configuration
>	jboss.server.data.dir = /mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-two/data
>	jboss.server.deploy.dir = /mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-two/data/content
>	jboss.server.log.dir = /mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-two/log
>	jboss.server.name = server-two
>	jboss.server.persist.config = true
>	jboss.server.temp.dir = /mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-two/tmp
>	kie.maven.settings.custom = /mnt/hudson_workspace/workspace/bpms-clustering-smoke/resources/brms/maven/kie-maven-settings.xml
>	line.separator = 
>
>	logging.configuration = file:/mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/configuration/default-server-logging.properties
>	module.path = /mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/modules
>	org.jboss.boot.log.file = /mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-two/log/server.log
>	org.jboss.resolver.warning = true
>	org.jbpm.designer.perspective = ${org.jbpm.designer.perspective:full}
>	org.kie.example = ${org.kie.example:true}
>	org.xml.sax.driver = __redirected.__XMLReaderFactory
>	os.arch = amd64
>	os.name = Linux
>	os.version = 2.6.32-358.23.2.el6.x86_64
>	path.separator = :
>	sun.arch.data.model = 64
>	sun.boot.class.path = /qa/tools/opt/x86_64/jdk1.7.0_51/jre/lib/resources.jar:/qa/tools/opt/x86_64/jdk1.7.0_51/jre/lib/rt.jar:/qa/tools/opt/x86_64/jdk1.7.0_51/jre/lib/sunrsasign.jar:/qa/tools/opt/x86_64/jdk1.7.0_51/jre/lib/jsse.jar:/qa/tools/opt/x86_64/jdk1.7.0_51/jre/lib/jce.jar:/qa/tools/opt/x86_64/jdk1.7.0_51/jre/lib/charsets.jar:/qa/tools/opt/x86_64/jdk1.7.0_51/jre/lib/jfr.jar:/qa/tools/opt/x86_64/jdk1.7.0_51/jre/classes
>	sun.boot.library.path = /qa/tools/opt/x86_64/jdk1.7.0_51/jre/lib/amd64
>	sun.cpu.endian = little
>	sun.cpu.isalist = 
>	sun.io.unicode.encoding = UnicodeLittle
>	sun.java.command = /mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/jboss-modules.jar -mp /mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/modules -jaxpmodule javax.xml.jaxp-provider org.jboss.as.server
>	sun.java.launcher = SUN_STANDARD
>	sun.jnu.encoding = UTF-8
>	sun.management.compiler = HotSpot 64-Bit Tiered Compilers
>	sun.os.patch.level = unknown
>	user.country = US
>	user.dir = /mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1
>	user.home = /home/hudson
>	user.language = en
>	user.name = hudson
>	user.timezone = America/New_York
>09:55:11,225 DEBUG [org.jboss.as.config] (MSC service thread 1-7) VM Arguments: -D[Server:server-two] -XX:PermSize=256m -XX:MaxPermSize=1024m -Xms1503m -Xmx1503m -D[Host Controller]=true -Djava.io.tmpdir=/mnt/hudson_workspace/workspace/bpms-clustering-smoke/tmp -Dkie.maven.settings.custom=/mnt/hudson_workspace/workspace/bpms-clustering-smoke/resources/brms/maven/kie-maven-settings.xml -Ddesignerdataobjects=${designerdataobjects:false} -Dorg.kie.example=${org.kie.example:true} -Djboss.home.dir=/mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1 -Djava.net.preferIPv4Stack=true -Dorg.jbpm.designer.perspective=${org.jbpm.designer.perspective:full} -Djboss.server.log.dir=/mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-two/log -Djboss.server.temp.dir=/mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-two/tmp -Djboss.server.data.dir=/mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-two/data -Dorg.jboss.boot.log.file=/mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-two/log/server.log -Dlogging.configuration=file:/mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/configuration/default-server-logging.properties 
>09:55:11,311 INFO  [org.xnio] (MSC service thread 1-7) XNIO Version 3.0.7.GA-redhat-1
>09:55:11,316 INFO  [org.xnio.nio] (MSC service thread 1-7) XNIO NIO Implementation Version 3.0.7.GA-redhat-1
>09:55:11,324 INFO  [org.jboss.remoting] (MSC service thread 1-7) JBoss Remoting version 3.2.16.GA-redhat-1
>09:55:12,426 INFO  [org.jboss.as.security] (ServerService Thread Pool -- 37) JBAS013171: Activating Security Subsystem
>09:55:12,427 INFO  [org.jboss.as.webservices] (ServerService Thread Pool -- 33) JBAS015537: Activating WebServices Extension
>09:55:12,430 INFO  [org.jboss.as.security] (MSC service thread 1-16) JBAS013170: Current PicketBox version=4.0.17.SP2-redhat-2
>09:55:12,431 INFO  [org.jboss.as.naming] (ServerService Thread Pool -- 42) JBAS011800: Activating Naming Subsystem
>09:55:12,443 INFO  [org.jboss.as.configadmin] (ServerService Thread Pool -- 60) JBAS016200: Activating ConfigAdmin Subsystem
>09:55:12,447 INFO  [org.jboss.as.clustering.jgroups] (ServerService Thread Pool -- 50) JBAS010260: Activating JGroups subsystem.
>09:55:12,449 INFO  [org.jboss.as.jsf] (ServerService Thread Pool -- 47) JBAS012605: Activated the following JSF Implementations: [main, 1.2]
>09:55:12,457 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 56) JBAS010280: Activating Infinispan subsystem.
>09:55:12,459 INFO  [org.jboss.as.jacorb] (ServerService Thread Pool -- 55) JBAS016300: Activating JacORB Subsystem
>09:55:12,465 INFO  [org.jboss.as.connector.subsystems.datasources] (ServerService Thread Pool -- 59) JBAS010403: Deploying JDBC-compliant driver class org.h2.Driver (version 1.3)
>09:55:12,477 INFO  [org.jboss.as.connector.logging] (MSC service thread 1-5) JBAS010408: Starting JCA Subsystem (IronJacamar 1.0.19.Final-redhat-2)
>09:55:12,489 INFO  [org.jboss.as.naming] (MSC service thread 1-12) JBAS011802: Starting Naming Service
>09:55:12,491 INFO  [org.jboss.as.mail.extension] (MSC service thread 1-14) JBAS015400: Bound mail session [java:jboss/mail/Default]
>09:55:12,492 INFO  [org.jboss.as.mail.extension] (MSC service thread 1-9) JBAS015400: Bound mail session [java:/mail/jbpmMailSession]
>09:55:12,506 INFO  [org.jboss.as.connector.subsystems.datasources] (ServerService Thread Pool -- 59) JBAS010404: Deploying non-JDBC-compliant driver class org.postgresql.Driver (version 9.2)
>09:55:12,515 INFO  [org.jboss.jaxr] (MSC service thread 1-13) JBAS014000: Started JAXR subsystem, binding JAXR connection factory into JNDI as: java:jboss/jaxr/ConnectionFactory
>09:55:12,586 INFO  [org.jboss.ws.common.management] (MSC service thread 1-7) JBWS022052: Starting JBoss Web Services - Stack CXF Server 4.1.4.Final-redhat-7
>09:55:12,657 INFO  [org.apache.coyote.ajp] (MSC service thread 1-2) JBWEB003046: Starting Coyote AJP/1.3 on ajp-localhost/127.0.0.1:8209
>09:55:12,658 INFO  [org.apache.coyote.http11] (MSC service thread 1-9) JBWEB003001: Coyote HTTP/1.1 initializing on : http-localhost/127.0.0.1:8280
>09:55:12,660 INFO  [org.apache.coyote.http11] (MSC service thread 1-9) JBWEB003000: Coyote HTTP/1.1 starting on: http-localhost/127.0.0.1:8280
>09:55:12,725 INFO  [org.jboss.modcluster] (ServerService Thread Pool -- 62) MODCLUSTER000001: Initializing mod_cluster ${project.version}
>09:55:12,739 INFO  [org.jboss.modcluster] (ServerService Thread Pool -- 62) MODCLUSTER000032: Listening to proxy advertisements on /224.0.1.105:23364
>09:55:12,748 INFO  [org.hornetq.core.server] (MSC service thread 1-15) HQ221000: live server is starting with configuration HornetQ Configuration (clustered=true,backup=false,sharedStore=true,journalDirectory=/mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-two/data/messagingjournal,bindingsDirectory=/mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-two/data/messagingbindings,largeMessagesDirectory=/mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-two/data/messaginglargemessages,pagingDirectory=/mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-two/data/messagingpaging)
>09:55:12,750 INFO  [org.hornetq.core.server] (MSC service thread 1-15) HQ221006: Waiting to obtain live lock
>09:55:12,765 INFO  [org.infinispan.configuration.cache.EvictionConfigurationBuilder] (ServerService Thread Pool -- 56) ISPN000152: Passivation configured without an eviction policy being selected. Only manually evicted entities will be passivated.
>09:55:12,771 INFO  [org.infinispan.configuration.cache.EvictionConfigurationBuilder] (ServerService Thread Pool -- 56) ISPN000152: Passivation configured without an eviction policy being selected. Only manually evicted entities will be passivated.
>09:55:12,781 INFO  [org.hornetq.core.server] (MSC service thread 1-15) HQ221013: Using NIO Journal
>09:55:12,792 INFO  [org.jboss.as.jacorb] (MSC service thread 1-3) JBAS016330: CORBA ORB Service started
>09:55:12,863 INFO  [org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-2) JBAS010400: Bound data source [java:jboss/datasources/ExampleDS]
>09:55:12,863 INFO  [org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-1) JBAS010400: Bound data source [java:jboss/datasources/brms-jdbc-ds]
>09:55:12,864 INFO  [org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-2) JBAS010400: Bound data source [java:jboss/datasources/brms-jdbc-dsQuartz]
>09:55:12,872 INFO  [org.jboss.as.jacorb] (MSC service thread 1-10) JBAS016328: CORBA Naming Service started
>09:55:12,886 INFO  [org.hornetq.core.server] (MSC service thread 1-15) HQ221034: Waiting to obtain live lock
>09:55:12,887 INFO  [org.hornetq.core.server] (MSC service thread 1-15) HQ221035: Live Server Obtained live lock
>09:55:13,004 INFO  [org.jboss.as.remoting] (MSC service thread 1-4) JBAS017100: Listening on 127.0.0.1:4647
>09:55:13,575 INFO  [org.hornetq.core.server] (MSC service thread 1-15) HQ221020: Started Netty Acceptor version 3.6.6.Final-redhat-1-fd3c6b7 127.0.0.1:5655 for CORE protocol
>09:55:13,576 INFO  [org.hornetq.core.server] (MSC service thread 1-15) HQ221020: Started Netty Acceptor version 3.6.6.Final-redhat-1-fd3c6b7 127.0.0.1:5645 for CORE protocol
>09:55:13,584 INFO  [org.hornetq.core.server] (MSC service thread 1-15) HQ221007: Server is now live
>09:55:13,584 INFO  [org.hornetq.core.server] (MSC service thread 1-15) HQ221001: HornetQ Server version 2.3.5.Final-redhat-2 (Monster Bee, 123) [38d04edd-cc81-11e3-bde4-69d5bf946063] 
>09:55:13,598 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 62) JBAS011601: Bound messaging object to jndi name java:/ConnectionFactory
>09:55:13,599 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 63) JBAS011601: Bound messaging object to jndi name java:jboss/exported/jms/RemoteConnectionFactory
>09:55:13,660 INFO  [org.jboss.as.connector.deployment] (MSC service thread 1-4) JBAS010406: Registered connection factory java:/JmsXA
>09:55:13,683 INFO  [org.hornetq.ra] (MSC service thread 1-4) HornetQ resource adaptor started
>09:55:13,684 INFO  [org.jboss.as.connector.services.resourceadapters.ResourceAdapterActivatorService$ResourceAdapterActivator] (MSC service thread 1-4) IJ020002: Deployed: file://RaActivatorhornetq-ra
>09:55:13,686 INFO  [org.jboss.as.connector.deployment] (MSC service thread 1-3) JBAS010401: Bound JCA ConnectionFactory [java:/JmsXA]
>09:55:13,728 INFO  [org.hornetq.core.server] (Thread-5 (HornetQ-server-HornetQServerImpl::serverUUID=38d04edd-cc81-11e3-bde4-69d5bf946063-285193534)) HQ221027: Bridge ClusterConnectionBridge@3b377670 [name=sf.my-cluster.37d218fc-cc81-11e3-ac85-ebcda1137edb, queue=QueueImpl[name=sf.my-cluster.37d218fc-cc81-11e3-ac85-ebcda1137edb, postOffice=PostOfficeImpl [server=HornetQServerImpl::serverUUID=38d04edd-cc81-11e3-bde4-69d5bf946063]]@1a7600bb targetConnector=ServerLocatorImpl (identity=(Cluster-connection-bridge::ClusterConnectionBridge@3b377670 [name=sf.my-cluster.37d218fc-cc81-11e3-ac85-ebcda1137edb, queue=QueueImpl[name=sf.my-cluster.37d218fc-cc81-11e3-ac85-ebcda1137edb, postOffice=PostOfficeImpl [server=HornetQServerImpl::serverUUID=38d04edd-cc81-11e3-bde4-69d5bf946063]]@1a7600bb targetConnector=ServerLocatorImpl [initialConnectors=[TransportConfiguration(name=netty, factory=org-hornetq-core-remoting-impl-netty-NettyConnectorFactory) ?port=5445&host=localhost], discoveryGroupConfiguration=null]]::ClusterConnectionImpl@202935750[nodeUUID=38d04edd-cc81-11e3-bde4-69d5bf946063, connector=TransportConfiguration(name=netty, factory=org-hornetq-core-remoting-impl-netty-NettyConnectorFactory) ?port=5645&host=localhost, address=jms, server=HornetQServerImpl::serverUUID=38d04edd-cc81-11e3-bde4-69d5bf946063])) [initialConnectors=[TransportConfiguration(name=netty, factory=org-hornetq-core-remoting-impl-netty-NettyConnectorFactory) ?port=5445&host=localhost], discoveryGroupConfiguration=null]] is connected
>09:55:13,734 INFO  [org.jboss.as] (Controller Boot Thread) JBAS015874: JBoss BPM Suite 6.0.2.GA (AS 7.2.1.Final-redhat-10) started in 3407ms - Started 158 of 279 services (118 services are passive or on-demand)
>09:56:01,047 INFO  [org.jboss.as.server.deployment] (MSC service thread 1-16) JBAS015876: Starting deployment of "business-central.war" (runtime-name: "business-central.war")
>09:56:05,848 WARN  [org.jboss.as.server.deployment] (MSC service thread 1-16) JBAS015960: Class Path entry xalan-2.7.1-redhat-3.jar in /content/business-central.war/WEB-INF/lib/jbpmmigration-0.13-redhat-2.jar  does not point to a valid jar for a Class-Path reference.
>09:56:05,848 WARN  [org.jboss.as.server.deployment] (MSC service thread 1-16) JBAS015960: Class Path entry serializer-2.7.1-redhat-3.jar in /content/business-central.war/WEB-INF/lib/jbpmmigration-0.13-redhat-2.jar  does not point to a valid jar for a Class-Path reference.
>09:56:05,848 WARN  [org.jboss.as.server.deployment] (MSC service thread 1-16) JBAS015960: Class Path entry xercesImpl-2.9.1-redhat-4.jar in /content/business-central.war/WEB-INF/lib/jbpmmigration-0.13-redhat-2.jar  does not point to a valid jar for a Class-Path reference.
>09:56:05,849 WARN  [org.jboss.as.server.deployment] (MSC service thread 1-16) JBAS015960: Class Path entry xml-apis-1.3.04.jar in /content/business-central.war/WEB-INF/lib/jbpmmigration-0.13-redhat-2.jar  does not point to a valid jar for a Class-Path reference.
>09:56:05,849 WARN  [org.jboss.as.server.deployment] (MSC service thread 1-16) JBAS015960: Class Path entry commons-lang-2.6-redhat-2.jar in /content/business-central.war/WEB-INF/lib/jbpmmigration-0.13-redhat-2.jar  does not point to a valid jar for a Class-Path reference.
>09:56:05,849 WARN  [org.jboss.as.server.deployment] (MSC service thread 1-16) JBAS015960: Class Path entry commons-io-2.1-redhat-2.jar in /content/business-central.war/WEB-INF/lib/jbpmmigration-0.13-redhat-2.jar  does not point to a valid jar for a Class-Path reference.
>09:56:05,849 WARN  [org.jboss.as.server.deployment] (MSC service thread 1-16) JBAS015960: Class Path entry log4j-1.2.16-redhat-2.jar in /content/business-central.war/WEB-INF/lib/jbpmmigration-0.13-redhat-2.jar  does not point to a valid jar for a Class-Path reference.
>09:56:06,260 INFO  [org.jboss.as.jpa] (MSC service thread 1-2) JBAS011401: Read persistence.xml for org.jbpm.domain
>09:56:06,738 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("com.google.guava:main") which may be changed or removed in future versions without notice.
>09:56:06,738 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("com.google.guava:main") which may be changed or removed in future versions without notice.
>09:56:06,739 WARN  [org.jboss.as.dependency.unsupported] (MSC service thread 1-13) JBAS018568: Deployment "deployment.business-central.war" is using an unsupported module ("com.h2database.h2:main") which may be changed or removed in future versions without notice.
>09:56:06,739 WARN  [org.jboss.as.dependency.unsupported] (MSC service thread 1-13) JBAS018568: Deployment "deployment.business-central.war" is using an unsupported module ("com.h2database.h2:main") which may be changed or removed in future versions without notice.
>09:56:06,743 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("com.sun.xml.bind:main") which may be changed or removed in future versions without notice.
>09:56:06,743 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("com.sun.xml.bind:main") which may be changed or removed in future versions without notice.
>09:56:06,745 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.antlr:main") which may be changed or removed in future versions without notice.
>09:56:06,745 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.antlr:main") which may be changed or removed in future versions without notice.
>09:56:06,748 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.apache.commons.cli:main") which may be changed or removed in future versions without notice.
>09:56:06,749 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.apache.commons.cli:main") which may be changed or removed in future versions without notice.
>09:56:06,749 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.apache.commons.codec:main") which may be changed or removed in future versions without notice.
>09:56:06,749 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.apache.commons.codec:main") which may be changed or removed in future versions without notice.
>09:56:06,749 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.apache.commons.collections:main") which may be changed or removed in future versions without notice.
>09:56:06,749 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.apache.commons.collections:main") which may be changed or removed in future versions without notice.
>09:56:06,752 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.apache.commons.io:main") which may be changed or removed in future versions without notice.
>09:56:06,752 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.apache.commons.io:main") which may be changed or removed in future versions without notice.
>09:56:06,753 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.apache.commons.lang:main") which may be changed or removed in future versions without notice.
>09:56:06,753 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.apache.commons.lang:main") which may be changed or removed in future versions without notice.
>09:56:06,764 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.apache.cxf.impl:main") which may be changed or removed in future versions without notice.
>09:56:06,765 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.apache.cxf.impl:main") which may be changed or removed in future versions without notice.
>09:56:06,767 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.apache.httpcomponents:main") which may be changed or removed in future versions without notice.
>09:56:06,767 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.apache.httpcomponents:main") which may be changed or removed in future versions without notice.
>09:56:06,768 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.apache.james.mime4j:main") which may be changed or removed in future versions without notice.
>09:56:06,768 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.apache.james.mime4j:main") which may be changed or removed in future versions without notice.
>09:56:06,771 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.apache.neethi:main") which may be changed or removed in future versions without notice.
>09:56:06,771 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.apache.neethi:main") which may be changed or removed in future versions without notice.
>09:56:06,772 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.apache.velocity:main") which may be changed or removed in future versions without notice.
>09:56:06,772 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.apache.velocity:main") which may be changed or removed in future versions without notice.
>09:56:06,772 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.apache.xml-resolver:main") which may be changed or removed in future versions without notice.
>09:56:06,773 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.apache.xml-resolver:main") which may be changed or removed in future versions without notice.
>09:56:06,774 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.codehaus.jackson.jackson-core-asl:main") which may be changed or removed in future versions without notice.
>09:56:06,774 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.codehaus.jackson.jackson-core-asl:main") which may be changed or removed in future versions without notice.
>09:56:06,774 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.codehaus.jackson.jackson-jaxrs:main") which may be changed or removed in future versions without notice.
>09:56:06,774 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.codehaus.jackson.jackson-jaxrs:main") which may be changed or removed in future versions without notice.
>09:56:06,775 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.codehaus.jackson.jackson-mapper-asl:main") which may be changed or removed in future versions without notice.
>09:56:06,775 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.codehaus.jackson.jackson-mapper-asl:main") which may be changed or removed in future versions without notice.
>09:56:06,776 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.codehaus.jackson.jackson-xc:main") which may be changed or removed in future versions without notice.
>09:56:06,776 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.codehaus.jackson.jackson-xc:main") which may be changed or removed in future versions without notice.
>09:56:06,776 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.codehaus.jettison:main") which may be changed or removed in future versions without notice.
>09:56:06,776 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.codehaus.jettison:main") which may be changed or removed in future versions without notice.
>09:56:06,776 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.codehaus.woodstox:main") which may be changed or removed in future versions without notice.
>09:56:06,776 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.codehaus.woodstox:main") which may be changed or removed in future versions without notice.
>09:56:06,779 WARN  [org.jboss.as.dependency.unsupported] (MSC service thread 1-13) JBAS018568: Deployment "deployment.business-central.war" is using an unsupported module ("org.dom4j:main") which may be changed or removed in future versions without notice.
>09:56:06,779 WARN  [org.jboss.as.dependency.unsupported] (MSC service thread 1-13) JBAS018568: Deployment "deployment.business-central.war" is using an unsupported module ("org.dom4j:main") which may be changed or removed in future versions without notice.
>09:56:06,785 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.javassist:main") which may be changed or removed in future versions without notice.
>09:56:06,786 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.javassist:main") which may be changed or removed in future versions without notice.
>09:56:06,786 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.jboss.as.web:main") which may be changed or removed in future versions without notice.
>09:56:06,786 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.jboss.as.web:main") which may be changed or removed in future versions without notice.
>09:56:06,786 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.jboss.netty:main") which may be changed or removed in future versions without notice.
>09:56:06,786 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-13) JBAS018567: Deployment "deployment.business-central.war" is using a private module ("org.jboss.netty:main") which may be changed or removed in future versions without notice.
>09:56:06,795 WARN  [org.jboss.as.dependency.unsupported] (MSC service thread 1-13) JBAS018568: Deployment "deployment.business-central.war" is using an unsupported module ("org.jdom:main") which may be changed or removed in future versions without notice.
>09:56:06,795 WARN  [org.jboss.as.dependency.unsupported] (MSC service thread 1-13) JBAS018568: Deployment "deployment.business-central.war" is using an unsupported module ("org.jdom:main") which may be changed or removed in future versions without notice.
>09:56:06,795 WARN  [org.jboss.as.dependency.unsupported] (MSC service thread 1-13) JBAS018568: Deployment "deployment.business-central.war" is using an unsupported module ("org.jgroups:main") which may be changed or removed in future versions without notice.
>09:56:06,795 WARN  [org.jboss.as.dependency.unsupported] (MSC service thread 1-13) JBAS018568: Deployment "deployment.business-central.war" is using an unsupported module ("org.jgroups:main") which may be changed or removed in future versions without notice.
>09:56:06,796 WARN  [org.jboss.as.dependency.unsupported] (MSC service thread 1-13) JBAS018568: Deployment "deployment.business-central.war" is using an unsupported module ("org.joda.time:main") which may be changed or removed in future versions without notice.
>09:56:06,796 WARN  [org.jboss.as.dependency.unsupported] (MSC service thread 1-13) JBAS018568: Deployment "deployment.business-central.war" is using an unsupported module ("org.joda.time:main") which may be changed or removed in future versions without notice.
>09:56:06,806 WARN  [org.jboss.as.dependency.unsupported] (MSC service thread 1-13) JBAS018568: Deployment "deployment.business-central.war" is using an unsupported module ("org.yaml.snakeyaml:main") which may be changed or removed in future versions without notice.
>09:56:06,806 WARN  [org.jboss.as.dependency.unsupported] (MSC service thread 1-13) JBAS018568: Deployment "deployment.business-central.war" is using an unsupported module ("org.yaml.snakeyaml:main") which may be changed or removed in future versions without notice.
>09:56:07,019 INFO  [org.jboss.weld.deployer] (MSC service thread 1-2) JBAS016002: Processing weld deployment business-central.war
>09:56:07,168 INFO  [org.jboss.as.ejb3.deployment.processors.EjbJndiBindingsDeploymentUnitProcessor] (MSC service thread 1-2) JNDI bindings for session bean named RetryTrackerSingleton in deployment unit deployment "business-central.war" are as follows:
>
>	java:global/business-central/RetryTrackerSingleton!org.kie.services.remote.jms.RetryTrackerSingleton
>	java:app/business-central/RetryTrackerSingleton!org.kie.services.remote.jms.RetryTrackerSingleton
>	java:module/RetryTrackerSingleton!org.kie.services.remote.jms.RetryTrackerSingleton
>	java:global/business-central/RetryTrackerSingleton
>	java:app/business-central/RetryTrackerSingleton
>	java:module/RetryTrackerSingleton
>
>09:56:07,406 INFO  [org.jboss.weld.deployer] (MSC service thread 1-6) JBAS016005: Starting Services for CDI deployment: business-central.war
>09:56:07,460 INFO  [org.jboss.weld.Version] (MSC service thread 1-6) WELD-000900 1.1.13 (redhat)
>09:56:07,533 INFO  [org.jboss.weld.deployer] (MSC service thread 1-7) JBAS016008: Starting weld service for deployment business-central.war
>09:56:07,544 INFO  [org.jboss.as.jpa] (ServerService Thread Pool -- 64) JBAS011402: Starting Persistence Unit Service 'business-central.war#org.jbpm.domain'
>09:56:07,547 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 68) HQ221003: trying to deploy queue jms.queue.KIE.TASK
>09:56:07,563 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 68) JBAS011601: Bound messaging object to jndi name java:jboss/exported/jms/queue/KIE.TASK
>09:56:07,564 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 68) JBAS011601: Bound messaging object to jndi name java:/queue/KIE.TASK.ALL
>09:56:07,564 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 65) HQ221003: trying to deploy queue jms.queue.KIE.AUDIT
>09:56:07,566 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 65) JBAS011601: Bound messaging object to jndi name java:jboss/exported/jms/queue/KIE.AUDIT
>09:56:07,567 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 65) JBAS011601: Bound messaging object to jndi name java:/queue/KIE.AUDIT.ALL
>09:56:07,579 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 66) HQ221003: trying to deploy queue jms.queue.KIE.SESSION
>09:56:07,584 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 66) JBAS011601: Bound messaging object to jndi name java:jboss/exported/jms/queue/KIE.SESSION
>09:56:07,584 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 66) JBAS011601: Bound messaging object to jndi name java:/queue/KIE.SESSION.ALL
>09:56:07,584 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 67) HQ221003: trying to deploy queue jms.queue.KIE.RESPONSE
>09:56:07,586 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 67) JBAS011601: Bound messaging object to jndi name java:jboss/exported/jms/queue/KIE.RESPONSE
>09:56:07,586 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 67) JBAS011601: Bound messaging object to jndi name java:/queue/KIE.RESPONSE.ALL
>09:56:07,614 INFO  [org.jboss.as.ejb3] (MSC service thread 1-14) JBAS014142: Started message driven bean 'TaskServiceRequesMessageBean' with 'hornetq-ra' resource adapter
>09:56:07,618 INFO  [org.jboss.as.ejb3] (MSC service thread 1-16) JBAS014142: Started message driven bean 'JMSAuditProcessor' with 'hornetq-ra' resource adapter
>09:56:07,619 INFO  [org.jboss.as.ejb3] (MSC service thread 1-12) JBAS014142: Started message driven bean 'KieSessionRequesMessageBean' with 'hornetq-ra' resource adapter
>09:56:07,694 INFO  [org.hibernate.annotations.common.Version] (ServerService Thread Pool -- 64) HCANN000001: Hibernate Commons Annotations {4.0.1.Final-redhat-2}
>09:56:07,698 INFO  [org.hibernate.Version] (ServerService Thread Pool -- 64) HHH000412: Hibernate Core {4.2.0.SP1-redhat-1}
>09:56:07,699 INFO  [org.hibernate.cfg.Environment] (ServerService Thread Pool -- 64) HHH000206: hibernate.properties not found
>09:56:07,701 INFO  [org.hibernate.cfg.Environment] (ServerService Thread Pool -- 64) HHH000021: Bytecode provider name : javassist
>09:56:07,717 INFO  [org.hibernate.ejb.Ejb3Configuration] (ServerService Thread Pool -- 64) HHH000204: Processing PersistenceUnitInfo [
>	name: org.jbpm.domain
>	...]
>09:56:08,732 INFO  [org.hibernate.service.jdbc.connections.internal.ConnectionProviderInitiator] (ServerService Thread Pool -- 64) HHH000130: Instantiating explicit connection provider: org.hibernate.ejb.connection.InjectedDataSourceConnectionProvider
>09:56:09,271 INFO  [org.hibernate.dialect.Dialect] (ServerService Thread Pool -- 64) HHH000400: Using dialect: org.hibernate.dialect.PostgreSQL82Dialect
>09:56:09,280 INFO  [org.hibernate.engine.jdbc.internal.LobCreatorBuilder] (ServerService Thread Pool -- 64) HHH000424: Disabling contextual LOB creation as createClob() method threw error : java.lang.reflect.InvocationTargetException
>09:56:09,370 INFO  [org.hibernate.engine.transaction.internal.TransactionFactoryInitiator] (ServerService Thread Pool -- 64) HHH000268: Transaction strategy: org.hibernate.engine.transaction.internal.jta.CMTTransactionFactory
>09:56:09,374 INFO  [org.hibernate.hql.internal.ast.ASTQueryTranslatorFactory] (ServerService Thread Pool -- 64) HHH000397: Using ASTQueryTranslatorFactory
>09:56:09,415 INFO  [org.hibernate.validator.internal.util.Version] (ServerService Thread Pool -- 64) HV000001: Hibernate Validator 4.3.1.Final-redhat-1
>09:56:10,060 INFO  [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000228: Running hbm2ddl schema update
>09:56:10,060 INFO  [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000102: Fetching database metadata
>09:56:10,070 INFO  [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000396: Updating schema
>09:56:10,078 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Attachment
>09:56:10,082 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: BAMTaskSummary
>09:56:10,086 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: BooleanExpression
>09:56:10,089 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Content
>09:56:10,092 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: ContextMappingInfo
>09:56:10,094 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: CorrelationKeyInfo
>09:56:10,097 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: CorrelationPropertyInfo
>09:56:10,099 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Deadline
>09:56:10,102 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Delegation_delegates
>09:56:10,107 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: ErrorInfo
>09:56:10,110 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Escalation
>09:56:10,114 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: EventTypes
>09:56:10,117 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: I18NText
>09:56:10,120 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: NodeInstanceLog
>09:56:10,122 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Notification
>09:56:10,124 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Notification_BAs
>09:56:10,127 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Notification_Recipients
>09:56:10,129 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Notification_email_header
>09:56:10,132 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: OrganizationalEntity
>09:56:10,134 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: PeopleAssignments_BAs
>09:56:10,137 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: PeopleAssignments_ExclOwners
>09:56:10,139 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: PeopleAssignments_PotOwners
>09:56:10,142 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: PeopleAssignments_Recipients
>09:56:10,144 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: PeopleAssignments_Stakeholders
>09:56:10,147 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: ProcessInstanceInfo
>09:56:10,149 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: ProcessInstanceLog
>09:56:10,151 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Reassignment
>09:56:10,154 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Reassignment_potentialOwners
>09:56:10,157 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: RequestInfo
>09:56:10,159 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: SessionInfo
>09:56:10,162 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Task
>09:56:10,165 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: TaskDef
>09:56:10,168 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: TaskEvent
>09:56:10,172 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: VariableInstanceLog
>09:56:10,175 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: WorkItemInfo
>09:56:10,179 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: email_header
>09:56:10,182 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: task_comment
>09:56:10,185 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Attachment
>09:56:10,188 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: BAMTaskSummary
>09:56:10,191 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: BooleanExpression
>09:56:10,193 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Content
>09:56:10,196 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: ContextMappingInfo
>09:56:10,198 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: CorrelationKeyInfo
>09:56:10,201 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: CorrelationPropertyInfo
>09:56:10,203 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Deadline
>09:56:10,207 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Delegation_delegates
>09:56:10,210 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: ErrorInfo
>09:56:10,214 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Escalation
>09:56:10,217 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: EventTypes
>09:56:10,220 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: I18NText
>09:56:10,222 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: NodeInstanceLog
>09:56:10,224 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Notification
>09:56:10,227 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Notification_BAs
>09:56:10,229 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Notification_Recipients
>09:56:10,232 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Notification_email_header
>09:56:10,234 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: OrganizationalEntity
>09:56:10,236 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: PeopleAssignments_BAs
>09:56:10,240 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: PeopleAssignments_ExclOwners
>09:56:10,243 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: PeopleAssignments_PotOwners
>09:56:10,245 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: PeopleAssignments_Recipients
>09:56:10,247 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: PeopleAssignments_Stakeholders
>09:56:10,250 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: ProcessInstanceInfo
>09:56:10,252 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: ProcessInstanceLog
>09:56:10,254 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Reassignment
>09:56:10,257 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Reassignment_potentialOwners
>09:56:10,259 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: RequestInfo
>09:56:10,261 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: SessionInfo
>09:56:10,263 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Task
>09:56:10,266 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: TaskDef
>09:56:10,268 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: TaskEvent
>09:56:10,270 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: VariableInstanceLog
>09:56:10,272 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: WorkItemInfo
>09:56:10,275 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: email_header
>09:56:10,277 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: task_comment
>09:56:10,282 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: ATTACHMENT_ID_SEQ
>09:56:10,285 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: BAM_TASK_ID_SEQ
>09:56:10,288 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: BOOLEANEXPR_ID_SEQ
>09:56:10,291 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: COMMENT_ID_SEQ
>09:56:10,293 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: CONTENT_ID_SEQ
>09:56:10,296 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: CONTEXT_MAPPING_INFO_ID_SEQ
>09:56:10,299 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: CORRELATION_KEY_ID_SEQ
>09:56:10,302 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: CORRELATION_PROP_ID_SEQ
>09:56:10,305 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: DEADLINE_ID_SEQ
>09:56:10,307 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: EMAILNOTIFHEAD_ID_SEQ
>09:56:10,310 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: ERROR_INFO_ID_SEQ
>09:56:10,313 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: ESCALATION_ID_SEQ
>09:56:10,316 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: I18NTEXT_ID_SEQ
>09:56:10,319 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: NODE_INST_LOG_ID_SEQ
>09:56:10,321 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: NOTIFICATION_ID_SEQ
>09:56:10,324 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: PROCESS_INSTANCE_INFO_ID_SEQ
>09:56:10,327 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: PROC_INST_LOG_ID_SEQ
>09:56:10,329 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: REASSIGNMENT_ID_SEQ
>09:56:10,332 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: REQUEST_INFO_ID_SEQ
>09:56:10,335 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: SESSIONINFO_ID_SEQ
>09:56:10,337 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: TASK_DEF_ID_SEQ
>09:56:10,340 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: TASK_EVENT_ID_SEQ
>09:56:10,343 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: TASK_ID_SEQ
>09:56:10,345 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: VAR_INST_LOG_ID_SEQ
>09:56:10,348 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: WORKITEMINFO_ID_SEQ
>09:56:10,383 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table Attachment (id int8 not null, accessType int4, attachedAt timestamp, attachmentContentId int8 not null, contentType varchar(255), name varchar(255), attachment_size int4, attachedBy_id varchar(255), TaskData_Attachments_Id int8, primary key (id))
>09:56:10,384 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(attachment, 2200) already exists.
>09:56:10,439 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table BAMTaskSummary (pk int8 not null, createdDate timestamp, duration int8, endDate timestamp, processInstanceId int8 not null, startDate timestamp, status varchar(255), taskId int8 not null, taskName varchar(255), userId varchar(255), OPTLOCK int4, primary key (pk))
>09:56:10,439 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(bamtasksummary, 2200) already exists.
>09:56:10,496 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table BooleanExpression (id int8 not null, expression text, type varchar(255), Escalation_Constraints_Id int8, primary key (id))
>09:56:10,497 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(booleanexpression, 2200) already exists.
>09:56:10,540 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table Content (id int8 not null, content oid, primary key (id))
>09:56:10,540 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(content, 2200) already exists.
>09:56:10,605 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table ContextMappingInfo (mappingId int8 not null, CONTEXT_ID varchar(255) not null, KSESSION_ID int4 not null, OPTLOCK int4, primary key (mappingId))
>09:56:10,605 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(contextmappinginfo, 2200) already exists.
>09:56:10,677 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table CorrelationKeyInfo (keyId int8 not null, name varchar(255), processInstanceId int8 not null, OPTLOCK int4, primary key (keyId))
>09:56:10,677 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(correlationkeyinfo, 2200) already exists.
>09:56:10,748 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table CorrelationPropertyInfo (propertyId int8 not null, name varchar(255), value varchar(255), OPTLOCK int4, correlationKey_keyId int8, primary key (propertyId))
>09:56:10,749 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(correlationpropertyinfo, 2200) already exists.
>09:56:10,790 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table Deadline (id int8 not null, deadline_date timestamp, escalated int2, Deadlines_StartDeadLine_Id int8, Deadlines_EndDeadLine_Id int8, primary key (id))
>09:56:10,790 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(deadline, 2200) already exists.
>09:56:10,796 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table Delegation_delegates (task_id int8 not null, entity_id varchar(255) not null)
>09:56:10,796 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(delegation_delegates, 2200) already exists.
>09:56:10,850 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table ErrorInfo (id int8 not null, message varchar(255), stacktrace varchar(5000), timestamp timestamp, REQUEST_ID int8 not null, primary key (id))
>09:56:10,850 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(errorinfo, 2200) already exists.
>09:56:10,880 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table Escalation (id int8 not null, name varchar(255), Deadline_Escalation_Id int8, primary key (id))
>09:56:10,880 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(escalation, 2200) already exists.
>09:56:10,886 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table EventTypes (InstanceId int8 not null, element varchar(255))
>09:56:10,886 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(eventtypes, 2200) already exists.
>09:56:10,935 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table I18NText (id int8 not null, language varchar(255), shortText varchar(255), text text, Task_Subjects_Id int8, Task_Names_Id int8, Task_Descriptions_Id int8, Reassignment_Documentation_Id int8, Notification_Subjects_Id int8, Notification_Names_Id int8, Notification_Documentation_Id int8, Notification_Descriptions_Id int8, Deadline_Documentation_Id int8, primary key (id))
>09:56:10,935 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(i18ntext, 2200) already exists.
>09:56:10,982 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table NodeInstanceLog (id int8 not null, connection varchar(255), log_date timestamp, externalId varchar(255), nodeId varchar(255), nodeInstanceId varchar(255), nodeName varchar(255), nodeType varchar(255), processId varchar(255), processInstanceId int8 not null, type int4 not null, workItemId int8, primary key (id))
>09:56:10,982 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(nodeinstancelog, 2200) already exists.
>09:56:11,012 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table Notification (DTYPE varchar(31) not null, id int8 not null, priority int4 not null, Escalation_Notifications_Id int8, primary key (id))
>09:56:11,012 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(notification, 2200) already exists.
>09:56:11,018 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table Notification_BAs (task_id int8 not null, entity_id varchar(255) not null)
>09:56:11,019 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(notification_bas, 2200) already exists.
>09:56:11,024 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table Notification_Recipients (task_id int8 not null, entity_id varchar(255) not null)
>09:56:11,025 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(notification_recipients, 2200) already exists.
>09:56:11,049 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table Notification_email_header (Notification_id int8 not null, emailHeaders_id int8 not null, mapkey varchar(255) not null, primary key (Notification_id, mapkey))
>09:56:11,049 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(notification_email_header, 2200) already exists.
>09:56:11,073 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table OrganizationalEntity (DTYPE varchar(31) not null, id varchar(255) not null, primary key (id))
>09:56:11,073 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(organizationalentity, 2200) already exists.
>09:56:11,079 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table PeopleAssignments_BAs (task_id int8 not null, entity_id varchar(255) not null)
>09:56:11,079 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(peopleassignments_bas, 2200) already exists.
>09:56:11,091 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table PeopleAssignments_ExclOwners (task_id int8 not null, entity_id varchar(255) not null)
>09:56:11,091 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(peopleassignments_exclowners, 2200) already exists.
>09:56:11,097 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table PeopleAssignments_PotOwners (task_id int8 not null, entity_id varchar(255) not null)
>09:56:11,097 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(peopleassignments_potowners, 2200) already exists.
>09:56:11,103 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table PeopleAssignments_Recipients (task_id int8 not null, entity_id varchar(255) not null)
>09:56:11,103 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(peopleassignments_recipients, 2200) already exists.
>09:56:11,109 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table PeopleAssignments_Stakeholders (task_id int8 not null, entity_id varchar(255) not null)
>09:56:11,109 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(peopleassignments_stakeholders, 2200) already exists.
>09:56:11,139 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table ProcessInstanceInfo (InstanceId int8 not null, lastModificationDate timestamp, lastReadDate timestamp, processId varchar(255), processInstanceByteArray oid, startDate timestamp, state int4 not null, OPTLOCK int4, primary key (InstanceId))
>09:56:11,139 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(processinstanceinfo, 2200) already exists.
>09:56:11,199 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table ProcessInstanceLog (id int8 not null, duration int8, end_date timestamp, externalId varchar(255), user_identity varchar(255), outcome varchar(255), parentProcessInstanceId int8, processId varchar(255), processInstanceId int8 not null, processName varchar(255), processVersion varchar(255), start_date timestamp, status int4, primary key (id))
>09:56:11,199 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(processinstancelog, 2200) already exists.
>09:56:11,235 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table Reassignment (id int8 not null, Escalation_Reassignments_Id int8, primary key (id))
>09:56:11,235 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(reassignment, 2200) already exists.
>09:56:11,241 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table Reassignment_potentialOwners (task_id int8 not null, entity_id varchar(255) not null)
>09:56:11,241 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(reassignment_potentialowners, 2200) already exists.
>09:56:11,301 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table RequestInfo (id int8 not null, commandName varchar(255), deploymentId varchar(255), executions int4 not null, businessKey varchar(255), message varchar(255), requestData oid, responseData oid, retries int4 not null, status varchar(255), timestamp timestamp, primary key (id))
>09:56:11,301 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(requestinfo, 2200) already exists.
>09:56:11,337 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table SessionInfo (id int4 not null, lastModificationDate timestamp, rulesByteArray oid, startDate timestamp, OPTLOCK int4, primary key (id))
>09:56:11,337 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(sessioninfo, 2200) already exists.
>09:56:11,385 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table Task (id int8 not null, archived int2, allowedToDelegate varchar(255), formName varchar(255), priority int4 not null, subTaskStrategy varchar(255), activationTime timestamp, createdOn timestamp, deploymentId varchar(255), documentAccessType int4, documentContentId int8 not null, documentType varchar(255), expirationTime timestamp, faultAccessType int4, faultContentId int8 not null, faultName varchar(255), faultType varchar(255), outputAccessType int4, outputContentId int8 not null, outputType varchar(255), parentId int8 not null, previousStatus int4, processId varchar(255), processInstanceId int8 not null, processSessionId int4 not null, skipable boolean not null, status varchar(255), workItemId int8 not null, taskType varchar(255), OPTLOCK int4, taskInitiator_id varchar(255), actualOwner_id varchar(255), createdBy_id varchar(255), primary key (id))
>09:56:11,385 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(task, 2200) already exists.
>09:56:11,421 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table TaskDef (id int8 not null, name varchar(255), priority int4 not null, primary key (id))
>09:56:11,421 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(taskdef, 2200) already exists.
>09:56:11,469 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table TaskEvent (id int8 not null, logTime timestamp, taskId int8, type varchar(255), userId varchar(255), OPTLOCK int4, primary key (id))
>09:56:11,469 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(taskevent, 2200) already exists.
>09:56:11,523 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table VariableInstanceLog (id int8 not null, log_date timestamp, externalId varchar(255), oldValue varchar(255), processId varchar(255), processInstanceId int8 not null, value varchar(255), variableId varchar(255), variableInstanceId varchar(255), primary key (id))
>09:56:11,523 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(variableinstancelog, 2200) already exists.
>09:56:11,553 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table WorkItemInfo (workItemId int8 not null, creationDate timestamp, name varchar(255), processInstanceId int8 not null, state int8 not null, OPTLOCK int4, workItemByteArray oid, primary key (workItemId))
>09:56:11,553 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(workiteminfo, 2200) already exists.
>09:56:11,602 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table email_header (id int8 not null, body text, fromAddress varchar(255), language varchar(255), replyToAddress varchar(255), subject varchar(255), primary key (id))
>09:56:11,602 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(email_header, 2200) already exists.
>09:56:11,656 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create table task_comment (id int8 not null, addedAt timestamp, text text, addedBy_id varchar(255), TaskData_Comments_Id int8, primary key (id))
>09:56:11,656 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: duplicate key value violates unique constraint "pg_type_typname_nsp_index"
>  Detail: Key (typname, typnamespace)=(task_comment, 2200) already exists.
>09:56:11,661 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table Attachment add constraint FK_7ndpfa311i50bq7hy18q05va3 foreign key (attachedBy_id) references OrganizationalEntity
>09:56:11,662 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_7ndpfa311i50bq7hy18q05va3" for relation "attachment" already exists
>09:56:11,667 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table Attachment add constraint FK_hqupx569krp0f0sgu9kh87513 foreign key (TaskData_Attachments_Id) references Task
>09:56:11,668 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_hqupx569krp0f0sgu9kh87513" for relation "attachment" already exists
>09:56:11,673 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table BooleanExpression add constraint FK_394nf2qoc0k9ok6omgd6jtpso foreign key (Escalation_Constraints_Id) references Escalation
>09:56:11,674 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_394nf2qoc0k9ok6omgd6jtpso" for relation "booleanexpression" already exists
>09:56:11,680 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table CorrelationPropertyInfo add constraint FK_hrmx1m882cejwj9c04ixh50i4 foreign key (correlationKey_keyId) references CorrelationKeyInfo
>09:56:11,680 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_hrmx1m882cejwj9c04ixh50i4" for relation "correlationpropertyinfo" already exists
>09:56:11,685 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table Deadline add constraint FK_68w742sge00vco2cq3jhbvmgx foreign key (Deadlines_StartDeadLine_Id) references Task
>09:56:11,685 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_68w742sge00vco2cq3jhbvmgx" for relation "deadline" already exists
>09:56:11,692 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table Deadline add constraint FK_euoohoelbqvv94d8a8rcg8s5n foreign key (Deadlines_EndDeadLine_Id) references Task
>09:56:11,692 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_euoohoelbqvv94d8a8rcg8s5n" for relation "deadline" already exists
>09:56:11,697 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table Delegation_delegates add constraint FK_gn7ula51sk55wj1o1m57guqxb foreign key (entity_id) references OrganizationalEntity
>09:56:11,697 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_gn7ula51sk55wj1o1m57guqxb" for relation "delegation_delegates" already exists
>09:56:11,703 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table Delegation_delegates add constraint FK_fajq6kossbsqwr3opkrctxei3 foreign key (task_id) references Task
>09:56:11,704 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_fajq6kossbsqwr3opkrctxei3" for relation "delegation_delegates" already exists
>09:56:11,709 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table ErrorInfo add constraint FK_cms0met37ggfw5p5gci3otaq0 foreign key (REQUEST_ID) references RequestInfo
>09:56:11,710 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_cms0met37ggfw5p5gci3otaq0" for relation "errorinfo" already exists
>09:56:11,715 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table Escalation add constraint FK_ay2gd4fvl9yaapviyxudwuvfg foreign key (Deadline_Escalation_Id) references Deadline
>09:56:11,715 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_ay2gd4fvl9yaapviyxudwuvfg" for relation "escalation" already exists
>09:56:11,721 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table EventTypes add constraint FK_nrecj4617iwxlc65ij6m7lsl1 foreign key (InstanceId) references ProcessInstanceInfo
>09:56:11,722 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_nrecj4617iwxlc65ij6m7lsl1" for relation "eventtypes" already exists
>09:56:11,728 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table I18NText add constraint FK_k16jpgrh67ti9uedf6konsu1p foreign key (Task_Subjects_Id) references Task
>09:56:11,728 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_k16jpgrh67ti9uedf6konsu1p" for relation "i18ntext" already exists
>09:56:11,734 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table I18NText add constraint FK_fd9uk6hemv2dx1ojovo7ms3vp foreign key (Task_Names_Id) references Task
>09:56:11,734 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_fd9uk6hemv2dx1ojovo7ms3vp" for relation "i18ntext" already exists
>09:56:11,740 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table I18NText add constraint FK_4eyfp69ucrron2hr7qx4np2fp foreign key (Task_Descriptions_Id) references Task
>09:56:11,740 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_4eyfp69ucrron2hr7qx4np2fp" for relation "i18ntext" already exists
>09:56:11,746 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table I18NText add constraint FK_pqarjvvnwfjpeyb87yd7m0bfi foreign key (Reassignment_Documentation_Id) references Reassignment
>09:56:11,746 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_pqarjvvnwfjpeyb87yd7m0bfi" for relation "i18ntext" already exists
>09:56:11,752 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table I18NText add constraint FK_o84rkh69r47ti8uv4eyj7bmo2 foreign key (Notification_Subjects_Id) references Notification
>09:56:11,752 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_o84rkh69r47ti8uv4eyj7bmo2" for relation "i18ntext" already exists
>09:56:11,758 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table I18NText add constraint FK_g1trxri8w64enudw2t1qahhk5 foreign key (Notification_Names_Id) references Notification
>09:56:11,758 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_g1trxri8w64enudw2t1qahhk5" for relation "i18ntext" already exists
>09:56:11,764 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table I18NText add constraint FK_qoce92c70adem3ccb3i7lec8x foreign key (Notification_Documentation_Id) references Notification
>09:56:11,764 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_qoce92c70adem3ccb3i7lec8x" for relation "i18ntext" already exists
>09:56:11,770 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table I18NText add constraint FK_bw8vmpekejxt1ei2ge26gdsry foreign key (Notification_Descriptions_Id) references Notification
>09:56:11,770 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_bw8vmpekejxt1ei2ge26gdsry" for relation "i18ntext" already exists
>09:56:11,776 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table I18NText add constraint FK_21qvifarxsvuxeaw5sxwh473w foreign key (Deadline_Documentation_Id) references Deadline
>09:56:11,776 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_21qvifarxsvuxeaw5sxwh473w" for relation "i18ntext" already exists
>09:56:11,782 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table Notification add constraint FK_bdbeml3768go5im41cgfpyso9 foreign key (Escalation_Notifications_Id) references Escalation
>09:56:11,782 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_bdbeml3768go5im41cgfpyso9" for relation "notification" already exists
>09:56:11,788 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table Notification_BAs add constraint FK_mfbsnbrhth4rjhqc2ud338s4i foreign key (entity_id) references OrganizationalEntity
>09:56:11,788 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_mfbsnbrhth4rjhqc2ud338s4i" for relation "notification_bas" already exists
>09:56:11,794 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table Notification_BAs add constraint FK_fc0uuy76t2bvxaxqysoo8xts7 foreign key (task_id) references Notification
>09:56:11,794 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_fc0uuy76t2bvxaxqysoo8xts7" for relation "notification_bas" already exists
>09:56:11,800 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table Notification_Recipients add constraint FK_blf9jsrumtrthdaqnpwxt25eu foreign key (entity_id) references OrganizationalEntity
>09:56:11,800 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_blf9jsrumtrthdaqnpwxt25eu" for relation "notification_recipients" already exists
>09:56:11,806 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table Notification_Recipients add constraint FK_3l244pj8sh78vtn9imaymrg47 foreign key (task_id) references Notification
>09:56:11,806 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_3l244pj8sh78vtn9imaymrg47" for relation "notification_recipients" already exists
>09:56:11,848 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table Notification_email_header add constraint FK_ptaka5kost68h7l3wflv7w6y8 foreign key (emailHeaders_id) references email_header
>09:56:11,848 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_ptaka5kost68h7l3wflv7w6y8" for relation "notification_email_header" already exists
>09:56:11,866 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table Notification_email_header add constraint FK_eth4nvxn21fk1vnju85vkjrai foreign key (Notification_id) references Notification
>09:56:11,866 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_eth4nvxn21fk1vnju85vkjrai" for relation "notification_email_header" already exists
>09:56:11,872 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table PeopleAssignments_BAs add constraint FK_t38xbkrq6cppifnxequhvjsl2 foreign key (entity_id) references OrganizationalEntity
>09:56:11,872 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_t38xbkrq6cppifnxequhvjsl2" for relation "peopleassignments_bas" already exists
>09:56:11,878 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table PeopleAssignments_BAs add constraint FK_omjg5qh7uv8e9bolbaq7hv6oh foreign key (task_id) references Task
>09:56:11,878 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_omjg5qh7uv8e9bolbaq7hv6oh" for relation "peopleassignments_bas" already exists
>09:56:12,132 INFO  [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000232: Schema update complete
>09:56:13,385 INFO  [org.jboss.solder.config.xml.bootstrap.XmlConfigExtension] (MSC service thread 1-5) Solder Config XML provider starting...
>09:56:13,388 INFO  [org.jboss.solder.config.xml.bootstrap.XmlConfigExtension] (MSC service thread 1-5) Loading XmlDocumentProvider: org.jboss.solder.config.xml.bootstrap.ResourceLoaderXmlDocumentProvider
>09:56:13,401 INFO  [org.jboss.solder.config.xml.bootstrap.XmlConfigExtension] (MSC service thread 1-5) Reading XML file: jar:file:/mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/modules/system/layers/bpms/org/jbpm/main/jbpm-kie-services-6.0.3-redhat-1.jar!/META-INF/beans.xml
>09:56:13,408 INFO  [org.jboss.solder.config.xml.bootstrap.XmlConfigExtension] (MSC service thread 1-5) Reading XML file: vfs:/content/business-central.war/WEB-INF/lib/uberfire-api-0.3.3-redhat-1.jar/META-INF/beans.xml
>09:56:13,410 INFO  [org.jboss.solder.config.xml.bootstrap.XmlConfigExtension] (MSC service thread 1-5) Reading XML file: vfs:/content/business-central.war/WEB-INF/lib/drools-wb-rest-defaultapprover-6.0.3-redhat-1.jar/META-INF/beans.xml
>09:56:13,411 INFO  [org.jboss.solder.config.xml.bootstrap.XmlConfigExtension] (MSC service thread 1-5) Reading XML file: vfs:/content/business-central.war/WEB-INF/lib/uberfire-security-server-0.3.3-redhat-1.jar/META-INF/beans.xml
>09:56:13,413 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) starting errai cdi ...
>09:56:13,422 INFO  [org.jboss.solder.Version] (MSC service thread 1-5) Solder 3.2.1.Final (build id: 3.2.1.Final)
>09:56:13,573 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.kie.workbench.common.screens.explorer.backend.server.ExplorerServiceImpl
>09:56:13,699 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.drools.workbench.screens.workitems.backend.server.WorkItemsEditorServiceImpl
>09:56:13,731 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.guvnor.common.services.backend.config.ResourceConfigServiceImpl
>09:56:13,749 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.guvnor.common.services.backend.version.VersionServiceImpl
>09:56:13,782 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service class org.guvnor.common.services.backend.file.RenameServiceImpl
>09:56:13,801 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.guvnor.common.services.backend.metadata.MetadataServiceImpl
>09:56:13,810 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service class org.guvnor.common.services.backend.file.CopyServiceImpl
>09:56:13,814 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.guvnor.common.services.backend.config.AppConfigServiceImpl
>09:56:13,832 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service class org.guvnor.common.services.backend.file.DeleteServiceImpl
>09:56:13,864 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.guvnor.common.services.backend.metadata.CategoryServiceImpl
>09:56:13,978 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.drools.workbench.screens.dtablexls.backend.server.DecisionTableXLSServiceImpl
>09:56:14,261 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @SessionScoped class org.jbpm.formModeler.renderer.backend.service.FormRenderingServiceImpl
>09:56:14,265 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.jbpm.formModeler.renderer.backend.service.FormRendererIncluderServiceImpl
>09:56:14,307 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.jbpm.console.ng.es.backend.server.ExecutorServiceEntryPointImpl
>09:56:14,368 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.jbpm.console.ng.bd.backend.server.DataServiceEntryPointImpl
>09:56:14,373 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.jbpm.console.ng.bd.backend.server.KieSessionEntryPointImpl
>09:56:14,405 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.jbpm.console.ng.bd.backend.server.DeploymentManagerEntryPointImpl
>09:56:14,432 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.uberfire.backend.server.FileNavigatorServiceImpl
>09:56:14,449 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.uberfire.backend.server.WorkbenchServicesImpl
>09:56:14,476 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.uberfire.backend.server.VFSServicesServerImpl
>09:56:14,508 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.uberfire.backend.server.plugin.RuntimePluginsServiceServerImpl
>09:56:14,510 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.uberfire.backend.server.repositories.RepositoryServiceEditorImpl
>09:56:14,521 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.uberfire.backend.server.organizationalunit.OrganizationalUnitServiceImpl
>09:56:14,526 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.uberfire.backend.server.repositories.RepositoryServiceImpl
>09:56:14,593 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.drools.workbench.screens.drltext.backend.server.DRLTextEditorServiceImpl
>09:56:14,605 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.kie.workbench.common.screens.defaulteditor.backend.server.DefaultEditorServiceImpl
>09:56:14,675 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.jbpm.console.ng.ht.backend.server.FormModelerProcessStarterEntryPointImpl
>09:56:14,678 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.jbpm.console.ng.ht.backend.server.TypeRoleServiceEntryPointImpl
>09:56:14,691 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.jbpm.console.ng.ht.backend.server.TaskServiceEntryPointImpl
>09:56:14,701 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.jbpm.console.ng.ht.backend.server.FormServiceEntryPointImpl
>09:56:14,706 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.jbpm.console.ng.ht.backend.server.UserServiceEntryPointImpl
>09:56:14,725 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.kie.workbench.common.screens.projecteditor.backend.server.ProjectScreenServiceImpl
>09:56:15,132 INFO  [org.jboss.errai.common.metadata.MetaDataScanner] (Thread-96) added class scanning extensions: org.jboss.errai.common.metadata.JbossVFsTypeHandler
>09:56:16,274 INFO  [org.jboss.errai.reflections.Reflections] (Thread-96) Reflections took 1139 ms to scan 95 urls, producing 2714 keys and 16640 values [using 2 cores]
>09:56:17,101 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.guvnor.common.services.project.backend.server.ProjectServiceImpl
>09:56:17,103 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.guvnor.common.services.project.backend.server.KModuleServiceImpl
>09:56:17,111 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.guvnor.common.services.project.backend.server.POMServiceImpl
>09:56:17,131 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.drools.workbench.screens.globals.backend.server.GlobalsEditorServiceImpl
>09:56:17,568 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.guvnor.m2repo.backend.server.M2RepoServiceImpl
>09:56:17,579 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.jbpm.dashboard.renderer.service.impl.DashboardRendererServiceImpl
>09:56:17,590 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.jbpm.formModeler.panels.modeler.backend.FormModelerServiceImpl
>09:56:17,706 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.drools.workbench.screens.dsltext.backend.server.DSLTextEditorServiceImpl
>09:56:17,727 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.drools.workbench.screens.guided.dtable.backend.server.GuidedDecisionTableEditorServiceImpl
>09:56:18,051 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.jbpm.designer.server.service.DefaultDesignerAssetService
>09:56:18,363 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.drools.workbench.screens.testscenario.backend.server.ScenarioTestEditorServiceImpl
>09:56:18,887 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.drools.workbench.screens.enums.backend.server.EnumServiceImpl
>09:56:18,907 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.drools.workbench.screens.guided.rule.backend.server.GuidedRuleEditorServiceImpl
>09:56:18,922 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.drools.workbench.screens.guided.rule.backend.server.EnumDropdownServiceImpl
>09:56:18,935 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.drools.workbench.screens.scorecardxls.backend.server.ScoreCardXLSServiceImpl
>09:56:18,980 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.guvnor.common.services.builder.BuildServiceImpl
>09:56:19,092 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.kie.workbench.common.screens.datamodeller.backend.server.DataModelerServiceImpl
>09:56:19,130 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.kie.workbench.common.services.datamodel.backend.server.IncrementalDataModelServiceImpl
>09:56:19,259 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.drools.workbench.screens.guided.scorecard.backend.server.GuidedScoreCardEditorServiceImpl
>09:56:19,272 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.guvnor.inbox.backend.server.InboxServiceImpl
>09:56:19,334 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.kie.workbench.common.screens.search.backend.server.SearchServiceImpl
>09:56:19,346 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.drools.workbench.screens.guided.template.server.GuidedRuleTemplateEditorServiceImpl
>09:56:19,361 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.kie.workbench.common.services.backend.source.SourceServicesImpl
>09:56:19,368 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.kie.workbench.common.services.backend.rulename.RuleNameServiceImpl
>09:56:19,371 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.kie.workbench.common.services.backend.security.KieWorkbenchSecurityServiceImpl
>09:56:19,390 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-5) discovered errai service: public@Service @ApplicationScoped class org.kie.workbench.common.services.backend.validation.ValidationServiceImpl
>09:56:19,534 INFO  [org.drools.compiler.kie.builder.impl.ClasspathKieProject] (MSC service thread 1-5) Found kmodule: vfs:/content/business-central.war/WEB-INF/lib/drools-wb-rest-defaultapprover-6.0.3-redhat-1.jar/META-INF/kmodule.xml
>09:56:19,535 INFO  [org.drools.compiler.kie.builder.impl.ClasspathKieProject] (MSC service thread 1-5) Virtual file physical path = /mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-two/tmp/vfs/deploymenta4343e2a32a298b4/drools-wb-rest-defaultapprover-6.0.3-redhat-1.jar-2119a1c43b53e9f8/drools-wb-rest-defaultapprover-6.0.3-redhat-1.jar
>09:56:19,577 INFO  [org.drools.compiler.kie.builder.impl.KieRepositoryImpl] (MSC service thread 1-5) KieModule was added:ZipKieModule[ ReleaseId=org.drools:drools-wb-rest-defaultapprover:6.0.3-redhat-1file=/mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-two/tmp/vfs/deploymenta4343e2a32a298b4/drools-wb-rest-defaultapprover-6.0.3-redhat-1.jar-2119a1c43b53e9f8/drools-wb-rest-defaultapprover-6.0.3-redhat-1.jar]
>09:56:21,382 WARN  [org.jboss.weld.Bootstrap] (MSC service thread 1-5) WELD-001440 Scope type @javax.enterprise.context.SessionScoped() used on injection point [field] @Inject @SessionScoped private org.kie.workbench.common.screens.explorer.backend.server.ExplorerServiceImpl.identity
>09:56:21,383 WARN  [org.jboss.weld.Bootstrap] (MSC service thread 1-5) WELD-001440 Scope type @javax.enterprise.context.SessionScoped() used on injection point [field] @Inject @SessionScoped private org.kie.workbench.common.screens.explorer.backend.server.ExplorerServiceImpl.sessionInfo
>09:56:21,521 WARN  [org.jboss.weld.Bootstrap] (MSC service thread 1-5) WELD-001440 Scope type @javax.enterprise.context.RequestScoped() used on injection point [field] @Named @Inject @RequestScoped private org.jbpm.console.ng.bd.backend.server.DeploymentManagerEntryPointImpl.deploymentUnits
>09:56:21,654 WARN  [org.jboss.weld.Bootstrap] (MSC service thread 1-5) WELD-001440 Scope type @javax.enterprise.context.SessionScoped() used on injection point [field] @Inject @SessionScoped private org.uberfire.backend.server.UserServicesImpl.identity
>09:56:21,984 WARN  [org.jboss.weld.Bootstrap] (MSC service thread 1-5) WELD-001440 Scope type @javax.enterprise.context.RequestScoped() used on injection point [field] @Inject @RequestScoped private org.jbpm.designer.repository.vfs.VFSRepository.descriptor
>09:56:22,183 WARN  [org.jboss.weld.Bootstrap] (MSC service thread 1-5) WELD-001440 Scope type @javax.enterprise.context.SessionScoped() used on injection point [field] @Inject @SessionScoped private org.guvnor.inbox.backend.server.InboxServiceImpl.identity
>09:56:22,301 INFO  [org.apache.helix.controller.GenericHelixController] (MSC service thread 1-5) createDefaultRegistry
>09:56:22,314 INFO  [org.apache.helix.manager.zk.ZKHelixManager] (MSC service thread 1-5) Create a zk-based cluster manager. zkSvr: localhost:2181, clusterName: bpms-cluster, instanceName: nodeTwo_12346, type: PARTICIPANT
>09:56:22,316 INFO  [org.apache.helix.HelixManagerProperties] (MSC service thread 1-5) load helix-manager properties: {minimum_supported_version.batch_message=0.6.1, clustermanager.version=0.6.2-incubating, minimum_supported_version.participant=0.4}
>09:56:22,326 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (MSC service thread 1-5) Added msg-factory for type: TASK_REPLY, threadpool size 40
>09:56:22,362 INFO  [org.apache.sshd.common.util.SecurityUtils] (MSC service thread 1-5) BouncyCastle not registered, using the default JCE provider
>09:56:22,829 INFO  [org.guvnor.m2repo.backend.server.GuvnorM2Repository] (MSC service thread 1-5) Maven Repository root set to: repositories/kie
>09:56:23,017 INFO  [org.guvnor.common.services.backend.config.ApplicationPreferencesLoader] (MSC service thread 1-5) Setting preference 'type' to 'kjar'.
>09:56:23,017 INFO  [org.guvnor.common.services.backend.config.ApplicationPreferencesLoader] (MSC service thread 1-5) Setting preference 'drools.dateformat' to 'dd-MMM-yyyy'.
>09:56:23,017 INFO  [org.guvnor.common.services.backend.config.ApplicationPreferencesLoader] (MSC service thread 1-5) Setting preference 'drools.defaultlanguage' to 'en'.
>09:56:23,017 INFO  [org.guvnor.common.services.backend.config.ApplicationPreferencesLoader] (MSC service thread 1-5) Setting preference 'rule-modeller-onlyShowDSLStatements' to 'false'.
>09:56:23,017 INFO  [org.guvnor.common.services.backend.config.ApplicationPreferencesLoader] (MSC service thread 1-5) Setting preference 'designer.context' to 'designer'.
>09:56:23,017 INFO  [org.guvnor.common.services.backend.config.ApplicationPreferencesLoader] (MSC service thread 1-5) Setting preference 'drools.defaultcountry' to 'US'.
>09:56:23,017 INFO  [org.guvnor.common.services.backend.config.ApplicationPreferencesLoader] (MSC service thread 1-5) Setting preference 'drools.datetimeformat' to 'dd-MMM-yyyy hh:mm:ss'.
>09:56:23,017 INFO  [org.guvnor.common.services.backend.config.ApplicationPreferencesLoader] (MSC service thread 1-5) Setting preference 'build.enable-incremental' to 'true'.
>09:56:23,018 INFO  [org.guvnor.common.services.backend.config.ApplicationPreferencesLoader] (MSC service thread 1-5) Setting preference 'designer.profile' to 'jbpm'.
>09:56:23,025 INFO  [org.apache.helix.manager.zk.ZKHelixManager] (MSC service thread 1-5) ClusterManager.connect()
>09:56:23,039 INFO  [org.I0Itec.zkclient.ZkEventThread] (ZkClient-EventThread-197-localhost:2181) Starting ZkClient event thread.
>09:56:23,045 INFO  [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-5) Client environment:zookeeper.version=3.3.3-1203054, built on 11/17/2011 05:47 GMT
>09:56:23,045 INFO  [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-5) Client environment:host.name=brmsperf05.mw.lab.eng.bos.redhat.com
>09:56:23,045 INFO  [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-5) Client environment:java.version=1.7.0_51
>09:56:23,045 INFO  [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-5) Client environment:java.vendor=Oracle Corporation
>09:56:23,046 INFO  [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-5) Client environment:java.home=/qa/tools/opt/x86_64/jdk1.7.0_51/jre
>09:56:23,046 INFO  [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-5) Client environment:java.class.path=/mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/jboss-modules.jar
>09:56:23,046 INFO  [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-5) Client environment:java.library.path=/qa/tools/opt/x86_64/jdk1.7.0_51/jre/lib/amd64/server:/qa/tools/opt/x86_64/jdk1.7.0_51/jre/lib/amd64:/qa/tools/opt/x86_64/jdk1.7.0_51/jre/../lib/amd64:/qa/tools/opt/x86_64/jdk1.6.0_45/jre/lib/amd64/server:/qa/tools/opt/x86_64/jdk1.6.0_45/jre/lib/amd64:/qa/tools/opt/x86_64/jdk1.6.0_45/jre/../lib/amd64:/usr/java/packages/lib/amd64:/usr/lib64:/lib64:/lib:/usr/lib
>09:56:23,046 INFO  [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-5) Client environment:java.io.tmpdir=/mnt/hudson_workspace/workspace/bpms-clustering-smoke/tmp
>09:56:23,046 INFO  [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-5) Client environment:java.compiler=<NA>
>09:56:23,046 INFO  [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-5) Client environment:os.name=Linux
>09:56:23,046 INFO  [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-5) Client environment:os.arch=amd64
>09:56:23,046 INFO  [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-5) Client environment:os.version=2.6.32-358.23.2.el6.x86_64
>09:56:23,046 INFO  [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-5) Client environment:user.name=hudson
>09:56:23,046 INFO  [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-5) Client environment:user.home=/home/hudson
>09:56:23,046 INFO  [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-5) Client environment:user.dir=/mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1
>09:56:23,047 INFO  [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-5) Initiating client connection, connectString=localhost:2181 sessionTimeout=30000 watcher=org.apache.helix.manager.zk.ZkClient@77b60df1
>09:56:23,060 INFO  [org.apache.zookeeper.ClientCnxn] (MSC service thread 1-5-SendThread()) Opening socket connection to server localhost/127.0.0.1:2181
>09:56:23,063 INFO  [org.apache.zookeeper.ClientCnxn] (MSC service thread 1-5-SendThread(localhost:2181)) Socket connection established to localhost/127.0.0.1:2181, initiating session
>09:56:23,076 INFO  [org.apache.zookeeper.ClientCnxn] (MSC service thread 1-5-SendThread(localhost:2181)) Session establishment complete on server localhost/127.0.0.1:2181, sessionid = 0x145992ad1fb0007, negotiated timeout = 30000
>09:56:23,078 INFO  [org.I0Itec.zkclient.ZkClient] (MSC service thread 1-5-EventThread) zookeeper state changed (SyncConnected)
>09:56:23,087 INFO  [org.apache.helix.manager.zk.ZKHelixManager] (MSC service thread 1-5) KeeperState: SyncConnected, zookeeper:State:CONNECTED Timeout:30000 sessionid:0x145992ad1fb0007 local:/127.0.0.1:34259 remoteserver:localhost/127.0.0.1:2181 lastZxid:0 xid:1 sent:1 recv:1 queuedpkts:0 pendingresp:0 queuedevents:0
>09:56:23,088 INFO  [org.apache.helix.manager.zk.ZKHelixManager] (MSC service thread 1-5) Handling new session, session id: 145992ad1fb0007, instance: nodeTwo_12346, instanceTye: PARTICIPANT, cluster: bpms-cluster, zkconnection: State:CONNECTED Timeout:30000 sessionid:0x145992ad1fb0007 local:/127.0.0.1:34259 remoteserver:localhost/127.0.0.1:2181 lastZxid:0 xid:1 sent:1 recv:1 queuedpkts:0 pendingresp:0 queuedevents:0
>09:56:23,088 WARN  [org.apache.helix.healthcheck.ParticipantHealthReportTask] (MSC service thread 1-5) ParticipantHealthReportTimerTask already stopped
>09:56:23,145 INFO  [org.apache.helix.manager.zk.ParticipantManagerHelper] (MSC service thread 1-5) instance: nodeTwo_12346 auto-joining bpms-cluster is false
>09:56:23,183 INFO  [org.apache.helix.messaging.DefaultMessagingService] (MSC service thread 1-5) registering msg factory for type STATE_TRANSITION
>09:56:23,199 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (MSC service thread 1-5) Added msg-factory for type: STATE_TRANSITION, threadpool size 40
>09:56:23,226 INFO  [org.apache.helix.manager.zk.CallbackHandler] (MSC service thread 1-5) 15 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:56:23,226 INFO  [org.apache.helix.manager.zk.CallbackHandler] (MSC service thread 1-5) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:56:23,233 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (MSC service thread 1-5) Dropping NO-OP message. mid: 73ae071d-dbc0-4958-bc58-d3f14d6c9ea7, from: nodeTwo_12346
>09:56:23,242 WARN  [org.apache.helix.participant.HelixStateMachineEngine] (MSC service thread 1-5) Fail to create msg-handler because cannot find stateModelFactory for model: LeaderStandby using factoryName: DEFAULT for resource: vfs-repo
>09:56:23,242 INFO  [org.apache.helix.manager.zk.CallbackHandler] (MSC service thread 1-5) 15 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 16ms
>09:56:23,242 INFO  [org.apache.helix.manager.zk.ZKHelixManager] (MSC service thread 1-5) Added listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4 for type: MESSAGES to path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES
>09:56:23,243 INFO  [org.apache.helix.manager.zk.CallbackHandler] (MSC service thread 1-5) 15 START:INVOKE /bpms-cluster/CONTROLLER listener:org.apache.helix.manager.zk.ZKHelixDataAccessor
>09:56:23,243 INFO  [org.apache.helix.manager.zk.CallbackHandler] (MSC service thread 1-5) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/CONTROLLER, listener: org.apache.helix.manager.zk.ZKHelixDataAccessor@78907798
>09:56:23,244 INFO  [org.apache.helix.manager.zk.ZKHelixDataAccessor] (MSC service thread 1-5) Controller has changed
>09:56:23,249 INFO  [org.apache.helix.manager.zk.ZKHelixDataAccessor] (MSC service thread 1-5) _zkPropertyTransferSvcUrl : null Controller brmsperf05.mw.lab.eng.bos.redhat.com-CONTROLLER
>09:56:23,249 INFO  [org.apache.helix.manager.zk.CallbackHandler] (MSC service thread 1-5) 15 END:INVOKE /bpms-cluster/CONTROLLER listener:org.apache.helix.manager.zk.ZKHelixDataAccessor Took: 6ms
>09:56:23,249 INFO  [org.apache.helix.manager.zk.ZKHelixManager] (MSC service thread 1-5) Added listener: org.apache.helix.manager.zk.ZKHelixDataAccessor@78907798 for type: CONTROLLER to path: /bpms-cluster/CONTROLLER
>09:56:23,250 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:56:23,250 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:56:23,252 INFO  [org.apache.helix.participant.HelixStateMachineEngine] (MSC service thread 1-5) Register state model factory for state model SchedulerTaskQueue using factory name DEFAULT with org.apache.helix.participant.statemachine.ScheduledTaskStateModelFactory@5d6acb1d
>09:56:23,265 INFO  [org.apache.helix.participant.HelixStateMachineEngine] (MSC service thread 1-5) Send NO_OP message to nodeTwo_12346, msgId: d5a28a82-5425-4321-adb4-defd12793bcd
>09:56:23,265 WARN  [org.apache.helix.participant.HelixStateMachineEngine] (ZkClient-EventThread-197-localhost:2181) Fail to create msg-handler because cannot find stateModelFactory for model: LeaderStandby using factoryName: DEFAULT for resource: vfs-repo
>09:56:23,266 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 16ms
>09:56:23,271 INFO  [org.apache.helix.manager.zk.ParticipantManagerHelper] (MSC service thread 1-5) Created healthcheck info path /bpms-cluster/INSTANCES/nodeTwo_12346/HEALTHREPORT
>09:56:23,271 INFO  [org.apache.helix.healthcheck.ParticipantHealthReportTask] (MSC service thread 1-5) Start HealthCheckInfoReportingTask
>09:56:23,271 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:56:23,271 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:56:23,274 WARN  [org.apache.helix.participant.HelixStateMachineEngine] (ZkClient-EventThread-197-localhost:2181) Fail to create msg-handler because cannot find stateModelFactory for model: LeaderStandby using factoryName: DEFAULT for resource: vfs-repo
>09:56:23,274 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Dropping NO-OP message. mid: d5a28a82-5425-4321-adb4-defd12793bcd, from: nodeTwo_12346
>09:56:23,277 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 6ms
>09:56:23,277 WARN  [org.apache.helix.manager.zk.CallbackHandler] (MSC service thread 1-5) Skip processing callbacks for listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4, path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, expected types: [CALLBACK, FINALIZE] but was INIT
>09:56:23,277 INFO  [org.apache.helix.manager.zk.ZKHelixManager] (MSC service thread 1-5) init handler: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:56:23,277 WARN  [org.apache.helix.manager.zk.CallbackHandler] (MSC service thread 1-5) Skip processing callbacks for listener: org.apache.helix.manager.zk.ZKHelixDataAccessor@78907798, path: /bpms-cluster/CONTROLLER, expected types: [CALLBACK, FINALIZE] but was INIT
>09:56:23,277 INFO  [org.apache.helix.manager.zk.ZKHelixManager] (MSC service thread 1-5) init handler: /bpms-cluster/CONTROLLER, org.apache.helix.manager.zk.ZKHelixDataAccessor@78907798
>09:56:23,278 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:56:23,278 INFO  [org.apache.helix.participant.HelixStateMachineEngine] (MSC service thread 1-5) Register state model factory for state model LeaderStandby using factory name DEFAULT with org.uberfire.io.impl.cluster.helix.LockTransitionalFactory@48f63bbd
>09:56:23,278 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:56:23,289 INFO  [org.apache.helix.participant.HelixStateMachineEngine] (MSC service thread 1-5) Send NO_OP message to nodeTwo_12346, msgId: 6cf872a0-fee0-4a91-9145-1da24a788e04
>09:56:23,291 INFO  [org.apache.helix.messaging.DefaultMessagingService] (MSC service thread 1-5) registering msg factory for type USER_DEFINE_MSG
>09:56:23,297 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Dropping NO-OP message. mid: 6cf872a0-fee0-4a91-9145-1da24a788e04, from: nodeTwo_12346
>09:56:23,308 WARN  [org.apache.helix.manager.zk.ZkAsyncCallbacks] (MSC service thread 1-5-EventThread) org.apache.helix.manager.zk.ZkAsyncCallbacks$CreateCallbackHandler@13f5a8ab, rc:NONODE, path: /bpms-cluster/INSTANCES/nodeTwo_12346/CURRENTSTATES/145992ad1fb0007/vfs-repo
>09:56:23,339 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (MSC service thread 1-5) Added msg-factory for type: USER_DEFINE_MSG, threadpool size 40
>09:56:23,359 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Scheduling message: cd9ae97e-d2bd-47a6-97c7-3181ee7c8a9f
>09:56:23,361 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Message: cd9ae97e-d2bd-47a6-97c7-3181ee7c8a9f handling task scheduled
>09:56:23,361 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-1) handling task: cd9ae97e-d2bd-47a6-97c7-3181ee7c8a9f begin, at: 1398434183360
>09:56:23,361 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 83ms
>09:56:23,363 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:56:23,363 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:56:23,370 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Dropping NO-OP message. mid: bd45eae4-ae99-4851-bd1c-0df6ef104463, from: nodeTwo_12346
>09:56:23,374 INFO  [org.jbpm.executor.impl.ExecutorImpl] (MSC service thread 1-5) Starting Executor Component ...
> 	 - Thread Pool Size: 1
> 	 - Interval: 3 Seconds
> 	 - Retries per Request: 3
>
>09:56:23,378 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 15ms
>09:56:23,388 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:56:23,388 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:56:23,389 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-1) Message cd9ae97e-d2bd-47a6-97c7-3181ee7c8a9f completed.
>09:56:23,397 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) No Messages to process
>09:56:23,400 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 12ms
>09:56:23,404 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:56:23,405 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:56:23,406 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) No Messages to process
>09:56:23,406 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 2ms
>09:56:23,408 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:56:23,408 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:56:23,409 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) No Messages to process
>09:56:23,409 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 1ms
>09:56:23,427 INFO  [org.apache.helix.monitoring.ParticipantMonitor] (pool-14-thread-1) Registering bean: Cluster=bpms-cluster,Resource=vfs-repo,Transition=OFFLINE--STANDBY
>09:56:23,429 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-1) message finished: cd9ae97e-d2bd-47a6-97c7-3181ee7c8a9f, took 66
>09:56:23,429 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-1) msg: cd9ae97e-d2bd-47a6-97c7-3181ee7c8a9f handling task completed, results:true, at: 1398434183429, took:69
>09:56:23,432 INFO  [org.kie.services.remote.jms.RetryTrackerSingleton] (ServerService Thread Pool -- 64) JMS message retry limit set to 2
>09:56:23,446 INFO  [org.jboss.web] (ServerService Thread Pool -- 64) JBAS018210: Register web context: /business-central
>09:56:23,605 INFO  [solder-servlet] (ServerService Thread Pool -- 64) Catch Integration for Servlets enabled
>09:56:23,730 INFO  [org.jboss.errai.bus.server.cluster.noop.NoopClusteringProvider] (ServerService Thread Pool -- 64) clustering support not configured.
>09:56:23,736 INFO  [org.jboss.errai.bus.server.service.bootstrap.OrderedBootstrap] (ServerService Thread Pool -- 64) starting errai bus ...
>09:56:23,738 INFO  [org.jboss.errai.bus.server.service.bootstrap.DefaultComponents] (ServerService Thread Pool -- 64) authentication adapter configured: org.jboss.errai.bus.server.security.auth.JAASAdapter
>09:56:23,743 INFO  [org.jboss.errai.bus.server.service.bootstrap.DefaultComponents] (ServerService Thread Pool -- 64) using dispatcher implementation: org.jboss.errai.bus.server.SimpleDispatcher
>09:56:23,745 INFO  [org.jboss.errai.bus.server.service.bootstrap.DefaultComponents] (ServerService Thread Pool -- 64) using session provider implementation: org.jboss.errai.bus.server.HttpSessionProvider
>09:56:23,757 INFO  [org.jboss.errai.bus.server.service.bootstrap.LoadExtensions] (ServerService Thread Pool -- 64) searching for errai extensions ...
>09:56:23,767 INFO  [org.jboss.errai.bus.server.service.bootstrap.OrderedBootstrap] (ServerService Thread Pool -- 64) errai bus started.
>09:56:24,004 INFO  [org.jboss.as.server] (host-controller-connection-threads - 1) JBAS018559: Deployed "business-central.war" (runtime-name : "business-central.war")
>09:57:48,411 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:57:48,411 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:57:48,422 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Scheduling message: ecfca41c-377a-4f60-bcfb-07b543f492d5
>09:57:48,422 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-15-thread-1) handling task: ecfca41c-377a-4f60-bcfb-07b543f492d5 begin, at: 1398434268422
>09:57:48,424 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Message starts with timeout 30000 MsgId: ecfca41c-377a-4f60-bcfb-07b543f492d5
>09:57:48,424 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Message: ecfca41c-377a-4f60-bcfb-07b543f492d5 handling task scheduled
>09:57:48,424 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 13ms
>09:57:52,810 ERROR [org.uberfire.io.impl.cluster.helix.ClusterServiceHelix] (pool-15-thread-1) Error while processing cluster message: java.lang.NullPointerException
>	at org.uberfire.io.impl.cluster.IOServiceClusterImpl$NewFileSystemMessageHandler.handleMessage(IOServiceClusterImpl.java:894) [uberfire-io-0.3.3-redhat-1.jar:0.3.3-redhat-1]
>	at org.uberfire.io.impl.cluster.helix.ClusterServiceHelix$MessageHandlerResolverWrapper$1$1.handleMessage(ClusterServiceHelix.java:294) [uberfire-io-0.3.3-redhat-1.jar:0.3.3-redhat-1]
>	at org.apache.helix.messaging.handling.HelixTask.call(HelixTask.java:93) [helix-core-0.6.2-incubating.jar:0.6.2-incubating]
>	at org.apache.helix.messaging.handling.HelixTask.call(HelixTask.java:50) [helix-core-0.6.2-incubating.jar:0.6.2-incubating]
>	at java.util.concurrent.FutureTask.run(FutureTask.java:262) [rt.jar:1.7.0_51]
>	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) [rt.jar:1.7.0_51]
>	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [rt.jar:1.7.0_51]
>	at java.lang.Thread.run(Thread.java:744) [rt.jar:1.7.0_51]
>
>09:57:52,812 ERROR [org.apache.helix.messaging.handling.HelixTask] (pool-15-thread-1) Message execution failed. msgId: ecfca41c-377a-4f60-bcfb-07b543f492d5, errorMsg: null
>09:57:52,933 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-15-thread-1) Sending reply for message 4fd157e8-6534-486a-992a-f7ba1b8be977
>09:57:52,934 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:57:52,934 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:57:52,982 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-15-thread-1) message finished: ecfca41c-377a-4f60-bcfb-07b543f492d5, took 4557
>09:57:52,982 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-15-thread-1) msg: ecfca41c-377a-4f60-bcfb-07b543f492d5 handling task completed, results:false, at: 1398434272982, took:4560
>09:57:52,982 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) No Messages to process
>09:57:52,982 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 48ms
>09:57:53,167 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:57:53,167 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:57:53,184 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Scheduling message: bf30ebde-5edd-430c-8732-2fea5dbcf0b2
>09:57:53,185 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Message: bf30ebde-5edd-430c-8732-2fea5dbcf0b2 handling task scheduled
>09:57:53,185 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 18ms
>09:57:53,185 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-2) handling task: bf30ebde-5edd-430c-8732-2fea5dbcf0b2 begin, at: 1398434273185
>09:57:53,214 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-2) Message bf30ebde-5edd-430c-8732-2fea5dbcf0b2 completed.
>09:57:53,226 INFO  [org.apache.helix.monitoring.ParticipantMonitor] (pool-14-thread-2) Registering bean: Cluster=bpms-cluster,Resource=vfs-repo,Transition=STANDBY--LEADER
>09:57:53,227 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-2) message finished: bf30ebde-5edd-430c-8732-2fea5dbcf0b2, took 41
>09:57:53,227 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-2) msg: bf30ebde-5edd-430c-8732-2fea5dbcf0b2 handling task completed, results:true, at: 1398434273227, took:42
>09:57:53,228 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:57:53,228 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:57:53,229 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) No Messages to process
>09:57:53,230 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 2ms
>09:57:53,281 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:57:53,281 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:57:53,319 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Scheduling message: 1a62d0bf-abce-42e1-8596-167b66311486
>09:57:53,319 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Message: 1a62d0bf-abce-42e1-8596-167b66311486 handling task scheduled
>09:57:53,319 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 38ms
>09:57:53,319 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-3) handling task: 1a62d0bf-abce-42e1-8596-167b66311486 begin, at: 1398434273319
>09:57:53,352 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-3) Message 1a62d0bf-abce-42e1-8596-167b66311486 completed.
>09:57:53,388 INFO  [org.apache.helix.monitoring.ParticipantMonitor] (pool-14-thread-3) Registering bean: Cluster=bpms-cluster,Resource=vfs-repo,Transition=LEADER--STANDBY
>09:57:53,388 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-3) message finished: 1a62d0bf-abce-42e1-8596-167b66311486, took 68
>09:57:53,388 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-3) msg: 1a62d0bf-abce-42e1-8596-167b66311486 handling task completed, results:true, at: 1398434273388, took:69
>09:57:53,389 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:57:53,389 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:57:53,391 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) No Messages to process
>09:57:53,391 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 2ms
>09:57:53,604 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:57:53,605 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:57:53,634 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Scheduling message: 9a1da41a-97f9-49a8-85eb-a895d433858e
>09:57:53,635 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Message: 9a1da41a-97f9-49a8-85eb-a895d433858e handling task scheduled
>09:57:53,635 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 31ms
>09:57:53,635 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-15-thread-2) handling task: 9a1da41a-97f9-49a8-85eb-a895d433858e begin, at: 1398434273635
>09:57:53,694 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:57:53,694 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:57:53,711 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Scheduling message: f96c2555-9c67-4e5d-abbb-81596bdfe3e8
>09:57:53,711 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Message: f96c2555-9c67-4e5d-abbb-81596bdfe3e8 handling task scheduled
>09:57:53,711 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 17ms
>09:57:53,711 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-15-thread-3) handling task: f96c2555-9c67-4e5d-abbb-81596bdfe3e8 begin, at: 1398434273711
>09:57:53,848 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-15-thread-2) Message 9a1da41a-97f9-49a8-85eb-a895d433858e completed.
>09:57:53,856 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-15-thread-3) Message f96c2555-9c67-4e5d-abbb-81596bdfe3e8 completed.
>09:57:53,897 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-15-thread-2) message finished: 9a1da41a-97f9-49a8-85eb-a895d433858e, took 260
>09:57:53,897 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-15-thread-2) msg: 9a1da41a-97f9-49a8-85eb-a895d433858e handling task completed, results:true, at: 1398434273897, took:262
>09:57:53,956 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-15-thread-3) message finished: f96c2555-9c67-4e5d-abbb-81596bdfe3e8, took 244
>09:57:53,957 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-15-thread-3) msg: f96c2555-9c67-4e5d-abbb-81596bdfe3e8 handling task completed, results:true, at: 1398434273957, took:246
>09:57:53,957 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:57:53,957 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:57:53,960 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) No Messages to process
>09:57:53,960 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 3ms
>09:57:54,023 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:57:54,023 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:57:54,053 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Scheduling message: c90bbb01-e5a7-4dd6-918f-75bf9008e001
>09:57:54,054 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Message: c90bbb01-e5a7-4dd6-918f-75bf9008e001 handling task scheduled
>09:57:54,054 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 31ms
>09:57:54,054 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-4) handling task: c90bbb01-e5a7-4dd6-918f-75bf9008e001 begin, at: 1398434274054
>09:57:54,082 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-4) Message c90bbb01-e5a7-4dd6-918f-75bf9008e001 completed.
>09:57:54,119 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-4) message finished: c90bbb01-e5a7-4dd6-918f-75bf9008e001, took 64
>09:57:54,119 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-4) msg: c90bbb01-e5a7-4dd6-918f-75bf9008e001 handling task completed, results:true, at: 1398434274119, took:65
>09:57:54,125 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:57:54,125 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:57:54,127 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) No Messages to process
>09:57:54,127 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 2ms
>09:57:54,155 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:57:54,155 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:57:54,228 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Scheduling message: 12921cb3-9088-4a46-8bdf-fbc167b65d58
>09:57:54,228 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Message: 12921cb3-9088-4a46-8bdf-fbc167b65d58 handling task scheduled
>09:57:54,228 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 73ms
>09:57:54,228 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-5) handling task: 12921cb3-9088-4a46-8bdf-fbc167b65d58 begin, at: 1398434274228
>09:57:54,262 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-5) Message 12921cb3-9088-4a46-8bdf-fbc167b65d58 completed.
>09:57:54,299 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-5) message finished: 12921cb3-9088-4a46-8bdf-fbc167b65d58, took 70
>09:57:54,299 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-5) msg: 12921cb3-9088-4a46-8bdf-fbc167b65d58 handling task completed, results:true, at: 1398434274299, took:71
>09:57:54,300 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:57:54,300 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:57:54,347 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) No Messages to process
>09:57:54,347 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 47ms
>09:57:54,382 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:57:54,382 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:57:54,417 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Scheduling message: eb648a10-abb8-49d5-b1d4-d772738f2268
>09:57:54,418 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Message: eb648a10-abb8-49d5-b1d4-d772738f2268 handling task scheduled
>09:57:54,418 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 36ms
>09:57:54,418 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-6) handling task: eb648a10-abb8-49d5-b1d4-d772738f2268 begin, at: 1398434274418
>09:57:54,453 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-6) Message eb648a10-abb8-49d5-b1d4-d772738f2268 completed.
>09:57:54,519 INFO  [org.apache.helix.monitoring.ParticipantMonitor] (pool-14-thread-6) Registering bean: Cluster=bpms-cluster,Resource=vfs-repo,Transition=STANDBY--OFFLINE
>09:57:54,519 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-6) message finished: eb648a10-abb8-49d5-b1d4-d772738f2268, took 100
>09:57:54,519 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-6) msg: eb648a10-abb8-49d5-b1d4-d772738f2268 handling task completed, results:true, at: 1398434274519, took:101
>09:57:54,520 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:57:54,520 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:57:54,522 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) No Messages to process
>09:57:54,522 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 2ms
>09:57:54,555 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:57:54,556 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:57:54,590 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Scheduling message: 87770e47-50b9-4b80-a090-538afa269be7
>09:57:54,591 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Message: 87770e47-50b9-4b80-a090-538afa269be7 handling task scheduled
>09:57:54,591 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 36ms
>09:57:54,591 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-7) handling task: 87770e47-50b9-4b80-a090-538afa269be7 begin, at: 1398434274591
>09:57:54,627 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-7) Message 87770e47-50b9-4b80-a090-538afa269be7 completed.
>09:57:54,646 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-7) message finished: 87770e47-50b9-4b80-a090-538afa269be7, took 54
>09:57:54,647 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:57:54,658 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-7) msg: 87770e47-50b9-4b80-a090-538afa269be7 handling task completed, results:true, at: 1398434274658, took:67
>09:57:54,658 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:57:54,686 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Scheduling message: 149e7c13-b903-40fd-aed1-c3e56a69bd7e
>09:57:54,693 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Message: 149e7c13-b903-40fd-aed1-c3e56a69bd7e handling task scheduled
>09:57:54,693 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 46ms
>09:57:54,693 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-8) handling task: 149e7c13-b903-40fd-aed1-c3e56a69bd7e begin, at: 1398434274693
>09:57:54,694 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:57:54,694 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:57:54,729 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-8) Message 149e7c13-b903-40fd-aed1-c3e56a69bd7e completed.
>09:57:54,752 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 58ms
>09:57:54,752 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-8) message finished: 149e7c13-b903-40fd-aed1-c3e56a69bd7e, took 58
>09:57:54,752 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-8) msg: 149e7c13-b903-40fd-aed1-c3e56a69bd7e handling task completed, results:true, at: 1398434274752, took:59
>09:57:54,753 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:57:54,753 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:57:54,755 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) No Messages to process
>09:57:54,755 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 2ms
>09:57:54,795 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:57:54,795 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:57:54,830 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Scheduling message: 971fb8aa-d762-40bc-a56f-342215ac3fa0
>09:57:54,830 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Message: 971fb8aa-d762-40bc-a56f-342215ac3fa0 handling task scheduled
>09:57:54,831 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 36ms
>09:57:54,831 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-9) handling task: 971fb8aa-d762-40bc-a56f-342215ac3fa0 begin, at: 1398434274830
>09:57:54,860 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-9) Message 971fb8aa-d762-40bc-a56f-342215ac3fa0 completed.
>09:57:54,896 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-9) message finished: 971fb8aa-d762-40bc-a56f-342215ac3fa0, took 64
>09:57:54,896 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-9) msg: 971fb8aa-d762-40bc-a56f-342215ac3fa0 handling task completed, results:true, at: 1398434274896, took:66
>09:57:54,897 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:57:54,897 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:57:54,898 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) No Messages to process
>09:57:54,898 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 1ms
>09:57:54,975 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:57:54,975 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:57:55,019 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Scheduling message: dfe5fb39-a983-4439-ab5b-9f9f59beda36
>09:57:55,020 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Message: dfe5fb39-a983-4439-ab5b-9f9f59beda36 handling task scheduled
>09:57:55,020 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 45ms
>09:57:55,020 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-10) handling task: dfe5fb39-a983-4439-ab5b-9f9f59beda36 begin, at: 1398434275020
>09:57:55,046 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-10) Message dfe5fb39-a983-4439-ab5b-9f9f59beda36 completed.
>09:57:55,100 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-10) message finished: dfe5fb39-a983-4439-ab5b-9f9f59beda36, took 79
>09:57:55,100 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-10) msg: dfe5fb39-a983-4439-ab5b-9f9f59beda36 handling task completed, results:true, at: 1398434275100, took:80
>09:57:55,101 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:57:55,101 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:57:55,102 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) No Messages to process
>09:57:55,102 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 1ms
>09:58:14,396 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:58:14,396 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:58:14,425 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Scheduling message: c091c26e-b3a6-42bf-9608-160434c144e6
>09:58:14,425 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Message: c091c26e-b3a6-42bf-9608-160434c144e6 handling task scheduled
>09:58:14,426 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 30ms
>09:58:14,426 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-15-thread-4) handling task: c091c26e-b3a6-42bf-9608-160434c144e6 begin, at: 1398434294426
>09:58:14,479 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:58:14,480 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:58:14,541 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-15-thread-4) Message c091c26e-b3a6-42bf-9608-160434c144e6 completed.
>09:58:14,544 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Scheduling message: f7835c38-21c7-43a1-b0c5-f7a9b2ad6f4e
>09:58:14,545 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Message: f7835c38-21c7-43a1-b0c5-f7a9b2ad6f4e handling task scheduled
>09:58:14,545 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 66ms
>09:58:14,545 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-15-thread-5) handling task: f7835c38-21c7-43a1-b0c5-f7a9b2ad6f4e begin, at: 1398434294545
>09:58:14,577 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-15-thread-5) Message f7835c38-21c7-43a1-b0c5-f7a9b2ad6f4e completed.
>09:58:14,592 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-15-thread-4) message finished: c091c26e-b3a6-42bf-9608-160434c144e6, took 166
>09:58:14,611 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:58:14,610 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-15-thread-5) message finished: f7835c38-21c7-43a1-b0c5-f7a9b2ad6f4e, took 65
>09:58:14,620 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-15-thread-4) msg: c091c26e-b3a6-42bf-9608-160434c144e6 handling task completed, results:true, at: 1398434294620, took:194
>09:58:14,620 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:58:14,620 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-15-thread-5) msg: f7835c38-21c7-43a1-b0c5-f7a9b2ad6f4e handling task completed, results:true, at: 1398434294620, took:75
>09:58:14,621 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) No Messages to process
>09:58:14,621 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 10ms
>09:58:14,820 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:58:14,820 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:58:14,850 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Scheduling message: 04813b3f-e209-4dc9-bb6d-a7ee0d3ca395
>09:58:14,851 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Message: 04813b3f-e209-4dc9-bb6d-a7ee0d3ca395 handling task scheduled
>09:58:14,851 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 31ms
>09:58:14,851 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-11) handling task: 04813b3f-e209-4dc9-bb6d-a7ee0d3ca395 begin, at: 1398434294851
>09:58:14,868 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-11) Message 04813b3f-e209-4dc9-bb6d-a7ee0d3ca395 completed.
>09:58:14,903 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-11) message finished: 04813b3f-e209-4dc9-bb6d-a7ee0d3ca395, took 51
>09:58:14,910 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-11) msg: 04813b3f-e209-4dc9-bb6d-a7ee0d3ca395 handling task completed, results:true, at: 1398434294910, took:59
>09:58:14,923 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:58:14,923 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:58:14,924 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) No Messages to process
>09:58:14,925 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 2ms
>09:58:14,946 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:58:14,947 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:58:14,983 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Scheduling message: 297434b5-2214-44eb-bbe7-f3764f0f2fca
>09:58:14,984 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Message: 297434b5-2214-44eb-bbe7-f3764f0f2fca handling task scheduled
>09:58:14,984 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 38ms
>09:58:14,984 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-12) handling task: 297434b5-2214-44eb-bbe7-f3764f0f2fca begin, at: 1398434294984
>09:58:14,999 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-12) Message 297434b5-2214-44eb-bbe7-f3764f0f2fca completed.
>09:58:15,041 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-12) message finished: 297434b5-2214-44eb-bbe7-f3764f0f2fca, took 56
>09:58:15,042 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:58:15,050 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-12) msg: 297434b5-2214-44eb-bbe7-f3764f0f2fca handling task completed, results:true, at: 1398434295050, took:66
>09:58:15,050 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:58:15,051 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) No Messages to process
>09:58:15,051 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 9ms
>09:58:15,096 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:58:15,096 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:58:15,119 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Scheduling message: 671ea73f-d03e-4f52-8be3-a018674b93a4
>09:58:15,135 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Message: 671ea73f-d03e-4f52-8be3-a018674b93a4 handling task scheduled
>09:58:15,135 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 39ms
>09:58:15,135 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-13) handling task: 671ea73f-d03e-4f52-8be3-a018674b93a4 begin, at: 1398434295135
>09:58:15,149 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-13) Message 671ea73f-d03e-4f52-8be3-a018674b93a4 completed.
>09:58:15,185 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-13) message finished: 671ea73f-d03e-4f52-8be3-a018674b93a4, took 48
>09:58:15,185 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-13) msg: 671ea73f-d03e-4f52-8be3-a018674b93a4 handling task completed, results:true, at: 1398434295185, took:50
>09:58:15,186 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:58:15,186 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:58:15,187 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) No Messages to process
>09:58:15,187 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 2ms
>09:58:15,239 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:58:15,239 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:58:15,274 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Scheduling message: 3c1330f6-4cb6-4b10-907e-08f45e09379b
>09:58:15,275 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Message: 3c1330f6-4cb6-4b10-907e-08f45e09379b handling task scheduled
>09:58:15,275 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 36ms
>09:58:15,275 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-14) handling task: 3c1330f6-4cb6-4b10-907e-08f45e09379b begin, at: 1398434295275
>09:58:15,286 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-14) Message 3c1330f6-4cb6-4b10-907e-08f45e09379b completed.
>09:58:15,310 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-14) message finished: 3c1330f6-4cb6-4b10-907e-08f45e09379b, took 34
>09:58:15,310 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-14) msg: 3c1330f6-4cb6-4b10-907e-08f45e09379b handling task completed, results:true, at: 1398434295310, took:35
>09:58:15,311 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:58:15,311 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:58:15,313 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) No Messages to process
>09:58:15,313 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 2ms
>09:58:38,490 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:58:38,490 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:58:38,518 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Scheduling message: 03a5ce20-be75-48d2-b27e-9a8733503aaa
>09:58:38,534 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Message: 03a5ce20-be75-48d2-b27e-9a8733503aaa handling task scheduled
>09:58:38,534 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 44ms
>09:58:38,534 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-15-thread-6) handling task: 03a5ce20-be75-48d2-b27e-9a8733503aaa begin, at: 1398434318534
>09:58:38,644 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-15-thread-6) Message 03a5ce20-be75-48d2-b27e-9a8733503aaa completed.
>09:58:38,680 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-15-thread-6) message finished: 03a5ce20-be75-48d2-b27e-9a8733503aaa, took 145
>09:58:38,687 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-15-thread-6) msg: 03a5ce20-be75-48d2-b27e-9a8733503aaa handling task completed, results:true, at: 1398434318687, took:153
>09:58:38,699 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:58:38,699 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:58:38,735 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Scheduling message: 50d0bf05-0aa4-425b-8e7a-3c24c339da74
>09:58:38,736 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Message: 50d0bf05-0aa4-425b-8e7a-3c24c339da74 handling task scheduled
>09:58:38,736 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 38ms
>09:58:38,736 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-15-thread-7) handling task: 50d0bf05-0aa4-425b-8e7a-3c24c339da74 begin, at: 1398434318736
>09:58:38,772 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-15-thread-7) Message 50d0bf05-0aa4-425b-8e7a-3c24c339da74 completed.
>09:58:38,818 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-15-thread-7) message finished: 50d0bf05-0aa4-425b-8e7a-3c24c339da74, took 81
>09:58:38,818 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-15-thread-7) msg: 50d0bf05-0aa4-425b-8e7a-3c24c339da74 handling task completed, results:true, at: 1398434318818, took:82
>09:58:38,819 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:58:38,819 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:58:38,836 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) No Messages to process
>09:58:38,844 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 25ms
>09:58:39,010 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:58:39,010 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:58:39,057 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Scheduling message: 7576ca9f-77f0-4805-8485-b080ff67855f
>09:58:39,058 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Message: 7576ca9f-77f0-4805-8485-b080ff67855f handling task scheduled
>09:58:39,058 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 48ms
>09:58:39,058 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-15) handling task: 7576ca9f-77f0-4805-8485-b080ff67855f begin, at: 1398434319058
>09:58:39,165 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-15) Message 7576ca9f-77f0-4805-8485-b080ff67855f completed.
>09:58:39,183 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-15) message finished: 7576ca9f-77f0-4805-8485-b080ff67855f, took 124
>09:58:39,184 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:58:39,189 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-15) msg: 7576ca9f-77f0-4805-8485-b080ff67855f handling task completed, results:true, at: 1398434319189, took:131
>09:58:39,189 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:58:39,219 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Scheduling message: e633cd37-2c9d-445b-b921-00f76988745d
>09:58:39,225 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Message: e633cd37-2c9d-445b-b921-00f76988745d handling task scheduled
>09:58:39,225 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 41ms
>09:58:39,225 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-16) handling task: e633cd37-2c9d-445b-b921-00f76988745d begin, at: 1398434319225
>09:58:39,226 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:58:39,227 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:58:39,237 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-16) Message e633cd37-2c9d-445b-b921-00f76988745d completed.
>09:58:39,237 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 11ms
>09:58:39,254 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-16) message finished: e633cd37-2c9d-445b-b921-00f76988745d, took 28
>09:58:39,255 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:58:39,261 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-16) msg: e633cd37-2c9d-445b-b921-00f76988745d handling task completed, results:true, at: 1398434319261, took:36
>09:58:39,261 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:58:39,280 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) No Messages to process
>09:58:39,286 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 31ms
>09:58:39,315 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:58:39,322 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:58:39,407 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Scheduling message: 490662d8-db57-4311-930c-14ffd9461d3a
>09:58:39,408 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Message: 490662d8-db57-4311-930c-14ffd9461d3a handling task scheduled
>09:58:39,408 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 93ms
>09:58:39,408 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-17) handling task: 490662d8-db57-4311-930c-14ffd9461d3a begin, at: 1398434319408
>09:58:39,452 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-17) Message 490662d8-db57-4311-930c-14ffd9461d3a completed.
>09:58:39,500 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-17) message finished: 490662d8-db57-4311-930c-14ffd9461d3a, took 91
>09:58:39,500 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-17) msg: 490662d8-db57-4311-930c-14ffd9461d3a handling task completed, results:true, at: 1398434319500, took:92
>09:58:39,501 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:58:39,501 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:58:39,502 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) No Messages to process
>09:58:39,502 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 1ms
>09:58:39,531 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:58:39,531 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:58:39,559 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Scheduling message: 1d3f56c7-5772-42f0-90c7-76d1710d7dcc
>09:58:39,560 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) Message: 1d3f56c7-5772-42f0-90c7-76d1710d7dcc handling task scheduled
>09:58:39,560 INFO  [stdout] (pool-12-thread-1)  wagon http use multi threaded http connection manager maxPerRoute 20, max total 40
>09:58:39,560 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 29ms
>09:58:39,560 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-18) handling task: 1d3f56c7-5772-42f0-90c7-76d1710d7dcc begin, at: 1398434319560
>09:58:39,590 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-18) Message 1d3f56c7-5772-42f0-90c7-76d1710d7dcc completed.
>09:58:39,626 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-18) message finished: 1d3f56c7-5772-42f0-90c7-76d1710d7dcc, took 65
>09:58:39,626 INFO  [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-18) msg: 1d3f56c7-5772-42f0-90c7-76d1710d7dcc handling task completed, results:true, at: 1398434319626, took:66
>09:58:39,627 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>09:58:39,627 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) nodeTwo_12346 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>09:58:39,628 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-197-localhost:2181) No Messages to process
>09:58:39,628 INFO  [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-197-localhost:2181) 197 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 1ms
>09:58:40,072 WARN  [org.uberfire.backend.server.deployment.DeploymentConfigServiceImpl] (pool-12-thread-1) Deployment org.jboss.qa.bpms:clustering:1.0.0.Final failed to deploy due to Cannot find KieModule: org.jboss.qa.bpms:clustering:1.0.0.Final: org.jbpm.console.ng.bd.exception.DeploymentException: Cannot find KieModule: org.jboss.qa.bpms:clustering:1.0.0.Final
>	at org.jbpm.console.ng.bd.backend.server.DeploymentManagerEntryPointImpl.deploy(DeploymentManagerEntryPointImpl.java:119) [jbpm-console-ng-business-domain-backend-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.console.ng.bd.backend.server.DeploymentManagerEntryPointImpl.deployOnEvent(DeploymentManagerEntryPointImpl.java:281) [jbpm-console-ng-business-domain-backend-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.console.ng.bd.backend.server.DeploymentManagerEntryPointImpl$Proxy$_$$_WeldClientProxy.deployOnEvent(DeploymentManagerEntryPointImpl$Proxy$_$$_WeldClientProxy.java) [jbpm-console-ng-business-domain-backend-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.7.0_51]
>	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_51]
>	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_51]
>	at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_51]
>	at org.jboss.weld.util.reflection.SecureReflections$13.work(SecureReflections.java:267) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.util.reflection.SecureReflectionAccess.run(SecureReflectionAccess.java:52) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.util.reflection.SecureReflectionAccess.runAsInvocation(SecureReflectionAccess.java:137) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.util.reflection.SecureReflections.invoke(SecureReflections.java:263) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.introspector.jlr.WeldMethodImpl.invokeOnInstance(WeldMethodImpl.java:170) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.introspector.ForwardingWeldMethod.invokeOnInstance(ForwardingWeldMethod.java:51) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.injection.MethodInjectionPoint.invokeOnInstanceWithSpecialValue(MethodInjectionPoint.java:154) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverMethodImpl.sendEvent(ObserverMethodImpl.java:245) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverMethodImpl.sendEvent(ObserverMethodImpl.java:233) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverMethodImpl.notify(ObserverMethodImpl.java:213) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverNotifier.notifyObserver(ObserverNotifier.java:117) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.TransactionalObserverNotifier.notifyObserver(TransactionalObserverNotifier.java:44) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverNotifier.notifyObservers(ObserverNotifier.java:85) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverNotifier.fireEvent(ObserverNotifier.java:80) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.EventImpl.fire(EventImpl.java:68) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.uberfire.backend.server.deployment.DeploymentConfigServiceImpl.updateRegisteredDeployments(DeploymentConfigServiceImpl.java:106) [uberfire-backend-server-0.3.3-redhat-1.jar:0.3.3-redhat-1]
>	at org.uberfire.backend.server.deployment.DeploymentConfigServiceImpl$Proxy$_$$_WeldClientProxy.updateRegisteredDeployments(DeploymentConfigServiceImpl$Proxy$_$$_WeldClientProxy.java) [uberfire-backend-server-0.3.3-redhat-1.jar:0.3.3-redhat-1]
>	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.7.0_51]
>	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_51]
>	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_51]
>	at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_51]
>	at org.jboss.weld.util.reflection.SecureReflections$13.work(SecureReflections.java:267) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.util.reflection.SecureReflectionAccess.run(SecureReflectionAccess.java:52) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.util.reflection.SecureReflectionAccess.runAsInvocation(SecureReflectionAccess.java:137) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.util.reflection.SecureReflections.invoke(SecureReflections.java:263) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.introspector.jlr.WeldMethodImpl.invokeOnInstance(WeldMethodImpl.java:170) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.introspector.ForwardingWeldMethod.invokeOnInstance(ForwardingWeldMethod.java:51) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.injection.MethodInjectionPoint.invokeOnInstanceWithSpecialValue(MethodInjectionPoint.java:154) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverMethodImpl.sendEvent(ObserverMethodImpl.java:245) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverMethodImpl.sendEvent(ObserverMethodImpl.java:233) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverMethodImpl.notify(ObserverMethodImpl.java:213) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverNotifier.notifyObserver(ObserverNotifier.java:117) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.TransactionalObserverNotifier.notifyObserver(TransactionalObserverNotifier.java:44) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverNotifier.notifyObservers(ObserverNotifier.java:85) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverNotifier.fireEvent(ObserverNotifier.java:80) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.EventImpl.fire(EventImpl.java:68) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.uberfire.backend.server.config.ConfigurationServiceImpl$CheckConfigurationUpdates.run(ConfigurationServiceImpl.java:303) [uberfire-backend-server-0.3.3-redhat-1.jar:0.3.3-redhat-1]
>	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) [rt.jar:1.7.0_51]
>	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [rt.jar:1.7.0_51]
>	at java.lang.Thread.run(Thread.java:744) [rt.jar:1.7.0_51]
>Caused by: java.lang.RuntimeException: Cannot find KieModule: org.jboss.qa.bpms:clustering:1.0.0.Final
>	at org.drools.compiler.kie.builder.impl.KieServicesImpl.newKieContainer(KieServicesImpl.java:108) [drools-compiler-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.kie.services.impl.KModuleDeploymentService.deploy(KModuleDeploymentService.java:65) [jbpm-kie-services-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.kie.services.impl.KModuleDeploymentService$Proxy$_$$_WeldClientProxy.deploy(KModuleDeploymentService$Proxy$_$$_WeldClientProxy.java) [jbpm-kie-services-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.console.ng.bd.backend.server.DeploymentManagerEntryPointImpl.deploy(DeploymentManagerEntryPointImpl.java:113) [jbpm-console-ng-business-domain-backend-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	... 46 more
>
>09:58:40,473 WARN  [org.uberfire.backend.server.deployment.DeploymentConfigServiceImpl] (pool-12-thread-1) Deployment org.jboss.qa.bpms:clustering:1.0.0.Final failed to deploy due to Cannot find KieModule: org.jboss.qa.bpms:clustering:1.0.0.Final: org.jbpm.console.ng.bd.exception.DeploymentException: Cannot find KieModule: org.jboss.qa.bpms:clustering:1.0.0.Final
>	at org.jbpm.console.ng.bd.backend.server.DeploymentManagerEntryPointImpl.deploy(DeploymentManagerEntryPointImpl.java:119) [jbpm-console-ng-business-domain-backend-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.console.ng.bd.backend.server.DeploymentManagerEntryPointImpl.deployOnEvent(DeploymentManagerEntryPointImpl.java:281) [jbpm-console-ng-business-domain-backend-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.console.ng.bd.backend.server.DeploymentManagerEntryPointImpl$Proxy$_$$_WeldClientProxy.deployOnEvent(DeploymentManagerEntryPointImpl$Proxy$_$$_WeldClientProxy.java) [jbpm-console-ng-business-domain-backend-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.7.0_51]
>	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_51]
>	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_51]
>	at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_51]
>	at org.jboss.weld.util.reflection.SecureReflections$13.work(SecureReflections.java:267) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.util.reflection.SecureReflectionAccess.run(SecureReflectionAccess.java:52) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.util.reflection.SecureReflectionAccess.runAsInvocation(SecureReflectionAccess.java:137) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.util.reflection.SecureReflections.invoke(SecureReflections.java:263) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.introspector.jlr.WeldMethodImpl.invokeOnInstance(WeldMethodImpl.java:170) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.introspector.ForwardingWeldMethod.invokeOnInstance(ForwardingWeldMethod.java:51) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.injection.MethodInjectionPoint.invokeOnInstanceWithSpecialValue(MethodInjectionPoint.java:154) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverMethodImpl.sendEvent(ObserverMethodImpl.java:245) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverMethodImpl.sendEvent(ObserverMethodImpl.java:233) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverMethodImpl.notify(ObserverMethodImpl.java:213) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverNotifier.notifyObserver(ObserverNotifier.java:117) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.TransactionalObserverNotifier.notifyObserver(TransactionalObserverNotifier.java:44) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverNotifier.notifyObservers(ObserverNotifier.java:85) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverNotifier.fireEvent(ObserverNotifier.java:80) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.EventImpl.fire(EventImpl.java:68) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.uberfire.backend.server.deployment.DeploymentConfigServiceImpl.updateRegisteredDeployments(DeploymentConfigServiceImpl.java:106) [uberfire-backend-server-0.3.3-redhat-1.jar:0.3.3-redhat-1]
>	at org.uberfire.backend.server.deployment.DeploymentConfigServiceImpl$Proxy$_$$_WeldClientProxy.updateRegisteredDeployments(DeploymentConfigServiceImpl$Proxy$_$$_WeldClientProxy.java) [uberfire-backend-server-0.3.3-redhat-1.jar:0.3.3-redhat-1]
>	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.7.0_51]
>	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_51]
>	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_51]
>	at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_51]
>	at org.jboss.weld.util.reflection.SecureReflections$13.work(SecureReflections.java:267) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.util.reflection.SecureReflectionAccess.run(SecureReflectionAccess.java:52) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.util.reflection.SecureReflectionAccess.runAsInvocation(SecureReflectionAccess.java:137) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.util.reflection.SecureReflections.invoke(SecureReflections.java:263) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.introspector.jlr.WeldMethodImpl.invokeOnInstance(WeldMethodImpl.java:170) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.introspector.ForwardingWeldMethod.invokeOnInstance(ForwardingWeldMethod.java:51) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.injection.MethodInjectionPoint.invokeOnInstanceWithSpecialValue(MethodInjectionPoint.java:154) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverMethodImpl.sendEvent(ObserverMethodImpl.java:245) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverMethodImpl.sendEvent(ObserverMethodImpl.java:233) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverMethodImpl.notify(ObserverMethodImpl.java:213) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverNotifier.notifyObserver(ObserverNotifier.java:117) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.TransactionalObserverNotifier.notifyObserver(TransactionalObserverNotifier.java:44) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverNotifier.notifyObservers(ObserverNotifier.java:85) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverNotifier.fireEvent(ObserverNotifier.java:80) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.EventImpl.fire(EventImpl.java:68) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.uberfire.backend.server.config.ConfigurationServiceImpl$CheckConfigurationUpdates.run(ConfigurationServiceImpl.java:305) [uberfire-backend-server-0.3.3-redhat-1.jar:0.3.3-redhat-1]
>	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) [rt.jar:1.7.0_51]
>	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [rt.jar:1.7.0_51]
>	at java.lang.Thread.run(Thread.java:744) [rt.jar:1.7.0_51]
>Caused by: java.lang.RuntimeException: Cannot find KieModule: org.jboss.qa.bpms:clustering:1.0.0.Final
>	at org.drools.compiler.kie.builder.impl.KieServicesImpl.newKieContainer(KieServicesImpl.java:108) [drools-compiler-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.kie.services.impl.KModuleDeploymentService.deploy(KModuleDeploymentService.java:65) [jbpm-kie-services-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.kie.services.impl.KModuleDeploymentService$Proxy$_$$_WeldClientProxy.deploy(KModuleDeploymentService$Proxy$_$$_WeldClientProxy.java) [jbpm-kie-services-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.console.ng.bd.backend.server.DeploymentManagerEntryPointImpl.deploy(DeploymentManagerEntryPointImpl.java:113) [jbpm-console-ng-business-domain-backend-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	... 46 more
>
>09:58:40,870 WARN  [org.uberfire.backend.server.deployment.DeploymentConfigServiceImpl] (pool-12-thread-1) Deployment org.jboss.qa.bpms:clustering:1.0.0.Final failed to deploy due to Cannot find KieModule: org.jboss.qa.bpms:clustering:1.0.0.Final: org.jbpm.console.ng.bd.exception.DeploymentException: Cannot find KieModule: org.jboss.qa.bpms:clustering:1.0.0.Final
>	at org.jbpm.console.ng.bd.backend.server.DeploymentManagerEntryPointImpl.deploy(DeploymentManagerEntryPointImpl.java:119) [jbpm-console-ng-business-domain-backend-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.console.ng.bd.backend.server.DeploymentManagerEntryPointImpl.deployOnEvent(DeploymentManagerEntryPointImpl.java:281) [jbpm-console-ng-business-domain-backend-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.console.ng.bd.backend.server.DeploymentManagerEntryPointImpl$Proxy$_$$_WeldClientProxy.deployOnEvent(DeploymentManagerEntryPointImpl$Proxy$_$$_WeldClientProxy.java) [jbpm-console-ng-business-domain-backend-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.7.0_51]
>	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_51]
>	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_51]
>	at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_51]
>	at org.jboss.weld.util.reflection.SecureReflections$13.work(SecureReflections.java:267) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.util.reflection.SecureReflectionAccess.run(SecureReflectionAccess.java:52) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.util.reflection.SecureReflectionAccess.runAsInvocation(SecureReflectionAccess.java:137) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.util.reflection.SecureReflections.invoke(SecureReflections.java:263) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.introspector.jlr.WeldMethodImpl.invokeOnInstance(WeldMethodImpl.java:170) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.introspector.ForwardingWeldMethod.invokeOnInstance(ForwardingWeldMethod.java:51) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.injection.MethodInjectionPoint.invokeOnInstanceWithSpecialValue(MethodInjectionPoint.java:154) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverMethodImpl.sendEvent(ObserverMethodImpl.java:245) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverMethodImpl.sendEvent(ObserverMethodImpl.java:233) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverMethodImpl.notify(ObserverMethodImpl.java:213) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverNotifier.notifyObserver(ObserverNotifier.java:117) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.TransactionalObserverNotifier.notifyObserver(TransactionalObserverNotifier.java:44) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverNotifier.notifyObservers(ObserverNotifier.java:85) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverNotifier.fireEvent(ObserverNotifier.java:80) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.EventImpl.fire(EventImpl.java:68) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.uberfire.backend.server.deployment.DeploymentConfigServiceImpl.updateRegisteredDeployments(DeploymentConfigServiceImpl.java:106) [uberfire-backend-server-0.3.3-redhat-1.jar:0.3.3-redhat-1]
>	at org.uberfire.backend.server.deployment.DeploymentConfigServiceImpl$Proxy$_$$_WeldClientProxy.updateRegisteredDeployments(DeploymentConfigServiceImpl$Proxy$_$$_WeldClientProxy.java) [uberfire-backend-server-0.3.3-redhat-1.jar:0.3.3-redhat-1]
>	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.7.0_51]
>	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_51]
>	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_51]
>	at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_51]
>	at org.jboss.weld.util.reflection.SecureReflections$13.work(SecureReflections.java:267) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.util.reflection.SecureReflectionAccess.run(SecureReflectionAccess.java:52) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.util.reflection.SecureReflectionAccess.runAsInvocation(SecureReflectionAccess.java:137) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.util.reflection.SecureReflections.invoke(SecureReflections.java:263) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.introspector.jlr.WeldMethodImpl.invokeOnInstance(WeldMethodImpl.java:170) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.introspector.ForwardingWeldMethod.invokeOnInstance(ForwardingWeldMethod.java:51) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.injection.MethodInjectionPoint.invokeOnInstanceWithSpecialValue(MethodInjectionPoint.java:154) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverMethodImpl.sendEvent(ObserverMethodImpl.java:245) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverMethodImpl.sendEvent(ObserverMethodImpl.java:233) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverMethodImpl.notify(ObserverMethodImpl.java:213) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverNotifier.notifyObserver(ObserverNotifier.java:117) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.TransactionalObserverNotifier.notifyObserver(TransactionalObserverNotifier.java:44) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverNotifier.notifyObservers(ObserverNotifier.java:85) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.ObserverNotifier.fireEvent(ObserverNotifier.java:80) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.jboss.weld.event.EventImpl.fire(EventImpl.java:68) [weld-core-1.1.13.Final-redhat-1.jar:1.1.13.Final-redhat-1]
>	at org.uberfire.backend.server.config.ConfigurationServiceImpl$CheckConfigurationUpdates.run(ConfigurationServiceImpl.java:307) [uberfire-backend-server-0.3.3-redhat-1.jar:0.3.3-redhat-1]
>	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) [rt.jar:1.7.0_51]
>	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [rt.jar:1.7.0_51]
>	at java.lang.Thread.run(Thread.java:744) [rt.jar:1.7.0_51]
>Caused by: java.lang.RuntimeException: Cannot find KieModule: org.jboss.qa.bpms:clustering:1.0.0.Final
>	at org.drools.compiler.kie.builder.impl.KieServicesImpl.newKieContainer(KieServicesImpl.java:108) [drools-compiler-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.kie.services.impl.KModuleDeploymentService.deploy(KModuleDeploymentService.java:65) [jbpm-kie-services-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.kie.services.impl.KModuleDeploymentService$Proxy$_$$_WeldClientProxy.deploy(KModuleDeploymentService$Proxy$_$$_WeldClientProxy.java) [jbpm-kie-services-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.console.ng.bd.backend.server.DeploymentManagerEntryPointImpl.deploy(DeploymentManagerEntryPointImpl.java:113) [jbpm-console-ng-business-domain-backend-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	... 46 more
>
>09:59:18,407 INFO  [org.jboss.resteasy.cdi.CdiInjectorFactory] (http-localhost/127.0.0.1:8280-1) Found BeanManager at java:comp/BeanManager
>09:59:19,189 WARN  [org.kie.services.remote.cdi.ProcessRequestBean] (http-localhost/127.0.0.1:8280-1) Unable to execute SignalEventCommand/0: org.kie.services.remote.exception.DeploymentNotFoundException: No runtime manager could be found for deployment 'org.jboss.qa.bpms:clustering:1.0.0.Final'.
>	at org.kie.services.remote.cdi.DeploymentInfoBean.getRuntimeEngine(DeploymentInfoBean.java:91) [kie-services-remote-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.kie.services.remote.cdi.DeploymentInfoBean$Proxy$_$$_WeldClientProxy.getRuntimeEngine(DeploymentInfoBean$Proxy$_$$_WeldClientProxy.java) [kie-services-remote-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.kie.services.remote.cdi.ProcessRequestBean.doKieSessionOperation(ProcessRequestBean.java:151) [kie-services-remote-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.kie.services.remote.cdi.ProcessRequestBean.processCommand(ProcessRequestBean.java:107) [kie-services-remote-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.kie.services.remote.cdi.ProcessRequestBean$Proxy$_$$_WeldClientProxy.processCommand(ProcessRequestBean$Proxy$_$$_WeldClientProxy.java) [kie-services-remote-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.kie.services.remote.rest.ResourceBase.restProcessJaxbCommandsRequest(ResourceBase.java:74) [kie-services-remote-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.kie.services.remote.rest.RuntimeResource.execute(RuntimeResource.java:95) [kie-services-remote-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.kie.services.remote.rest.RuntimeResource$Proxy$_$$_WeldClientProxy.execute(RuntimeResource$Proxy$_$$_WeldClientProxy.java) [kie-services-remote-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.7.0_51]
>	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_51]
>	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_51]
>	at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_51]
>	at org.jboss.resteasy.core.MethodInjectorImpl.invoke(MethodInjectorImpl.java:167) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at org.jboss.resteasy.core.ResourceMethod.invokeOnTarget(ResourceMethod.java:269) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at org.jboss.resteasy.core.ResourceMethod.invoke(ResourceMethod.java:227) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at org.jboss.resteasy.core.ResourceMethod.invoke(ResourceMethod.java:216) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at org.jboss.resteasy.core.SynchronousDispatcher.getResponse(SynchronousDispatcher.java:542) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:524) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:126) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at org.jboss.resteasy.plugins.server.servlet.ServletContainerDispatcher.service(ServletContainerDispatcher.java:208) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(HttpServletDispatcher.java:55) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(HttpServletDispatcher.java:50) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at javax.servlet.http.HttpServlet.service(HttpServlet.java:847) [jboss-servlet-api_3.0_spec-1.0.2.Final-redhat-1.jar:1.0.2.Final-redhat-1]
>	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:295) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.jboss.solder.servlet.exception.CatchExceptionFilter.doFilter(CatchExceptionFilter.java:65) [solder-impl-3.2.1.Final.jar:3.2.1.Final]
>	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:246) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.jboss.solder.servlet.event.ServletEventBridgeFilter.doFilter(ServletEventBridgeFilter.java:74) [solder-impl-3.2.1.Final.jar:3.2.1.Final]
>	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:246) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.jbpm.designer.web.filter.impl.PluggableFilter.doFilter(PluggableFilter.java:70) [jbpm-designer-backend-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:246) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.uberfire.security.server.UberFireSecurityFilter.doFilter(UberFireSecurityFilter.java:266) [uberfire-security-server-0.3.3-redhat-1.jar:0.3.3-redhat-1]
>	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:246) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:230) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:149) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.jboss.modcluster.container.jbossweb.JBossWebContext$RequestListenerValve.event(JBossWebContext.java:91)
>	at org.jboss.modcluster.container.jbossweb.JBossWebContext$RequestListenerValve.invoke(JBossWebContext.java:72)
>	at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:407) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.jboss.as.jpa.interceptor.WebNonTxEmCloserValve.invoke(WebNonTxEmCloserValve.java:50) [jboss-as-jpa-7.2.1.Final-redhat-10.jar:7.2.1.Final-redhat-10]
>	at org.jboss.as.jpa.interceptor.WebNonTxEmCloserValve.invoke(WebNonTxEmCloserValve.java:50) [jboss-as-jpa-7.2.1.Final-redhat-10.jar:7.2.1.Final-redhat-10]
>	at org.jboss.as.web.security.SecurityContextAssociationValve.invoke(SecurityContextAssociationValve.java:169) [jboss-as-web-7.2.1.Final-redhat-10.jar:7.2.1.Final-redhat-10]
>	at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:145) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:97) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.authenticator.SingleSignOn.invoke(SingleSignOn.java:389) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:102) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:336) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:856) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:653) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:920) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at java.lang.Thread.run(Thread.java:744) [rt.jar:1.7.0_51]
>
>09:59:28,741 WARN  [org.jbpm.services.task.persistence.TaskTransactionInterceptor] (http-localhost/127.0.0.1:8280-1) Could not commit session: java.lang.NullPointerException
>	at org.jbpm.services.task.wih.ExternalTaskEventListener.afterTaskCompletedEvent(ExternalTaskEventListener.java:115) [jbpm-human-task-workitems-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.services.task.events.TaskEventSupport.fireAfterTaskCompleted(TaskEventSupport.java:189) [jbpm-human-task-core-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.services.task.internals.lifecycle.MVELLifeCycleManager.taskOperation(MVELLifeCycleManager.java:340) [jbpm-human-task-core-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.services.task.identity.UserGroupLifeCycleManagerDecorator.taskOperation(UserGroupLifeCycleManagerDecorator.java:46) [jbpm-human-task-core-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.services.task.impl.TaskInstanceServiceImpl.complete(TaskInstanceServiceImpl.java:142) [jbpm-human-task-core-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.services.task.commands.CompleteTaskCommand.execute(CompleteTaskCommand.java:70) [jbpm-human-task-core-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.services.task.commands.CompleteTaskCommand.execute(CompleteTaskCommand.java:37) [jbpm-human-task-core-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.services.task.commands.CompositeCommand.execute(CompositeCommand.java:38) [jbpm-human-task-core-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.services.task.commands.TaskCommandExecutorImpl$SelfExecutionCommandService.execute(TaskCommandExecutorImpl.java:65) [jbpm-human-task-core-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.drools.core.command.impl.AbstractInterceptor.executeNext(AbstractInterceptor.java:41) [drools-core-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.services.task.persistence.TaskTransactionInterceptor.execute(TaskTransactionInterceptor.java:54) [jbpm-human-task-core-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.services.task.commands.TaskCommandExecutorImpl.execute(TaskCommandExecutorImpl.java:40) [jbpm-human-task-core-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.services.task.impl.command.CommandBasedTaskService.execute(CommandBasedTaskService.java:128) [jbpm-human-task-core-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.kie.services.remote.cdi.ProcessRequestBean.doTaskOperation(ProcessRequestBean.java:224) [kie-services-remote-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.kie.services.remote.cdi.ProcessRequestBean.processCommand(ProcessRequestBean.java:96) [kie-services-remote-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.kie.services.remote.cdi.ProcessRequestBean$Proxy$_$$_WeldClientProxy.processCommand(ProcessRequestBean$Proxy$_$$_WeldClientProxy.java) [kie-services-remote-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.kie.services.remote.rest.ResourceBase.restProcessJaxbCommandsRequest(ResourceBase.java:74) [kie-services-remote-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.kie.services.remote.rest.TaskResource.execute(TaskResource.java:108) [kie-services-remote-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.kie.services.remote.rest.TaskResource$Proxy$_$$_WeldClientProxy.execute(TaskResource$Proxy$_$$_WeldClientProxy.java) [kie-services-remote-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.7.0_51]
>	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_51]
>	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_51]
>	at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_51]
>	at org.jboss.resteasy.core.MethodInjectorImpl.invoke(MethodInjectorImpl.java:167) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at org.jboss.resteasy.core.ResourceMethod.invokeOnTarget(ResourceMethod.java:269) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at org.jboss.resteasy.core.ResourceMethod.invoke(ResourceMethod.java:227) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at org.jboss.resteasy.core.ResourceMethod.invoke(ResourceMethod.java:216) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at org.jboss.resteasy.core.SynchronousDispatcher.getResponse(SynchronousDispatcher.java:542) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:524) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:126) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at org.jboss.resteasy.plugins.server.servlet.ServletContainerDispatcher.service(ServletContainerDispatcher.java:208) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(HttpServletDispatcher.java:55) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(HttpServletDispatcher.java:50) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at javax.servlet.http.HttpServlet.service(HttpServlet.java:847) [jboss-servlet-api_3.0_spec-1.0.2.Final-redhat-1.jar:1.0.2.Final-redhat-1]
>	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:295) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.jboss.solder.servlet.exception.CatchExceptionFilter.doFilter(CatchExceptionFilter.java:65) [solder-impl-3.2.1.Final.jar:3.2.1.Final]
>	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:246) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.jboss.solder.servlet.event.ServletEventBridgeFilter.doFilter(ServletEventBridgeFilter.java:74) [solder-impl-3.2.1.Final.jar:3.2.1.Final]
>	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:246) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.jbpm.designer.web.filter.impl.PluggableFilter.doFilter(PluggableFilter.java:70) [jbpm-designer-backend-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:246) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.uberfire.security.server.UberFireSecurityFilter.doFilter(UberFireSecurityFilter.java:266) [uberfire-security-server-0.3.3-redhat-1.jar:0.3.3-redhat-1]
>	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:246) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:230) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:149) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.jboss.modcluster.container.jbossweb.JBossWebContext$RequestListenerValve.event(JBossWebContext.java:91)
>	at org.jboss.modcluster.container.jbossweb.JBossWebContext$RequestListenerValve.invoke(JBossWebContext.java:72)
>	at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:407) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.jboss.as.jpa.interceptor.WebNonTxEmCloserValve.invoke(WebNonTxEmCloserValve.java:50) [jboss-as-jpa-7.2.1.Final-redhat-10.jar:7.2.1.Final-redhat-10]
>	at org.jboss.as.jpa.interceptor.WebNonTxEmCloserValve.invoke(WebNonTxEmCloserValve.java:50) [jboss-as-jpa-7.2.1.Final-redhat-10.jar:7.2.1.Final-redhat-10]
>	at org.jboss.as.web.security.SecurityContextAssociationValve.invoke(SecurityContextAssociationValve.java:169) [jboss-as-web-7.2.1.Final-redhat-10.jar:7.2.1.Final-redhat-10]
>	at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:145) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:97) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.authenticator.SingleSignOn.invoke(SingleSignOn.java:389) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:102) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:336) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:856) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:653) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:920) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at java.lang.Thread.run(Thread.java:744) [rt.jar:1.7.0_51]
>
>09:59:28,745 WARN  [org.kie.services.remote.cdi.ProcessRequestBean] (http-localhost/127.0.0.1:8280-1) Unable to execute CompositeCommand/0: java.lang.NullPointerException
>	at org.jbpm.services.task.wih.ExternalTaskEventListener.afterTaskCompletedEvent(ExternalTaskEventListener.java:115) [jbpm-human-task-workitems-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.services.task.events.TaskEventSupport.fireAfterTaskCompleted(TaskEventSupport.java:189) [jbpm-human-task-core-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.services.task.internals.lifecycle.MVELLifeCycleManager.taskOperation(MVELLifeCycleManager.java:340) [jbpm-human-task-core-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.services.task.identity.UserGroupLifeCycleManagerDecorator.taskOperation(UserGroupLifeCycleManagerDecorator.java:46) [jbpm-human-task-core-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.services.task.impl.TaskInstanceServiceImpl.complete(TaskInstanceServiceImpl.java:142) [jbpm-human-task-core-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.services.task.commands.CompleteTaskCommand.execute(CompleteTaskCommand.java:70) [jbpm-human-task-core-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.services.task.commands.CompleteTaskCommand.execute(CompleteTaskCommand.java:37) [jbpm-human-task-core-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.services.task.commands.CompositeCommand.execute(CompositeCommand.java:38) [jbpm-human-task-core-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.services.task.commands.TaskCommandExecutorImpl$SelfExecutionCommandService.execute(TaskCommandExecutorImpl.java:65) [jbpm-human-task-core-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.drools.core.command.impl.AbstractInterceptor.executeNext(AbstractInterceptor.java:41) [drools-core-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.services.task.persistence.TaskTransactionInterceptor.execute(TaskTransactionInterceptor.java:54) [jbpm-human-task-core-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.services.task.commands.TaskCommandExecutorImpl.execute(TaskCommandExecutorImpl.java:40) [jbpm-human-task-core-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.jbpm.services.task.impl.command.CommandBasedTaskService.execute(CommandBasedTaskService.java:128) [jbpm-human-task-core-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.kie.services.remote.cdi.ProcessRequestBean.doTaskOperation(ProcessRequestBean.java:224) [kie-services-remote-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.kie.services.remote.cdi.ProcessRequestBean.processCommand(ProcessRequestBean.java:96) [kie-services-remote-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.kie.services.remote.cdi.ProcessRequestBean$Proxy$_$$_WeldClientProxy.processCommand(ProcessRequestBean$Proxy$_$$_WeldClientProxy.java) [kie-services-remote-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.kie.services.remote.rest.ResourceBase.restProcessJaxbCommandsRequest(ResourceBase.java:74) [kie-services-remote-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.kie.services.remote.rest.TaskResource.execute(TaskResource.java:108) [kie-services-remote-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.kie.services.remote.rest.TaskResource$Proxy$_$$_WeldClientProxy.execute(TaskResource$Proxy$_$$_WeldClientProxy.java) [kie-services-remote-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.7.0_51]
>	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_51]
>	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_51]
>	at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_51]
>	at org.jboss.resteasy.core.MethodInjectorImpl.invoke(MethodInjectorImpl.java:167) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at org.jboss.resteasy.core.ResourceMethod.invokeOnTarget(ResourceMethod.java:269) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at org.jboss.resteasy.core.ResourceMethod.invoke(ResourceMethod.java:227) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at org.jboss.resteasy.core.ResourceMethod.invoke(ResourceMethod.java:216) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at org.jboss.resteasy.core.SynchronousDispatcher.getResponse(SynchronousDispatcher.java:542) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:524) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:126) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at org.jboss.resteasy.plugins.server.servlet.ServletContainerDispatcher.service(ServletContainerDispatcher.java:208) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(HttpServletDispatcher.java:55) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(HttpServletDispatcher.java:50) [resteasy-jaxrs-2.3.6.Final-redhat-1.jar:2.3.6.Final-redhat-1]
>	at javax.servlet.http.HttpServlet.service(HttpServlet.java:847) [jboss-servlet-api_3.0_spec-1.0.2.Final-redhat-1.jar:1.0.2.Final-redhat-1]
>	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:295) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.jboss.solder.servlet.exception.CatchExceptionFilter.doFilter(CatchExceptionFilter.java:65) [solder-impl-3.2.1.Final.jar:3.2.1.Final]
>	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:246) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.jboss.solder.servlet.event.ServletEventBridgeFilter.doFilter(ServletEventBridgeFilter.java:74) [solder-impl-3.2.1.Final.jar:3.2.1.Final]
>	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:246) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.jbpm.designer.web.filter.impl.PluggableFilter.doFilter(PluggableFilter.java:70) [jbpm-designer-backend-6.0.3-redhat-1.jar:6.0.3-redhat-1]
>	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:246) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.uberfire.security.server.UberFireSecurityFilter.doFilter(UberFireSecurityFilter.java:266) [uberfire-security-server-0.3.3-redhat-1.jar:0.3.3-redhat-1]
>	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:246) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:230) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:149) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.jboss.modcluster.container.jbossweb.JBossWebContext$RequestListenerValve.event(JBossWebContext.java:91)
>	at org.jboss.modcluster.container.jbossweb.JBossWebContext$RequestListenerValve.invoke(JBossWebContext.java:72)
>	at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:407) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.jboss.as.jpa.interceptor.WebNonTxEmCloserValve.invoke(WebNonTxEmCloserValve.java:50) [jboss-as-jpa-7.2.1.Final-redhat-10.jar:7.2.1.Final-redhat-10]
>	at org.jboss.as.jpa.interceptor.WebNonTxEmCloserValve.invoke(WebNonTxEmCloserValve.java:50) [jboss-as-jpa-7.2.1.Final-redhat-10.jar:7.2.1.Final-redhat-10]
>	at org.jboss.as.web.security.SecurityContextAssociationValve.invoke(SecurityContextAssociationValve.java:169) [jboss-as-web-7.2.1.Final-redhat-10.jar:7.2.1.Final-redhat-10]
>	at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:145) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:97) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.authenticator.SingleSignOn.invoke(SingleSignOn.java:389) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:102) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:336) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:856) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:653) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:920) [jbossweb-7.2.2.Final-redhat-4.jar:7.2.2.Final-redhat-4]
>	at java.lang.Thread.run(Thread.java:744) [rt.jar:1.7.0_51]
>
>10:00:14,951 INFO  [org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-7) JBAS010409: Unbound data source [java:jboss/datasources/ExampleDS]
>10:00:14,952 INFO  [org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-16) JBAS010409: Unbound data source [java:jboss/datasources/brms-jdbc-dsQuartz]
>10:00:14,958 INFO  [org.apache.coyote.http11] (MSC service thread 1-12) JBWEB003075: Coyote HTTP/1.1 pausing on: http-localhost/127.0.0.1:8280
>10:00:14,959 INFO  [org.apache.coyote.http11] (MSC service thread 1-12) JBWEB003077: Coyote HTTP/1.1 stopping on : http-localhost/127.0.0.1:8280
>10:00:14,960 INFO  [org.apache.catalina.core] (MSC service thread 1-4) JBWEB001079: Container org.apache.catalina.core.ContainerBase.[jboss.web].[default-host].[/] has not been started
>10:00:14,962 INFO  [org.jboss.modcluster] (ServerService Thread Pool -- 84) MODCLUSTER000002: Initiating mod_cluster shutdown
>10:00:14,962 INFO  [org.jboss.jaxr] (MSC service thread 1-14) JBAS014002: UnBinding JAXR ConnectionFactory: java:jboss/jaxr/ConnectionFactory
>10:00:14,963 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 80) JBAS011605: Unbound messaging object to jndi name java:/queue/KIE.TASK.ALL
>10:00:14,964 INFO  [org.apache.coyote.ajp] (MSC service thread 1-12) JBWEB003048: Pausing Coyote AJP/1.3 on ajp-localhost/127.0.0.1:8209
>10:00:14,965 INFO  [org.apache.coyote.ajp] (MSC service thread 1-12) JBWEB003051: Stopping Coyote AJP/1.3 on ajp-localhost/127.0.0.1:8209
>10:00:14,965 INFO  [org.jboss.web] (ServerService Thread Pool -- 86) JBAS018224: Unregister web context: /business-central
>10:00:15,071 INFO  [org.jboss.as.connector.deployment] (MSC service thread 1-12) JBAS010410: Unbound JCA ConnectionFactory [java:/JmsXA]
>10:00:15,072 INFO  [org.jboss.as.jpa] (ServerService Thread Pool -- 83) JBAS011403: Stopping Persistence Unit Service 'business-central.war#org.jbpm.domain'
>10:00:15,072 INFO  [org.jboss.weld.deployer] (MSC service thread 1-5) JBAS016009: Stopping weld service for deployment business-central.war
>10:00:15,081 INFO  [org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-4) JBAS010409: Unbound data source [java:jboss/datasources/brms-jdbc-ds]
>10:00:15,082 INFO  [org.hornetq.ra] (MSC service thread 1-2) HQ151003: HornetQ resource adaptor stopped
>10:00:15,087 ERROR [org.hornetq.core.server] (Thread-2 (HornetQ-client-global-threads-8562031)) HQ224037: cluster connection Failed to handle message: java.lang.IllegalStateException: Cannot find binding for jms.queue.KIE.TASK37d218fc-cc81-11e3-ac85-ebcda1137edb
>	at org.hornetq.core.server.cluster.impl.ClusterConnectionImpl$MessageFlowRecordImpl.doConsumerClosed(ClusterConnectionImpl.java:1567) [hornetq-server-2.3.5.Final-redhat-2.jar:2.3.5.Final-redhat-2]
>	at org.hornetq.core.server.cluster.impl.ClusterConnectionImpl$MessageFlowRecordImpl.onMessage(ClusterConnectionImpl.java:1285) [hornetq-server-2.3.5.Final-redhat-2.jar:2.3.5.Final-redhat-2]
>	at org.hornetq.core.client.impl.ClientConsumerImpl.callOnMessage(ClientConsumerImpl.java:1114) [hornetq-core-client-2.3.5.Final-redhat-2.jar:2.3.5.Final-redhat-2]
>	at org.hornetq.core.client.impl.ClientConsumerImpl.access$500(ClientConsumerImpl.java:57) [hornetq-core-client-2.3.5.Final-redhat-2.jar:2.3.5.Final-redhat-2]
>	at org.hornetq.core.client.impl.ClientConsumerImpl$Runner.run(ClientConsumerImpl.java:1249) [hornetq-core-client-2.3.5.Final-redhat-2.jar:2.3.5.Final-redhat-2]
>	at org.hornetq.utils.OrderedExecutorFactory$OrderedExecutor$1.run(OrderedExecutorFactory.java:106) [hornetq-core-client-2.3.5.Final-redhat-2.jar:2.3.5.Final-redhat-2]
>	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) [rt.jar:1.7.0_51]
>	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [rt.jar:1.7.0_51]
>	at java.lang.Thread.run(Thread.java:744) [rt.jar:1.7.0_51]
>
>10:00:15,095 INFO  [org.hornetq.core.server] (Thread-18 (HornetQ-server-HornetQServerImpl::serverUUID=38d04edd-cc81-11e3-bde4-69d5bf946063-285193534)) HQ221029: stopped bridge sf.my-cluster.37d218fc-cc81-11e3-ac85-ebcda1137edb
>10:00:15,108 INFO  [org.jboss.errai.cdi.server.events.ShutdownEventObserver] (MSC service thread 1-5) Shutting down CDI-to-ErraiBus event bridge
>10:00:15,112 INFO  [org.apache.helix.manager.zk.ZKHelixManager] (MSC service thread 1-5) disconnect nodeTwo_12346(PARTICIPANT) from bpms-cluster
>10:00:15,112 INFO  [org.apache.helix.healthcheck.ParticipantHealthReportTask] (MSC service thread 1-5) Stop ParticipantHealthReportTimerTask
>10:00:15,112 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (MSC service thread 1-5) shutting down TaskExecutor
>10:00:15,113 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (MSC service thread 1-5) 0 tasks are still in the threadpool for msgType USER_DEFINE_MSG
>10:00:15,113 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (MSC service thread 1-5) 0 tasks are still in the threadpool for msgType STATE_TRANSITION
>10:00:15,114 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (MSC service thread 1-5) 0 tasks are still in the threadpool for msgType TASK_REPLY
>10:00:15,114 INFO  [org.apache.helix.monitoring.ParticipantMonitor] (MSC service thread 1-5) Registering bean: Cluster=bpms-cluster,Resource=vfs-repo,Transition=STANDBY--OFFLINE
>10:00:15,114 INFO  [org.apache.helix.monitoring.ParticipantMonitor] (MSC service thread 1-5) Registering bean: Cluster=bpms-cluster,Resource=vfs-repo,Transition=OFFLINE--STANDBY
>10:00:15,114 INFO  [org.apache.helix.monitoring.ParticipantMonitor] (MSC service thread 1-5) Registering bean: Cluster=bpms-cluster,Resource=vfs-repo,Transition=LEADER--STANDBY
>10:00:15,114 INFO  [org.apache.helix.monitoring.ParticipantMonitor] (MSC service thread 1-5) Registering bean: Cluster=bpms-cluster,Resource=vfs-repo,Transition=STANDBY--LEADER
>10:00:15,115 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (MSC service thread 1-5) shutdown finished
>10:00:15,115 INFO  [org.apache.helix.manager.zk.CallbackHandler] (MSC service thread 1-5) 15 START:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
>10:00:15,115 INFO  [org.apache.helix.manager.zk.CallbackHandler] (MSC service thread 1-5) nodeTwo_12346 unsubscribe child-change. path: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>10:00:15,116 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (MSC service thread 1-5) Get FINALIZE notification
>10:00:15,116 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (MSC service thread 1-5) 0 tasks never executed for msgType: USER_DEFINE_MSG. tasks: []
>10:00:15,116 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (MSC service thread 1-5) 0 tasks never executed for msgType: STATE_TRANSITION. tasks: []
>10:00:15,116 WARN  [org.apache.helix.participant.statemachine.StateModel] (MSC service thread 1-5) Default reset method invoked. Either because the process longer own this resource or session timedout
>10:00:15,116 INFO  [org.apache.helix.messaging.handling.HelixTaskExecutor] (MSC service thread 1-5) 0 tasks never executed for msgType: TASK_REPLY. tasks: []
>10:00:15,116 INFO  [org.apache.helix.manager.zk.CallbackHandler] (MSC service thread 1-5) 15 END:INVOKE /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 1ms
>10:00:15,117 INFO  [org.apache.helix.manager.zk.ZKHelixManager] (MSC service thread 1-5) reset handler: /bpms-cluster/INSTANCES/nodeTwo_12346/MESSAGES, org.apache.helix.messaging.handling.HelixTaskExecutor@232269d4
>10:00:15,117 INFO  [org.apache.helix.manager.zk.CallbackHandler] (MSC service thread 1-5) 15 START:INVOKE /bpms-cluster/CONTROLLER listener:org.apache.helix.manager.zk.ZKHelixDataAccessor
>10:00:15,117 INFO  [org.apache.helix.manager.zk.CallbackHandler] (MSC service thread 1-5) nodeTwo_12346 unsubscribe child-change. path: /bpms-cluster/CONTROLLER, listener: org.apache.helix.manager.zk.ZKHelixDataAccessor@78907798
>10:00:15,117 INFO  [org.apache.helix.manager.zk.ZKHelixDataAccessor] (MSC service thread 1-5) Controller has changed
>10:00:15,118 INFO  [org.apache.helix.manager.zk.ZKHelixDataAccessor] (MSC service thread 1-5) _zkPropertyTransferSvcUrl : null Controller brmsperf05.mw.lab.eng.bos.redhat.com-CONTROLLER
>10:00:15,118 INFO  [org.apache.helix.manager.zk.CallbackHandler] (MSC service thread 1-5) 15 END:INVOKE /bpms-cluster/CONTROLLER listener:org.apache.helix.manager.zk.ZKHelixDataAccessor Took: 1ms
>10:00:15,118 INFO  [org.apache.helix.manager.zk.ZKHelixManager] (MSC service thread 1-5) reset handler: /bpms-cluster/CONTROLLER, org.apache.helix.manager.zk.ZKHelixDataAccessor@78907798
>10:00:15,118 INFO  [org.apache.helix.manager.zk.ZkClient] (MSC service thread 1-5) Closing zkclient: State:CONNECTED Timeout:30000 sessionid:0x145992ad1fb0007 local:/127.0.0.1:34259 remoteserver:localhost/127.0.0.1:2181 lastZxid:300 xid:597 sent:613 recv:665 queuedpkts:0 pendingresp:0 queuedevents:0
>10:00:15,118 INFO  [org.I0Itec.zkclient.ZkEventThread] (ZkClient-EventThread-197-localhost:2181) Terminate ZkClient event thread.
>10:00:15,145 INFO  [org.apache.zookeeper.ClientCnxn] (MSC service thread 1-5-EventThread) EventThread shut down
>10:00:15,145 INFO  [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-5) Session: 0x145992ad1fb0007 closed
>10:00:15,146 INFO  [org.apache.helix.manager.zk.ZkClient] (MSC service thread 1-5) Closed zkclient
>10:00:15,146 INFO  [org.apache.helix.manager.zk.ZKHelixManager] (MSC service thread 1-5) Cluster manager: nodeTwo_12346 disconnected
>10:00:15,151 INFO  [org.hornetq.core.server] (MSC service thread 1-7) HQ221002: HornetQ Server version 2.3.5.Final-redhat-2 (Monster Bee, 123) [38d04edd-cc81-11e3-bde4-69d5bf946063] stopped
>10:00:15,153 INFO  [org.jbpm.executor.impl.ExecutorImpl] (MSC service thread 1-5)  >>>>> Destroying Executor !!!
>10:00:15,419 INFO  [org.jboss.as.server.deployment] (MSC service thread 1-14) JBAS015877: Stopped deployment business-central.war (runtime-name: business-central.war) in 472ms
>10:00:15,428 INFO  [org.jboss.as] (MSC service thread 1-5) JBAS015950: JBoss BPM Suite 6.0.2.GA (AS 7.2.1.Final-redhat-10) stopped in 480ms

Actions: View

Attachments on bug 1091458: 889817 | 889818 | 889819