[kie-server] DBUserGroupCallbackImpl cannot connect to running postgresql database

569 views
Skip to first unread message

Radek Koubský

unread,
Apr 27, 2016, 10:16:44 AM4/27/16
to jBPM Setup
Hi,
I have a bit specific case of jbpm, I run only kie-server (deployed on EAP 6) I communicate with via kie-server-client.

My environment:
I run kie-server as docker image within OpenShift, thus I have
 
i) kie-server docker image (based on EAP 6/rhel7 image) running on OpenShift
ii) postgresql docker image (based on rhel7) running on OpenShift

This configuration works properly, kie-server uses postgresql (thus, kie-server is able to find postgresql JNDI) to store process instances etc.

However, I want kie-server human task engine to use the same postgresql database to fetch data about users/groups, these are my configuration changes:

1) I put jbpm.usergroup.callback.properties to eap_home/standalone/deployments/kie-server.war/WEB-INF/classes dir
the content of the file:
db.ds.jndi.name="java:jboss/datasources/testdb_postgresql"
db.user.query="SELECT id FROM persons WHERE login = ?"
db.roles.query="SELECT id FROM roles WHERE name = ?"
db.user.roles.query="SELECT r.name FROM persons_x_roles pxr, roles r WHERE pxr.person_id = (SELECT id FROM persons WHERE login = ?) AND pxr.role_id = r.id"

2) I set system property org.jbpm.ht.callback=db when run EAP 6

When I run the configuration above I get the following exception:
09:55:22,915 ERROR [org.kie.server.services.impl.KieServerImpl] (ServerService Thread Pool -- 55) Error when initializing server extension of type jBPM KIE Server extension: java.lang.IllegalStateException: Can get data source for DB usergroup callback, JNDI name: "java:jboss/datasources/testdb_postgresql"

NOTE:
The postgresql data source is already bound to java:jboss/datasources/testdb_postgresql according to:
 09:55:11,294 INFO  [org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-3) JBAS010400: Bound data source [java:jboss/datasources/testdb_postgresql]

which happens before the exception occurs, thus I don't understand where is the problem.

NOTE2: see attachment for the standalone-openshift.xml file where data source is defined

Thanks for help.

Here is full log output:
=========================================================================

  JBoss Bootstrap Environment

  JBOSS_HOME: /opt/eap

  JAVA: /usr/lib/jvm/java-1.8.0/bin/java

  JAVA_OPTS:  -XX:+UseCompressedOops -verbose:gc -Xloggc:"/opt/eap/standalone/log/gc.log" -XX:+PrintGCDetails -XX:+PrintGCDateStamps -XX:+UseGCLogFileRotation -XX:NumberOfGCLogFiles=5 -XX:GCLogFileSize=3M -XX:-TraceClassUnloading -Xms1303m -Xmx1303m -XX:MaxPermSize=256m -Djava.net.preferIPv4Stack=true -Djboss.modules.system.pkgs=org.jboss.logmanager -Djava.awt.headless=true -Djboss.modules.policy-permissions=true -Xbootclasspath/p:/opt/eap/jboss-modules.jar:/opt/eap/modules/system/layers/base/org/jboss/logmanager/main/jboss-logmanager-1.5.4.Final-redhat-1.jar:/opt/eap/modules/system/layers/base/org/jboss/logmanager/ext/main/javax.json-1.0.4.jar:/opt/eap/modules/system/layers/base/org/jboss/logmanager/ext/main/jboss-logmanager-ext-1.0.0.Alpha2-redhat-1.jar -Djava.util.logging.manager=org.jboss.logmanager.LogManager -javaagent:/opt/eap/jolokia.jar=port=8778,protocol=https,caCert=/var/run/secrets/kubernetes.io/serviceaccount/ca.crt,clientPrincipal=cn=system:master-proxy,useSslClientAuthentication=true,extraClientCheck=true,host=0.0.0.0,discoveryEnabled=false -Djava.security.egd=file:/dev/./urandom  -Dkie.maven.settings.custom=/home/jboss/.m2/settings.xml -Dkie.mbeans=enabled -Dkie.scanner.mbeans=enabled -Dkie.server.jms.queues.response=queue/KIE.SERVER.RESPONSE -Dorg.drools.server.ext.disabled=false -Dorg.drools.server.filter.classes=true -Dorg.jbpm.ht.callback=db -Dorg.jbpm.server.ext.disabled=false -Dorg.kie.server.bypass.auth.user=true -Dorg.kie.server.domain=other -Dorg.kie.executor.disabled=false -Dorg.kie.executor.pool.size=1 -Dorg.kie.executor.retry.count=3 -Dorg.kie.executor.interval=3 -Dorg.kie.executor.initial.delay=100 -Dorg.kie.executor.timeunit=SECONDS -Dorg.kie.executor.jms=true -Dorg.kie.executor.jms.queue=queue/KIE.EXECUTOR -Dorg.kie.executor.jms.transacted=false -Dorg.kie.server.id=kieserver-multi-user-task-1-pt03f -Dorg.kie.server.location=http://multi-user-task-1-pt03f:8080/kie-server/services/rest/server -Dorg.kie.server.persistence.dialect=org.hibernate.dialect.PostgreSQLDialect -Dorg.kie.server.persistence.ds=java:jboss/datasources/testdb_postgresql -Dorg.kie.server.persistence.tm=org.hibernate.service.jta.platform.internal.JBossAppServerJtaPlatform -Dorg.kie.server.repo=/opt/eap

=========================================================================

