Michal Toth created ARTEMIS-1686:
------------------------------------
Summary: Connection to PostgreSQL seems to be broken
Key: ARTEMIS-1686
URL: https://issues.apache.org/jira/browse/ARTEMIS-1686
Project: ActiveMQ Artemis
Issue Type: Bug
Components: Broker
Affects Versions: 2.4.0
Environment: Rhel7
Reporter: Michal Toth
Unable to connect to PostreSQL database with configured broker.xml and added
appropriate connector-jar.
{normat}
[root@hp-dl380pgen8-02-vm-12 ~]# /opt/jboss-amq-7-i0/bin/artemis run
__ __ ____ ____ _
/\ | \/ |/ __ \ | _ \ | |
/ \ | \ / | | | | | |_) |_ __ ___ | | _____ _ __
/ /\ \ | |\/| | | | | | _ <| '__/ _ | |/ / _ \ '__|
/ ____ | | | | |__| | | |_) | | | (_) | < __/ |
/_/ __| |_|____\ |____/|_| ___/|_|____|_|
Red Hat JBoss AMQ 7.1.0.GA
10:36:31.298 DEBUG [org.jboss.logging] Logging Provider:
org.jboss.logging.JBossLogManagerProvider
10:36:31.299 DEBUG [org.apache.activemq.artemis.integration.bootstrap]
AMQ101005: Using broker configuration: xml:/opt/jboss-amq-7-i0/etc/bootstrap.xml
10:36:31.301 FINE [javax.xml.bind] Searching jaxb.properties
10:36:31.301 FINE [javax.xml.bind] Searching the system property
10:36:31.302 FINE [javax.xml.bind] Unable to find from OSGi:
javax.xml.bind.JAXBContext
10:36:31.302 FINE [javax.xml.bind] Searching META-INF/services
10:36:31.302 FINE [javax.xml.bind] Unable to
load:META-INF/services/javax.xml.bind.JAXBContext
10:36:31.302 FINE [javax.xml.bind] Trying to create the platform default
provider
10:36:31.302 FINE [javax.xml.bind] Trying to load
com.sun.xml.internal.bind.v2.ContextFactory
...
10:36:32.045 WARN [org.apache.activemq.artemis.core.server] AMQ222269: Please
use a fixed value for "journal-pool-files". Default changed per
https://issues.apache.org/jira/browse/ARTEMIS-1628
10:36:32.094 INFO [org.apache.activemq.artemis.integration.bootstrap]
AMQ101000: Starting ActiveMQ Artemis Server
10:36:32.112 DEBUG
[org.apache.activemq.artemis.core.server.impl.ActiveMQServerImpl] Starting
server ActiveMQServerImpl::
10:36:32.796 INFO [org.apache.activemq.artemis.core.server] AMQ221000: live
Message Broker is starting with configuration Broker Configuration
(clustered=false,journalDirectory=./data/journal,bindingsDirectory=./data/bindings,largeMessagesDirectory=./data/large-messages,pagingDirectory=./data/paging)
10:36:32.956 WARN
[org.apache.activemq.artemis.jdbc.store.drivers.AbstractJDBCDriver]
SQL EXCEPTIONS:
SQLState: 0A000 ErrorCode: 0 Message: Method
org.postgresql.jdbc.PgConnection.setNetworkTimeout(Executor, int) is not yet
implemented.
10:36:32.959 WARN [org.apache.activemq.artemis.journal] Unable to set a
network timeout on the JDBC connection
10:36:33.170 WARN
[org.apache.activemq.artemis.jdbc.store.drivers.AbstractJDBCDriver]
SQL EXCEPTIONS:
SQLState: 0A000 ErrorCode: 0 Message: Method
org.postgresql.jdbc.PgConnection.setNetworkTimeout(Executor, int) is not yet
implemented.
10:36:33.171 WARN [org.apache.activemq.artemis.journal] Unable to set a
network timeout on the JDBC connection
10:36:33.267 DEBUG
[org.apache.activemq.artemis.spi.core.protocol.MessagePersister] Cannot find
persister for
org.apache.activemq.artemis.core.protocol.mqtt.MQTTProtocolManagerFactory@21b2e768
10:36:33.269 DEBUG
[org.apache.activemq.artemis.spi.core.protocol.MessagePersister] Cannot find
persister for
org.apache.activemq.artemis.core.protocol.openwire.OpenWireProtocolManagerFactory@fa36558
10:36:33.270 DEBUG
[org.apache.activemq.artemis.spi.core.protocol.MessagePersister] Cannot find
persister for
org.apache.activemq.artemis.core.protocol.stomp.StompProtocolManagerFactory@7748410a
10:36:33.270 INFO [org.apache.activemq.artemis.core.server] AMQ221043:
Protocol module found: [artemis-server]. Adding protocol support for: CORE
10:36:33.271 INFO [org.apache.activemq.artemis.core.server] AMQ221043:
Protocol module found: [artemis-amqp-protocol]. Adding protocol support for:
AMQP
10:36:33.271 INFO [org.apache.activemq.artemis.core.server] AMQ221043:
Protocol module found: [artemis-hornetq-protocol]. Adding protocol support for:
HORNETQ
10:36:33.272 DEBUG
[org.apache.activemq.artemis.spi.core.protocol.MessagePersister] Cannot find
persister for
org.apache.activemq.artemis.core.protocol.mqtt.MQTTProtocolManagerFactory@65b3f4a4
10:36:33.272 INFO [org.apache.activemq.artemis.core.server] AMQ221043:
Protocol module found: [artemis-mqtt-protocol]. Adding protocol support for:
MQTT
10:36:33.272 DEBUG
[org.apache.activemq.artemis.spi.core.protocol.MessagePersister] Cannot find
persister for
org.apache.activemq.artemis.core.protocol.openwire.OpenWireProtocolManagerFactory@50caa560
10:36:33.272 INFO [org.apache.activemq.artemis.core.server] AMQ221043:
Protocol module found: [artemis-openwire-protocol]. Adding protocol support
for: OPENWIRE
10:36:33.272 DEBUG
[org.apache.activemq.artemis.spi.core.protocol.MessagePersister] Cannot find
persister for
org.apache.activemq.artemis.core.protocol.stomp.StompProtocolManagerFactory@186f8716
10:36:33.273 INFO [org.apache.activemq.artemis.core.server] AMQ221043:
Protocol module found: [artemis-stomp-protocol]. Adding protocol support for:
STOMP
10:36:33.666 WARN
[org.apache.activemq.artemis.jdbc.store.drivers.AbstractJDBCDriver]
SQL EXCEPTIONS:
SQLState: 0A000 ErrorCode: 0 Message: Method
org.postgresql.jdbc.PgConnection.setNetworkTimeout(Executor, int) is not yet
implemented.
10:36:33.666 WARN [org.apache.activemq.artemis.journal] Unable to set a
network timeout on the JDBC connection
10:36:33.954 WARN
[org.apache.activemq.artemis.jdbc.store.drivers.AbstractJDBCDriver]
SQL EXCEPTIONS:
SQLState: 0A000 ErrorCode: 0 Message: Method
org.postgresql.jdbc.PgConnection.setNetworkTimeout(Executor, int) is not yet
implemented.
10:36:33.954 WARN [org.apache.activemq.artemis.journal] Unable to set a
network timeout on the JDBC connection
10:36:35.305 DEBUG [io.netty.buffer.PooledByteBufAllocator]
-Dio.netty.allocator.numHeapArenas: 4
10:36:35.305 DEBUG [io.netty.buffer.PooledByteBufAllocator]
-Dio.netty.allocator.numDirectArenas: 4
10:36:35.305 DEBUG [io.netty.buffer.PooledByteBufAllocator]
-Dio.netty.allocator.pageSize: 8192
10:36:35.305 DEBUG [io.netty.buffer.PooledByteBufAllocator]
-Dio.netty.allocator.maxOrder: 11
10:36:35.305 DEBUG [io.netty.buffer.PooledByteBufAllocator]
-Dio.netty.allocator.chunkSize: 16777216
10:36:35.305 DEBUG [io.netty.buffer.PooledByteBufAllocator]
-Dio.netty.allocator.tinyCacheSize: 512
10:36:35.305 DEBUG [io.netty.buffer.PooledByteBufAllocator]
-Dio.netty.allocator.smallCacheSize: 256
10:36:35.305 DEBUG [io.netty.buffer.PooledByteBufAllocator]
-Dio.netty.allocator.normalCacheSize: 64
10:36:35.306 DEBUG [io.netty.buffer.PooledByteBufAllocator]
-Dio.netty.allocator.maxCachedBufferCapacity: 32768
10:36:35.306 DEBUG [io.netty.buffer.PooledByteBufAllocator]
-Dio.netty.allocator.cacheTrimInterval: 8192
10:36:35.306 DEBUG [io.netty.buffer.PooledByteBufAllocator]
-Dio.netty.allocator.useCacheForAllThreads: true
10:36:35.313 DEBUG [io.netty.util.internal.InternalThreadLocalMap]
-Dio.netty.threadLocalMap.stringBuilder.initialSize: 1024
10:36:35.313 DEBUG [io.netty.util.internal.InternalThreadLocalMap]
-Dio.netty.threadLocalMap.stringBuilder.maxSize: 4096
10:36:35.338 DEBUG [io.netty.buffer.AbstractByteBuf]
-Dio.netty.buffer.bytebuf.checkAccessible: true
10:36:35.342 DEBUG [io.netty.util.ResourceLeakDetector]
-Dio.netty.leakDetection.level: simple
10:36:35.342 DEBUG [io.netty.util.ResourceLeakDetector]
-Dio.netty.leakDetection.maxRecords: 4
10:36:35.342 DEBUG [io.netty.util.ResourceLeakDetector]
-Dio.netty.leakDetection.maxSampledRecords: 40
10:36:35.343 DEBUG [io.netty.util.ResourceLeakDetectorFactory] Loaded default
ResourceLeakDetector: io.netty.util.ResourceLeakDetector@57d7f8ca
10:36:36.003 WARN [org.apache.activemq.artemis.core.server] AMQ222010:
Critical IO Error, shutting down the server. file=NULL, message=Unable to start
database driver: java.lang.IllegalStateException: jdbcDriverClass is null or
empty!
at
org.apache.activemq.artemis.jdbc.store.drivers.AbstractJDBCDriver.connect(AbstractJDBCDriver.java:127)
[artemis-jdbc-store-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at
org.apache.activemq.artemis.jdbc.store.drivers.AbstractJDBCDriver.start(AbstractJDBCDriver.java:80)
[artemis-jdbc-store-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at
org.apache.activemq.artemis.jdbc.store.file.JDBCSequentialFileFactory.start(JDBCSequentialFileFactory.java:132)
[artemis-jdbc-store-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at
org.apache.activemq.artemis.core.paging.impl.PagingStoreFactoryDatabase.reloadStores(PagingStoreFactoryDatabase.java:203)
[artemis-server-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at
org.apache.activemq.artemis.core.paging.impl.PagingManagerImpl.reloadStores(PagingManagerImpl.java:246)
[artemis-server-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at
org.apache.activemq.artemis.core.paging.impl.PagingManagerImpl.start(PagingManagerImpl.java:335)
[artemis-server-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at
org.apache.activemq.artemis.core.server.impl.ActiveMQServerImpl.initialisePart1(ActiveMQServerImpl.java:2291)
[artemis-server-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at
org.apache.activemq.artemis.core.server.impl.LiveOnlyActivation.run(LiveOnlyActivation.java:63)
[artemis-server-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at
org.apache.activemq.artemis.core.server.impl.ActiveMQServerImpl.internalStart(ActiveMQServerImpl.java:521)
[artemis-server-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at
org.apache.activemq.artemis.core.server.impl.ActiveMQServerImpl.start(ActiveMQServerImpl.java:460)
[artemis-server-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at
org.apache.activemq.artemis.integration.FileBroker.start(FileBroker.java:111)
[artemis-cli-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at org.apache.activemq.artemis.cli.commands.Run.execute(Run.java:82)
[artemis-cli-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at org.apache.activemq.artemis.cli.Artemis.internalExecute(Artemis.java:149)
[artemis-cli-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at org.apache.activemq.artemis.cli.Artemis.execute(Artemis.java:96)
[artemis-cli-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at org.apache.activemq.artemis.cli.Artemis.execute(Artemis.java:123)
[artemis-cli-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[rt.jar:1.8.0_161]
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[rt.jar:1.8.0_161]
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[rt.jar:1.8.0_161]
at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_161]
at org.apache.activemq.artemis.boot.Artemis.execute(Artemis.java:129)
[artemis-boot.jar:2.4.0.amq-710004-redhat-1]
at org.apache.activemq.artemis.boot.Artemis.main(Artemis.java:49)
[artemis-boot.jar:2.4.0.amq-710004-redhat-1]
java.lang.NullPointerException
at
org.apache.activemq.artemis.jdbc.store.file.JDBCSequentialFileFactoryDriver.fileExists(JDBCSequentialFileFactoryDriver.java:133)
at
org.apache.activemq.artemis.jdbc.store.file.JDBCSequentialFileFactoryDriver.openFile(JDBCSequentialFileFactoryDriver.java:111)
at
org.apache.activemq.artemis.jdbc.store.file.JDBCSequentialFile.load(JDBCSequentialFile.java:110)
at
org.apache.activemq.artemis.jdbc.store.file.JDBCSequentialFile.open(JDBCSequentialFile.java:104)
at
org.apache.activemq.artemis.core.paging.impl.PagingStoreFactoryDatabase.reloadStores(PagingStoreFactoryDatabase.java:206)
at
org.apache.activemq.artemis.core.paging.impl.PagingManagerImpl.reloadStores(PagingManagerImpl.java:246)
at
org.apache.activemq.artemis.core.paging.impl.PagingManagerImpl.start(PagingManagerImpl.java:335)
at
org.apache.activemq.artemis.core.server.impl.ActiveMQServerImpl.initialisePart1(ActiveMQServerImpl.java:2291)
at
org.apache.activemq.artemis.core.server.impl.LiveOnlyActivation.run(LiveOnlyActivation.java:63)
at
org.apache.activemq.artemis.core.server.impl.ActiveMQServerImpl.internalStart(ActiveMQServerImpl.java:521)
at
org.apache.activemq.artemis.core.server.impl.ActiveMQServerImpl.start(ActiveMQServerImpl.java:460)
at
org.apache.activemq.artemis.integration.FileBroker.start(FileBroker.java:111)
at org.apache.activemq.artemis.cli.commands.Run.execute(Run.java:82)
at org.apache.activemq.artemis.cli.Artemis.internalExecute(Artemis.java:149)
at org.apache.activemq.artemis.cli.Artemis.execute(Artemis.java:96)
at org.apache.activemq.artemis.cli.Artemis.execute(Artemis.java:123)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at org.apache.activemq.artemis.boot.Artemis.execute(Artemis.java:129)
at org.apache.activemq.artemis.boot.Artemis.main(Artemis.java:49)
10:36:36.009 ERROR [org.apache.activemq.artemis.core.server] AMQ224000:
Failure in initialisation: java.lang.NullPointerException
at
org.apache.activemq.artemis.jdbc.store.file.JDBCSequentialFileFactoryDriver.fileExists(JDBCSequentialFileFactoryDriver.java:133)
[artemis-jdbc-store-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at
org.apache.activemq.artemis.jdbc.store.file.JDBCSequentialFileFactoryDriver.openFile(JDBCSequentialFileFactoryDriver.java:111)
[artemis-jdbc-store-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at
org.apache.activemq.artemis.jdbc.store.file.JDBCSequentialFile.load(JDBCSequentialFile.java:110)
[artemis-jdbc-store-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at
org.apache.activemq.artemis.jdbc.store.file.JDBCSequentialFile.open(JDBCSequentialFile.java:104)
[artemis-jdbc-store-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at
org.apache.activemq.artemis.core.paging.impl.PagingStoreFactoryDatabase.reloadStores(PagingStoreFactoryDatabase.java:206)
[artemis-server-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at
org.apache.activemq.artemis.core.paging.impl.PagingManagerImpl.reloadStores(PagingManagerImpl.java:246)
[artemis-server-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at
org.apache.activemq.artemis.core.paging.impl.PagingManagerImpl.start(PagingManagerImpl.java:335)
[artemis-server-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at
org.apache.activemq.artemis.core.server.impl.ActiveMQServerImpl.initialisePart1(ActiveMQServerImpl.java:2291)
[artemis-server-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at
org.apache.activemq.artemis.core.server.impl.LiveOnlyActivation.run(LiveOnlyActivation.java:63)
[artemis-server-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at
org.apache.activemq.artemis.core.server.impl.ActiveMQServerImpl.internalStart(ActiveMQServerImpl.java:521)
[artemis-server-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at
org.apache.activemq.artemis.core.server.impl.ActiveMQServerImpl.start(ActiveMQServerImpl.java:460)
[artemis-server-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at
org.apache.activemq.artemis.integration.FileBroker.start(FileBroker.java:111)
[artemis-cli-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at org.apache.activemq.artemis.cli.commands.Run.execute(Run.java:82)
[artemis-cli-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at org.apache.activemq.artemis.cli.Artemis.internalExecute(Artemis.java:149)
[artemis-cli-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at org.apache.activemq.artemis.cli.Artemis.execute(Artemis.java:96)
[artemis-cli-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at org.apache.activemq.artemis.cli.Artemis.execute(Artemis.java:123)
[artemis-cli-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[rt.jar:1.8.0_161]
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[rt.jar:1.8.0_161]
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[rt.jar:1.8.0_161]
at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_161]
at org.apache.activemq.artemis.boot.Artemis.execute(Artemis.java:129)
[artemis-boot.jar:2.4.0.amq-710004-redhat-1]
at org.apache.activemq.artemis.boot.Artemis.main(Artemis.java:49)
[artemis-boot.jar:2.4.0.amq-710004-redhat-1]
10:36:36.010 INFO [org.apache.activemq.artemis.core.server] AMQ221001: Apache
ActiveMQ Artemis Message Broker version 2.4.0.amq-710004-redhat-1 [amq,
nodeID=1069b1b9-1325-11e8-93ce-5254012ce134]
10:36:36.037 DEBUG [org.eclipse.jetty.util.component.ContainerLifeCycle]
org.eclipse.jetty.server.Server@6404f418 added {qtp1473205473
{STOPPED,8<=0<=200,i=0,q=0},AUTO}
10:36:36.062 DEBUG [org.eclipse.jetty.util.component.ContainerLifeCycle]
HttpConnectionFactory@130c12b7[HTTP/1.1] added
\{HttpConfiguration@5e600dd5{32768/8192,8192/8192,https://:0,[]},POJO}
10:36:36.066 DEBUG [org.eclipse.jetty.util.component.ContainerLifeCycle]
ServerConnector@3012646b\{null,[]}{0.0.0.0:0} added
\{org.eclipse.jetty.server.Server@6404f418,UNMANAGED}
10:36:36.066 DEBUG [org.eclipse.jetty.util.component.ContainerLifeCycle]
ServerConnector@3012646b\{null,[]}{0.0.0.0:0} added
\{qtp1473205473{STOPPED,8<=0<=200,i=0,q=0}
,AUTO}
10:36:36.067 DEBUG [org.eclipse.jetty.util.component.ContainerLifeCycle]
ServerConnector@3012646b
{null,[]}\{0.0.0.0:0} added
\{org.eclipse.jetty.util.thread.ScheduledExecutorScheduler@4d5650ae,AUTO}
10:36:36.067 DEBUG [org.eclipse.jetty.util.component.ContainerLifeCycle]
ServerConnector@3012646b\{null,[]} \{0.0.0.0:0}
added
{org.eclipse.jetty.io.ArrayByteBufferPool@4a883b15,POJO}
10:36:36.067 DEBUG [org.eclipse.jetty.util.component.ContainerLifeCycle]
ServerConnector@3012646b
{null,[http/1.1]} \{0.0.0.0:0}
added
{HttpConnectionFactory@130c12b7[HTTP/1.1],AUTO}
10:36:36.068 DEBUG [org.eclipse.jetty.server.AbstractConnector]
ServerConnector@3012646b
{HTTP/1.1,[http/1.1]}\{0.0.0.0:0} added HttpConnectionFactory@130c12b7[HTTP/1.1]
10:36:36.070 DEBUG [org.eclipse.jetty.util.component.ContainerLifeCycle]
ServerConnector@3012646b\{HTTP/1.1,[http/1.1]} \{0.0.0.0:0}
added
{org.eclipse.jetty.server.ServerConnector$ServerConnectorManager@5824a83d,MANAGED}
10:36:36.070 DEBUG [org.eclipse.jetty.util.component.ContainerLifeCycle]
org.eclipse.jetty.server.Server@6404f418 added {ServerConnector@3012646b
{HTTP/1.1,[http/1.1]}\{0.0.0.0:8161},AUTO}
10:36:36.122 DEBUG [org.eclipse.jetty.util.DecoratedObjectFactory] Adding
Decorator: org.eclipse.jetty.util.DeprecationWarning@19e4653c
10:36:36.125 ERROR [org.apache.activemq.artemis.core.server] AMQ224068: Unable
to stop component:
org.apache.activemq.artemis.core.server.impl.LiveOnlyActivation:
java.lang.IllegalStateException: live lock can't be renewed
at
org.apache.activemq.artemis.core.server.impl.jdbc.JdbcNodeManager.pauseLiveServer(JdbcNodeManager.java:332)
[artemis-server-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at
org.apache.activemq.artemis.core.server.impl.LiveOnlyActivation.close(LiveOnlyActivation.java:99)
[artemis-server-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at
org.apache.activemq.artemis.core.server.impl.ActiveMQServerImpl.stop(ActiveMQServerImpl.java:1105)
[artemis-server-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at
org.apache.activemq.artemis.core.server.impl.ActiveMQServerImpl.stop(ActiveMQServerImpl.java:939)
[artemis-server-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
at
org.apache.activemq.artemis.core.server.impl.ActiveMQServerImpl$4.run(ActiveMQServerImpl.java:774)
[artemis-server-2.4.0.amq-710004-redhat-1.jar:2.4.0.amq-710004-redhat-1]
10:36:36.127 INFO [org.apache.activemq.artemis.core.server] AMQ221002: Apache
ActiveMQ Artemis Message Broker version 2.4.0.amq-710004-redhat-1
[1069b1b9-1325-11e8-93ce-5254012ce134] stopped, uptime 4.016 seconds
10:36:36.136 DEBUG [org.eclipse.jetty.util.component.ContainerLifeCycle]
o.e.j.w.WebAppContext@68c9133c\{/,null,null} added
\{org.eclipse.jetty.server.session.SessionHandler2050339061==dftMaxIdleSec=-1,MANAGED}
10:36:36.140 DEBUG [org.eclipse.jetty.util.component.ContainerLifeCycle]
org.eclipse.jetty.security.ConstraintSecurityHandler@57a78e3 added
\{org.eclipse.jetty.security.DefaultAuthenticatorFactory@402c4085,POJO}
10:36:36.143 DEBUG [org.eclipse.jetty.util.component.ContainerLifeCycle]
org.eclipse.jetty.server.session.SessionHandler2050339061==dftMaxIdleSec=-1
added \{org.eclipse.jetty.security.ConstraintSecurityHandler@57a78e3,MANAGED}
jetty + webapp going on ....
10:36:38.658 DEBUG [org.eclipse.jetty.util.component.AbstractLifeCycle]
STARTED @8243ms
o.e.j.w.WebAppContext@7ae0a9ec\{/console,file:///opt/jboss-amq-7-i0/tmp/jetty-0.0.0.0-8161-console.war-_console-any-6426451029843409248.dir/webapp/,AVAILABLE}{/opt/amq-broker-7.1.0/web/console.war}
10:36:38.658 DEBUG [org.eclipse.jetty.util.component.AbstractLifeCycle]
starting
o.e.j.s.h.ContextHandler@1b1cfb87\{/,file:///opt/amq-broker-7.1.0/web/,null}
10:36:38.659 DEBUG [org.eclipse.jetty.server.handler.AbstractHandler] starting
o.e.j.s.h.ContextHandler@1b1cfb87\{/,file:///opt/amq-broker-7.1.0/web/,STARTING}
10:36:38.659 DEBUG [org.eclipse.jetty.util.component.AbstractLifeCycle]
starting org.eclipse.jetty.server.handler.ResourceHandler@821330f
10:36:38.660 DEBUG [org.eclipse.jetty.server.handler.AbstractHandler] starting
org.eclipse.jetty.server.handler.ResourceHandler@821330f
10:36:38.660 DEBUG [org.eclipse.jetty.util.component.AbstractLifeCycle]
STARTED @8245ms org.eclipse.jetty.server.handler.ResourceHandler@821330f
10:36:38.660 INFO [org.eclipse.jetty.server.handler.ContextHandler] Started
o.e.j.s.h.ContextHandler@1b1cfb87\{/,file:///opt/amq-broker-7.1.0/web/,AVAILABLE}
10:36:38.660 DEBUG [org.eclipse.jetty.util.component.AbstractLifeCycle]
STARTED @8245ms
o.e.j.s.h.ContextHandler@1b1cfb87\{/,file:///opt/amq-broker-7.1.0/web/,AVAILABLE}
10:36:38.660 DEBUG [org.eclipse.jetty.util.component.AbstractLifeCycle]
starting org.eclipse.jetty.server.handler.DefaultHandler@6f43c82
10:36:38.660 DEBUG [org.eclipse.jetty.server.handler.AbstractHandler] starting
org.eclipse.jetty.server.handler.DefaultHandler@6f43c82
10:36:38.660 DEBUG [org.eclipse.jetty.util.component.AbstractLifeCycle]
STARTED @8246ms org.eclipse.jetty.server.handler.DefaultHandler@6f43c82
10:36:38.660 DEBUG [org.eclipse.jetty.util.component.AbstractLifeCycle]
STARTED @8246ms
org.eclipse.jetty.server.handler.HandlerList@4a003cbe[o.e.j.w.WebAppContext@68c9133c\{/redhat-branding,file:///opt/jboss-amq-7-i0/tmp/jetty-0.0.0.0-8161-redhat-branding.war-_redhat-branding-any-195246742116516801.dir/webapp/,AVAILABLE}{/opt/amq-broker-7.1.0/web/redhat-branding.war},
o.e.j.w.WebAppContext@17fc391b\{/artemis-plugin,file:///opt/jboss-amq-7-i0/tmp/jetty-0.0.0.0-8161-artemis-plugin.war-_artemis-plugin-any-8238292246569969926.dir/webapp/,AVAILABLE}{/opt/amq-broker-7.1.0/web/artemis-plugin.war},
o.e.j.w.WebAppContext@23e84203\{/dispatch-hawtio-console,file:///opt/jboss-amq-7-i0/tmp/jetty-0.0.0.0-8161-dispatch-hawtio-console.war-_dispatch-hawtio-console-any-1959574602472882568.dir/webapp/,AVAILABLE}{/opt/amq-broker-7.1.0/web/dispatch-hawtio-console.war},
o.e.j.w.WebAppContext@7ae0a9ec\{/console,file:///opt/jboss-amq-7-i0/tmp/jetty-0.0.0.0-8161-console.war-_console-any-6426451029843409248.dir/webapp/,AVAILABLE}{/opt/amq-broker-7.1.0/web/console.war},
o.e.j.s.h.ContextHandler@1b1cfb87\{/,file:///opt/amq-broker-7.1.0/web/,AVAILABLE},
org.eclipse.jetty.server.handler.DefaultHandler@6f43c82]
10:36:38.660 DEBUG [org.eclipse.jetty.util.component.AbstractLifeCycle]
starting org.eclipse.jetty.server.handler.ErrorHandler@5db6b9cd
10:36:38.661 DEBUG [org.eclipse.jetty.server.handler.AbstractHandler] starting
org.eclipse.jetty.server.handler.ErrorHandler@5db6b9cd
10:36:38.661 DEBUG [org.eclipse.jetty.util.component.AbstractLifeCycle]
STARTED @8246ms org.eclipse.jetty.server.handler.ErrorHandler@5db6b9cd
10:36:38.661 DEBUG [org.eclipse.jetty.util.component.AbstractLifeCycle]
starting ServerConnector@3012646b\{HTTP/1.1,[http/1.1]} \{0.0.0.0:8161}
10:36:38.667 DEBUG [org.eclipse.jetty.util.component.ContainerLifeCycle]
ServerConnector@3012646b
{HTTP/1.1,[http/1.1]}\{0.0.0.0:8161} added
\{sun.nio.ch.ServerSocketChannelImpl[/0:0:0:0:0:0:0:0:8161],POJO}
10:36:38.668 DEBUG [org.eclipse.jetty.util.component.AbstractLifeCycle]
starting org.eclipse.jetty.util.thread.ScheduledExecutorScheduler@4d5650ae
10:36:38.668 DEBUG [org.eclipse.jetty.util.component.AbstractLifeCycle]
STARTED @8253ms
org.eclipse.jetty.util.thread.ScheduledExecutorScheduler@4d5650ae
10:36:38.668 DEBUG [org.eclipse.jetty.util.component.AbstractLifeCycle]
starting HttpConnectionFactory@130c12b7[HTTP/1.1]
10:36:38.668 DEBUG [org.eclipse.jetty.util.component.AbstractLifeCycle]
STARTED @8254ms HttpConnectionFactory@130c12b7[HTTP/1.1]
10:36:38.669 DEBUG [org.eclipse.jetty.util.component.AbstractLifeCycle]
starting
org.eclipse.jetty.server.ServerConnector$ServerConnectorManager@5824a83d
10:36:38.676 DEBUG [org.eclipse.jetty.util.component.ContainerLifeCycle]
org.eclipse.jetty.server.ServerConnector$ServerConnectorManager@5824a83d added
\{org.eclipse.jetty.io.ManagedSelector@75e91545 id=0 keys=-1 selected=-1,AUTO}
10:36:38.676 DEBUG [org.eclipse.jetty.util.component.AbstractLifeCycle]
starting org.eclipse.jetty.io.ManagedSelector@75e91545 id=0 keys=-1 selected=-1
10:36:38.681 DEBUG [org.eclipse.jetty.util.thread.QueuedThreadPool] queue
org.eclipse.jetty.io.ManagedSelector$$Lambda$24/582300198@1fcb4808
10:36:38.682 DEBUG [org.eclipse.jetty.util.thread.QueuedThreadPool] queue
org.eclipse.jetty.io.ManagedSelector$$Lambda$25/1086849943@4b672daa
10:36:38.682 DEBUG [org.eclipse.jetty.util.component.AbstractLifeCycle]
STARTED @8268ms org.eclipse.jetty.io.ManagedSelector@75e91545 id=0 keys=0
selected=0
10:36:38.682 DEBUG [org.eclipse.jetty.util.component.AbstractLifeCycle]
STARTED @8268ms
org.eclipse.jetty.server.ServerConnector$ServerConnectorManager@5824a83d
10:36:38.683 DEBUG [org.eclipse.jetty.util.component.ContainerLifeCycle]
ServerConnector@3012646b\{HTTP/1.1,[http/1.1]} \{0.0.0.0:8161}
added
{acceptor-0@ed3068a,POJO}
10:36:38.683 DEBUG [org.eclipse.jetty.util.thread.QueuedThreadPool] queue
acceptor-0@ed3068a
10:36:38.684 INFO [org.eclipse.jetty.server.AbstractConnector] Started
ServerConnector@3012646b
{HTTP/1.1,[http/1.1]}\{0.0.0.0:8161}
10:36:38.684 DEBUG [org.eclipse.jetty.util.component.AbstractLifeCycle]
STARTED @8269ms ServerConnector@3012646b\{HTTP/1.1,[http/1.1]} \{0.0.0.0:8161}
10:36:38.684 INFO [org.eclipse.jetty.server.Server] Started @8269ms
10:36:38.684 DEBUG [org.eclipse.jetty.util.component.AbstractLifeCycle]
STARTED @8269ms org.eclipse.jetty.server.Server@6404f418
10:36:38.686 INFO [org.apache.activemq.artemis] AMQ241001: HTTP Server started
at [http://0.0.0.0:8161|http://0.0.0.0:8161/]
10:36:38.686 INFO [org.apache.activemq.artemis] AMQ241002: Artemis Jolokia
REST API available at [http://0.0.0.0:8161/console/jolokia]
10:36:38.686 INFO [org.apache.activemq.artemis] AMQ241004: Artemis Console
available at [http://0.0.0.0:8161/console]
10:36:38.687 DEBUG [org.eclipse.jetty.util.thread.QueuedThreadPool] run
org.eclipse.jetty.io.ManagedSelector$$Lambda$24/582300198@1fcb4808
10:36:38.687 DEBUG
[org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume] EPC
Idle/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3be575af execute
10:36:38.688 DEBUG
[org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume] EPC
Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3be575af produce
enter
10:36:38.688 DEBUG
[org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume] EPC
Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3be575af producing
10:36:38.688 DEBUG [org.eclipse.jetty.io.ManagedSelector] Selector loop
waiting on select
10:36:38.688 DEBUG [org.eclipse.jetty.util.thread.QueuedThreadPool] run
org.eclipse.jetty.io.ManagedSelector$$Lambda$25/1086849943@4b672daa
10:36:38.689 DEBUG [org.eclipse.jetty.util.thread.QueuedThreadPool] run
acceptor-0@ed3068a
10:36:46.709 FINE [sun.rmi.transport.tcp] RMI Scheduler(0): close connection
10:36:46.710 FINE [sun.rmi.transport.tcp] RMI Scheduler(0): close connection
10:36:46.710 FINE [sun.rmi.transport.tcp] RMI TCP Connection(2)-<host>: (port
43598) connection closed
10:36:46.710 FINE [sun.rmi.transport.tcp] RMI TCP Connection(2)-<host>: close
connection
10:36:46.710 FINE [sun.rmi.transport.tcp] RMI TCP Connection(1)-<host>: (port
1099) connection closed
10:36:46.710 FINE [sun.rmi.transport.tcp] RMI TCP Connection(1)-<host>: close
connection
^Z
[1]+ Stopped /opt/artemis/bin/artemis run
[root@hp-dl380pgen8-02-vm-12 ~]# netstat -nlp |grep java
tcp6 0 0 :::1099 :::* LISTEN 28252/java
tcp6 0 0 :::43598 :::* LISTEN 28252/java
tcp6 0 0 :::8161 :::* LISTEN 28252/java
{noformat}
{noformat}
used connector: {{broker-home/lib/postgresql-9.4.1212.jar}}
{{broker.xml store}} part:
{code:xml}
<store>
<database-store>
<bindings-table-name>BINDINGS_TABLE</bindings-table-name>
<jdbc-connection-url>jdbc:postgresql://postgres-96.rhev-ci-vms.eng.rdu2.redhat.com:5432/dballo12?user=dballo12&password=dballo12</jdbc-connection-url>
<large-message-table-name>LARGE_MESSAGES_TABLE</large-message-table-name>
<page-store-table-name>PG_STR_TBL</page-store-table-name>
<jdbc-driver-class-name>org.postgresql.Driver</jdbc-driver-class-name>
<message-table-name>MESSAGE_TABLE</message-table-name>
</database-store>
</store>
{code}
--
This message was sent by Atlassian JIRA
(v7.6.3#76005)
