Login
[x]
Log in using an account from:
Fedora Account System
Red Hat Associate
Red Hat Customer
Or login using a Red Hat Bugzilla account
Forgot Password
Login:
Hide Forgot
Create an Account
Red Hat Bugzilla – Attachment 889817 Details for
Bug 1091458
Business-central cluster does not synchronize kdeployments
[?]
New
Simple Search
Advanced Search
My Links
Browse
Requests
Reports
Current State
Search
Tabular reports
Graphical reports
Duplicates
Other Reports
User Changes
Plotly Reports
Bug Status
Bug Severity
Non-Defaults
|
Product Dashboard
Help
Page Help!
Bug Writing Guidelines
What's new
Browser Support Policy
5.0.4.rh83 Release notes
FAQ
Guides index
User guide
Web Services
Contact
Legal
This site requires JavaScript to be enabled to function correctly, please enable it.
server log node one
server.log (text/x-log), 166.90 KB, created by
Radovan Synek
on 2014-04-25 15:45:07 UTC
(
hide
)
Description:
server log node one
Filename:
MIME Type:
Creator:
Radovan Synek
Created:
2014-04-25 15:45:07 UTC
Size:
166.90 KB
patch
obsolete
>09:55:09,016 INFO [org.jboss.modules] (main) JBoss Modules version 1.2.2.Final-redhat-1 >09:55:09,264 INFO [org.jboss.msc] (main) JBoss MSC version 1.0.4.GA-redhat-1 >09:55:09,335 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:09,342 DEBUG [org.jboss.as.config] (MSC service thread 1-7) Configured system properties: > [Host Controller] = true > [Server:server-one] = > 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-one > jboss.qualified.host.name = brmsperf05 > jboss.server.base.dir = /mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-one > jboss.server.config.dir = /mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-one/configuration > jboss.server.data.dir = /mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-one/data > jboss.server.deploy.dir = /mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-one/data/content > jboss.server.log.dir = /mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-one/log > jboss.server.name = server-one > jboss.server.persist.config = true > jboss.server.temp.dir = /mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-one/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-one/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:09,345 DEBUG [org.jboss.as.config] (MSC service thread 1-7) VM Arguments: -D[Server:server-one] -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-one/log -Djboss.server.temp.dir=/mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-one/tmp -Djboss.server.data.dir=/mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-one/data -Dorg.jboss.boot.log.file=/mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-one/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:09,431 INFO [org.xnio] (MSC service thread 1-3) XNIO Version 3.0.7.GA-redhat-1 >09:55:09,437 INFO [org.xnio.nio] (MSC service thread 1-3) XNIO NIO Implementation Version 3.0.7.GA-redhat-1 >09:55:09,445 INFO [org.jboss.remoting] (MSC service thread 1-3) JBoss Remoting version 3.2.16.GA-redhat-1 >09:55:10,693 INFO [org.jboss.as.security] (ServerService Thread Pool -- 37) JBAS013171: Activating Security Subsystem >09:55:10,694 INFO [org.jboss.as.webservices] (ServerService Thread Pool -- 33) JBAS015537: Activating WebServices Extension >09:55:10,696 INFO [org.jboss.as.security] (MSC service thread 1-6) JBAS013170: Current PicketBox version=4.0.17.SP2-redhat-2 >09:55:10,728 INFO [org.jboss.as.naming] (ServerService Thread Pool -- 42) JBAS011800: Activating Naming Subsystem >09:55:10,730 INFO [org.jboss.as.jsf] (ServerService Thread Pool -- 47) JBAS012605: Activated the following JSF Implementations: [main, 1.2] >09:55:10,737 INFO [org.jboss.as.clustering.jgroups] (ServerService Thread Pool -- 50) JBAS010260: Activating JGroups subsystem. >09:55:10,748 INFO [org.jboss.as.jacorb] (ServerService Thread Pool -- 55) JBAS016300: Activating JacORB Subsystem >09:55:10,750 INFO [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 56) JBAS010280: Activating Infinispan subsystem. >09:55:10,756 INFO [org.jboss.as.configadmin] (ServerService Thread Pool -- 60) JBAS016200: Activating ConfigAdmin Subsystem >09:55:10,781 INFO [org.jboss.as.connector.logging] (MSC service thread 1-1) JBAS010408: Starting JCA Subsystem (IronJacamar 1.0.19.Final-redhat-2) >09:55:10,792 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:10,804 INFO [org.jboss.as.naming] (MSC service thread 1-9) JBAS011802: Starting Naming Service >09:55:10,806 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:10,806 INFO [org.jboss.as.mail.extension] (MSC service thread 1-5) JBAS015400: Bound mail session [java:/mail/jbpmMailSession] >09:55:10,808 INFO [org.jboss.as.mail.extension] (MSC service thread 1-6) JBAS015400: Bound mail session [java:jboss/mail/Default] >09:55:10,828 INFO [org.jboss.jaxr] (MSC service thread 1-9) JBAS014000: Started JAXR subsystem, binding JAXR connection factory into JNDI as: java:jboss/jaxr/ConnectionFactory >09:55:10,834 INFO [org.jboss.ws.common.management] (MSC service thread 1-14) JBWS022052: Starting JBoss Web Services - Stack CXF Server 4.1.4.Final-redhat-7 >09:55:10,923 INFO [org.apache.coyote.http11] (MSC service thread 1-2) JBWEB003001: Coyote HTTP/1.1 initializing on : http-localhost/127.0.0.1:8080 >09:55:10,929 INFO [org.apache.coyote.http11] (MSC service thread 1-2) JBWEB003000: Coyote HTTP/1.1 starting on: http-localhost/127.0.0.1:8080 >09:55:10,931 INFO [org.apache.coyote.ajp] (MSC service thread 1-16) JBWEB003046: Starting Coyote AJP/1.3 on ajp-localhost/127.0.0.1:8009 >09:55:10,984 INFO [org.jboss.modcluster] (ServerService Thread Pool -- 62) MODCLUSTER000001: Initializing mod_cluster ${project.version} >09:55:11,008 INFO [org.jboss.modcluster] (ServerService Thread Pool -- 62) MODCLUSTER000032: Listening to proxy advertisements on /224.0.1.105:23364 >09:55:11,085 INFO [org.hornetq.core.server] (MSC service thread 1-4) 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-one/data/messagingjournal,bindingsDirectory=/mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-one/data/messagingbindings,largeMessagesDirectory=/mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-one/data/messaginglargemessages,pagingDirectory=/mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-one/data/messagingpaging) >09:55:11,087 INFO [org.hornetq.core.server] (MSC service thread 1-4) HQ221006: Waiting to obtain live lock >09:55:11,122 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:11,128 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:11,134 INFO [org.hornetq.core.server] (MSC service thread 1-4) HQ221013: Using NIO Journal >09:55:11,136 INFO [org.jboss.as.jacorb] (MSC service thread 1-13) JBAS016330: CORBA ORB Service started >09:55:11,195 INFO [org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-2) JBAS010400: Bound data source [java:jboss/datasources/ExampleDS] >09:55:11,196 INFO [org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-2) JBAS010400: Bound data source [java:jboss/datasources/brms-jdbc-ds] >09:55:11,196 INFO [org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-2) JBAS010400: Bound data source [java:jboss/datasources/brms-jdbc-dsQuartz] >09:55:11,236 INFO [org.jboss.as.jacorb] (MSC service thread 1-3) JBAS016328: CORBA Naming Service started >09:55:11,247 INFO [org.hornetq.core.server] (MSC service thread 1-4) HQ221034: Waiting to obtain live lock >09:55:11,248 INFO [org.hornetq.core.server] (MSC service thread 1-4) HQ221035: Live Server Obtained live lock >09:55:11,307 INFO [org.jboss.as.remoting] (MSC service thread 1-7) JBAS017100: Listening on 127.0.0.1:4447 >09:55:11,889 INFO [org.hornetq.core.server] (MSC service thread 1-4) HQ221020: Started Netty Acceptor version 3.6.6.Final-redhat-1-fd3c6b7 127.0.0.1:5445 for CORE protocol >09:55:11,891 INFO [org.hornetq.core.server] (MSC service thread 1-4) HQ221020: Started Netty Acceptor version 3.6.6.Final-redhat-1-fd3c6b7 127.0.0.1:5455 for CORE protocol >09:55:11,901 INFO [org.hornetq.core.server] (MSC service thread 1-4) HQ221007: Server is now live >09:55:11,901 INFO [org.hornetq.core.server] (MSC service thread 1-4) HQ221001: HornetQ Server version 2.3.5.Final-redhat-2 (Monster Bee, 123) [37d218fc-cc81-11e3-ac85-ebcda1137edb] >09:55:11,915 INFO [org.jboss.as.messaging] (ServerService Thread Pool -- 62) JBAS011601: Bound messaging object to jndi name java:/ConnectionFactory >09:55:11,916 INFO [org.jboss.as.messaging] (ServerService Thread Pool -- 63) JBAS011601: Bound messaging object to jndi name java:jboss/exported/jms/RemoteConnectionFactory >09:55:11,971 INFO [org.jboss.as.connector.deployment] (MSC service thread 1-10) JBAS010406: Registered connection factory java:/JmsXA >09:55:12,000 INFO [org.hornetq.ra] (MSC service thread 1-10) HornetQ resource adaptor started >09:55:12,001 INFO [org.jboss.as.connector.services.resourceadapters.ResourceAdapterActivatorService$ResourceAdapterActivator] (MSC service thread 1-10) IJ020002: Deployed: file://RaActivatorhornetq-ra >09:55:12,003 INFO [org.jboss.as.connector.deployment] (MSC service thread 1-11) JBAS010401: Bound JCA ConnectionFactory [java:/JmsXA] >09:55:12,055 INFO [org.jboss.as] (Controller Boot Thread) JBAS015874: JBoss BPM Suite 6.0.2.GA (AS 7.2.1.Final-redhat-10) started in 3511ms - Started 158 of 279 services (118 services are passive or on-demand) >09:55:13,698 INFO [org.hornetq.core.server] (Thread-5 (HornetQ-server-HornetQServerImpl::serverUUID=37d218fc-cc81-11e3-ac85-ebcda1137edb-791162793)) HQ221027: Bridge ClusterConnectionBridge@a9acf21 [name=sf.my-cluster.38d04edd-cc81-11e3-bde4-69d5bf946063, queue=QueueImpl[name=sf.my-cluster.38d04edd-cc81-11e3-bde4-69d5bf946063, postOffice=PostOfficeImpl [server=HornetQServerImpl::serverUUID=37d218fc-cc81-11e3-ac85-ebcda1137edb]]@399484f7 targetConnector=ServerLocatorImpl (identity=(Cluster-connection-bridge::ClusterConnectionBridge@a9acf21 [name=sf.my-cluster.38d04edd-cc81-11e3-bde4-69d5bf946063, queue=QueueImpl[name=sf.my-cluster.38d04edd-cc81-11e3-bde4-69d5bf946063, postOffice=PostOfficeImpl [server=HornetQServerImpl::serverUUID=37d218fc-cc81-11e3-ac85-ebcda1137edb]]@399484f7 targetConnector=ServerLocatorImpl [initialConnectors=[TransportConfiguration(name=netty, factory=org-hornetq-core-remoting-impl-netty-NettyConnectorFactory) ?port=5645&host=localhost], discoveryGroupConfiguration=null]]::ClusterConnectionImpl@50804542[nodeUUID=37d218fc-cc81-11e3-ac85-ebcda1137edb, connector=TransportConfiguration(name=netty, factory=org-hornetq-core-remoting-impl-netty-NettyConnectorFactory) ?port=5445&host=localhost, address=jms, server=HornetQServerImpl::serverUUID=37d218fc-cc81-11e3-ac85-ebcda1137edb])) [initialConnectors=[TransportConfiguration(name=netty, factory=org-hornetq-core-remoting-impl-netty-NettyConnectorFactory) ?port=5645&host=localhost], discoveryGroupConfiguration=null]] is connected >09:56:01,044 INFO [org.jboss.as.server.deployment] (MSC service thread 1-14) JBAS015876: Starting deployment of "business-central.war" (runtime-name: "business-central.war") >09:56:05,881 WARN [org.jboss.as.server.deployment] (MSC service thread 1-1) 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,881 WARN [org.jboss.as.server.deployment] (MSC service thread 1-1) 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,881 WARN [org.jboss.as.server.deployment] (MSC service thread 1-1) 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,881 WARN [org.jboss.as.server.deployment] (MSC service thread 1-1) 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,881 WARN [org.jboss.as.server.deployment] (MSC service thread 1-1) 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,882 WARN [org.jboss.as.server.deployment] (MSC service thread 1-1) 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,882 WARN [org.jboss.as.server.deployment] (MSC service thread 1-1) 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,293 INFO [org.jboss.as.jpa] (MSC service thread 1-6) JBAS011401: Read persistence.xml for org.jbpm.domain >09:56:06,777 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,777 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,778 WARN [org.jboss.as.dependency.unsupported] (MSC service thread 1-3) 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,778 WARN [org.jboss.as.dependency.unsupported] (MSC service thread 1-3) 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,781 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,781 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,783 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,783 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,786 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,787 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,787 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,787 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,787 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,787 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,790 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,790 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,791 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,791 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,801 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,801 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,803 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,803 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,804 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,804 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,807 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,807 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,808 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,808 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,808 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,808 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,809 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,810 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,810 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,810 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,811 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,811 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,811 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,812 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,812 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,812 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,812 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,812 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,815 WARN [org.jboss.as.dependency.unsupported] (MSC service thread 1-3) 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,815 WARN [org.jboss.as.dependency.unsupported] (MSC service thread 1-3) 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,821 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,821 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,821 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,822 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,822 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,822 WARN [org.jboss.as.dependency.private] (MSC service thread 1-3) 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,830 WARN [org.jboss.as.dependency.unsupported] (MSC service thread 1-3) 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,830 WARN [org.jboss.as.dependency.unsupported] (MSC service thread 1-3) 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,831 WARN [org.jboss.as.dependency.unsupported] (MSC service thread 1-3) 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,831 WARN [org.jboss.as.dependency.unsupported] (MSC service thread 1-3) 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,831 WARN [org.jboss.as.dependency.unsupported] (MSC service thread 1-3) 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,831 WARN [org.jboss.as.dependency.unsupported] (MSC service thread 1-3) 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,841 WARN [org.jboss.as.dependency.unsupported] (MSC service thread 1-3) 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,841 WARN [org.jboss.as.dependency.unsupported] (MSC service thread 1-3) 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,049 INFO [org.jboss.weld.deployer] (MSC service thread 1-8) JBAS016002: Processing weld deployment business-central.war >09:56:07,189 INFO [org.jboss.as.ejb3.deployment.processors.EjbJndiBindingsDeploymentUnitProcessor] (MSC service thread 1-8) 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,436 INFO [org.jboss.weld.deployer] (MSC service thread 1-5) JBAS016005: Starting Services for CDI deployment: business-central.war >09:56:07,486 INFO [org.jboss.weld.Version] (MSC service thread 1-5) WELD-000900 1.1.13 (redhat) >09:56:07,552 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 64) JBAS011402: Starting Persistence Unit Service 'business-central.war#org.jbpm.domain' >09:56:07,555 INFO [org.jboss.weld.deployer] (MSC service thread 1-3) JBAS016008: Starting weld service for deployment business-central.war >09:56:07,557 INFO [org.hornetq.core.server] (ServerService Thread Pool -- 67) HQ221003: trying to deploy queue jms.queue.KIE.SESSION >09:56:07,575 INFO [org.jboss.as.messaging] (ServerService Thread Pool -- 67) JBAS011601: Bound messaging object to jndi name java:jboss/exported/jms/queue/KIE.SESSION >09:56:07,576 INFO [org.jboss.as.messaging] (ServerService Thread Pool -- 67) JBAS011601: Bound messaging object to jndi name java:/queue/KIE.SESSION.ALL >09:56:07,576 INFO [org.hornetq.core.server] (ServerService Thread Pool -- 65) HQ221003: trying to deploy queue jms.queue.KIE.TASK >09:56:07,578 INFO [org.jboss.as.messaging] (ServerService Thread Pool -- 65) JBAS011601: Bound messaging object to jndi name java:jboss/exported/jms/queue/KIE.TASK >09:56:07,578 INFO [org.jboss.as.messaging] (ServerService Thread Pool -- 65) JBAS011601: Bound messaging object to jndi name java:/queue/KIE.TASK.ALL >09:56:07,578 INFO [org.hornetq.core.server] (ServerService Thread Pool -- 68) HQ221003: trying to deploy queue jms.queue.KIE.AUDIT >09:56:07,595 INFO [org.jboss.as.messaging] (ServerService Thread Pool -- 68) JBAS011601: Bound messaging object to jndi name java:jboss/exported/jms/queue/KIE.AUDIT >09:56:07,596 INFO [org.jboss.as.messaging] (ServerService Thread Pool -- 68) JBAS011601: Bound messaging object to jndi name java:/queue/KIE.AUDIT.ALL >09:56:07,603 INFO [org.hornetq.core.server] (ServerService Thread Pool -- 66) HQ221003: trying to deploy queue jms.queue.KIE.RESPONSE >09:56:07,605 INFO [org.jboss.as.messaging] (ServerService Thread Pool -- 66) JBAS011601: Bound messaging object to jndi name java:jboss/exported/jms/queue/KIE.RESPONSE >09:56:07,605 INFO [org.jboss.as.messaging] (ServerService Thread Pool -- 66) JBAS011601: Bound messaging object to jndi name java:/queue/KIE.RESPONSE.ALL >09:56:07,626 INFO [org.jboss.as.ejb3] (MSC service thread 1-7) JBAS014142: Started message driven bean 'JMSAuditProcessor' with 'hornetq-ra' resource adapter >09:56:07,627 INFO [org.jboss.as.ejb3] (MSC service thread 1-2) JBAS014142: Started message driven bean 'TaskServiceRequesMessageBean' with 'hornetq-ra' resource adapter >09:56:07,628 INFO [org.jboss.as.ejb3] (MSC service thread 1-9) JBAS014142: Started message driven bean 'KieSessionRequesMessageBean' with 'hornetq-ra' resource adapter >09:56:07,707 INFO [org.hibernate.annotations.common.Version] (ServerService Thread Pool -- 64) HCANN000001: Hibernate Commons Annotations {4.0.1.Final-redhat-2} >09:56:07,712 INFO [org.hibernate.Version] (ServerService Thread Pool -- 64) HHH000412: Hibernate Core {4.2.0.SP1-redhat-1} >09:56:07,714 INFO [org.hibernate.cfg.Environment] (ServerService Thread Pool -- 64) HHH000206: hibernate.properties not found >09:56:07,716 INFO [org.hibernate.cfg.Environment] (ServerService Thread Pool -- 64) HHH000021: Bytecode provider name : javassist >09:56:07,738 INFO [org.hibernate.ejb.Ejb3Configuration] (ServerService Thread Pool -- 64) HHH000204: Processing PersistenceUnitInfo [ > name: org.jbpm.domain > ...] >09:56:08,767 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,289 INFO [org.hibernate.dialect.Dialect] (ServerService Thread Pool -- 64) HHH000400: Using dialect: org.hibernate.dialect.PostgreSQL82Dialect >09:56:09,367 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,379 INFO [org.hibernate.engine.transaction.internal.TransactionFactoryInitiator] (ServerService Thread Pool -- 64) HHH000268: Transaction strategy: org.hibernate.engine.transaction.internal.jta.CMTTransactionFactory >09:56:09,383 INFO [org.hibernate.hql.internal.ast.ASTQueryTranslatorFactory] (ServerService Thread Pool -- 64) HHH000397: Using ASTQueryTranslatorFactory >09:56:09,426 INFO [org.hibernate.validator.internal.util.Version] (ServerService Thread Pool -- 64) HV000001: Hibernate Validator 4.3.1.Final-redhat-1 >09:56:10,038 INFO [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000228: Running hbm2ddl schema update >09:56:10,038 INFO [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000102: Fetching database metadata >09:56:10,048 INFO [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000396: Updating schema >09:56:10,055 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Attachment >09:56:10,059 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: BAMTaskSummary >09:56:10,062 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: BooleanExpression >09:56:10,067 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Content >09:56:10,070 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: ContextMappingInfo >09:56:10,074 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: CorrelationKeyInfo >09:56:10,078 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: CorrelationPropertyInfo >09:56:10,081 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Deadline >09:56:10,084 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Delegation_delegates >09:56:10,088 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: ErrorInfo >09:56:10,091 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Escalation >09:56:10,093 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: EventTypes >09:56:10,096 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: I18NText >09:56:10,099 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: NodeInstanceLog >09:56:10,102 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Notification >09:56:10,105 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Notification_BAs >09:56:10,109 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Notification_Recipients >09:56:10,112 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Notification_email_header >09:56:10,115 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: OrganizationalEntity >09:56:10,119 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: PeopleAssignments_BAs >09:56:10,122 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: PeopleAssignments_ExclOwners >09:56:10,126 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: PeopleAssignments_PotOwners >09:56:10,128 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: PeopleAssignments_Recipients >09:56:10,131 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: PeopleAssignments_Stakeholders >09:56:10,133 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: ProcessInstanceInfo >09:56:10,135 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: ProcessInstanceLog >09:56:10,138 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Reassignment >09:56:10,141 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Reassignment_potentialOwners >09:56:10,143 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: RequestInfo >09:56:10,145 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: SessionInfo >09:56:10,148 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Task >09:56:10,151 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: TaskDef >09:56:10,153 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: TaskEvent >09:56:10,156 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: VariableInstanceLog >09:56:10,159 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: WorkItemInfo >09:56:10,162 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: email_header >09:56:10,165 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: task_comment >09:56:10,168 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Attachment >09:56:10,170 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: BAMTaskSummary >09:56:10,174 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: BooleanExpression >09:56:10,177 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Content >09:56:10,180 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: ContextMappingInfo >09:56:10,184 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: CorrelationKeyInfo >09:56:10,186 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: CorrelationPropertyInfo >09:56:10,189 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Deadline >09:56:10,191 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Delegation_delegates >09:56:10,194 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: ErrorInfo >09:56:10,196 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Escalation >09:56:10,199 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: EventTypes >09:56:10,201 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: I18NText >09:56:10,205 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: NodeInstanceLog >09:56:10,209 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Notification >09:56:10,212 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Notification_BAs >09:56:10,215 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Notification_Recipients >09:56:10,219 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Notification_email_header >09:56:10,221 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: OrganizationalEntity >09:56:10,223 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: PeopleAssignments_BAs >09:56:10,225 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: PeopleAssignments_ExclOwners >09:56:10,228 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: PeopleAssignments_PotOwners >09:56:10,231 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: PeopleAssignments_Recipients >09:56:10,233 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: PeopleAssignments_Stakeholders >09:56:10,235 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: ProcessInstanceInfo >09:56:10,238 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: ProcessInstanceLog >09:56:10,239 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Reassignment >09:56:10,241 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Reassignment_potentialOwners >09:56:10,244 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: RequestInfo >09:56:10,246 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: SessionInfo >09:56:10,249 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: Task >09:56:10,251 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: TaskDef >09:56:10,253 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: TaskEvent >09:56:10,255 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: VariableInstanceLog >09:56:10,258 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: WorkItemInfo >09:56:10,260 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: email_header >09:56:10,262 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: task_comment >09:56:10,266 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: ATTACHMENT_ID_SEQ >09:56:10,269 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: BAM_TASK_ID_SEQ >09:56:10,271 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: BOOLEANEXPR_ID_SEQ >09:56:10,273 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: COMMENT_ID_SEQ >09:56:10,275 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: CONTENT_ID_SEQ >09:56:10,278 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: CONTEXT_MAPPING_INFO_ID_SEQ >09:56:10,280 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: CORRELATION_KEY_ID_SEQ >09:56:10,283 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: CORRELATION_PROP_ID_SEQ >09:56:10,286 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: DEADLINE_ID_SEQ >09:56:10,289 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: EMAILNOTIFHEAD_ID_SEQ >09:56:10,292 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: ERROR_INFO_ID_SEQ >09:56:10,295 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: ESCALATION_ID_SEQ >09:56:10,297 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: I18NTEXT_ID_SEQ >09:56:10,300 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: NODE_INST_LOG_ID_SEQ >09:56:10,303 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: NOTIFICATION_ID_SEQ >09:56:10,306 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: PROCESS_INSTANCE_INFO_ID_SEQ >09:56:10,309 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: PROC_INST_LOG_ID_SEQ >09:56:10,311 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: REASSIGNMENT_ID_SEQ >09:56:10,314 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: REQUEST_INFO_ID_SEQ >09:56:10,317 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: SESSIONINFO_ID_SEQ >09:56:10,320 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: TASK_DEF_ID_SEQ >09:56:10,322 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: TASK_EVENT_ID_SEQ >09:56:10,325 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: TASK_ID_SEQ >09:56:10,328 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: VAR_INST_LOG_ID_SEQ >09:56:10,330 INFO [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 64) HHH000262: Table not found: WORKITEMINFO_ID_SEQ >09:56:11,884 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table PeopleAssignments_ExclOwners add constraint FK_pth28a73rj6bxtlfc69kmqo0a foreign key (entity_id) references OrganizationalEntity >09:56:11,884 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_pth28a73rj6bxtlfc69kmqo0a" for relation "peopleassignments_exclowners" already exists >09:56:11,890 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table PeopleAssignments_ExclOwners add constraint FK_b8owuxfrdng050ugpk0pdowa7 foreign key (task_id) references Task >09:56:11,890 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_b8owuxfrdng050ugpk0pdowa7" for relation "peopleassignments_exclowners" already exists >09:56:11,896 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table PeopleAssignments_PotOwners add constraint FK_tee3ftir7xs6eo3fdvi3xw026 foreign key (entity_id) references OrganizationalEntity >09:56:11,896 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_tee3ftir7xs6eo3fdvi3xw026" for relation "peopleassignments_potowners" already exists >09:56:11,903 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table PeopleAssignments_PotOwners add constraint FK_4dv2oji7pr35ru0w45trix02x foreign key (task_id) references Task >09:56:11,905 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_4dv2oji7pr35ru0w45trix02x" for relation "peopleassignments_potowners" already exists >09:56:11,908 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table PeopleAssignments_Recipients add constraint FK_4g7y3wx6gnokf6vycgpxs83d6 foreign key (entity_id) references OrganizationalEntity >09:56:11,909 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_4g7y3wx6gnokf6vycgpxs83d6" for relation "peopleassignments_recipients" already exists >09:56:11,914 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table PeopleAssignments_Recipients add constraint FK_enhk831fghf6akjilfn58okl4 foreign key (task_id) references Task >09:56:11,914 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_enhk831fghf6akjilfn58okl4" for relation "peopleassignments_recipients" already exists >09:56:11,920 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table PeopleAssignments_Stakeholders add constraint FK_met63inaep6cq4ofb3nnxi4tm foreign key (entity_id) references OrganizationalEntity >09:56:11,920 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_met63inaep6cq4ofb3nnxi4tm" for relation "peopleassignments_stakeholders" already exists >09:56:11,926 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table PeopleAssignments_Stakeholders add constraint FK_4bh3ay74x6ql9usunubttfdf1 foreign key (task_id) references Task >09:56:11,927 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_4bh3ay74x6ql9usunubttfdf1" for relation "peopleassignments_stakeholders" already exists >09:56:11,932 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table Reassignment add constraint FK_pnpeue9hs6kx2ep0sp16b6kfd foreign key (Escalation_Reassignments_Id) references Escalation >09:56:11,932 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_pnpeue9hs6kx2ep0sp16b6kfd" for relation "reassignment" already exists >09:56:11,938 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table Reassignment_potentialOwners add constraint FK_8frl6la7tgparlnukhp8xmody foreign key (entity_id) references OrganizationalEntity >09:56:11,938 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_8frl6la7tgparlnukhp8xmody" for relation "reassignment_potentialowners" already exists >09:56:11,944 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table Reassignment_potentialOwners add constraint FK_qbega5ncu6b9yigwlw55aeijn foreign key (task_id) references Reassignment >09:56:11,945 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_qbega5ncu6b9yigwlw55aeijn" for relation "reassignment_potentialowners" already exists >09:56:11,951 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table Task add constraint FK_dpk0f9ucm14c78bsxthh7h8yh foreign key (taskInitiator_id) references OrganizationalEntity >09:56:11,951 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_dpk0f9ucm14c78bsxthh7h8yh" for relation "task" already exists >09:56:11,957 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table Task add constraint FK_nh9nnt47f3l61qjlyedqt05rf foreign key (actualOwner_id) references OrganizationalEntity >09:56:11,957 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_nh9nnt47f3l61qjlyedqt05rf" for relation "task" already exists >09:56:11,963 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table Task add constraint FK_k02og0u71obf1uxgcdjx9rcjc foreign key (createdBy_id) references OrganizationalEntity >09:56:11,963 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_k02og0u71obf1uxgcdjx9rcjc" for relation "task" already exists >09:56:11,969 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table task_comment add constraint FK_aax378yjnsmw9kb9vsu994jjv foreign key (addedBy_id) references OrganizationalEntity >09:56:11,969 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_aax378yjnsmw9kb9vsu994jjv" for relation "task_comment" already exists >09:56:11,975 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: alter table task_comment add constraint FK_1ws9jdmhtey6mxu7jb0r0ufvs foreign key (TaskData_Comments_Id) references Task >09:56:11,975 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) ERROR: constraint "fk_1ws9jdmhtey6mxu7jb0r0ufvs" for relation "task_comment" already exists >09:56:11,981 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create sequence ATTACHMENT_ID_SEQ >09:56:11,981 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_id_seq, 2200) already exists. >09:56:11,987 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create sequence BAM_TASK_ID_SEQ >09:56:11,987 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)=(bam_task_id_seq, 2200) already exists. >09:56:11,993 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create sequence BOOLEANEXPR_ID_SEQ >09:56:11,993 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)=(booleanexpr_id_seq, 2200) already exists. >09:56:11,999 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create sequence COMMENT_ID_SEQ >09:56:11,999 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)=(comment_id_seq, 2200) already exists. >09:56:12,005 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create sequence CONTENT_ID_SEQ >09:56:12,005 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_id_seq, 2200) already exists. >09:56:12,011 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create sequence CONTEXT_MAPPING_INFO_ID_SEQ >09:56:12,011 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)=(context_mapping_info_id_seq, 2200) already exists. >09:56:12,017 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create sequence CORRELATION_KEY_ID_SEQ >09:56:12,017 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)=(correlation_key_id_seq, 2200) already exists. >09:56:12,023 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create sequence CORRELATION_PROP_ID_SEQ >09:56:12,023 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)=(correlation_prop_id_seq, 2200) already exists. >09:56:12,029 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create sequence DEADLINE_ID_SEQ >09:56:12,029 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_id_seq, 2200) already exists. >09:56:12,035 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create sequence EMAILNOTIFHEAD_ID_SEQ >09:56:12,036 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)=(emailnotifhead_id_seq, 2200) already exists. >09:56:12,041 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create sequence ERROR_INFO_ID_SEQ >09:56:12,041 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)=(error_info_id_seq, 2200) already exists. >09:56:12,047 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create sequence ESCALATION_ID_SEQ >09:56:12,048 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_id_seq, 2200) already exists. >09:56:12,053 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create sequence I18NTEXT_ID_SEQ >09:56:12,054 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_id_seq, 2200) already exists. >09:56:12,060 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create sequence NODE_INST_LOG_ID_SEQ >09:56:12,060 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)=(node_inst_log_id_seq, 2200) already exists. >09:56:12,066 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create sequence NOTIFICATION_ID_SEQ >09:56:12,066 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_id_seq, 2200) already exists. >09:56:12,072 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create sequence PROCESS_INSTANCE_INFO_ID_SEQ >09:56:12,072 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)=(process_instance_info_id_seq, 2200) already exists. >09:56:12,078 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create sequence PROC_INST_LOG_ID_SEQ >09:56:12,078 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)=(proc_inst_log_id_seq, 2200) already exists. >09:56:12,084 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create sequence REASSIGNMENT_ID_SEQ >09:56:12,084 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_id_seq, 2200) already exists. >09:56:12,090 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create sequence REQUEST_INFO_ID_SEQ >09:56:12,090 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)=(request_info_id_seq, 2200) already exists. >09:56:12,096 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create sequence SESSIONINFO_ID_SEQ >09:56:12,096 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_id_seq, 2200) already exists. >09:56:12,102 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create sequence TASK_DEF_ID_SEQ >09:56:12,102 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_def_id_seq, 2200) already exists. >09:56:12,114 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create sequence TASK_EVENT_ID_SEQ >09:56:12,114 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_event_id_seq, 2200) already exists. >09:56:12,120 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create sequence TASK_ID_SEQ >09:56:12,120 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_id_seq, 2200) already exists. >09:56:12,126 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create sequence VAR_INST_LOG_ID_SEQ >09:56:12,126 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)=(var_inst_log_id_seq, 2200) already exists. >09:56:12,132 ERROR [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000388: Unsuccessful: create sequence WORKITEMINFO_ID_SEQ >09:56:12,132 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_id_seq, 2200) already exists. >09:56:12,132 INFO [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 64) HHH000232: Schema update complete >09:56:13,512 INFO [org.jboss.solder.config.xml.bootstrap.XmlConfigExtension] (MSC service thread 1-14) Solder Config XML provider starting... >09:56:13,514 INFO [org.jboss.solder.config.xml.bootstrap.XmlConfigExtension] (MSC service thread 1-14) Loading XmlDocumentProvider: org.jboss.solder.config.xml.bootstrap.ResourceLoaderXmlDocumentProvider >09:56:13,528 INFO [org.jboss.solder.config.xml.bootstrap.XmlConfigExtension] (MSC service thread 1-14) 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,535 INFO [org.jboss.solder.config.xml.bootstrap.XmlConfigExtension] (MSC service thread 1-14) 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,537 INFO [org.jboss.solder.config.xml.bootstrap.XmlConfigExtension] (MSC service thread 1-14) 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,539 INFO [org.jboss.solder.config.xml.bootstrap.XmlConfigExtension] (MSC service thread 1-14) 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,540 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) starting errai cdi ... >09:56:13,551 INFO [org.jboss.solder.Version] (MSC service thread 1-14) Solder 3.2.1.Final (build id: 3.2.1.Final) >09:56:13,664 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @SessionScoped class org.jbpm.formModeler.renderer.backend.service.FormRenderingServiceImpl >09:56:13,672 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.jbpm.formModeler.renderer.backend.service.FormRendererIncluderServiceImpl >09:56:13,748 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.drools.workbench.screens.testscenario.backend.server.ScenarioTestEditorServiceImpl >09:56:13,772 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.jbpm.console.ng.es.backend.server.ExecutorServiceEntryPointImpl >09:56:13,821 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.drools.workbench.screens.drltext.backend.server.DRLTextEditorServiceImpl >09:56:13,912 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.kie.workbench.common.screens.projecteditor.backend.server.ProjectScreenServiceImpl >09:56:14,708 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.drools.workbench.screens.globals.backend.server.GlobalsEditorServiceImpl >09:56:14,726 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.jbpm.console.ng.ht.backend.server.FormModelerProcessStarterEntryPointImpl >09:56:14,730 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.jbpm.console.ng.ht.backend.server.TypeRoleServiceEntryPointImpl >09:56:14,742 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.jbpm.console.ng.ht.backend.server.TaskServiceEntryPointImpl >09:56:14,752 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.jbpm.console.ng.ht.backend.server.FormServiceEntryPointImpl >09:56:14,756 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.jbpm.console.ng.ht.backend.server.UserServiceEntryPointImpl >09:56:14,794 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.drools.workbench.screens.workitems.backend.server.WorkItemsEditorServiceImpl >09:56:14,818 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.kie.workbench.common.services.backend.source.SourceServicesImpl >09:56:14,834 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.kie.workbench.common.services.backend.rulename.RuleNameServiceImpl >09:56:14,838 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.kie.workbench.common.services.backend.security.KieWorkbenchSecurityServiceImpl >09:56:14,843 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.kie.workbench.common.services.backend.validation.ValidationServiceImpl >09:56:14,868 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.jbpm.formModeler.panels.modeler.backend.FormModelerServiceImpl >09:56:15,337 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.jbpm.console.ng.bd.backend.server.DataServiceEntryPointImpl >09:56:15,340 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.jbpm.console.ng.bd.backend.server.KieSessionEntryPointImpl >09:56:15,368 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.jbpm.console.ng.bd.backend.server.DeploymentManagerEntryPointImpl >09:56:15,736 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.kie.workbench.common.screens.search.backend.server.SearchServiceImpl >09:56:15,763 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.drools.workbench.screens.scorecardxls.backend.server.ScoreCardXLSServiceImpl >09:56:16,000 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.drools.workbench.screens.dsltext.backend.server.DSLTextEditorServiceImpl >09:56:16,011 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.uberfire.backend.server.FileNavigatorServiceImpl >09:56:16,029 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.uberfire.backend.server.WorkbenchServicesImpl >09:56:16,068 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.uberfire.backend.server.VFSServicesServerImpl >09:56:16,098 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.uberfire.backend.server.plugin.RuntimePluginsServiceServerImpl >09:56:16,101 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.uberfire.backend.server.repositories.RepositoryServiceEditorImpl >09:56:16,110 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.uberfire.backend.server.organizationalunit.OrganizationalUnitServiceImpl >09:56:16,114 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.uberfire.backend.server.repositories.RepositoryServiceImpl >09:56:16,227 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.drools.workbench.screens.guided.template.server.GuidedRuleTemplateEditorServiceImpl >09:56:16,545 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.jbpm.designer.server.service.DefaultDesignerAssetService >09:56:16,731 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.jbpm.dashboard.renderer.service.impl.DashboardRendererServiceImpl >09:56:16,895 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.drools.workbench.screens.enums.backend.server.EnumServiceImpl >09:56:16,921 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.guvnor.common.services.builder.BuildServiceImpl >09:56:16,961 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.guvnor.common.services.project.backend.server.ProjectServiceImpl >09:56:16,963 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.guvnor.common.services.project.backend.server.KModuleServiceImpl >09:56:16,970 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.guvnor.common.services.project.backend.server.POMServiceImpl >09:56:17,008 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.kie.workbench.common.services.datamodel.backend.server.IncrementalDataModelServiceImpl >09:56:17,027 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.guvnor.inbox.backend.server.InboxServiceImpl >09:56:17,051 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.drools.workbench.screens.guided.dtable.backend.server.GuidedDecisionTableEditorServiceImpl >09:56:17,066 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.drools.workbench.screens.guided.scorecard.backend.server.GuidedScoreCardEditorServiceImpl >09:56:17,112 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.guvnor.common.services.backend.config.ResourceConfigServiceImpl >09:56:17,119 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.guvnor.common.services.backend.version.VersionServiceImpl >09:56:17,132 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service class org.guvnor.common.services.backend.file.RenameServiceImpl >09:56:17,137 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.guvnor.common.services.backend.metadata.MetadataServiceImpl >09:56:17,140 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service class org.guvnor.common.services.backend.file.CopyServiceImpl >09:56:17,142 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.guvnor.common.services.backend.config.AppConfigServiceImpl >09:56:17,149 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service class org.guvnor.common.services.backend.file.DeleteServiceImpl >09:56:17,161 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.guvnor.common.services.backend.metadata.CategoryServiceImpl >09:56:17,200 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.kie.workbench.common.screens.datamodeller.backend.server.DataModelerServiceImpl >09:56:17,240 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.kie.workbench.common.screens.defaulteditor.backend.server.DefaultEditorServiceImpl >09:56:17,285 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.drools.workbench.screens.dtablexls.backend.server.DecisionTableXLSServiceImpl >09:56:17,393 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.drools.workbench.screens.guided.rule.backend.server.GuidedRuleEditorServiceImpl >09:56:17,405 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.drools.workbench.screens.guided.rule.backend.server.EnumDropdownServiceImpl >09:56:17,508 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.kie.workbench.common.screens.explorer.backend.server.ExplorerServiceImpl >09:56:17,885 INFO [org.jboss.errai.common.metadata.MetaDataScanner] (Thread-96) added class scanning extensions: org.jboss.errai.common.metadata.JbossVFsTypeHandler >09:56:18,863 INFO [org.jboss.errai.reflections.Reflections] (Thread-96) Reflections took 975 ms to scan 95 urls, producing 2714 keys and 16640 values [using 2 cores] >09:56:19,421 INFO [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-14) discovered errai service: public@Service @ApplicationScoped class org.guvnor.m2repo.backend.server.M2RepoServiceImpl >09:56:19,547 INFO [org.drools.compiler.kie.builder.impl.ClasspathKieProject] (MSC service thread 1-14) 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,548 INFO [org.drools.compiler.kie.builder.impl.ClasspathKieProject] (MSC service thread 1-14) Virtual file physical path = /mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/domain/servers/server-one/tmp/vfs/deployment230c79f908e83d71/drools-wb-rest-defaultapprover-6.0.3-redhat-1.jar-bec3f8dc6bb7bf2c/drools-wb-rest-defaultapprover-6.0.3-redhat-1.jar >09:56:19,591 INFO [org.drools.compiler.kie.builder.impl.KieRepositoryImpl] (MSC service thread 1-14) 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-one/tmp/vfs/deployment230c79f908e83d71/drools-wb-rest-defaultapprover-6.0.3-redhat-1.jar-bec3f8dc6bb7bf2c/drools-wb-rest-defaultapprover-6.0.3-redhat-1.jar] >09:56:21,465 WARN [org.jboss.weld.Bootstrap] (MSC service thread 1-14) WELD-001440 Scope type @javax.enterprise.context.RequestScoped() used on injection point [field] @Inject @Named @RequestScoped private org.jbpm.console.ng.bd.backend.server.DeploymentManagerEntryPointImpl.deploymentUnits >09:56:21,503 WARN [org.jboss.weld.Bootstrap] (MSC service thread 1-14) 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,519 WARN [org.jboss.weld.Bootstrap] (MSC service thread 1-14) 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:21,558 WARN [org.jboss.weld.Bootstrap] (MSC service thread 1-14) 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:21,633 WARN [org.jboss.weld.Bootstrap] (MSC service thread 1-14) 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,633 WARN [org.jboss.weld.Bootstrap] (MSC service thread 1-14) 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,717 INFO [org.apache.helix.controller.GenericHelixController] (MSC service thread 1-14) createDefaultRegistry >09:56:21,730 INFO [org.apache.helix.manager.zk.ZKHelixManager] (MSC service thread 1-14) Create a zk-based cluster manager. zkSvr: localhost:2181, clusterName: bpms-cluster, instanceName: nodeOne_12345, type: PARTICIPANT >09:56:21,732 INFO [org.apache.helix.HelixManagerProperties] (MSC service thread 1-14) 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:21,741 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (MSC service thread 1-14) Added msg-factory for type: TASK_REPLY, threadpool size 40 >09:56:21,775 INFO [org.apache.sshd.common.util.SecurityUtils] (MSC service thread 1-14) BouncyCastle not registered, using the default JCE provider >09:56:22,350 INFO [org.guvnor.m2repo.backend.server.GuvnorM2Repository] (MSC service thread 1-14) Maven Repository root set to: repositories/kie >09:56:22,350 INFO [org.guvnor.m2repo.backend.server.GuvnorM2Repository] (MSC service thread 1-14) Creating Maven Repository root: repositories/kie >09:56:22,521 INFO [org.guvnor.common.services.backend.config.ApplicationPreferencesLoader] (MSC service thread 1-14) Setting preference 'type' to 'kjar'. >09:56:22,521 INFO [org.guvnor.common.services.backend.config.ApplicationPreferencesLoader] (MSC service thread 1-14) Setting preference 'drools.dateformat' to 'dd-MMM-yyyy'. >09:56:22,521 INFO [org.guvnor.common.services.backend.config.ApplicationPreferencesLoader] (MSC service thread 1-14) Setting preference 'drools.defaultlanguage' to 'en'. >09:56:22,521 INFO [org.guvnor.common.services.backend.config.ApplicationPreferencesLoader] (MSC service thread 1-14) Setting preference 'rule-modeller-onlyShowDSLStatements' to 'false'. >09:56:22,521 INFO [org.guvnor.common.services.backend.config.ApplicationPreferencesLoader] (MSC service thread 1-14) Setting preference 'designer.context' to 'designer'. >09:56:22,521 INFO [org.guvnor.common.services.backend.config.ApplicationPreferencesLoader] (MSC service thread 1-14) Setting preference 'drools.defaultcountry' to 'US'. >09:56:22,521 INFO [org.guvnor.common.services.backend.config.ApplicationPreferencesLoader] (MSC service thread 1-14) Setting preference 'drools.datetimeformat' to 'dd-MMM-yyyy hh:mm:ss'. >09:56:22,521 INFO [org.guvnor.common.services.backend.config.ApplicationPreferencesLoader] (MSC service thread 1-14) Setting preference 'build.enable-incremental' to 'true'. >09:56:22,522 INFO [org.guvnor.common.services.backend.config.ApplicationPreferencesLoader] (MSC service thread 1-14) Setting preference 'designer.profile' to 'jbpm'. >09:56:22,528 INFO [org.apache.helix.manager.zk.ZKHelixManager] (MSC service thread 1-14) ClusterManager.connect() >09:56:22,540 INFO [org.I0Itec.zkclient.ZkEventThread] (ZkClient-EventThread-200-localhost:2181) Starting ZkClient event thread. >09:56:22,545 INFO [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-14) Client environment:zookeeper.version=3.3.3-1203054, built on 11/17/2011 05:47 GMT >09:56:22,546 INFO [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-14) Client environment:host.name=brmsperf05.mw.lab.eng.bos.redhat.com >09:56:22,546 INFO [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-14) Client environment:java.version=1.7.0_51 >09:56:22,546 INFO [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-14) Client environment:java.vendor=Oracle Corporation >09:56:22,546 INFO [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-14) Client environment:java.home=/qa/tools/opt/x86_64/jdk1.7.0_51/jre >09:56:22,546 INFO [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-14) Client environment:java.class.path=/mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1/jboss-modules.jar >09:56:22,546 INFO [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-14) 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:22,546 INFO [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-14) Client environment:java.io.tmpdir=/mnt/hudson_workspace/workspace/bpms-clustering-smoke/tmp >09:56:22,546 INFO [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-14) Client environment:java.compiler=<NA> >09:56:22,546 INFO [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-14) Client environment:os.name=Linux >09:56:22,546 INFO [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-14) Client environment:os.arch=amd64 >09:56:22,547 INFO [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-14) Client environment:os.version=2.6.32-358.23.2.el6.x86_64 >09:56:22,547 INFO [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-14) Client environment:user.name=hudson >09:56:22,547 INFO [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-14) Client environment:user.home=/home/hudson >09:56:22,547 INFO [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-14) Client environment:user.dir=/mnt/hudson_workspace/workspace/bpms-clustering-smoke/jboss-eap-6.1 >09:56:22,548 INFO [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-14) Initiating client connection, connectString=localhost:2181 sessionTimeout=30000 watcher=org.apache.helix.manager.zk.ZkClient@58053c9d >09:56:22,559 INFO [org.apache.zookeeper.ClientCnxn] (MSC service thread 1-14-SendThread()) Opening socket connection to server localhost/127.0.0.1:2181 >09:56:22,560 INFO [org.apache.zookeeper.ClientCnxn] (MSC service thread 1-14-SendThread(localhost:2181)) Socket connection established to localhost/127.0.0.1:2181, initiating session >09:56:22,573 INFO [org.apache.zookeeper.ClientCnxn] (MSC service thread 1-14-SendThread(localhost:2181)) Session establishment complete on server localhost/127.0.0.1:2181, sessionid = 0x145992ad1fb0006, negotiated timeout = 30000 >09:56:22,574 INFO [org.I0Itec.zkclient.ZkClient] (MSC service thread 1-14-EventThread) zookeeper state changed (SyncConnected) >09:56:22,584 INFO [org.apache.helix.manager.zk.ZKHelixManager] (MSC service thread 1-14) KeeperState: SyncConnected, zookeeper:State:CONNECTED Timeout:30000 sessionid:0x145992ad1fb0006 local:/127.0.0.1:34258 remoteserver:localhost/127.0.0.1:2181 lastZxid:0 xid:1 sent:1 recv:1 queuedpkts:0 pendingresp:0 queuedevents:0 >09:56:22,584 INFO [org.apache.helix.manager.zk.ZKHelixManager] (MSC service thread 1-14) Handling new session, session id: 145992ad1fb0006, instance: nodeOne_12345, instanceTye: PARTICIPANT, cluster: bpms-cluster, zkconnection: State:CONNECTED Timeout:30000 sessionid:0x145992ad1fb0006 local:/127.0.0.1:34258 remoteserver:localhost/127.0.0.1:2181 lastZxid:0 xid:1 sent:1 recv:1 queuedpkts:0 pendingresp:0 queuedevents:0 >09:56:22,584 WARN [org.apache.helix.healthcheck.ParticipantHealthReportTask] (MSC service thread 1-14) ParticipantHealthReportTimerTask already stopped >09:56:22,646 INFO [org.apache.helix.manager.zk.ParticipantManagerHelper] (MSC service thread 1-14) instance: nodeOne_12345 auto-joining bpms-cluster is false >09:56:22,669 INFO [org.apache.helix.messaging.DefaultMessagingService] (MSC service thread 1-14) registering msg factory for type STATE_TRANSITION >09:56:22,685 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (MSC service thread 1-14) Added msg-factory for type: STATE_TRANSITION, threadpool size 40 >09:56:22,740 INFO [org.apache.helix.manager.zk.CallbackHandler] (MSC service thread 1-14) 24 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:56:22,741 INFO [org.apache.helix.manager.zk.CallbackHandler] (MSC service thread 1-14) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:56:22,751 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (MSC service thread 1-14) Dropping NO-OP message. mid: 49921778-9ded-46fa-82f1-3035b5077c35, from: nodeOne_12345 >09:56:22,758 WARN [org.apache.helix.participant.HelixStateMachineEngine] (MSC service thread 1-14) Fail to create msg-handler because cannot find stateModelFactory for model: LeaderStandby using factoryName: DEFAULT for resource: vfs-repo >09:56:22,758 INFO [org.apache.helix.manager.zk.CallbackHandler] (MSC service thread 1-14) 24 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 18ms >09:56:22,758 INFO [org.apache.helix.manager.zk.ZKHelixManager] (MSC service thread 1-14) Added listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 for type: MESSAGES to path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES >09:56:22,758 INFO [org.apache.helix.manager.zk.CallbackHandler] (MSC service thread 1-14) 24 START:INVOKE /bpms-cluster/CONTROLLER listener:org.apache.helix.manager.zk.ZKHelixDataAccessor >09:56:22,758 INFO [org.apache.helix.manager.zk.CallbackHandler] (MSC service thread 1-14) nodeOne_12345 subscribes child-change. path: /bpms-cluster/CONTROLLER, listener: org.apache.helix.manager.zk.ZKHelixDataAccessor@282084c4 >09:56:22,760 INFO [org.apache.helix.manager.zk.ZKHelixDataAccessor] (MSC service thread 1-14) Controller has changed >09:56:22,765 INFO [org.apache.helix.manager.zk.ZKHelixDataAccessor] (MSC service thread 1-14) _zkPropertyTransferSvcUrl : null Controller brmsperf05.mw.lab.eng.bos.redhat.com-CONTROLLER >09:56:22,765 INFO [org.apache.helix.manager.zk.CallbackHandler] (MSC service thread 1-14) 24 END:INVOKE /bpms-cluster/CONTROLLER listener:org.apache.helix.manager.zk.ZKHelixDataAccessor Took: 7ms >09:56:22,765 INFO [org.apache.helix.manager.zk.ZKHelixManager] (MSC service thread 1-14) Added listener: org.apache.helix.manager.zk.ZKHelixDataAccessor@282084c4 for type: CONTROLLER to path: /bpms-cluster/CONTROLLER >09:56:22,765 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:56:22,766 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:56:22,767 INFO [org.apache.helix.participant.HelixStateMachineEngine] (MSC service thread 1-14) Register state model factory for state model SchedulerTaskQueue using factory name DEFAULT with org.apache.helix.participant.statemachine.ScheduledTaskStateModelFactory@18d76539 >09:56:22,780 INFO [org.apache.helix.participant.HelixStateMachineEngine] (MSC service thread 1-14) Send NO_OP message to nodeOne_12345, msgId: 7934973e-ea52-4c80-92fe-3930b41f711c >09:56:22,781 WARN [org.apache.helix.participant.HelixStateMachineEngine] (ZkClient-EventThread-200-localhost:2181) Fail to create msg-handler because cannot find stateModelFactory for model: LeaderStandby using factoryName: DEFAULT for resource: vfs-repo >09:56:22,782 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 17ms >09:56:22,786 INFO [org.apache.helix.manager.zk.ParticipantManagerHelper] (MSC service thread 1-14) Created healthcheck info path /bpms-cluster/INSTANCES/nodeOne_12345/HEALTHREPORT >09:56:22,786 INFO [org.apache.helix.healthcheck.ParticipantHealthReportTask] (MSC service thread 1-14) Start HealthCheckInfoReportingTask >09:56:22,787 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:56:22,787 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:56:22,790 WARN [org.apache.helix.participant.HelixStateMachineEngine] (ZkClient-EventThread-200-localhost:2181) Fail to create msg-handler because cannot find stateModelFactory for model: LeaderStandby using factoryName: DEFAULT for resource: vfs-repo >09:56:22,790 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Dropping NO-OP message. mid: 7934973e-ea52-4c80-92fe-3930b41f711c, from: nodeOne_12345 >09:56:22,798 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 12ms >09:56:22,798 WARN [org.apache.helix.manager.zk.CallbackHandler] (MSC service thread 1-14) Skip processing callbacks for listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787, path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, expected types: [CALLBACK, FINALIZE] but was INIT >09:56:22,798 INFO [org.apache.helix.manager.zk.ZKHelixManager] (MSC service thread 1-14) init handler: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:56:22,798 WARN [org.apache.helix.manager.zk.CallbackHandler] (MSC service thread 1-14) Skip processing callbacks for listener: org.apache.helix.manager.zk.ZKHelixDataAccessor@282084c4, path: /bpms-cluster/CONTROLLER, expected types: [CALLBACK, FINALIZE] but was INIT >09:56:22,798 INFO [org.apache.helix.manager.zk.ZKHelixManager] (MSC service thread 1-14) init handler: /bpms-cluster/CONTROLLER, org.apache.helix.manager.zk.ZKHelixDataAccessor@282084c4 >09:56:22,799 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:56:22,799 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:56:22,799 INFO [org.apache.helix.participant.HelixStateMachineEngine] (MSC service thread 1-14) Register state model factory for state model LeaderStandby using factory name DEFAULT with org.uberfire.io.impl.cluster.helix.LockTransitionalFactory@3149e47d >09:56:22,822 INFO [org.apache.helix.participant.HelixStateMachineEngine] (MSC service thread 1-14) Send NO_OP message to nodeOne_12345, msgId: 785ffad7-5854-4644-9e07-439127ca9ac1 >09:56:22,824 INFO [org.apache.helix.messaging.DefaultMessagingService] (MSC service thread 1-14) registering msg factory for type USER_DEFINE_MSG >09:56:22,835 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Dropping NO-OP message. mid: 785ffad7-5854-4644-9e07-439127ca9ac1, from: nodeOne_12345 >09:56:22,847 WARN [org.apache.helix.manager.zk.ZkAsyncCallbacks] (MSC service thread 1-14-EventThread) org.apache.helix.manager.zk.ZkAsyncCallbacks$CreateCallbackHandler@1807a634, rc:NONODE, path: /bpms-cluster/INSTANCES/nodeOne_12345/CURRENTSTATES/145992ad1fb0006/vfs-repo >09:56:22,882 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (MSC service thread 1-14) Added msg-factory for type: USER_DEFINE_MSG, threadpool size 40 >09:56:22,905 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Scheduling message: a0222515-4b68-4ec4-a106-633e2f85da29 >09:56:22,906 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Message: a0222515-4b68-4ec4-a106-633e2f85da29 handling task scheduled >09:56:22,906 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 107ms >09:56:22,906 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-1) handling task: a0222515-4b68-4ec4-a106-633e2f85da29 begin, at: 1398434182906 >09:56:22,908 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:56:22,908 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:56:22,912 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Dropping NO-OP message. mid: a31dbc2d-18ee-4c7c-bf13-9de2232b139b, from: nodeOne_12345 >09:56:22,916 INFO [org.jbpm.executor.impl.ExecutorImpl] (MSC service thread 1-14) Starting Executor Component ... > - Thread Pool Size: 1 > - Interval: 3 Seconds > - Retries per Request: 3 > >09:56:22,918 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 10ms >09:56:22,919 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:56:22,919 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:56:22,931 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-1) Message a0222515-4b68-4ec4-a106-633e2f85da29 completed. >09:56:22,933 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 14ms >09:56:22,940 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:56:22,941 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:56:22,948 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) No Messages to process >09:56:22,948 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 8ms >09:56:22,950 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:56:22,950 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:56:22,952 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) No Messages to process >09:56:22,952 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 3ms >09:56:22,961 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:56:22,961 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:56:22,971 INFO [org.kie.services.remote.jms.RetryTrackerSingleton] (ServerService Thread Pool -- 64) JMS message retry limit set to 2 >09:56:22,972 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Scheduling message: 008dab62-fc1b-4673-bdd2-f136d9c510ee >09:56:22,972 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Message: 008dab62-fc1b-4673-bdd2-f136d9c510ee handling task scheduled >09:56:22,973 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 11ms >09:56:22,972 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-2) handling task: 008dab62-fc1b-4673-bdd2-f136d9c510ee begin, at: 1398434182972 >09:56:22,981 INFO [org.apache.helix.monitoring.ParticipantMonitor] (pool-14-thread-1) Registering bean: Cluster=bpms-cluster,Resource=vfs-repo,Transition=OFFLINE--STANDBY >09:56:22,988 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-1) message finished: a0222515-4b68-4ec4-a106-633e2f85da29, took 80 >09:56:22,989 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-1) msg: a0222515-4b68-4ec4-a106-633e2f85da29 handling task completed, results:true, at: 1398434182988, took:82 >09:56:22,990 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-2) Message 008dab62-fc1b-4673-bdd2-f136d9c510ee completed. >09:56:22,997 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:56:22,997 INFO [org.jboss.web] (ServerService Thread Pool -- 64) JBAS018210: Register web context: /business-central >09:56:22,997 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:56:22,998 INFO [org.apache.helix.monitoring.ParticipantMonitor] (pool-14-thread-2) Registering bean: Cluster=bpms-cluster,Resource=vfs-repo,Transition=STANDBY--LEADER >09:56:22,999 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) No Messages to process >09:56:22,999 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 2ms >09:56:22,999 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-2) message finished: 008dab62-fc1b-4673-bdd2-f136d9c510ee, took 14 >09:56:22,999 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-2) msg: 008dab62-fc1b-4673-bdd2-f136d9c510ee handling task completed, results:true, at: 1398434182999, took:27 >09:56:23,173 INFO [solder-servlet] (ServerService Thread Pool -- 64) Catch Integration for Servlets enabled >09:56:23,299 INFO [org.jboss.errai.bus.server.cluster.noop.NoopClusteringProvider] (ServerService Thread Pool -- 64) clustering support not configured. >09:56:23,305 INFO [org.jboss.errai.bus.server.service.bootstrap.OrderedBootstrap] (ServerService Thread Pool -- 64) starting errai bus ... >09:56:23,307 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,313 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,315 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,328 INFO [org.jboss.errai.bus.server.service.bootstrap.LoadExtensions] (ServerService Thread Pool -- 64) searching for errai extensions ... >09:56:23,340 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:41,623 INFO [org.jboss.resteasy.cdi.CdiInjectorFactory] (http-localhost/127.0.0.1:8080-1) Found BeanManager at java:comp/BeanManager >09:57:42,013 INFO [org.drools.workbench.common.services.rest.JobRequestHelper] (http-localhost/127.0.0.1:8080-1) -----createOrCloneRepository--- , repository name:bpms-assets >09:57:42,023 INFO [org.drools.workbench.common.services.rest.JobRequestObserver] (http-localhost/127.0.0.1:8080-1) CreateOrCloneRepositoryRequest event received. >09:57:42,023 INFO [org.drools.workbench.common.services.rest.JobRequestApprovalService] (http-localhost/127.0.0.1:8080-1) Approval request for Job: 1398434262014-1 received. >09:57:42,881 INFO [org.drools.workbench.common.services.rest.JobRequestApprovalService] (http-localhost/127.0.0.1:8080-1) Approval request for Job: 1398434262014-1 result: ACCEPTED >09:57:42,881 INFO [org.drools.workbench.common.services.rest.JobRequestObserver] (http-localhost/127.0.0.1:8080-1) CreateOrCloneRepositoryRequest event approved. Performing requested operation. >09:57:42,888 INFO [org.drools.workbench.common.services.rest.JobRequestHelper] (http-localhost/127.0.0.1:8080-1) -----JobRequestHelper:createOrCloneRepository--- , repository name:bpms-assets >09:57:48,329 INFO [org.apache.helix.messaging.AsyncCallback] (http-localhost/127.0.0.1:8080-1) Setting time out to 30000 ms >09:57:48,330 INFO [org.apache.helix.messaging.CriteriaEvaluator] (http-localhost/127.0.0.1:8080-1) JOSQL query: SELECT DISTINCT mapSubKey, recordId, '', '' FROM EXTERNALVIEW.Table WHERE mapSubKey LIKE '%' AND recordId LIKE 'vfs-repo' AND mapKey LIKE '%' AND mapValue LIKE '%' AND mapSubKey IN ((SELECT [*]id FROM :LIVEINSTANCES)) >09:57:48,392 INFO [org.apache.helix.messaging.CriteriaEvaluator] (http-localhost/127.0.0.1:8080-1) JOSQL query return 2 rows >09:57:48,395 INFO [org.apache.helix.messaging.DefaultMessagingService] (http-localhost/127.0.0.1:8080-1) Send 1 messages with criteria instanceName=%resourceName=vfs-repopartitionName=partitionState= >09:57:48,395 INFO [org.apache.helix.messaging.AsyncCallback] (http-localhost/127.0.0.1:8080-1) Setting time out to 30000 ms >09:57:48,396 INFO [org.apache.helix.messaging.handling.AsyncCallbackService] (http-localhost/127.0.0.1:8080-1) registering correlation id 4fd157e8-6534-486a-992a-f7ba1b8be977 >09:57:52,982 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:57:52,982 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:57:52,986 INFO [org.apache.helix.messaging.handling.AsyncCallbackService] (ZkClient-EventThread-200-localhost:2181) Verified reply message ac14351b-5142-46b9-a305-de5a4434c3d5 correlation:4fd157e8-6534-486a-992a-f7ba1b8be977 >09:57:52,999 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Scheduling message: ac14351b-5142-46b9-a305-de5a4434c3d5 >09:57:53,005 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Message: ac14351b-5142-46b9-a305-de5a4434c3d5 handling task scheduled >09:57:53,005 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 23ms >09:57:53,005 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-9-thread-1) handling task: ac14351b-5142-46b9-a305-de5a4434c3d5 begin, at: 1398434273005 >09:57:53,006 INFO [org.apache.helix.messaging.handling.AsyncCallbackService] (pool-9-thread-1) Verified reply message ac14351b-5142-46b9-a305-de5a4434c3d5 correlation:4fd157e8-6534-486a-992a-f7ba1b8be977 >09:57:53,006 INFO [org.apache.helix.messaging.handling.AsyncCallbackService] (pool-9-thread-1) invoking reply message ac14351b-5142-46b9-a305-de5a4434c3d5, correlationid:4fd157e8-6534-486a-992a-f7ba1b8be977 >09:57:53,006 INFO [org.apache.helix.messaging.AsyncCallback] (pool-9-thread-1) OnReply msg ac14351b-5142-46b9-a305-de5a4434c3d5 >09:57:53,007 INFO [org.apache.helix.messaging.handling.AsyncCallbackService] (pool-9-thread-1) Removing finished callback, correlationid:4fd157e8-6534-486a-992a-f7ba1b8be977 >09:57:53,007 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-9-thread-1) Message ac14351b-5142-46b9-a305-de5a4434c3d5 completed. >09:57:53,017 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-9-thread-1) message finished: ac14351b-5142-46b9-a305-de5a4434c3d5, took 11 >09:57:53,017 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-9-thread-1) msg: ac14351b-5142-46b9-a305-de5a4434c3d5 handling task completed, results:true, at: 1398434273017, took:12 >09:57:53,018 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:57:53,018 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:57:53,019 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) No Messages to process >09:57:53,019 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 1ms >09:57:53,053 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:57:53,053 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:57:53,070 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Scheduling message: 65eff92c-8c34-443a-a6f2-94072be7ea4d >09:57:53,077 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Message: 65eff92c-8c34-443a-a6f2-94072be7ea4d handling task scheduled >09:57:53,078 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 25ms >09:57:53,078 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-3) handling task: 65eff92c-8c34-443a-a6f2-94072be7ea4d begin, at: 1398434273078 >09:57:53,089 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-3) Message 65eff92c-8c34-443a-a6f2-94072be7ea4d completed. >09:57:53,107 INFO [org.apache.helix.monitoring.ParticipantMonitor] (pool-14-thread-3) Registering bean: Cluster=bpms-cluster,Resource=vfs-repo,Transition=LEADER--STANDBY >09:57:53,113 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-3) message finished: 65eff92c-8c34-443a-a6f2-94072be7ea4d, took 34 >09:57:53,114 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-3) msg: 65eff92c-8c34-443a-a6f2-94072be7ea4d handling task completed, results:true, at: 1398434273114, took:36 >09:57:53,166 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:57:53,166 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:57:53,168 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) No Messages to process >09:57:53,168 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 2ms >09:57:53,425 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:57:53,425 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:57:53,466 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Scheduling message: 3255a9dc-8c95-4482-bb34-42c2252d604f >09:57:53,466 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Message: 3255a9dc-8c95-4482-bb34-42c2252d604f handling task scheduled >09:57:53,467 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 42ms >09:57:53,467 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-4) handling task: 3255a9dc-8c95-4482-bb34-42c2252d604f begin, at: 1398434273467 >09:57:53,490 INFO [org.apache.helix.messaging.CriteriaEvaluator] (http-localhost/127.0.0.1:8080-1) JOSQL query: SELECT DISTINCT mapSubKey, recordId, '', '' FROM EXTERNALVIEW.Table WHERE mapSubKey LIKE '%' AND recordId LIKE 'vfs-repo' AND mapKey LIKE '%' AND mapValue LIKE '%' AND mapSubKey IN ((SELECT [*]id FROM :LIVEINSTANCES)) >09:57:53,502 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-4) Message 3255a9dc-8c95-4482-bb34-42c2252d604f completed. >09:57:53,538 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-4) message finished: 3255a9dc-8c95-4482-bb34-42c2252d604f, took 70 >09:57:53,538 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-4) msg: 3255a9dc-8c95-4482-bb34-42c2252d604f handling task completed, results:true, at: 1398434273538, took:71 >09:57:53,539 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:57:53,539 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:57:53,540 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) No Messages to process >09:57:53,540 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 1ms >09:57:53,549 INFO [org.apache.helix.messaging.CriteriaEvaluator] (http-localhost/127.0.0.1:8080-1) JOSQL query return 2 rows >09:57:53,556 INFO [org.apache.helix.messaging.DefaultMessagingService] (http-localhost/127.0.0.1:8080-1) Send 1 messages with criteria instanceName=%resourceName=vfs-repopartitionName=partitionState= >09:57:53,629 INFO [org.apache.helix.messaging.CriteriaEvaluator] (http-localhost/127.0.0.1:8080-1) JOSQL query: SELECT DISTINCT mapSubKey, recordId, '', '' FROM EXTERNALVIEW.Table WHERE mapSubKey LIKE '%' AND recordId LIKE 'vfs-repo' AND mapKey LIKE '%' AND mapValue LIKE '%' AND mapSubKey IN ((SELECT [*]id FROM :LIVEINSTANCES)) >09:57:53,650 INFO [org.apache.helix.messaging.CriteriaEvaluator] (http-localhost/127.0.0.1:8080-1) JOSQL query return 2 rows >09:57:53,660 INFO [org.apache.helix.messaging.DefaultMessagingService] (http-localhost/127.0.0.1:8080-1) Send 1 messages with criteria instanceName=%resourceName=vfs-repopartitionName=partitionState= >09:57:53,778 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:57:53,778 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:57:53,822 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Scheduling message: d92de3e7-f64d-4240-a08f-267e32e54d07 >09:57:53,823 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Message: d92de3e7-f64d-4240-a08f-267e32e54d07 handling task scheduled >09:57:53,823 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 45ms >09:57:53,823 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-5) handling task: d92de3e7-f64d-4240-a08f-267e32e54d07 begin, at: 1398434273823 >09:57:53,855 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-5) Message d92de3e7-f64d-4240-a08f-267e32e54d07 completed. >09:57:53,943 INFO [org.drools.workbench.common.services.rest.JobRequestHelper] (http-localhost/127.0.0.1:8080-2) -----getJobStatus--- , jobId:1398434262014-1 >09:57:53,958 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-5) message finished: d92de3e7-f64d-4240-a08f-267e32e54d07, took 134 >09:57:53,958 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-5) msg: d92de3e7-f64d-4240-a08f-267e32e54d07 handling task completed, results:true, at: 1398434273958, took:135 >09:57:53,960 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:57:53,960 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:57:53,974 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) No Messages to process >09:57:53,980 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 20ms >09:57:54,023 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:57:54,023 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:57:54,058 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Scheduling message: 543959f1-0ef8-491b-a06c-41676dd33f52 >09:57:54,059 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Message: 543959f1-0ef8-491b-a06c-41676dd33f52 handling task scheduled >09:57:54,059 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 36ms >09:57:54,059 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-6) handling task: 543959f1-0ef8-491b-a06c-41676dd33f52 begin, at: 1398434274059 >09:57:54,106 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-6) Message 543959f1-0ef8-491b-a06c-41676dd33f52 completed. >09:57:54,124 INFO [org.apache.helix.monitoring.ParticipantMonitor] (pool-14-thread-6) Registering bean: Cluster=bpms-cluster,Resource=vfs-repo,Transition=STANDBY--OFFLINE >09:57:54,124 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-6) message finished: 543959f1-0ef8-491b-a06c-41676dd33f52, took 64 >09:57:54,124 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-6) msg: 543959f1-0ef8-491b-a06c-41676dd33f52 handling task completed, results:true, at: 1398434274124, took:65 >09:57:54,125 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:57:54,125 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:57:54,127 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) No Messages to process >09:57:54,127 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 2ms >09:58:14,012 INFO [org.drools.workbench.common.services.rest.JobRequestHelper] (http-localhost/127.0.0.1:8080-3) -----createOrganizationalUnit--- , OrganizationalUnit name:bpms, OrganizationalUnit owner:testadmin >09:58:14,013 INFO [org.drools.workbench.common.services.rest.JobRequestObserver] (http-localhost/127.0.0.1:8080-3) CreateOrganizationalUnitRequest event received. >09:58:14,013 INFO [org.drools.workbench.common.services.rest.JobRequestApprovalService] (http-localhost/127.0.0.1:8080-3) Approval request for Job: 1398434294012-2 received. >09:58:14,017 INFO [org.drools.workbench.common.services.rest.JobRequestApprovalService] (http-localhost/127.0.0.1:8080-3) Approval request for Job: 1398434294012-2 result: ACCEPTED >09:58:14,017 INFO [org.drools.workbench.common.services.rest.JobRequestObserver] (http-localhost/127.0.0.1:8080-3) CreateOrganizationalUnitRequest event approved. Performing requested operation. >09:58:14,017 INFO [org.drools.workbench.common.services.rest.JobRequestHelper] (http-localhost/127.0.0.1:8080-3) -----JobRequestHelper:createOrganizationalUnit--- , OrganizationalUnit name:bpms, OrganizationalUnit owner:testadmin >09:58:14,073 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:58:14,073 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:58:14,089 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Scheduling message: 3915ae21-d789-4508-aaf2-e7ebffbff68e >09:58:14,090 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Message: 3915ae21-d789-4508-aaf2-e7ebffbff68e handling task scheduled >09:58:14,090 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 18ms >09:58:14,090 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-7) handling task: 3915ae21-d789-4508-aaf2-e7ebffbff68e begin, at: 1398434294090 >09:58:14,127 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-7) Message 3915ae21-d789-4508-aaf2-e7ebffbff68e completed. >09:58:14,174 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-7) message finished: 3915ae21-d789-4508-aaf2-e7ebffbff68e, took 83 >09:58:14,174 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-7) msg: 3915ae21-d789-4508-aaf2-e7ebffbff68e handling task completed, results:true, at: 1398434294174, took:84 >09:58:14,175 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:58:14,175 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:58:14,177 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) No Messages to process >09:58:14,177 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 2ms >09:58:14,228 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:58:14,228 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:58:14,257 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Scheduling message: 3f0aea16-ce2c-4599-8e32-a71e44438505 >09:58:14,257 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Message: 3f0aea16-ce2c-4599-8e32-a71e44438505 handling task scheduled >09:58:14,258 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 30ms >09:58:14,258 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-8) handling task: 3f0aea16-ce2c-4599-8e32-a71e44438505 begin, at: 1398434294258 >09:58:14,278 INFO [org.apache.helix.messaging.CriteriaEvaluator] (http-localhost/127.0.0.1:8080-3) JOSQL query: SELECT DISTINCT mapSubKey, recordId, '', '' FROM EXTERNALVIEW.Table WHERE mapSubKey LIKE '%' AND recordId LIKE 'vfs-repo' AND mapKey LIKE '%' AND mapValue LIKE '%' AND mapSubKey IN ((SELECT [*]id FROM :LIVEINSTANCES)) >09:58:14,287 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-8) Message 3f0aea16-ce2c-4599-8e32-a71e44438505 completed. >09:58:14,311 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-8) message finished: 3f0aea16-ce2c-4599-8e32-a71e44438505, took 53 >09:58:14,312 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:58:14,321 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-8) msg: 3f0aea16-ce2c-4599-8e32-a71e44438505 handling task completed, results:true, at: 1398434294321, took:63 >09:58:14,321 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:58:14,322 INFO [org.apache.helix.messaging.CriteriaEvaluator] (http-localhost/127.0.0.1:8080-3) JOSQL query return 2 rows >09:58:14,336 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) No Messages to process >09:58:14,336 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 24ms >09:58:14,336 INFO [org.apache.helix.messaging.DefaultMessagingService] (http-localhost/127.0.0.1:8080-3) Send 1 messages with criteria instanceName=%resourceName=vfs-repopartitionName=partitionState= >09:58:14,419 INFO [org.apache.helix.messaging.CriteriaEvaluator] (http-localhost/127.0.0.1:8080-3) JOSQL query: SELECT DISTINCT mapSubKey, recordId, '', '' FROM EXTERNALVIEW.Table WHERE mapSubKey LIKE '%' AND recordId LIKE 'vfs-repo' AND mapKey LIKE '%' AND mapValue LIKE '%' AND mapSubKey IN ((SELECT [*]id FROM :LIVEINSTANCES)) >09:58:14,444 INFO [org.apache.helix.messaging.CriteriaEvaluator] (http-localhost/127.0.0.1:8080-3) JOSQL query return 2 rows >09:58:14,445 INFO [org.apache.helix.messaging.DefaultMessagingService] (http-localhost/127.0.0.1:8080-3) Send 1 messages with criteria instanceName=%resourceName=vfs-repopartitionName=partitionState= >09:58:14,635 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:58:14,635 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:58:14,705 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Scheduling message: 87385b95-0b84-4865-b0b9-146ce9928272 >09:58:14,705 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Message: 87385b95-0b84-4865-b0b9-146ce9928272 handling task scheduled >09:58:14,705 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 70ms >09:58:14,705 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-9) handling task: 87385b95-0b84-4865-b0b9-146ce9928272 begin, at: 1398434294705 >09:58:14,737 INFO [org.drools.workbench.common.services.rest.JobRequestHelper] (http-localhost/127.0.0.1:8080-4) -----getJobStatus--- , jobId:1398434294012-2 >09:58:14,742 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-9) Message 87385b95-0b84-4865-b0b9-146ce9928272 completed. >09:58:14,778 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-9) message finished: 87385b95-0b84-4865-b0b9-146ce9928272, took 72 >09:58:14,778 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-9) msg: 87385b95-0b84-4865-b0b9-146ce9928272 handling task completed, results:true, at: 1398434294778, took:73 >09:58:14,778 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:58:14,778 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:58:14,780 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) No Messages to process >09:58:14,780 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 2ms >09:58:14,820 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:58:14,820 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:58:14,855 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Scheduling message: 91092cdf-26ee-4dd5-b01f-704b2d21a3e6 >09:58:14,856 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Message: 91092cdf-26ee-4dd5-b01f-704b2d21a3e6 handling task scheduled >09:58:14,856 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 36ms >09:58:14,856 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-10) handling task: 91092cdf-26ee-4dd5-b01f-704b2d21a3e6 begin, at: 1398434294856 >09:58:14,891 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-10) Message 91092cdf-26ee-4dd5-b01f-704b2d21a3e6 completed. >09:58:14,922 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-10) message finished: 91092cdf-26ee-4dd5-b01f-704b2d21a3e6, took 65 >09:58:14,923 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-10) msg: 91092cdf-26ee-4dd5-b01f-704b2d21a3e6 handling task completed, results:true, at: 1398434294923, took:67 >09:58:14,923 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:58:14,924 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:58:14,925 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) No Messages to process >09:58:14,925 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 2ms >09:58:34,752 INFO [org.drools.workbench.common.services.rest.JobRequestHelper] (http-localhost/127.0.0.1:8080-5) -----compileProject--- , repositoryName:bpms-assets, project name:clustering >09:58:34,754 INFO [org.drools.workbench.common.services.rest.JobRequestObserver] (http-localhost/127.0.0.1:8080-5) CompileProjectRequest event received. >09:58:34,754 INFO [org.drools.workbench.common.services.rest.JobRequestApprovalService] (http-localhost/127.0.0.1:8080-5) Approval request for Job: 1398434314753-3 received. >09:58:34,755 INFO [org.drools.workbench.common.services.rest.JobRequestApprovalService] (http-localhost/127.0.0.1:8080-5) Approval request for Job: 1398434314753-3 result: ACCEPTED >09:58:34,755 INFO [org.drools.workbench.common.services.rest.JobRequestObserver] (http-localhost/127.0.0.1:8080-5) CompileProjectRequest event approved. Performing requested operation. >09:58:34,755 INFO [org.drools.workbench.common.services.rest.JobRequestHelper] (http-localhost/127.0.0.1:8080-5) -----JobRequestHelper:compileProject--- , repositoryName:bpms-assets, project name:clustering >09:58:36,012 ERROR [stderr] (http-localhost/127.0.0.1:8080-5) line 1:57 no viable alternative at character '\' >09:58:36,373 INFO [org.drools.compiler.kie.builder.impl.KieRepositoryImpl] (http-localhost/127.0.0.1:8080-5) KieModule was added:MemoryKieModule[ ReleaseId=org.jboss.qa.bpms:clustering:1.0.0.Final] >09:58:36,610 INFO [org.drools.workbench.common.services.rest.JobRequestHelper] (http-localhost/127.0.0.1:8080-6) -----getJobStatus--- , jobId:1398434314753-3 >09:58:36,641 INFO [org.kie.services.remote.rest.async.AsyncDeploymentJobExecutor] (http-localhost/127.0.0.1:8080-7) Deployment executing as async jobs >09:58:36,642 INFO [org.kie.services.remote.rest.async.AsyncDeploymentJobExecutor] (http-localhost/127.0.0.1:8080-7) DEPLOY job for [org.jboss.qa.bpms:clustering:1.0.0.Final] submitted succesfully >09:58:36,776 INFO [stdout] (pool-22-thread-1) wagon http use multi threaded http connection manager maxPerRoute 20, max total 40 >09:58:37,283 ERROR [stderr] (pool-22-thread-1) line 1:57 no viable alternative at character '\' >09:58:37,551 INFO [org.quartz.core.SchedulerSignalerImpl] (pool-22-thread-1) Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl >09:58:37,552 INFO [org.quartz.core.QuartzScheduler] (pool-22-thread-1) Quartz Scheduler v.1.8.5 created. >09:58:37,553 INFO [org.quartz.impl.jdbcjobstore.JobStoreCMT] (pool-22-thread-1) Using db table-based data access locking (synchronization). >09:58:37,555 INFO [org.quartz.impl.jdbcjobstore.JobStoreCMT] (pool-22-thread-1) JobStoreCMT initialized. >09:58:37,556 INFO [org.quartz.core.QuartzScheduler] (pool-22-thread-1) Scheduler meta-data: Quartz Scheduler (v1.8.5) 'jBPMClusteredScheduler' with instanceId 'brmsperf05.mw.lab.eng.bos.redhat.com1398434317535' > Scheduler class: 'org.quartz.core.QuartzScheduler' - running locally. > NOT STARTED. > Currently in standby mode. > Number of jobs executed: 0 > Using thread pool 'org.quartz.simpl.SimpleThreadPool' - with 5 threads. > Using job-store 'org.quartz.impl.jdbcjobstore.JobStoreCMT' - which supports persistence. and is clustered. > >09:58:37,556 INFO [org.quartz.impl.StdSchedulerFactory] (pool-22-thread-1) Quartz scheduler 'jBPMClusteredScheduler' initialized from specified file: '/mnt/hudson_workspace/workspace/bpms-clustering-smoke/quartz.properties' >09:58:37,556 INFO [org.quartz.impl.StdSchedulerFactory] (pool-22-thread-1) Quartz scheduler version: 1.8.5 >09:58:37,599 INFO [org.quartz.core.QuartzScheduler] (pool-22-thread-1) Scheduler jBPMClusteredScheduler_$_brmsperf05.mw.lab.eng.bos.redhat.com1398434317535 started. >09:58:38,117 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:58:38,117 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:58:38,142 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Scheduling message: f40bd341-ccc6-4c9a-b1e9-1e545447c601 >09:58:38,142 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Message: f40bd341-ccc6-4c9a-b1e9-1e545447c601 handling task scheduled >09:58:38,142 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 25ms >09:58:38,142 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-11) handling task: f40bd341-ccc6-4c9a-b1e9-1e545447c601 begin, at: 1398434318142 >09:58:38,154 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-11) Message f40bd341-ccc6-4c9a-b1e9-1e545447c601 completed. >09:58:38,207 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-11) message finished: f40bd341-ccc6-4c9a-b1e9-1e545447c601, took 64 >09:58:38,207 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-11) msg: f40bd341-ccc6-4c9a-b1e9-1e545447c601 handling task completed, results:true, at: 1398434318207, took:65 >09:58:38,208 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:58:38,208 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:58:38,210 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) No Messages to process >09:58:38,210 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 2ms >09:58:38,262 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:58:38,262 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:58:38,279 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Scheduling message: a5464d48-798b-4f39-906d-9da282bf3c7a >09:58:38,328 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Message: a5464d48-798b-4f39-906d-9da282bf3c7a handling task scheduled >09:58:38,329 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 67ms >09:58:38,329 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-12) handling task: a5464d48-798b-4f39-906d-9da282bf3c7a begin, at: 1398434318328 >09:58:38,362 INFO [org.apache.helix.messaging.CriteriaEvaluator] (pool-22-thread-1) JOSQL query: SELECT DISTINCT mapSubKey, recordId, '', '' FROM EXTERNALVIEW.Table WHERE mapSubKey LIKE '%' AND recordId LIKE 'vfs-repo' AND mapKey LIKE '%' AND mapValue LIKE '%' AND mapSubKey IN ((SELECT [*]id FROM :LIVEINSTANCES)) >09:58:38,364 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-12) Message a5464d48-798b-4f39-906d-9da282bf3c7a completed. >09:58:38,381 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-12) message finished: a5464d48-798b-4f39-906d-9da282bf3c7a, took 51 >09:58:38,392 INFO [org.apache.helix.messaging.CriteriaEvaluator] (pool-22-thread-1) JOSQL query return 2 rows >09:58:38,382 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:58:38,403 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-12) msg: a5464d48-798b-4f39-906d-9da282bf3c7a handling task completed, results:true, at: 1398434318403, took:75 >09:58:38,403 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:58:38,405 INFO [org.apache.helix.messaging.DefaultMessagingService] (pool-22-thread-1) Send 1 messages with criteria instanceName=%resourceName=vfs-repopartitionName=partitionState= >09:58:38,405 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) No Messages to process >09:58:38,405 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 23ms >09:58:38,537 INFO [org.apache.helix.messaging.CriteriaEvaluator] (pool-22-thread-1) JOSQL query: SELECT DISTINCT mapSubKey, recordId, '', '' FROM EXTERNALVIEW.Table WHERE mapSubKey LIKE '%' AND recordId LIKE 'vfs-repo' AND mapKey LIKE '%' AND mapValue LIKE '%' AND mapSubKey IN ((SELECT [*]id FROM :LIVEINSTANCES)) >09:58:38,549 INFO [org.apache.helix.messaging.CriteriaEvaluator] (pool-22-thread-1) JOSQL query return 2 rows >09:58:38,575 INFO [org.apache.helix.messaging.DefaultMessagingService] (pool-22-thread-1) Send 1 messages with criteria instanceName=%resourceName=vfs-repopartitionName=partitionState= >09:58:38,818 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:58:38,818 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:58:38,883 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Scheduling message: 727a06b8-8137-45fc-89e9-67ece8c35cd6 >09:58:38,884 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Message: 727a06b8-8137-45fc-89e9-67ece8c35cd6 handling task scheduled >09:58:38,884 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 66ms >09:58:38,884 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-13) handling task: 727a06b8-8137-45fc-89e9-67ece8c35cd6 begin, at: 1398434318884 >09:58:38,896 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-13) Message 727a06b8-8137-45fc-89e9-67ece8c35cd6 completed. >09:58:38,937 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-13) message finished: 727a06b8-8137-45fc-89e9-67ece8c35cd6, took 52 >09:58:38,938 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:58:38,939 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-13) msg: 727a06b8-8137-45fc-89e9-67ece8c35cd6 handling task completed, results:true, at: 1398434318939, took:55 >09:58:38,939 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:58:38,941 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) No Messages to process >09:58:38,941 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 3ms >09:58:39,010 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:58:39,010 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:58:39,051 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Scheduling message: d7d999b5-c5c2-4aba-b212-21ed9225c0a2 >09:58:39,052 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) Message: d7d999b5-c5c2-4aba-b212-21ed9225c0a2 handling task scheduled >09:58:39,052 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 42ms >09:58:39,052 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-14) handling task: d7d999b5-c5c2-4aba-b212-21ed9225c0a2 begin, at: 1398434319052 >09:58:39,093 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-14) Message d7d999b5-c5c2-4aba-b212-21ed9225c0a2 completed. >09:58:39,123 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (pool-14-thread-14) message finished: d7d999b5-c5c2-4aba-b212-21ed9225c0a2, took 70 >09:58:39,123 INFO [org.apache.helix.messaging.handling.HelixTask] (pool-14-thread-14) msg: d7d999b5-c5c2-4aba-b212-21ed9225c0a2 handling task completed, results:true, at: 1398434319123, took:71 >09:58:39,165 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >09:58:39,166 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) nodeOne_12345 subscribes child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >09:58:39,184 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (ZkClient-EventThread-200-localhost:2181) No Messages to process >09:58:39,189 INFO [org.apache.helix.manager.zk.CallbackHandler] (ZkClient-EventThread-200-localhost:2181) 200 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 24ms >10:00:14,950 INFO [org.apache.coyote.http11] (MSC service thread 1-11) JBWEB003075: Coyote HTTP/1.1 pausing on: http-localhost/127.0.0.1:8080 >10:00:14,951 INFO [org.apache.coyote.http11] (MSC service thread 1-11) JBWEB003077: Coyote HTTP/1.1 stopping on : http-localhost/127.0.0.1:8080 >10:00:14,955 INFO [org.jboss.jaxr] (MSC service thread 1-10) JBAS014002: UnBinding JAXR ConnectionFactory: java:jboss/jaxr/ConnectionFactory >10:00:14,955 INFO [org.jboss.modcluster] (ServerService Thread Pool -- 85) MODCLUSTER000002: Initiating mod_cluster shutdown >10:00:14,956 INFO [org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-4) JBAS010409: Unbound data source [java:jboss/datasources/ExampleDS] >10:00:14,959 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,961 INFO [org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-6) JBAS010409: Unbound data source [java:jboss/datasources/brms-jdbc-dsQuartz] >10:00:14,965 INFO [org.jboss.as.messaging] (ServerService Thread Pool -- 83) JBAS011605: Unbound messaging object to jndi name java:jboss/exported/jms/queue/KIE.AUDIT >10:00:14,964 INFO [org.jboss.web] (ServerService Thread Pool -- 89) JBAS018224: Unregister web context: /business-central >10:00:14,965 INFO [org.apache.coyote.ajp] (MSC service thread 1-16) JBWEB003048: Pausing Coyote AJP/1.3 on ajp-localhost/127.0.0.1:8009 >10:00:14,966 INFO [org.apache.coyote.ajp] (MSC service thread 1-16) JBWEB003051: Stopping Coyote AJP/1.3 on ajp-localhost/127.0.0.1:8009 >10:00:15,089 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 85) JBAS011403: Stopping Persistence Unit Service 'business-central.war#org.jbpm.domain' >10:00:15,093 INFO [org.jboss.as.connector.deployment] (MSC service thread 1-9) JBAS010410: Unbound JCA ConnectionFactory [java:/JmsXA] >10:00:15,093 INFO [org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-11) JBAS010409: Unbound data source [java:jboss/datasources/brms-jdbc-ds] >10:00:15,096 INFO [org.jboss.weld.deployer] (MSC service thread 1-9) JBAS016009: Stopping weld service for deployment business-central.war >10:00:15,099 INFO [org.hornetq.ra] (MSC service thread 1-13) HQ151003: HornetQ resource adaptor stopped >10:00:15,100 WARN [org.hornetq.core.client] (Thread-6 (HornetQ-client-global-threads-1545553401)) HQ212037: Connection failure has been detected: HQ119015: The connection was disconnected because of server shutdown [code=DISCONNECTED] >10:00:15,101 WARN [org.hornetq.core.client] (Thread-8 (HornetQ-client-global-threads-1545553401)) HQ212037: Connection failure has been detected: HQ119015: The connection was disconnected because of server shutdown [code=DISCONNECTED] >10:00:15,102 WARN [org.hornetq.core.server] (Thread-8 (HornetQ-client-global-threads-1545553401)) HQ222095: Connection failed with failedOver=false: HornetQException[errorType=DISCONNECTED message=HQ119015: The connection was disconnected because of server shutdown] > at org.hornetq.core.client.impl.ClientSessionFactoryImpl$CloseRunnable.run(ClientSessionFactoryImpl.java:1631) [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,117 INFO [org.hornetq.core.server] (Thread-26 (HornetQ-server-HornetQServerImpl::serverUUID=37d218fc-cc81-11e3-ac85-ebcda1137edb-791162793)) HQ221029: stopped bridge sf.my-cluster.38d04edd-cc81-11e3-bde4-69d5bf946063 >10:00:15,129 INFO [org.jboss.errai.cdi.server.events.ShutdownEventObserver] (MSC service thread 1-9) Shutting down CDI-to-ErraiBus event bridge >10:00:15,143 INFO [org.apache.helix.manager.zk.ZKHelixManager] (MSC service thread 1-9) disconnect nodeOne_12345(PARTICIPANT) from bpms-cluster >10:00:15,143 INFO [org.apache.helix.healthcheck.ParticipantHealthReportTask] (MSC service thread 1-9) Stop ParticipantHealthReportTimerTask >10:00:15,143 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (MSC service thread 1-9) shutting down TaskExecutor >10:00:15,143 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (MSC service thread 1-9) 0 tasks are still in the threadpool for msgType USER_DEFINE_MSG >10:00:15,144 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (MSC service thread 1-9) 0 tasks are still in the threadpool for msgType STATE_TRANSITION >10:00:15,145 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (MSC service thread 1-9) 0 tasks are still in the threadpool for msgType TASK_REPLY >10:00:15,145 INFO [org.apache.helix.monitoring.ParticipantMonitor] (MSC service thread 1-9) Registering bean: Cluster=bpms-cluster,Resource=vfs-repo,Transition=STANDBY--OFFLINE >10:00:15,145 INFO [org.apache.helix.monitoring.ParticipantMonitor] (MSC service thread 1-9) Registering bean: Cluster=bpms-cluster,Resource=vfs-repo,Transition=OFFLINE--STANDBY >10:00:15,146 INFO [org.apache.helix.monitoring.ParticipantMonitor] (MSC service thread 1-9) Registering bean: Cluster=bpms-cluster,Resource=vfs-repo,Transition=LEADER--STANDBY >10:00:15,146 INFO [org.apache.helix.monitoring.ParticipantMonitor] (MSC service thread 1-9) Registering bean: Cluster=bpms-cluster,Resource=vfs-repo,Transition=STANDBY--LEADER >10:00:15,146 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (MSC service thread 1-9) shutdown finished >10:00:15,146 INFO [org.apache.helix.manager.zk.CallbackHandler] (MSC service thread 1-9) 19 START:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor >10:00:15,146 INFO [org.apache.helix.manager.zk.CallbackHandler] (MSC service thread 1-9) nodeOne_12345 unsubscribe child-change. path: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >10:00:15,147 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (MSC service thread 1-9) Get FINALIZE notification >10:00:15,147 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (MSC service thread 1-9) 0 tasks never executed for msgType: USER_DEFINE_MSG. tasks: [] >10:00:15,147 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (MSC service thread 1-9) 0 tasks never executed for msgType: STATE_TRANSITION. tasks: [] >10:00:15,147 WARN [org.apache.helix.participant.statemachine.StateModel] (MSC service thread 1-9) Default reset method invoked. Either because the process longer own this resource or session timedout >10:00:15,147 INFO [org.apache.helix.messaging.handling.HelixTaskExecutor] (MSC service thread 1-9) 0 tasks never executed for msgType: TASK_REPLY. tasks: [] >10:00:15,148 INFO [org.apache.helix.manager.zk.CallbackHandler] (MSC service thread 1-9) 19 END:INVOKE /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 1ms >10:00:15,148 INFO [org.apache.helix.manager.zk.ZKHelixManager] (MSC service thread 1-9) reset handler: /bpms-cluster/INSTANCES/nodeOne_12345/MESSAGES, org.apache.helix.messaging.handling.HelixTaskExecutor@63a01787 >10:00:15,148 INFO [org.apache.helix.manager.zk.CallbackHandler] (MSC service thread 1-9) 19 START:INVOKE /bpms-cluster/CONTROLLER listener:org.apache.helix.manager.zk.ZKHelixDataAccessor >10:00:15,148 INFO [org.apache.helix.manager.zk.CallbackHandler] (MSC service thread 1-9) nodeOne_12345 unsubscribe child-change. path: /bpms-cluster/CONTROLLER, listener: org.apache.helix.manager.zk.ZKHelixDataAccessor@282084c4 >10:00:15,148 INFO [org.apache.helix.manager.zk.ZKHelixDataAccessor] (MSC service thread 1-9) Controller has changed >10:00:15,150 INFO [org.apache.helix.manager.zk.ZKHelixDataAccessor] (MSC service thread 1-9) _zkPropertyTransferSvcUrl : null Controller brmsperf05.mw.lab.eng.bos.redhat.com-CONTROLLER >10:00:15,150 INFO [org.apache.helix.manager.zk.CallbackHandler] (MSC service thread 1-9) 19 END:INVOKE /bpms-cluster/CONTROLLER listener:org.apache.helix.manager.zk.ZKHelixDataAccessor Took: 2ms >10:00:15,150 INFO [org.apache.helix.manager.zk.ZKHelixManager] (MSC service thread 1-9) reset handler: /bpms-cluster/CONTROLLER, org.apache.helix.manager.zk.ZKHelixDataAccessor@282084c4 >10:00:15,151 INFO [org.apache.helix.manager.zk.ZkClient] (MSC service thread 1-9) Closing zkclient: State:CONNECTED Timeout:30000 sessionid:0x145992ad1fb0006 local:/127.0.0.1:34258 remoteserver:localhost/127.0.0.1:2181 lastZxid:301 xid:608 sent:627 recv:662 queuedpkts:0 pendingresp:0 queuedevents:0 >10:00:15,151 INFO [org.I0Itec.zkclient.ZkEventThread] (ZkClient-EventThread-200-localhost:2181) Terminate ZkClient event thread. >10:00:15,175 INFO [org.hornetq.core.server] (MSC service thread 1-8) HQ221002: HornetQ Server version 2.3.5.Final-redhat-2 (Monster Bee, 123) [37d218fc-cc81-11e3-ac85-ebcda1137edb] stopped >10:00:15,181 INFO [org.apache.zookeeper.ClientCnxn] (MSC service thread 1-14-EventThread) EventThread shut down >10:00:15,182 INFO [org.apache.zookeeper.ZooKeeper] (MSC service thread 1-9) Session: 0x145992ad1fb0006 closed >10:00:15,182 INFO [org.apache.helix.manager.zk.ZkClient] (MSC service thread 1-9) Closed zkclient >10:00:15,182 INFO [org.apache.helix.manager.zk.ZKHelixManager] (MSC service thread 1-9) Cluster manager: nodeOne_12345 disconnected >10:00:15,187 INFO [org.jbpm.executor.impl.ExecutorImpl] (MSC service thread 1-9) >>>>> Destroying Executor !!! >10:00:15,468 INFO [org.jboss.as.server.deployment] (MSC service thread 1-12) JBAS015877: Stopped deployment business-central.war (runtime-name: business-central.war) in 530ms >10:00:15,480 INFO [org.jboss.as] (MSC service thread 1-4) JBAS015950: JBoss BPM Suite 6.0.2.GA (AS 7.2.1.Final-redhat-10) stopped in 535ms
You cannot view the attachment while viewing its details because your browser does not support IFRAMEs.
View the attachment on a separate page
.
View Attachment As Raw
Actions:
View
Attachments on
bug 1091458
: 889817 |
889818
|
889819