Picked up JAVA_TOOL_OPTIONS: -Duser.home=/home/jboss -Duser.name=jboss
OpenJDK 64-Bit Server VM warning: ignoring option MaxPermSize=256m; support was removed in 8.0
I> No access restrictor found, access to all MBean is allowed
Jolokia: Agent started with URL https://10.1.0.3:8778/jolokia/
09:55:08,572 INFO  [org.jboss.modules] (main) JBoss Modules version 1.3.7.Final-redhat-1
09:55:08,824 INFO  [org.jboss.msc] (main) JBoss MSC version 1.1.5.Final-redhat-1
09:55:08,887 INFO  [org.jboss.as] (MSC service thread 1-8) JBAS015899: JBoss EAP 6.4.4.GA (AS 7.5.4.Final-redhat-4) starting
09:55:08,892 DEBUG [org.jboss.as.config] (MSC service thread 1-8) Configured system properties:
[Standalone] = 
awt.toolkit = sun.awt.X11.XToolkit
file.encoding = ANSI_X3.4-1968
file.encoding.pkg = sun.io
file.separator = /
java.awt.graphicsenv = sun.awt.X11GraphicsEnvironment
java.awt.headless = true
java.awt.printerjob = sun.print.PSPrinterJob
java.class.path = /opt/eap/jboss-modules.jar:/opt/eap/jolokia.jar
java.class.version = 52.0
java.endorsed.dirs = /usr/lib/jvm/java-1.8.0-openjdk-1.8.0.71-2.b15.el7_2.x86_64/jre/lib/endorsed
java.ext.dirs = /usr/lib/jvm/java-1.8.0-openjdk-1.8.0.71-2.b15.el7_2.x86_64/jre/lib/ext:/usr/java/packages/lib/ext
java.home = /usr/lib/jvm/java-1.8.0-openjdk-1.8.0.71-2.b15.el7_2.x86_64/jre
java.io.tmpdir = /tmp
java.library.path = /usr/java/packages/lib/amd64:/usr/lib64:/lib64:/lib:/usr/lib
java.net.preferIPv4Stack = true
java.runtime.name = OpenJDK Runtime Environment
java.runtime.version = 1.8.0_71-b15
java.security.egd = file:/dev/./urandom
java.specification.name = Java Platform API Specification
java.specification.vendor = Oracle Corporation
java.specification.version = 1.8
java.util.logging.manager = org.jboss.logmanager.LogManager
java.vendor = Oracle Corporation
java.vendor.url = http://java.oracle.com/
java.version = 1.8.0_71
java.vm.info = mixed mode
java.vm.name = OpenJDK 64-Bit Server VM
java.vm.specification.name = Java Virtual Machine Specification
java.vm.specification.vendor = Oracle Corporation
java.vm.specification.version = 1.8
java.vm.vendor = Oracle Corporation
java.vm.version = 25.71-b15
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.bind.address = 10.1.0.3
jboss.bind.address.management = 127.0.0.1
jboss.home.dir = /opt/eap
jboss.host.name = multi-user-task-1-pt03f
jboss.modules.dir = /opt/eap/modules
jboss.modules.policy-permissions = true
jboss.modules.system.pkgs = org.jboss.logmanager
jboss.node.name = multi-user-task-1-pt03f
jboss.qualified.host.name = multi-user-task-1-pt03f
jboss.server.base.dir = /opt/eap/standalone
jboss.server.config.dir = /opt/eap/standalone/configuration
jboss.server.data.dir = /opt/eap/standalone/data
jboss.server.deploy.dir = /opt/eap/standalone/data/content
jboss.server.log.dir = /opt/eap/standalone/log
jboss.server.name = multi-user-task-1-pt03f
jboss.server.persist.config = true
jboss.server.temp.dir = /opt/eap/standalone/tmp
kie.maven.settings.custom = /home/jboss/.m2/settings.xml
kie.mbeans = enabled
kie.scanner.mbeans = enabled
kie.server.jms.queues.response = queue/KIE.SERVER.RESPONSE
line.separator = 

logging.configuration = file:/opt/eap/standalone/configuration/logging.properties
module.path = /opt/eap/modules
org.drools.server.ext.disabled = false
org.drools.server.filter.classes = true
org.jboss.boot.log.file = /opt/eap/standalone/log/server.log
org.jboss.resolver.warning = true
org.jbpm.ht.callback = db
org.jbpm.server.ext.disabled = false
org.kie.executor.disabled = false
org.kie.executor.initial.delay = 100
org.kie.executor.interval = 3
org.kie.executor.jms = true
org.kie.executor.jms.queue = queue/KIE.EXECUTOR
org.kie.executor.jms.transacted = false
org.kie.executor.pool.size = 1
org.kie.executor.retry.count = 3
org.kie.executor.timeunit = SECONDS
org.kie.server.bypass.auth.user = true
org.kie.server.domain = other
org.kie.server.id = kieserver-multi-user-task-1-pt03f
org.kie.server.persistence.dialect = org.hibernate.dialect.PostgreSQLDialect
org.kie.server.persistence.ds = java:jboss/datasources/testdb_postgresql
org.kie.server.persistence.tm = org.hibernate.service.jta.platform.internal.JBossAppServerJtaPlatform
org.kie.server.repo = /opt/eap
org.xml.sax.driver = __redirected.__XMLReaderFactory
os.arch = amd64
os.name = Linux
os.version = 3.10.0-327.13.1.el7.x86_64
path.separator = :
sun.arch.data.model = 64
sun.boot.class.path = /opt/eap/jboss-modules.jar:/opt/eap/modules/system/layers/base/org/jboss/logmanager/main/jboss-logmanager-1.5.4.Final-redhat-1.jar:/opt/eap/modules/system/layers/base/org/jboss/logmanager/ext/main/javax.json-1.0.4.jar:/opt/eap/modules/system/layers/base/org/jboss/logmanager/ext/main/jboss-logmanager-ext-1.0.0.Alpha2-redhat-1.jar:/usr/lib/jvm/java-1.8.0-openjdk-1.8.0.71-2.b15.el7_2.x86_64/jre/lib/resources.jar:/usr/lib/jvm/java-1.8.0-openjdk-1.8.0.71-2.b15.el7_2.x86_64/jre/lib/rt.jar:/usr/lib/jvm/java-1.8.0-openjdk-1.8.0.71-2.b15.el7_2.x86_64/jre/lib/sunrsasign.jar:/usr/lib/jvm/java-1.8.0-openjdk-1.8.0.71-2.b15.el7_2.x86_64/jre/lib/jsse.jar:/usr/lib/jvm/java-1.8.0-openjdk-1.8.0.71-2.b15.el7_2.x86_64/jre/lib/jce.jar:/usr/lib/jvm/java-1.8.0-openjdk-1.8.0.71-2.b15.el7_2.x86_64/jre/lib/charsets.jar:/usr/lib/jvm/java-1.8.0-openjdk-1.8.0.71-2.b15.el7_2.x86_64/jre/lib/jfr.jar:/usr/lib/jvm/java-1.8.0-openjdk-1.8.0.71-2.b15.el7_2.x86_64/jre/classes
sun.boot.library.path = /usr/lib/jvm/java-1.8.0-openjdk-1.8.0.71-2.b15.el7_2.x86_64/jre/lib/amd64
sun.cpu.endian = little
sun.cpu.isalist = 
sun.io.unicode.encoding = UnicodeLittle
sun.java.command = /opt/eap/jboss-modules.jar -mp /opt/eap/modules -jaxpmodule javax.xml.jaxp-provider org.jboss.as.standalone -Djboss.home.dir=/opt/eap -Djboss.server.base.dir=/opt/eap/standalone -c standalone-openshift.xml -bmanagement 127.0.0.1 -b 10.1.0.3 -Djboss.node.name=multi-user-task-1-pt03f
sun.java.launcher = SUN_STANDARD
sun.jnu.encoding = ANSI_X3.4-1968
sun.management.compiler = HotSpot 64-Bit Tiered Compilers
sun.os.patch.level = unknown
user.country = US
user.dir = /home/jboss
user.home = /home/jboss
user.language = en
user.name = jboss
user.timezone = America/New_York
09:55:08,892 DEBUG [org.jboss.as.config] (MSC service thread 1-8) VM Arguments: -Duser.home=/home/jboss -Duser.name=jboss -D[Standalone] -XX:+UseCompressedOops -verbose:gc -Xloggc:/opt/eap/standalone/log/gc.log -XX:+PrintGCDetails -XX:+PrintGCDateStamps -XX:+UseGCLogFileRotation -XX:NumberOfGCLogFiles=5 -XX:GCLogFileSize=3M -XX:-TraceClassUnloading -Xms1303m -Xmx1303m -XX:MaxPermSize=256m -Djava.net.preferIPv4Stack=true -Djboss.modules.system.pkgs=org.jboss.logmanager -Djava.awt.headless=true -Djboss.modules.policy-permissions=true -Xbootclasspath/p:/opt/eap/jboss-modules.jar:/opt/eap/modules/system/layers/base/org/jboss/logmanager/main/jboss-logmanager-1.5.4.Final-redhat-1.jar:/opt/eap/modules/system/layers/base/org/jboss/logmanager/ext/main/javax.json-1.0.4.jar:/opt/eap/modules/system/layers/base/org/jboss/logmanager/ext/main/jboss-logmanager-ext-1.0.0.Alpha2-redhat-1.jar -Djava.util.logging.manager=org.jboss.logmanager.LogManager -javaagent:/opt/eap/jolokia.jar=port=8778,protocol=https,caCert=/var/run/secrets/kubernetes.io/serviceaccount/ca.crt,clientPrincipal=cn=system:master-proxy,useSslClientAuthentication=true,extraClientCheck=true,host=0.0.0.0,discoveryEnabled=false -Djava.security.egd=file:/dev/./urandom -Dkie.maven.settings.custom=/home/jboss/.m2/settings.xml -Dkie.mbeans=enabled -Dkie.scanner.mbeans=enabled -Dkie.server.jms.queues.response=queue/KIE.SERVER.RESPONSE -Dorg.drools.server.ext.disabled=false -Dorg.drools.server.filter.classes=true -Dorg.jbpm.ht.callback=db -Dorg.jbpm.server.ext.disabled=false -Dorg.kie.server.bypass.auth.user=true -Dorg.kie.server.domain=other -Dorg.kie.executor.disabled=false -Dorg.kie.executor.pool.size=1 -Dorg.kie.executor.retry.count=3 -Dorg.kie.executor.interval=3 -Dorg.kie.executor.initial.delay=100 -Dorg.kie.executor.timeunit=SECONDS -Dorg.kie.executor.jms=true -Dorg.kie.executor.jms.queue=queue/KIE.EXECUTOR -Dorg.kie.executor.jms.transacted=false -Dorg.kie.server.id=kieserver-multi-user-task-1-pt03f -Dorg.kie.server.location=http://multi-user-task-1-pt03f:8080/kie-server/services/rest/server -Dorg.kie.server.persistence.dialect=org.hibernate.dialect.PostgreSQLDialect -Dorg.kie.server.persistence.ds=java:jboss/datasources/testdb_postgresql -Dorg.kie.server.persistence.tm=org.hibernate.service.jta.platform.internal.JBossAppServerJtaPlatform -Dorg.kie.server.repo=/opt/eap -Dorg.jboss.boot.log.file=/opt/eap/standalone/log/server.log -Dlogging.configuration=file:/opt/eap/standalone/configuration/logging.properties 
09:55:10,471 INFO  [org.jboss.as.server.deployment.scanner] (DeploymentScanner-threads - 1) JBAS015003: Found kie-server.war in deployment directory. To trigger deployment create a file called kie-server.war.dodeploy
09:55:10,499 INFO  [org.xnio] (MSC service thread 1-7) XNIO Version 3.0.14.GA-redhat-1
09:55:10,501 INFO  [org.jboss.as.server] (Controller Boot Thread) JBAS015888: Creating http management service using socket-binding (management-http)
09:55:10,501 WARN  [org.jboss.as.server] (Controller Boot Thread) JBAS015884: No security realm defined for http management service; all access will be unrestricted.
09:55:10,503 INFO  [org.xnio.nio] (MSC service thread 1-7) XNIO NIO Implementation Version 3.0.14.GA-redhat-1
09:55:10,578 INFO  [org.jboss.remoting] (MSC service thread 1-7) JBoss Remoting version 3.3.5.Final-redhat-1
09:55:10,609 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 33) JBAS010280: Activating Infinispan subsystem.
09:55:10,672 INFO  [org.jboss.as.clustering.jgroups] (ServerService Thread Pool -- 37) JBAS010260: Activating JGroups subsystem.
09:55:10,673 INFO  [org.jboss.as.naming] (ServerService Thread Pool -- 43) JBAS011800: Activating Naming Subsystem
09:55:10,684 INFO  [org.jboss.as.jsf] (ServerService Thread Pool -- 40) JBAS012615: Activated the following JSF Implementations: [main, 1.2]
09:55:10,685 INFO  [org.jboss.as.security] (ServerService Thread Pool -- 48) JBAS013371: Activating Security Subsystem
09:55:10,720 INFO  [org.jboss.as.webservices] (ServerService Thread Pool -- 52) JBAS015537: Activating WebServices Extension
09:55:10,751 INFO  [org.jboss.as.security] (MSC service thread 1-3) JBAS013370: Current PicketBox version=4.1.1.Final-redhat-1
09:55:10,777 INFO  [org.jboss.as.connector.logging] (MSC service thread 1-7) JBAS010408: Starting JCA Subsystem (IronJacamar 1.0.32.Final-redhat-1)
09:55:10,806 INFO  [org.jboss.as.naming] (MSC service thread 1-6) JBAS011802: Starting Naming Service
09:55:10,807 INFO  [org.jboss.as.mail.extension] (MSC service thread 1-2) JBAS015400: Bound mail session [java:jboss/mail/Default]
09:55:10,843 INFO  [org.jboss.as.connector.subsystems.datasources] (ServerService Thread Pool -- 29) JBAS010403: Deploying JDBC-compliant driver class org.h2.Driver (version 1.3)
09:55:10,905 INFO  [org.jboss.as.connector.subsystems.datasources] (ServerService Thread Pool -- 29) JBAS010404: Deploying non-JDBC-compliant driver class com.mysql.jdbc.Driver (version 5.1)
09:55:10,967 INFO  [org.jboss.as.connector.subsystems.datasources] (ServerService Thread Pool -- 29) JBAS010404: Deploying non-JDBC-compliant driver class org.postgresql.Driver (version 9.2)
09:55:11,149 INFO  [org.apache.coyote.http11.Http11Protocol] (MSC service thread 1-6) JBWEB003001: Coyote HTTP/1.1 initializing on : http-/10.1.0.3:8080
09:55:11,151 INFO  [org.apache.coyote.http11.Http11Protocol] (MSC service thread 1-6) JBWEB003000: Coyote HTTP/1.1 starting on: http-/10.1.0.3:8080
09:55:11,170 INFO  [org.infinispan.configuration.cache.EvictionConfigurationBuilder] (ServerService Thread Pool -- 33) ISPN000152: Passivation configured without an eviction policy being selected. Only manually evicted entities will be passivated.
09:55:11,173 INFO  [org.infinispan.configuration.cache.EvictionConfigurationBuilder] (ServerService Thread Pool -- 33) ISPN000152: Passivation configured without an eviction policy being selected. Only manually evicted entities will be passivated.
09:55:11,234 INFO  [org.jgroups.protocols.openshift.KUBE_PING] (MSC service thread 1-7) namespace not set; clustering disabled
09:55:11,294 INFO  [org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-3) JBAS010400: Bound data source [java:jboss/datasources/testdb_postgresql]
09:55:11,384 INFO  [org.jboss.as.server.deployment] (MSC service thread 1-8) JBAS015876: Starting deployment of "activemq-rar.rar" (runtime-name: "activemq-rar.rar")
09:55:11,384 INFO  [org.jboss.as.server.deployment] (MSC service thread 1-6) JBAS015876: Starting deployment of "kie-server.war" (runtime-name: "kie-server.war")
09:55:11,388 INFO  [org.jboss.as.server.deployment.scanner] (MSC service thread 1-7) JBAS015012: Started FileSystemDeploymentService for directory /opt/eap/standalone/deployments
09:55:11,397 INFO  [org.jboss.as.remoting] (MSC service thread 1-2) JBAS017100: Listening on 10.1.0.3:4447
09:55:11,399 INFO  [org.jboss.as.remoting] (MSC service thread 1-3) JBAS017100: Listening on 127.0.0.1:9999
09:55:11,457 INFO  [org.jboss.ws.common.management] (MSC service thread 1-4) JBWS022052: Starting JBoss Web Services - Stack CXF Server 4.3.5.Final-redhat-3
09:55:11,871 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 54) HQ221000: live server is starting with configuration HornetQ Configuration (clustered=true,backup=false,sharedStore=true,journalDirectory=/opt/eap/standalone/data/messagingjournal,bindingsDirectory=/opt/eap/standalone/data/messagingbindings,largeMessagesDirectory=/opt/eap/standalone/data/messaginglargemessages,pagingDirectory=/opt/eap/standalone/data/messagingpaging)
09:55:11,872 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 54) HQ221006: Waiting to obtain live lock
09:55:11,894 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 54) HQ221013: Using NIO Journal
09:55:11,987 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 54) HQ221034: Waiting to obtain live lock
09:55:11,987 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 54) HQ221035: Live Server Obtained live lock
09:55:12,160 INFO  [org.jboss.as.connector.deployers.RADeployer] (MSC service thread 1-7) IJ020001: Required license terms for file:/opt/eap/standalone/tmp/vfs/temp/temp7823d858faf825c4/activemq-rar.rar-e63752a5588c9d2b/contents/
09:55:14,355 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 54) HQ221020: Started Netty Acceptor version 3.6.10.Final-266dbdf 10.1.0.3:5445 for CORE protocol
09:55:14,366 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 54) HQ221020: Started Netty Acceptor version 3.6.10.Final-266dbdf 10.1.0.3:5455 for CORE protocol
09:55:14,375 INFO  [stdout] (ServerService Thread Pool -- 54) 
09:55:14,375 INFO  [stdout] (ServerService Thread Pool -- 54) -------------------------------------------------------------------
09:55:14,375 INFO  [stdout] (ServerService Thread Pool -- 54) GMS: address=multi-user-task-1-pt03f/hornetq-channel, cluster=hornetq-channel, physical address=10.1.0.3:7600
09:55:14,375 INFO  [stdout] (ServerService Thread Pool -- 54) -------------------------------------------------------------------
09:55:16,097 WARN  [org.jboss.as.server.deployment] (MSC service thread 1-6) JBAS015960: Class Path entry jaxb-api.jar in /opt/eap/standalone/deployments/kie-server.war/WEB-INF/lib/jaxb-core-2.2.11.jar  does not point to a valid jar for a Class-Path reference.
09:55:16,099 WARN  [org.jboss.as.server.deployment] (MSC service thread 1-6) JBAS015960: Class Path entry jaxb-core.jar in /opt/eap/standalone/deployments/kie-server.war/WEB-INF/lib/jaxb-impl-2.2.11.jar  does not point to a valid jar for a Class-Path reference.
09:55:16,103 WARN  [org.jboss.as.server.deployment] (MSC service thread 1-6) JBAS015960: Class Path entry jaxb-core.jar in /opt/eap/standalone/deployments/kie-server.war/WEB-INF/lib/jaxb-xjc-2.2.11.jar  does not point to a valid jar for a Class-Path reference.
09:55:16,103 WARN  [org.jboss.as.server.deployment] (MSC service thread 1-6) JBAS015960: Class Path entry jaxb-impl.jar in /opt/eap/standalone/deployments/kie-server.war/WEB-INF/lib/jaxb-xjc-2.2.11.jar  does not point to a valid jar for a Class-Path reference.
09:55:16,198 WARN  [org.jboss.as.server.deployment] (MSC service thread 1-6) JBAS015893: Encountered invalid class name 'org.xmlpull.mxp1.MXParser,org.xmlpull.mxp1_serializer.MXSerializer' for service type 'org.xmlpull.v1.XmlPullParserFactory'
09:55:16,432 WARN  [org.jboss.as.dependency.deprecated] (MSC service thread 1-1) JBAS015980: Deployment "deployment.kie-server.war" is using a deprecated module ("org.osgi.core:main") which may be removed in future versions without notice.
09:55:16,432 WARN  [org.jboss.as.dependency.deprecated] (MSC service thread 1-1) JBAS015980: Deployment "deployment.kie-server.war" is using a deprecated module ("org.osgi.core:main") which may be removed in future versions without notice.
09:55:16,432 WARN  [org.jboss.as.dependency.deprecated] (MSC service thread 1-1) JBAS015980: Deployment "deployment.kie-server.war" is using a deprecated module ("org.osgi.enterprise:main") which may be removed in future versions without notice.
09:55:16,432 WARN  [org.jboss.as.dependency.deprecated] (MSC service thread 1-1) JBAS015980: Deployment "deployment.kie-server.war" is using a deprecated module ("org.osgi.enterprise:main") which may be removed in future versions without notice.
09:55:16,705 INFO  [org.jboss.weld.deployer] (MSC service thread 1-1) JBAS016002: Processing weld deployment kie-server.war
09:55:16,717 INFO  [org.jboss.as.ejb3.deployment.processors.EjbJndiBindingsDeploymentUnitProcessor] (MSC service thread 1-1) JNDI bindings for session bean named EJBTimerScheduler in deployment unit deployment "kie-server.war" are as follows:

java:global/kie-server/EJBTimerScheduler!org.jbpm.services.ejb.timer.EJBTimerScheduler
java:app/kie-server/EJBTimerScheduler!org.jbpm.services.ejb.timer.EJBTimerScheduler
java:module/EJBTimerScheduler!org.jbpm.services.ejb.timer.EJBTimerScheduler
java:global/kie-server/EJBTimerScheduler
java:app/kie-server/EJBTimerScheduler
java:module/EJBTimerScheduler

09:55:16,717 INFO  [org.jboss.as.ejb3.deployment.processors.EjbJndiBindingsDeploymentUnitProcessor] (MSC service thread 1-1) JNDI bindings for session bean named AvailableJobsExecutor in deployment unit deployment "kie-server.war" are as follows:

java:global/kie-server/AvailableJobsExecutor!org.kie.server.jms.executor.PollExecutorBean
java:app/kie-server/AvailableJobsExecutor!org.kie.server.jms.executor.PollExecutorBean
java:module/AvailableJobsExecutor!org.kie.server.jms.executor.PollExecutorBean
java:global/kie-server/AvailableJobsExecutor
java:app/kie-server/AvailableJobsExecutor
java:module/AvailableJobsExecutor

09:55:16,717 INFO  [org.jboss.as.ejb3.deployment.processors.EjbJndiBindingsDeploymentUnitProcessor] (MSC service thread 1-1) JNDI bindings for session bean named RetryTrackerSingleton in deployment unit deployment "kie-server.war" are as follows:

java:global/kie-server/RetryTrackerSingleton!org.kie.server.jms.RetryTrackerSingleton
java:app/kie-server/RetryTrackerSingleton!org.kie.server.jms.RetryTrackerSingleton
java:module/RetryTrackerSingleton!org.kie.server.jms.RetryTrackerSingleton
java:global/kie-server/RetryTrackerSingleton
java:app/kie-server/RetryTrackerSingleton
java:module/RetryTrackerSingleton

09:55:16,717 INFO  [org.jboss.as.ejb3.deployment.processors.EjbJndiBindingsDeploymentUnitProcessor] (MSC service thread 1-1) JNDI bindings for session bean named ContainerManagerEJB in deployment unit deployment "kie-server.war" are as follows:

java:global/kie-server/ContainerManagerEJB!org.kie.server.jms.ContainerManagerEJB
java:app/kie-server/ContainerManagerEJB!org.kie.server.jms.ContainerManagerEJB
java:module/ContainerManagerEJB!org.kie.server.jms.ContainerManagerEJB
java:global/kie-server/ContainerManagerEJB
java:app/kie-server/ContainerManagerEJB
java:module/ContainerManagerEJB

09:55:16,937 INFO  [org.jboss.weld.deployer] (MSC service thread 1-1) JBAS016005: Starting Services for CDI deployment: kie-server.war
09:55:16,975 INFO  [org.jboss.weld.Version] (MSC service thread 1-1) WELD-000900 1.1.31 (redhat)
09:55:17,008 INFO  [org.jboss.weld.deployer] (MSC service thread 1-5) JBAS016008: Starting weld service for deployment kie-server.war
09:55:17,391 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 54) HQ221007: Server is now live
09:55:17,391 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 54) HQ221001: HornetQ Server version 2.3.25.SP3 (2.3.x, 123) [a8e21ec8-0c7f-11e6-a34b-1bdf7c2ab36d] 
09:55:17,394 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 56) HQ221003: trying to deploy queue jms.queue.KIE.SERVER.EXECUTOR
09:55:17,429 INFO  [org.jboss.as.connector.deployment] (MSC service thread 1-4) JBAS010406: Registered connection factory java:/JmsXA
09:55:17,443 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 56) JBAS011601: Bound messaging object to jndi name java:/queue/KIE.SERVER.EXECUTOR
09:55:17,455 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 60) JBAS011601: Bound messaging object to jndi name java:jboss/exported/jms/RemoteConnectionFactory
09:55:17,456 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 54) HQ221003: trying to deploy queue jms.queue.KIE.SERVER.RESPONSE
09:55:17,457 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 54) JBAS011601: Bound messaging object to jndi name java:jboss/exported/jms/queue/KIE.SERVER.RESPONSE
09:55:17,457 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 54) JBAS011601: Bound messaging object to jndi name java:/queue/KIE.SERVER.RESPONSE
09:55:17,458 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 59) HQ221003: trying to deploy queue jms.queue.ExpiryQueue
09:55:17,468 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 59) JBAS011601: Bound messaging object to jndi name java:/jms/queue/ExpiryQueue
09:55:17,468 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 58) HQ221003: trying to deploy queue jms.queue.DLQ
09:55:17,476 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 58) JBAS011601: Bound messaging object to jndi name java:/jms/queue/DLQ
09:55:17,480 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 55) JBAS011601: Bound messaging object to jndi name java:/ConnectionFactory
09:55:17,480 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 57) HQ221003: trying to deploy queue jms.queue.KIE.SERVER.REQUEST
09:55:17,483 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 57) JBAS011601: Bound messaging object to jndi name java:/queue/KIE.SERVER.REQUEST
09:55:17,483 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 57) JBAS011601: Bound messaging object to jndi name java:jboss/exported/jms/queue/KIE.SERVER.REQUEST
09:55:17,498 INFO  [org.hornetq.ra] (MSC service thread 1-4) HornetQ resource adaptor started
09:55:17,498 INFO  [org.jboss.as.connector.services.resourceadapters.ResourceAdapterActivatorService$ResourceAdapterActivator] (MSC service thread 1-4) IJ020002: Deployed: file://RaActivatorhornetq-ra
09:55:17,500 INFO  [org.jboss.as.connector.deployment] (MSC service thread 1-4) JBAS010401: Bound JCA ConnectionFactory [java:/JmsXA]
09:55:17,508 WARN  [org.jboss.as.ejb3] (MSC service thread 1-3) JBAS014105: ActivationConfigProperty destinationJndiName will be ignored since it is not allowed by resource adapter: hornetq-ra
09:55:17,578 INFO  [org.jboss.as.ejb3] (MSC service thread 1-8) JBAS014142: Started message driven bean 'KieExecutorMDB' with 'hornetq-ra' resource adapter
09:55:17,579 INFO  [org.jboss.as.ejb3] (MSC service thread 1-3) JBAS014142: Started message driven bean 'KieServerMDB' with 'hornetq-ra' resource adapter
09:55:17,903 INFO  [org.drools.compiler.kie.builder.impl.ClasspathKieProject] (MSC service thread 1-4) Found kmodule: vfs:/opt/eap/standalone/deployments/kie-server.war/WEB-INF/lib/drools-pmml-6.3.0.Final-redhat-7.jar/META-INF/kmodule.xml
09:55:17,904 INFO  [org.drools.compiler.kie.builder.impl.ClasspathKieProject] (MSC service thread 1-4) Virtual file physical path = /opt/eap/standalone/tmp/vfs/deployment/deployment5f01d9a2acf2b7aa/drools-pmml-6.3.0.Final-redhat-7.jar-68c87ba434fb0f59/drools-pmml-6.3.0.Final-redhat-7.jar
09:55:18,090 INFO  [org.drools.compiler.kie.builder.impl.KieRepositoryImpl] (MSC service thread 1-4) KieModule was added: ZipKieModule[releaseId=org.drools:drools-pmml:6.3.0.Final-redhat-7,file=/opt/eap/standalone/tmp/vfs/deployment/deployment5f01d9a2acf2b7aa/drools-pmml-6.3.0.Final-redhat-7.jar-68c87ba434fb0f59/drools-pmml-6.3.0.Final-redhat-7.jar]
09:55:18,237 INFO  [org.kie.server.jms.RetryTrackerSingleton] (ServerService Thread Pool -- 55) JMS message retry limit set to 2
09:55:18,253 INFO  [org.jboss.web] (ServerService Thread Pool -- 55) JBAS018210: Register web context: /kie-server
09:55:18,283 INFO  [org.kie.server.services.Bootstrap] (ServerService Thread Pool -- 55) KieServer (id kieserver-multi-user-task-1-pt03f (name kieserver-multi-user-task-1-pt03f)) started initialization process
09:55:18,381 INFO  [org.kie.server.services.impl.KieServerImpl] (ServerService Thread Pool -- 55) Server Default Extension has been successfully registered as server extension
09:55:18,386 INFO  [org.kie.server.services.impl.KieServerImpl] (ServerService Thread Pool -- 55) Drools KIE Server extension has been successfully registered as server extension
09:55:18,536 INFO  [org.hibernate.annotations.common.Version] (ServerService Thread Pool -- 55) HCANN000001: Hibernate Commons Annotations {4.0.2.Final-redhat-1}
09:55:18,539 INFO  [org.hibernate.Version] (ServerService Thread Pool -- 55) HHH000412: Hibernate Core {4.2.20.Final-redhat-1}
09:55:18,540 INFO  [org.hibernate.cfg.Environment] (ServerService Thread Pool -- 55) HHH000206: hibernate.properties not found
09:55:18,542 INFO  [org.hibernate.cfg.Environment] (ServerService Thread Pool -- 55) HHH000021: Bytecode provider name : javassist
09:55:18,554 INFO  [org.hibernate.ejb.Ejb3Configuration] (ServerService Thread Pool -- 55) HHH000204: Processing PersistenceUnitInfo [
name: org.jbpm.domain
...]
09:55:19,122 INFO  [org.hibernate.dialect.Dialect] (ServerService Thread Pool -- 55) HHH000400: Using dialect: org.hibernate.dialect.PostgreSQLDialect
09:55:19,129 INFO  [org.hibernate.engine.jdbc.internal.LobCreatorBuilder] (ServerService Thread Pool -- 55) HHH000424: Disabling contextual LOB creation as createClob() method threw error : java.lang.reflect.InvocationTargetException
09:55:19,337 INFO  [org.hibernate.engine.transaction.internal.TransactionFactoryInitiator] (ServerService Thread Pool -- 55) HHH000268: Transaction strategy: org.hibernate.engine.transaction.internal.jta.CMTTransactionFactory
09:55:19,340 INFO  [org.hibernate.hql.internal.ast.ASTQueryTranslatorFactory] (ServerService Thread Pool -- 55) HHH000397: Using ASTQueryTranslatorFactory
09:55:19,601 INFO  [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 55) HHH000228: Running hbm2ddl schema update
09:55:19,601 INFO  [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 55) HHH000102: Fetching database metadata
09:55:19,612 INFO  [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 55) HHH000396: Updating schema
09:55:19,620 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Attachment
09:55:19,622 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: AuditTaskImpl
09:55:19,624 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: BAMTaskSummary
09:55:19,625 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: BooleanExpression
09:55:19,627 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Content
09:55:19,628 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: ContextMappingInfo
09:55:19,630 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: CorrelationKeyInfo
09:55:19,631 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: CorrelationPropertyInfo
09:55:19,633 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Deadline
09:55:19,635 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Delegation_delegates
09:55:19,636 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: DeploymentStore
09:55:19,638 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: ErrorInfo
09:55:19,639 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Escalation
09:55:19,641 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: EventTypes
09:55:19,643 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: I18NText
09:55:19,644 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: NodeInstanceLog
09:55:19,646 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Notification
09:55:19,648 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Notification_BAs
09:55:19,649 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Notification_Recipients
09:55:19,651 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Notification_email_header
09:55:19,652 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: OrganizationalEntity
09:55:19,654 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: PeopleAssignments_BAs
09:55:19,656 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: PeopleAssignments_ExclOwners
09:55:19,657 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: PeopleAssignments_PotOwners
09:55:19,659 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: PeopleAssignments_Recipients
09:55:19,661 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: PeopleAssignments_Stakeholders
09:55:19,662 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: ProcessInstanceInfo
09:55:19,664 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: ProcessInstanceLog
09:55:19,665 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Reassignment
09:55:19,667 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Reassignment_potentialOwners
09:55:19,669 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: RequestInfo
09:55:19,670 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: SessionInfo
09:55:19,672 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Task
09:55:19,674 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: TaskDef
09:55:19,675 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: TaskEvent
09:55:19,677 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: VariableInstanceLog
09:55:19,678 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: WorkItemInfo
09:55:19,680 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: email_header
09:55:19,681 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: task_comment
09:55:19,683 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Attachment
09:55:19,684 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: AuditTaskImpl
09:55:19,686 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: BAMTaskSummary
09:55:19,687 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: BooleanExpression
09:55:19,689 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Content
09:55:19,690 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: ContextMappingInfo
09:55:19,692 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: CorrelationKeyInfo
09:55:19,693 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: CorrelationPropertyInfo
09:55:19,694 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Deadline
09:55:19,696 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Delegation_delegates
09:55:19,697 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: DeploymentStore
09:55:19,699 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: ErrorInfo
09:55:19,700 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Escalation
09:55:19,702 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: EventTypes
09:55:19,703 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: I18NText
09:55:19,705 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: NodeInstanceLog
09:55:19,706 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Notification
09:55:19,708 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Notification_BAs
09:55:19,710 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Notification_Recipients
09:55:19,713 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Notification_email_header
09:55:19,714 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: OrganizationalEntity
09:55:19,716 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: PeopleAssignments_BAs
09:55:19,717 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: PeopleAssignments_ExclOwners
09:55:19,718 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: PeopleAssignments_PotOwners
09:55:19,720 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: PeopleAssignments_Recipients
09:55:19,721 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: PeopleAssignments_Stakeholders
09:55:19,723 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: ProcessInstanceInfo
09:55:19,724 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: ProcessInstanceLog
09:55:19,725 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Reassignment
09:55:19,727 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Reassignment_potentialOwners
09:55:19,728 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: RequestInfo
09:55:19,729 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: SessionInfo
09:55:19,730 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Task
09:55:19,732 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: TaskDef
09:55:19,733 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: TaskEvent
09:55:19,734 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: VariableInstanceLog
09:55:19,735 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: WorkItemInfo
09:55:19,738 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: email_header
09:55:19,739 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: task_comment
09:55:19,741 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Attachment
09:55:19,742 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: AuditTaskImpl
09:55:19,743 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: BAMTaskSummary
09:55:19,747 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: BooleanExpression
09:55:19,749 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Content
09:55:19,750 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: ContextMappingInfo
09:55:19,751 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: CorrelationKeyInfo
09:55:19,753 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: CorrelationPropertyInfo
09:55:19,755 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Deadline
09:55:19,756 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Delegation_delegates
09:55:19,758 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: DeploymentStore
09:55:19,759 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: ErrorInfo
09:55:19,760 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Escalation
09:55:19,761 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: EventTypes
09:55:19,763 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: I18NText
09:55:19,764 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: NodeInstanceLog
09:55:19,765 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Notification
09:55:19,767 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Notification_BAs
09:55:19,768 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Notification_Recipients
09:55:19,769 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Notification_email_header
09:55:19,771 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: OrganizationalEntity
09:55:19,772 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: PeopleAssignments_BAs
09:55:19,773 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: PeopleAssignments_ExclOwners
09:55:19,775 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: PeopleAssignments_PotOwners
09:55:19,776 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: PeopleAssignments_Recipients
09:55:19,777 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: PeopleAssignments_Stakeholders
09:55:19,779 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: ProcessInstanceInfo
09:55:19,780 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: ProcessInstanceLog
09:55:19,781 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Reassignment
09:55:19,782 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Reassignment_potentialOwners
09:55:19,784 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: RequestInfo
09:55:19,786 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: SessionInfo
09:55:19,787 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: Task
09:55:19,788 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: TaskDef
09:55:19,790 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: TaskEvent
09:55:19,791 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: VariableInstanceLog
09:55:19,792 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: WorkItemInfo
09:55:19,793 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: email_header
09:55:19,795 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: task_comment
09:55:19,797 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: ATTACHMENT_ID_SEQ
09:55:19,798 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: AUDIT_ID_SEQ
09:55:19,799 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: BAM_TASK_ID_SEQ
09:55:19,801 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: BOOLEANEXPR_ID_SEQ
09:55:19,802 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: COMMENT_ID_SEQ
09:55:19,803 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: CONTENT_ID_SEQ
09:55:19,805 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: CONTEXT_MAPPING_INFO_ID_SEQ
09:55:19,806 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: CORRELATION_KEY_ID_SEQ
09:55:19,807 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: CORRELATION_PROP_ID_SEQ
09:55:19,809 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: DEADLINE_ID_SEQ
09:55:19,810 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: DEPLOY_STORE_ID_SEQ
09:55:19,811 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: EMAILNOTIFHEAD_ID_SEQ
09:55:19,813 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: ERROR_INFO_ID_SEQ
09:55:19,814 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: ESCALATION_ID_SEQ
09:55:19,815 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: I18NTEXT_ID_SEQ
09:55:19,817 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: NODE_INST_LOG_ID_SEQ
09:55:19,818 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: NOTIFICATION_ID_SEQ
09:55:19,819 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: PROCESS_INSTANCE_INFO_ID_SEQ
09:55:19,821 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: PROC_INST_LOG_ID_SEQ
09:55:19,822 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: REASSIGNMENT_ID_SEQ
09:55:19,823 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: REQUEST_INFO_ID_SEQ
09:55:19,825 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: SESSIONINFO_ID_SEQ
09:55:19,826 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: TASK_DEF_ID_SEQ
09:55:19,827 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: TASK_EVENT_ID_SEQ
09:55:19,829 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: TASK_ID_SEQ
09:55:19,830 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: VAR_INST_LOG_ID_SEQ
09:55:19,831 INFO  [java.sql.DatabaseMetaData] (ServerService Thread Pool -- 55) HHH000262: Table not found: WORKITEMINFO_ID_SEQ
09:55:20,892 INFO  [org.hibernate.tool.hbm2ddl.SchemaUpdate] (ServerService Thread Pool -- 55) HHH000232: Schema update complete
09:55:22,915 ERROR [org.kie.server.services.impl.KieServerImpl] (ServerService Thread Pool -- 55) Error when initializing server extension of type jBPM KIE Server extension: java.lang.IllegalStateException: Can get data source for DB usergroup callback, JNDI name: "java:jboss/datasources/testdb_postgresql"
at org.jbpm.services.task.identity.DBUserGroupCallbackImpl.init(DBUserGroupCallbackImpl.java:159)
at org.jbpm.services.task.identity.DBUserGroupCallbackImpl.<init>(DBUserGroupCallbackImpl.java:65)
at org.jbpm.runtime.manager.impl.identity.UserDataServiceProvider.getUserGroupCallback(UserDataServiceProvider.java:77)
at org.kie.server.services.jbpm.JbpmKieServerExtension.init(JbpmKieServerExtension.java:153)
at org.kie.server.services.impl.KieServerImpl.<init>(KieServerImpl.java:93)
at org.kie.server.services.impl.KieServerLocator.<clinit>(KieServerLocator.java:20)
at org.kie.server.services.Bootstrap.contextInitialized(Bootstrap.java:50)
at org.apache.catalina.core.StandardContext.contextListenerStart(StandardContext.java:3339)
at org.apache.catalina.core.StandardContext.start(StandardContext.java:3780)
at org.jboss.as.web.deployment.WebDeploymentService.doStart(WebDeploymentService.java:163)
at org.jboss.as.web.deployment.WebDeploymentService.access$000(WebDeploymentService.java:61)
at org.jboss.as.web.deployment.WebDeploymentService$1.run(WebDeploymentService.java:96)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [rt.jar:1.8.0_71]
at java.util.concurrent.FutureTask.run(FutureTask.java:266) [rt.jar:1.8.0_71]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [rt.jar:1.8.0_71]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [rt.jar:1.8.0_71]
at java.lang.Thread.run(Thread.java:745) [rt.jar:1.8.0_71]
at org.jboss.threads.JBossThread.run(JBossThread.java:122)
Caused by: javax.naming.NameNotFoundException: "java:jboss/datasources/testdb_postgresql"
at org.jboss.as.naming.InitialContext$DefaultInitialContext.findContext(InitialContext.java:197)
at org.jboss.as.naming.InitialContext$DefaultInitialContext.lookup(InitialContext.java:241)
at org.jboss.as.naming.NamingContext.lookup(NamingContext.java:183)
at org.jboss.as.naming.NamingContext.lookup(NamingContext.java:179)
at javax.naming.InitialContext.lookup(InitialContext.java:417) [rt.jar:1.8.0_71]
at javax.naming.InitialContext.lookup(InitialContext.java:417) [rt.jar:1.8.0_71]
at org.jbpm.services.task.identity.DBUserGroupCallbackImpl.init(DBUserGroupCallbackImpl.java:156)
... 17 more

09:55:22,921 INFO  [org.kie.server.services.Bootstrap] (ServerService Thread Pool -- 55) KieServer (id kieserver-multi-user-task-1-pt03f) started successfully
09:55:22,932 INFO  [org.kie.server.services.impl.ContainerManager] (EJB default - 1) About to install containers '[KieContainerResource [containerId=testContainer, releaseId=com.redhat.xpaas.bpms:multi-user-task-project:1.0.0, resolvedReleaseId=null, status=STARTED]]' on kie server 'KieServer{id='kieserver-multi-user-task-1-pt03f'name='kieserver-multi-user-task-1-pt03f'version='6.3.0.Final-redhat-7'location='http://multi-user-task-1-pt03f:8080/kie-server/services/rest/server'}'
09:55:23,056 INFO  [org.jboss.as.server] (ServerService Thread Pool -- 30) JBAS015859: Deployed "kie-server.war" (runtime-name : "kie-server.war")
09:55:23,056 INFO  [org.jboss.as.server] (ServerService Thread Pool -- 30) JBAS015859: Deployed "activemq-rar.rar" (runtime-name : "activemq-rar.rar")
09:55:23,207 INFO  [org.jboss.as] (Controller Boot Thread) JBAS015961: Http management interface listening on http://127.0.0.1:9990/management
09:55:23,207 INFO  [org.jboss.as] (Controller Boot Thread) JBAS015951: Admin console listening on http://127.0.0.1:9990
09:55:23,207 INFO  [org.jboss.as] (Controller Boot Thread) JBAS015874: JBoss EAP 6.4.4.GA (AS 7.5.4.Final-redhat-4) started in 14838ms - Started 369 of 461 services (132 services are lazy, passive or on-demand)
09:55:23,650 INFO  [org.jboss.resteasy.cdi.i18n] (http-/10.1.0.3:8080-1) RESTEASY006050: Found BeanManager at java:comp/BeanManager
09:55:23,692 INFO  [org.kie.scanner.embedder.MavenEmbedderUtils] (EJB default - 1) Not in OSGi: using plexus based maven parser
09:55:23,726 INFO  [org.hibernate.validator.internal.util.Version] (http-/10.1.0.3:8080-1) HV000001: Hibernate Validator 4.3.2.Final-redhat-2
09:55:24,215 INFO  [org.jboss.resteasy.resteasy_jaxrs.i18n] (http-/10.1.0.3:8080-1) RESTEASY000320: Deploying javax.ws.rs.core.Application: class org.kie.server.remote.rest.common.KieServerApplication
09:55:24,216 INFO  [org.jboss.resteasy.resteasy_jaxrs.i18n] (http-/10.1.0.3:8080-1) RESTEASY000315: Adding singleton resource org.kie.server.remote.rest.common.resource.KieServerRestImpl from Application javax.ws.rs.core.Application
09:55:24,216 INFO  [org.jboss.resteasy.resteasy_jaxrs.i18n] (http-/10.1.0.3:8080-1) RESTEASY000315: Adding singleton resource org.kie.server.remote.rest.common.resource.KieServerResource from Application javax.ws.rs.core.Application
09:55:24,216 INFO  [org.jboss.resteasy.resteasy_jaxrs.i18n] (http-/10.1.0.3:8080-1) RESTEASY000315: Adding singleton resource org.kie.server.remote.rest.drools.CommandResource from Application javax.ws.rs.core.Application
09:55:25,126 ERROR [stderr] (EJB default - 1) ScriptEngineManager providers.next(): javax.script.ScriptEngineFactory: Provider jdk.nashorn.api.scripting.NashornScriptEngineFactory not found
09:55:25,128 ERROR [stderr] (EJB default - 1) ScriptEngineManager providers.next(): javax.script.ScriptEngineFactory: Provider com.sun.script.javascript.RhinoScriptEngineFactory not found
09:55:25,364 INFO  [org.drools.compiler.kie.builder.impl.KieRepositoryImpl] (EJB default - 1) KieModule was added: ZipKieModule[releaseId=com.redhat.xpaas.bpms:multi-user-task-project:1.0.0,file=/home/jboss/.m2/repository/com/redhat/xpaas/bpms/multi-user-task-project/1.0.0/multi-user-task-project-1.0.0.jar]
09:55:25,440 INFO  [org.kie.scanner.embedder.MavenEmbedderUtils] (EJB default - 1) Not in OSGi: using plexus based maven parser
09:55:25,758 INFO  [org.kie.server.services.impl.KieServerImpl] (EJB default - 1) Container testContainer (for release id com.redhat.xpaas.bpms:multi-user-task-project:1.0.0) successfully started


standalone-openshift.xml

Maciej Swiderski

unread,
Apr 27, 2016, 10:23:44 AM4/27/16
to Radek Koubský, jBPM Setup
I believe the problem is that you included the JNDI name in quotes ("java:jboss/datasources/testdb_postgresql”). Remove the quotes from the db.ds.jndi.name and you should be fine. Same applies to all other properties that you define in that property file.

Maciej
--
You received this message because you are subscribed to the Google Groups "jBPM Setup" group.
To unsubscribe from this group and stop receiving emails from it, send an email to jbpm-setup+...@googlegroups.com.
To post to this group, send email to jbpm-...@googlegroups.com.
To view this discussion on the web visit https://groups.google.com/d/msgid/jbpm-setup/77b7e048-364d-4a22-8fa0-d9bef2280a33%40googlegroups.com.
For more options, visit https://groups.google.com/d/optout.
<standalone-openshift.xml>

Radek Koubský

unread,
Apr 27, 2016, 11:10:30 AM4/27/16
to jBPM Setup, radekk...@gmail.com
Hi Maciej,
I can't believe I put  the quotes there and I didn't see them! I have removed them and it works properly now. Thanks again.
...
Reply all
Reply to author
Forward
0 new messages