-
1. Re: Wildfly 9.0 server log shows transaction timed out
jbertram Mar 1, 2017 12:27 PM (in response to ajitkumar2807)Couple of questions:
- What kind of client are you using (e.g. remote, standard JMS; MDB; etc.)?
- How long are you taking to process the message?
- Do you actually mean to process the message transactionally?
-
2. Re: Wildfly 9.0 server log shows transaction timed out
ajitkumar2807 Mar 1, 2017 1:18 PM (in response to jbertram)Thanks for your response Justin. I am using MDB queue. I have implemented it using jboss Wildfly 9.0.2 for messaging. I am able to send the message to server end and server starts processing it. Its a big calculation processing and can take several hours over server. Here in order to produce outOfMemory error I have reduced Server heap size to very low value. My requirement is, when outOfMemory error occurs there should not be re-delivery of same message. But in my case server starts the processing of same message several times. When message processing starts on server, I get below exception in server log file:
16 WARN [org.hornetq.core.server] (Thread-1 (HornetQ-scheduled-threads-1626716896)) HQ222103: transaction with xid XidImpl (1438449470 bq:0.0.0.0.0.0.0.0.0.0.-1.-1.10.87
6.86.-71.-55.88.-90.-39.117.0.0.0.19.0.0.0.0.0.0.0.0 formatID:131077 gtxid:0.0.0.0.0.0.0.0.0.0.-1.-1.10.87.-54.50.-66.86.-71.-55.88.-90.-39.117.0.0.0.18.49 base64:AAAAAAA
lfKMr5WuclYptl1AAAAEwAAAAAAAAAAAAAAAAAAAAAAAP__ClfKMr5WuclYptl1AAAAEjEHAgIA timed out
16 INFO [stdout] (Thread-7 (HornetQ-client-global-threads-1946155136)) deleting data for trajectory with ID : 5ca61516-a271-4ded-960f-bb667a6d12b3
96 WARN [org.hornetq.core.server] (Thread-1 (HornetQ-scheduled-threads-1626716896)) HQ222103: transaction with xid XidImpl (885460690 bq:0.0.0.0.0.0.0.0.0.0.-1.-1.10.87.
.86.-71.-55.88.-90.-39.117.0.0.0.60.0.0.0.0.0.0.0.0 formatID:131077 gtxid:0.0.0.0.0.0.0.0.0.0.-1.-1.10.87.-54.50.-66.86.-71.-55.88.-90.-39.117.0.0.0.59.49 base64:AAAAAAAA
fKMr5WuclYptl1AAAAPAAAAAAAAAAAAAAAAAAAAAAAAP__ClfKMr5WuclYptl1AAAAOzEHAgIA timed out
Then after the above error I get:
OutOfMemoryError: GC overhead limit exceeded
ap to java_pid3988.hprof ...
file created [507981757 bytes in 2.874 secs]
38 ERROR [stderr] (Thread-11 (HornetQ-client-global-threads-1946155136)) java.lang.OutOfMemoryError: GC overhead limit exceeded
I am catching this error and sending this back to client in order to let client know that due to outOfMemoryError calcualtion process was aborted over server and user can send another message request to server for processing. But then on Server side the Server starts redelivery of same Message after outOfMemory error and the same calculation process restarts again and then again outOfMemory and this keeps on repeating at server side.
I also got few of the following exceptions in server log file:
16:56:48,685 WARN [com.arjuna.ats.jta] (Thread-7 (HornetQ-client-global-threads-1946155136)) ARJUNA016039: onePhaseCommit on < formatId=131077, gtrid_length=29, bqual_le
x_uid=0:ffff0a57ca32:-41a94637:58a6d975:3b, node_name=1, branch_uid=0:ffff0a57ca32:-41a94637:58a6d975:3c, subordinatenodename=null, eis_name=unknown eis name > (Delegatin
session=ClientSessionImpl [name=53086480-f501-11e6-939f-97227d3d3130, username=null, closed=false, factory = ClientSessionFactoryImpl [serverLocator=ServerLocatorImpl [in
ctors=[TransportConfiguration(name=49b26884-f501-11e6-939f-97227d3d3130, factory=org-hornetq-core-remoting-impl-invm-InVMConnectorFactory) ?server-id=0], discoveryGroupCo
n=null], connectorConfig=TransportConfiguration(name=52fec78d-f501-11e6-939f-97227d3d3130, factory=org-hornetq-core-remoting-impl-invm-InVMConnectorFactory) ?server-id=0,
fig=null], metaData=(jms-session=,resource-adapter=inbound,)]@27c6a1d4]) failed with exception XAException.XAER_PROTO: javax.transaction.xa.XAException
16:56:48,708 WARN [org.hornetq.ra] (Thread-7 (HornetQ-client-global-threads-1946155136)) HQ152006: Unable to call after delivery: javax.resource.spi.LocalTransactionExce
ax.transaction.RollbackException: ARJUNA016053: Could not commit transaction.
Caused by: javax.transaction.RollbackException: ARJUNA016053: Could not commit transaction.
Below are my connectionFactory settings in standalone-full.xml file for wildfly server. I am using remoteConnectionFactory.
<address-settings>
<address-setting match="#">
<dead-letter-address>jms.queue.DLQ</dead-letter-address>
<expiry-address>jms.queue.ExpiryQueue</expiry-address>
<max-delivery-attempts>0</max-delivery-attempts>
<max-size-bytes>10485760</max-size-bytes>
<page-size-bytes>2097152</page-size-bytes>
<message-counter-history-day-limit>10</message-counter-history-day-limit>
</address-setting>
</address-settings>
<jms-connection-factories>
<connection-factory name="InVmConnectionFactory">
<connectors>
<connector-ref connector-name="in-vm"/>
</connectors>
<entries>
<entry name="java:/ConnectionFactory"/>
</entries>
</connection-factory>
<connection-factory name="RemoteConnectionFactory">
<connectors>
<connector-ref connector-name="http-connector"/>
</connectors>
<entries>
<entry name="java:jboss/exported/jms/RemoteConnectionFactory"/>
</entries>
<retry-interval>1000</retry-interval>
<retry-interval-multiplier>1.0</retry-interval-multiplier>
<reconnect-attempts>0</reconnect-attempts>
<connection-ttl>-1</connection-ttl>
<client-failure-check-period>-1</client-failure-check-period>
</connection-factory>
<pooled-connection-factory name="hornetq-ra">
<transaction mode="xa"/>
<connectors>
<connector-ref connector-name="in-vm"/>
</connectors>
<entries>
<entry name="java:/JmsXA"/>
<entry name="java:jboss/DefaultJMSConnectionFactory"/>
</entries>
</pooled-connection-factory>
</jms-connection-factories>
-
3. Re: Wildfly 9.0 server log shows transaction timed out
jbertram Mar 1, 2017 3:28 PM (in response to ajitkumar2807)I am able to send the message to server end and server starts processing it. Its a big calculation processing and can take several hours over server.
If that's true then your MDB should be explicitly configured to not use transactions (e.g. using the @TransactionAttribute(TransactionAttributeType.NOT_SUPPORTED) annotation).
By default, every time your MDB receives a message it will begin a JTA transaction. When the MDB takes a long time to process the message (as in your case) then the transaction timeout (which defaults to 300 seconds) will elapse. When the transaction timeout elapses then the transaction is rolledback and the message is redelivered. Disabling the transaction should fix this.
Aside from that, I'm not sure that detecting an OOME and telling the user about it is going to be effective. If the user sends another message there is a good chance that they will simply keep getting OOMEs. Unless you can guarantee that whatever caused the OOME has been completely cleaned up then continuing to process messages will almost certainly just result in more errors. Furthermore, when the JVM hits an OOME performance degrades significantly due to the intense GC. This means any "calculation" which would normally take a long time could then take significantly longer. You'd probably be better served by simply restarting the JVM, although it would be better to avoid the OOME in the first place.
-
4. Re: Wildfly 9.0 server log shows transaction timed out
ajitkumar2807 Mar 1, 2017 10:17 PM (in response to jbertram)Below is the content from my server.log file:
2017-02-28 13:12:07,624 INFO [org.jboss.weld.deployer] (MSC service thread 1-2) WFLYWELD0006: Starting Services for CDI deployment: protoel.war
2017-02-28 13:12:07,656 INFO [org.jboss.weld.Version] (MSC service thread 1-2) WELD-000900: 2.2.14 (Final)
2017-02-28 13:12:07,693 INFO [org.jboss.as.connector.deployers.jdbc] (MSC service thread 1-8) WFLYJCA0018: Started Driver service with driver-name = protoel.war_org.postgresql.Driver_9_3
2017-02-28 13:12:07,693 INFO [org.jboss.as.connector.deployers.jdbc] (MSC service thread 1-1) WFLYJCA0018: Started Driver service with driver-name = protoel.war_org.h2.Driver_1_4
2017-02-28 13:12:07,694 INFO [org.jboss.weld.deployer] (MSC service thread 1-8) WFLYWELD0009: Starting weld service for deployment protoel.war
2017-02-28 13:12:07,746 INFO [org.jboss.as.ejb3] (MSC service thread 1-2) WFLYEJB0042: Started message driven bean 'ProtoelQueueMDB' with 'hornetq-ra.rar' resource adapter
2017-02-28 13:12:09,592 INFO [org.wildfly.extension.undertow] (ServerService Thread Pool -- 77) WFLYUT0021: Registered web context: /protoel
2017-02-28 13:12:09,663 INFO [org.jboss.as.server] (XNIO-1 task-5) WFLYSRV0010: Deployed "protoel.war" (runtime-name : "protoel.war")
2017-02-28 13:20:30,997 INFO [stdout] (Thread-7 (HornetQ-client-global-threads-244609549)) :: Connecting to remote database.........
2017-02-28 13:20:31,087 INFO [org.hibernate.annotations.common.Version] (Thread-7 (HornetQ-client-global-threads-244609549)) HCANN000001: Hibernate Commons Annotations {4.0.4.Final}
2017-02-28 13:20:31,093 INFO [org.hibernate.Version] (Thread-7 (HornetQ-client-global-threads-244609549)) HHH000412: Hibernate Core {4.3.5.Final}
2017-02-28 13:20:31,096 INFO [org.hibernate.cfg.Environment] (Thread-7 (HornetQ-client-global-threads-244609549)) HHH000206: hibernate.properties not found
2017-02-28 13:20:31,097 INFO [org.hibernate.cfg.Environment] (Thread-7 (HornetQ-client-global-threads-244609549)) HHH000021: Bytecode provider name : javassist
2017-02-28 13:20:31,115 INFO [org.hibernate.cfg.Configuration] (Thread-7 (HornetQ-client-global-threads-244609549)) HHH000042: Configuring from file: hibernate.cfg.remote.xml
2017-02-28 13:20:31,472 WARN [org.hibernate.internal.util.xml.DTDEntityResolver] (Thread-7 (HornetQ-client-global-threads-244609549)) HHH000223: Recognized obsolete hibernate namespace http://hibernate.sourceforge.net/. Use namespace http://www.hibernate.org/dtd/ instead. Refer to Hibernate 3.6 Migration Guide!
2017-02-28 13:20:31,507 INFO [org.hibernate.cfg.Configuration] (Thread-7 (HornetQ-client-global-threads-244609549)) HHH000041: Configured SessionFactory: null
2017-02-28 13:20:31,662 WARN [org.hibernate.engine.jdbc.connections.internal.DriverManagerConnectionProviderImpl] (Thread-7 (HornetQ-client-global-threads-244609549)) HHH000402: Using Hibernate built-in connection pool (not for production use!)
2017-02-28 13:20:31,663 INFO [org.hibernate.engine.jdbc.connections.internal.DriverManagerConnectionProviderImpl] (Thread-7 (HornetQ-client-global-threads-244609549)) HHH000401: using driver [org.postgresql.Driver] at URL [jdbc:postgresql://10.129.36.119:5432/protoel]
2017-02-28 13:20:31,664 INFO [org.hibernate.engine.jdbc.connections.internal.DriverManagerConnectionProviderImpl] (Thread-7 (HornetQ-client-global-threads-244609549)) HHH000046: Connection properties: {user=protoel, password=****}
2017-02-28 13:20:31,664 INFO [org.hibernate.engine.jdbc.connections.internal.DriverManagerConnectionProviderImpl] (Thread-7 (HornetQ-client-global-threads-244609549)) HHH000006: Autocommit mode: false
2017-02-28 13:20:31,665 INFO [org.hibernate.engine.jdbc.connections.internal.DriverManagerConnectionProviderImpl] (Thread-7 (HornetQ-client-global-threads-244609549)) HHH000115: Hibernate connection pool size: 20 (min=1)
2017-02-28 13:20:32,019 INFO [org.hibernate.dialect.Dialect] (Thread-7 (HornetQ-client-global-threads-244609549)) HHH000400: Using dialect: org.hibernate.dialect.PostgreSQL82Dialect
2017-02-28 13:20:32,030 INFO [org.hibernate.engine.jdbc.internal.LobCreatorBuilder] (Thread-7 (HornetQ-client-global-threads-244609549)) HHH000424: Disabling contextual LOB creation as createClob() method threw error : java.lang.reflect.InvocationTargetException
2017-02-28 13:20:32,332 INFO [org.hibernate.engine.transaction.internal.TransactionFactoryInitiator] (Thread-7 (HornetQ-client-global-threads-244609549)) HHH000399: Using default transaction strategy (direct JDBC transactions)
2017-02-28 13:20:32,336 INFO [org.hibernate.hql.internal.ast.ASTQueryTranslatorFactory] (Thread-7 (HornetQ-client-global-threads-244609549)) HHH000397: Using ASTQueryTranslatorFactory
2017-02-28 13:20:33,366 INFO [stdout] (Thread-7 (HornetQ-client-global-threads-244609549)) :: Connected to remote database.........
2017-02-28 13:20:33,605 INFO [stdout] (Thread-7 (HornetQ-client-global-threads-244609549)) deleting data for trajectory with ID : 3f661d13-4232-4456-834b-53269558c1f8
2017-02-28 13:21:23,282 INFO [org.jboss.as.repository] (ServerService Thread Pool -- 1) WFLYDR0009: Content /var/project/wildfly/standalone/data/content/1f/d495f95ec3df9e9fa36a0cec2e3cc00350dc5a is obsolete and will be removed
2017-02-28 13:21:23,297 INFO [org.jboss.as.repository] (ServerService Thread Pool -- 1) WFLYDR0002: Content removed from location /var/project/wildfly/standalone/data/content/1f/d495f95ec3df9e9fa36a0cec2e3cc00350dc5a/content
2017-02-28 13:22:22,726 INFO [stdout] (Thread-7 (HornetQ-client-global-threads-244609549)) deleted data for trajectory with ID : 3f661d13-4232-4456-834b-53269558c1f8
2017-02-28 13:22:22,727 INFO [stdout] (Thread-7 (HornetQ-client-global-threads-244609549)) deleting data for trajectory with ID : 98dca10d-0c80-4abe-8f01-7e5fbd5895d0
2017-02-28 13:24:10,527 INFO [stdout] (Thread-7 (HornetQ-client-global-threads-244609549)) deleted data for trajectory with ID : 98dca10d-0c80-4abe-8f01-7e5fbd5895d0
2017-02-28 13:25:31,004 WARN [org.hornetq.core.server] (Thread-1 (HornetQ-scheduled-threads-1491035066)) HQ222103: transaction with xid XidImpl (1904454033 bq:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.-125.-84.57.-25.88.-75.104.-19.0.0.0.67.0.0.0.0.0.0.0.0 formatID:131077 gtxid:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.-125.-84.57.-25.88.-75.104.-19.0.0.0.66.49 base64:AAAAAAAAAAAAAP__CoEkgoOsOedYtWjtAAAAQwAAAAAAAAAAAAAAAAAAAAAAAP__CoEkgoOsOedYtWjtAAAAQjEHAgIA timed out
2017-02-28 13:25:31,069 INFO [stdout] (Thread-11 (HornetQ-client-global-threads-244609549)) deleting data for trajectory with ID : 3f661d13-4232-4456-834b-53269558c1f8
2017-02-28 13:27:30,363 INFO [stdout] (Thread-11 (HornetQ-client-global-threads-244609549)) deleted data for trajectory with ID : 3f661d13-4232-4456-834b-53269558c1f8
2017-02-28 13:27:30,364 INFO [stdout] (Thread-11 (HornetQ-client-global-threads-244609549)) deleting data for trajectory with ID : 98dca10d-0c80-4abe-8f01-7e5fbd5895d0
2017-02-28 13:30:32,003 WARN [org.hornetq.core.server] (Thread-4 (HornetQ-scheduled-threads-1491035066)) HQ222103: transaction with xid XidImpl (2016885204 bq:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.-125.-84.57.-25.88.-75.104.-19.0.0.0.96.0.0.0.0.0.0.0.0 formatID:131077 gtxid:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.-125.-84.57.-25.88.-75.104.-19.0.0.0.95.49 base64:AAAAAAAAAAAAAP__CoEkgoOsOedYtWjtAAAAYAAAAAAAAAAAAAAAAAAAAAAAAP__CoEkgoOsOedYtWjtAAAAXzEHAgIA timed out
2017-02-28 13:30:32,036 INFO [stdout] (Thread-15 (HornetQ-client-global-threads-244609549)) deleting data for trajectory with ID : 3f661d13-4232-4456-834b-53269558c1f8
2017-02-28 13:35:33,845 WARN [org.hornetq.core.server] (Thread-3 (HornetQ-scheduled-threads-1491035066)) HQ222103: transaction with xid XidImpl (310279214 bq:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.-125.-84.57.-25.88.-75.104.-19.0.0.0.125.0.0.0.0.0.0.0.0 formatID:131077 gtxid:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.-125.-84.57.-25.88.-75.104.-19.0.0.0.124.49 base64:AAAAAAAAAAAAAP__CoEkgoOsOedYtWjtAAAAfQAAAAAAAAAAAAAAAAAAAAAAAP__CoEkgoOsOedYtWjtAAAAfDEHAgIA timed out
2017-02-28 13:35:33,893 INFO [stdout] (Thread-18 (HornetQ-client-global-threads-244609549)) deleting data for trajectory with ID : 3f661d13-4232-4456-834b-53269558c1f8
2017-02-28 13:40:35,269 WARN [org.hornetq.core.server] (Thread-1 (HornetQ-scheduled-threads-1491035066)) HQ222103: transaction with xid XidImpl (290744584 bq:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.-125.-84.57.-25.88.-75.104.-19.0.0.0.-90.0.0.0.0.0.0.0.0 formatID:131077 gtxid:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.-125.-84.57.-25.88.-75.104.-19.0.0.0.-91.49 base64:AAAAAAAAAAAAAP__CoEkgoOsOedYtWjtAAAApgAAAAAAAAAAAAAAAAAAAAAAAP__CoEkgoOsOedYtWjtAAAApTEHAgIA timed out
2017-02-28 13:40:37,210 INFO [stdout] (Thread-21 (HornetQ-client-global-threads-244609549)) deleting data for trajectory with ID : 3f661d13-4232-4456-834b-53269558c1f8
2017-02-28 13:45:36,459 WARN [org.hornetq.core.server] (Thread-4 (HornetQ-scheduled-threads-1491035066)) HQ222103: transaction with xid XidImpl (1471316844 bq:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.-125.-84.57.-25.88.-75.104.-19.0.0.0.-61.0.0.0.0.0.0.0.0 formatID:131077 gtxid:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.-125.-84.57.-25.88.-75.104.-19.0.0.0.-62.49 base64:AAAAAAAAAAAAAP__CoEkgoOsOedYtWjtAAAAwwAAAAAAAAAAAAAAAAAAAAAAAP__CoEkgoOsOedYtWjtAAAAwjEHAgIA timed out
2017-02-28 13:45:49,957 INFO [stdout] (Thread-26 (HornetQ-client-global-threads-244609549)) deleting data for trajectory with ID : 3f661d13-4232-4456-834b-53269558c1f8
2017-02-28 13:46:11,774 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) java.lang.OutOfMemoryError: GC overhead limit exceeded
2017-02-28 13:46:13,716 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at java.util.UUID.fromString(UUID.java:196)
2017-02-28 13:46:13,716 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.postgresql.jdbc3g.AbstractJdbc3gResultSet.getUUID(AbstractJdbc3gResultSet.java:35)
2017-02-28 13:46:13,716 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.postgresql.jdbc2.AbstractJdbc2ResultSet.internalGetObject(AbstractJdbc2ResultSet.java:185)
2017-02-28 13:46:13,716 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.postgresql.jdbc3.AbstractJdbc3ResultSet.internalGetObject(AbstractJdbc3ResultSet.java:36)
2017-02-28 13:46:13,716 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.postgresql.jdbc4.AbstractJdbc4ResultSet.internalGetObject(AbstractJdbc4ResultSet.java:300)
2017-02-28 13:46:13,716 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.postgresql.jdbc2.AbstractJdbc2ResultSet.getObject(AbstractJdbc2ResultSet.java:2704)
2017-02-28 13:46:13,717 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.postgresql.jdbc2.AbstractJdbc2ResultSet.getObject(AbstractJdbc2ResultSet.java:2716)
2017-02-28 13:46:13,717 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at common.util.UuidType.nullSafeGet(UuidType.java:66)
2017-02-28 13:46:13,717 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.hibernate.type.CustomType.nullSafeGet(CustomType.java:127)
2017-02-28 13:46:13,717 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.hibernate.type.AbstractType.hydrate(AbstractType.java:106)
2017-02-28 13:46:13,717 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.extractKeysFromResultSet(Loader.java:784)
2017-02-28 13:46:13,718 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.getRowFromResultSet(Loader.java:720)
2017-02-28 13:46:13,718 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.processResultSet(Loader.java:952)
2017-02-28 13:46:13,718 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.doQuery(Loader.java:920)
2017-02-28 13:46:13,718 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.doQueryAndInitializeNonLazyCollections(Loader.java:354)
2017-02-28 13:46:13,718 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.doQueryAndInitializeNonLazyCollections(Loader.java:324)
2017-02-28 13:46:13,718 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.loadEntity(Loader.java:2148)
2017-02-28 13:46:13,718 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.entity.AbstractEntityLoader.load(AbstractEntityLoader.java:78)
2017-02-28 13:46:13,719 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.entity.EntityLoader.loadByUniqueKey(EntityLoader.java:161)
2017-02-28 13:46:13,719 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.hibernate.persister.entity.AbstractEntityPersister.loadByUniqueKey(AbstractEntityPersister.java:2385)
2017-02-28 13:46:13,719 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.hibernate.type.EntityType.loadByUniqueKey(EntityType.java:767)
2017-02-28 13:46:13,719 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.hibernate.type.EntityType.resolve(EntityType.java:505)
2017-02-28 13:46:13,719 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.hibernate.engine.internal.TwoPhaseLoad.doInitializeEntity(TwoPhaseLoad.java:170)
2017-02-28 13:46:13,720 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.hibernate.engine.internal.TwoPhaseLoad.initializeEntity(TwoPhaseLoad.java:144)
2017-02-28 13:46:13,720 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.plan.exec.process.internal.AbstractRowReader.performTwoPhaseLoad(AbstractRowReader.java:244)
2017-02-28 13:46:13,720 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.plan.exec.process.internal.AbstractRowReader.finishUp(AbstractRowReader.java:215)
2017-02-28 13:46:13,720 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.plan.exec.process.internal.ResultSetProcessorImpl.extractResults(ResultSetProcessorImpl.java:140)
2017-02-28 13:46:13,720 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.plan.exec.internal.AbstractLoadPlanBasedLoader.executeLoad(AbstractLoadPlanBasedLoader.java:138)
2017-02-28 13:46:13,720 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.plan.exec.internal.AbstractLoadPlanBasedLoader.executeLoad(AbstractLoadPlanBasedLoader.java:102)
2017-02-28 13:46:13,721 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.collection.plan.AbstractLoadPlanBasedCollectionInitializer.initialize(AbstractLoadPlanBasedCollectionInitializer.java:100)
2017-02-28 13:46:13,721 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.hibernate.persister.collection.AbstractCollectionPersister.initialize(AbstractCollectionPersister.java:693)
2017-02-28 13:46:13,721 ERROR [stderr] (Thread-18 (HornetQ-client-global-threads-244609549)) at org.hibernate.event.internal.DefaultInitializeCollectionEventListener.onInitializeCollection(DefaultInitializeCollectionEventListener.java:92)
2017-02-28 13:46:13,748 SEVERE [class backend.dao.calc.TrajectoryDAO] (Thread-18 (HornetQ-client-global-threads-244609549)) Error while updating records from the database null
2017-02-28 13:46:13,755 INFO [stdout] (Thread-18 (HornetQ-client-global-threads-244609549)) Send Reply...........
2017-02-28 13:46:13,755 INFO [stdout] (Thread-18 (HornetQ-client-global-threads-244609549)) :: Initializing initial context.........
2017-02-28 13:46:15,840 INFO [org.xnio] (Thread-18 (HornetQ-client-global-threads-244609549)) XNIO version 3.3.1.Final
2017-02-28 13:46:15,849 INFO [org.xnio.nio] (Thread-18 (HornetQ-client-global-threads-244609549)) XNIO NIO Implementation Version 3.3.1.Final
2017-02-28 13:46:17,931 INFO [org.jboss.remoting] (Thread-18 (HornetQ-client-global-threads-244609549)) JBoss Remoting version 4.0.9.Final
2017-02-28 13:46:17,951 INFO [stdout] (Thread-18 (HornetQ-client-global-threads-244609549)) :: Initialized initial context.........
2017-02-28 13:46:47,131 INFO [class backend.mdb.ProtoelQueueMDB] (Thread-18 (HornetQ-client-global-threads-244609549)) ProtoelQueueMDB.sendReply, dest= HornetQQueue[MDBQueueReply] TEXTMESSAGE: [B@76264026
2017-02-28 13:46:48,934 INFO [class backend.mdb.ProtoelQueueMDB] (Thread-18 (HornetQ-client-global-threads-244609549)) Sending response to client....... 2017-02-28 12:46:48.934
2017-02-28 13:46:50,879 INFO [class backend.mdb.ProtoelQueueMDB] (Thread-18 (HornetQ-client-global-threads-244609549)) Zipped file to delete on server..........null
2017-02-28 13:46:50,886 WARN [com.arjuna.ats.jta] (Thread-18 (HornetQ-client-global-threads-244609549)) ARJUNA016039: onePhaseCommit on < formatId=131077, gtrid_length=29, bqual_length=36, tx_uid=0:ffff0a812482:-7c53c619:58b568ed:a5, node_name=1, branch_uid=0:ffff0a812482:-7c53c619:58b568ed:a6, subordinatenodename=null, eis_name=unknown eis name > (DelegatingSession [session=ClientSessionImpl [name=20e9dc15-fdaf-11e6-beeb-f53e17d73150, username=null, closed=false, factory = ClientSessionFactoryImpl [serverLocator=ServerLocatorImpl [initialConnectors=[TransportConfiguration(name=091a4744-fdaf-11e6-beeb-f53e17d73150, factory=org-hornetq-core-remoting-impl-invm-InVMConnectorFactory) ?server-id=0], discoveryGroupConfiguration=null], connectorConfig=TransportConfiguration(name=20e9b503-fdaf-11e6-beeb-f53e17d73150, factory=org-hornetq-core-remoting-impl-invm-InVMConnectorFactory) ?server-id=0, backupConfig=null], metaData=(jms-session=,resource-adapter=inbound,)]@4db50cae]) failed with exception XAException.XAER_PROTO: javax.transaction.xa.XAException
at org.hornetq.core.client.impl.ClientSessionImpl.end(ClientSessionImpl.java:1558)
at org.hornetq.core.client.impl.DelegatingSession.end(DelegatingSession.java:348)
at com.arjuna.ats.internal.jta.resources.arjunacore.XAResourceRecord.topLevelOnePhaseCommit(XAResourceRecord.java:625)
at com.arjuna.ats.arjuna.coordinator.BasicAction.onePhaseCommit(BasicAction.java:2364)
at com.arjuna.ats.arjuna.coordinator.BasicAction.End(BasicAction.java:1518)
at com.arjuna.ats.arjuna.coordinator.TwoPhaseCoordinator.end(TwoPhaseCoordinator.java:96)
at com.arjuna.ats.arjuna.AtomicAction.commit(AtomicAction.java:162)
at com.arjuna.ats.internal.jta.transaction.arjunacore.TransactionImple.commitAndDisassociate(TransactionImple.java:1200)
at com.arjuna.ats.internal.jta.transaction.arjunacore.BaseTransaction.commit(BaseTransaction.java:126)
at com.arjuna.ats.jbossatx.BaseTransactionManagerDelegate.commit(BaseTransactionManagerDelegate.java:75)
at org.jboss.as.ejb3.inflow.MessageEndpointInvocationHandler.afterDelivery(MessageEndpointInvocationHandler.java:71)
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:497)
at org.jboss.as.ejb3.inflow.AbstractInvocationHandler.handle(AbstractInvocationHandler.java:60)
at org.jboss.as.ejb3.inflow.MessageEndpointInvocationHandler.doInvoke(MessageEndpointInvocationHandler.java:135)
at org.jboss.as.ejb3.inflow.AbstractInvocationHandler.invoke(AbstractInvocationHandler.java:73)
at backend.mdb.ProtoelQueueMDB$$$endpoint1.afterDelivery(Unknown Source)
at org.hornetq.ra.inflow.HornetQMessageHandler.onMessage(HornetQMessageHandler.java:330)
at org.hornetq.core.client.impl.ClientConsumerImpl.callOnMessage(ClientConsumerImpl.java:1116)
at org.hornetq.core.client.impl.ClientConsumerImpl.access$500(ClientConsumerImpl.java:56)
at org.hornetq.core.client.impl.ClientConsumerImpl$Runner.run(ClientConsumerImpl.java:1251)
at org.hornetq.utils.OrderedExecutorFactory$OrderedExecutor$1.run(OrderedExecutorFactory.java:104)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
2017-02-28 13:46:50,890 WARN [org.hornetq.ra] (Thread-18 (HornetQ-client-global-threads-244609549)) HQ152006: Unable to call after delivery: javax.resource.spi.LocalTransactionException: javax.transaction.RollbackException: ARJUNA016053: Could not commit transaction.
at org.jboss.as.ejb3.inflow.MessageEndpointInvocationHandler.afterDelivery(MessageEndpointInvocationHandler.java:87)
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:497)
at org.jboss.as.ejb3.inflow.AbstractInvocationHandler.handle(AbstractInvocationHandler.java:60)
at org.jboss.as.ejb3.inflow.MessageEndpointInvocationHandler.doInvoke(MessageEndpointInvocationHandler.java:135)
at org.jboss.as.ejb3.inflow.AbstractInvocationHandler.invoke(AbstractInvocationHandler.java:73)
at backend.mdb.ProtoelQueueMDB$$$endpoint1.afterDelivery(Unknown Source)
at org.hornetq.ra.inflow.HornetQMessageHandler.onMessage(HornetQMessageHandler.java:330)
at org.hornetq.core.client.impl.ClientConsumerImpl.callOnMessage(ClientConsumerImpl.java:1116)
at org.hornetq.core.client.impl.ClientConsumerImpl.access$500(ClientConsumerImpl.java:56)
at org.hornetq.core.client.impl.ClientConsumerImpl$Runner.run(ClientConsumerImpl.java:1251)
at org.hornetq.utils.OrderedExecutorFactory$OrderedExecutor$1.run(OrderedExecutorFactory.java:104)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
Caused by: javax.transaction.RollbackException: ARJUNA016053: Could not commit transaction.
at com.arjuna.ats.internal.jta.transaction.arjunacore.TransactionImple.commitAndDisassociate(TransactionImple.java:1212)
at com.arjuna.ats.internal.jta.transaction.arjunacore.BaseTransaction.commit(BaseTransaction.java:126)
at com.arjuna.ats.jbossatx.BaseTransactionManagerDelegate.commit(BaseTransactionManagerDelegate.java:75)
at org.jboss.as.ejb3.inflow.MessageEndpointInvocationHandler.afterDelivery(MessageEndpointInvocationHandler.java:71)
... 16 more
Suppressed: javax.transaction.xa.XAException
at org.hornetq.core.client.impl.ClientSessionImpl.end(ClientSessionImpl.java:1558)
at org.hornetq.core.client.impl.DelegatingSession.end(DelegatingSession.java:348)
at com.arjuna.ats.internal.jta.resources.arjunacore.XAResourceRecord.topLevelOnePhaseCommit(XAResourceRecord.java:625)
at com.arjuna.ats.arjuna.coordinator.BasicAction.onePhaseCommit(BasicAction.java:2364)
at com.arjuna.ats.arjuna.coordinator.BasicAction.End(BasicAction.java:1518)
at com.arjuna.ats.arjuna.coordinator.TwoPhaseCoordinator.end(TwoPhaseCoordinator.java:96)
at com.arjuna.ats.arjuna.AtomicAction.commit(AtomicAction.java:162)
at com.arjuna.ats.internal.jta.transaction.arjunacore.TransactionImple.commitAndDisassociate(TransactionImple.java:1200)
... 19 more
2017-02-28 13:50:39,599 WARN [org.hornetq.core.server] (Thread-1 (HornetQ-scheduled-threads-1491035066)) HQ222103: transaction with xid XidImpl (318089235 bq:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.-125.-84.57.-25.88.-75.104.-19.0.0.0.-32.0.0.0.0.0.0.0.0 formatID:131077 gtxid:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.-125.-84.57.-25.88.-75.104.-19.0.0.0.-33.49 base64:AAAAAAAAAAAAAP__CoEkgoOsOedYtWjtAAAA4AAAAAAAAAAAAAAAAAAAAAAAAP__CoEkgoOsOedYtWjtAAAA3zEHAgIA timed out
2017-02-28 13:50:43,106 INFO [stdout] (Thread-29 (HornetQ-client-global-threads-244609549)) deleting data for trajectory with ID : 3f661d13-4232-4456-834b-53269558c1f8
2017-02-28 13:52:33,157 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) java.lang.OutOfMemoryError: GC overhead limit exceeded
2017-02-28 13:52:33,158 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.postgresql.core.Encoding.decode(Encoding.java:191)
2017-02-28 13:52:33,159 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.postgresql.core.Encoding.decode(Encoding.java:203)
2017-02-28 13:52:35,075 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.postgresql.jdbc2.AbstractJdbc2ResultSet.getString(AbstractJdbc2ResultSet.java:1979)
2017-02-28 13:52:35,075 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.postgresql.jdbc2.AbstractJdbc2ResultSet.internalGetObject(AbstractJdbc2ResultSet.java:185)
2017-02-28 13:52:35,075 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.postgresql.jdbc3.AbstractJdbc3ResultSet.internalGetObject(AbstractJdbc3ResultSet.java:36)
2017-02-28 13:52:35,076 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.postgresql.jdbc4.AbstractJdbc4ResultSet.internalGetObject(AbstractJdbc4ResultSet.java:300)
2017-02-28 13:52:35,078 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.postgresql.jdbc2.AbstractJdbc2ResultSet.getObject(AbstractJdbc2ResultSet.java:2704)
2017-02-28 13:52:35,078 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.postgresql.jdbc2.AbstractJdbc2ResultSet.getObject(AbstractJdbc2ResultSet.java:2716)
2017-02-28 13:52:35,078 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at common.util.UuidType.nullSafeGet(UuidType.java:66)
2017-02-28 13:52:35,079 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.hibernate.type.CustomType.nullSafeGet(CustomType.java:127)
2017-02-28 13:52:35,079 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.hibernate.type.AbstractType.hydrate(AbstractType.java:106)
2017-02-28 13:52:35,079 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.extractKeysFromResultSet(Loader.java:784)
2017-02-28 13:52:35,079 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.getRowFromResultSet(Loader.java:720)
2017-02-28 13:52:35,079 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.processResultSet(Loader.java:952)
2017-02-28 13:52:35,079 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.doQuery(Loader.java:920)
2017-02-28 13:52:35,079 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.doQueryAndInitializeNonLazyCollections(Loader.java:354)
2017-02-28 13:52:35,080 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.doQueryAndInitializeNonLazyCollections(Loader.java:324)
2017-02-28 13:52:35,080 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.loadEntity(Loader.java:2148)
2017-02-28 13:52:35,080 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.entity.AbstractEntityLoader.load(AbstractEntityLoader.java:78)
2017-02-28 13:52:35,080 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.entity.EntityLoader.loadByUniqueKey(EntityLoader.java:161)
2017-02-28 13:52:35,080 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.hibernate.persister.entity.AbstractEntityPersister.loadByUniqueKey(AbstractEntityPersister.java:2385)
2017-02-28 13:52:35,080 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.hibernate.type.EntityType.loadByUniqueKey(EntityType.java:767)
2017-02-28 13:52:35,081 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.hibernate.type.EntityType.resolve(EntityType.java:505)
2017-02-28 13:52:35,081 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.hibernate.engine.internal.TwoPhaseLoad.doInitializeEntity(TwoPhaseLoad.java:170)
2017-02-28 13:52:35,081 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.hibernate.engine.internal.TwoPhaseLoad.initializeEntity(TwoPhaseLoad.java:144)
2017-02-28 13:52:35,081 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.plan.exec.process.internal.AbstractRowReader.performTwoPhaseLoad(AbstractRowReader.java:244)
2017-02-28 13:52:35,081 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.plan.exec.process.internal.AbstractRowReader.finishUp(AbstractRowReader.java:215)
2017-02-28 13:52:35,081 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.plan.exec.process.internal.ResultSetProcessorImpl.extractResults(ResultSetProcessorImpl.java:140)
2017-02-28 13:52:35,082 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.plan.exec.internal.AbstractLoadPlanBasedLoader.executeLoad(AbstractLoadPlanBasedLoader.java:138)
2017-02-28 13:52:35,082 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.plan.exec.internal.AbstractLoadPlanBasedLoader.executeLoad(AbstractLoadPlanBasedLoader.java:102)
2017-02-28 13:52:35,082 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.collection.plan.AbstractLoadPlanBasedCollectionInitializer.initialize(AbstractLoadPlanBasedCollectionInitializer.java:100)
2017-02-28 13:52:35,082 ERROR [stderr] (Thread-21 (HornetQ-client-global-threads-244609549)) at org.hibernate.persister.collection.AbstractCollectionPersister.initialize(AbstractCollectionPersister.java:693)
2017-02-28 13:52:35,097 SEVERE [class backend.dao.calc.TrajectoryDAO] (Thread-21 (HornetQ-client-global-threads-244609549)) Error while updating records from the database null
2017-02-28 13:52:35,098 INFO [stdout] (Thread-21 (HornetQ-client-global-threads-244609549)) Send Reply...........
2017-02-28 13:52:39,534 INFO [class backend.mdb.ProtoelQueueMDB] (Thread-21 (HornetQ-client-global-threads-244609549)) ProtoelQueueMDB.sendReply, dest= HornetQQueue[MDBQueueReply] TEXTMESSAGE: [B@193feb6a
2017-02-28 13:52:39,535 INFO [class backend.mdb.ProtoelQueueMDB] (Thread-21 (HornetQ-client-global-threads-244609549)) Sending response to client....... 2017-02-28 12:52:39.535
2017-02-28 13:52:39,542 INFO [class backend.mdb.ProtoelQueueMDB] (Thread-21 (HornetQ-client-global-threads-244609549)) Zipped file to delete on server..........null
2017-02-28 13:52:39,545 WARN [com.arjuna.ats.jta] (Thread-21 (HornetQ-client-global-threads-244609549)) ARJUNA016039: onePhaseCommit on < formatId=131077, gtrid_length=29, bqual_length=36, tx_uid=0:ffff0a812482:-7c53c619:58b568ed:c2, node_name=1, branch_uid=0:ffff0a812482:-7c53c619:58b568ed:c3, subordinatenodename=null, eis_name=unknown eis name > (DelegatingSession [session=ClientSessionImpl [name=20ea2a38-fdaf-11e6-beeb-f53e17d73150, username=null, closed=false, factory = ClientSessionFactoryImpl [serverLocator=ServerLocatorImpl [initialConnectors=[TransportConfiguration(name=091a4744-fdaf-11e6-beeb-f53e17d73150, factory=org-hornetq-core-remoting-impl-invm-InVMConnectorFactory) ?server-id=0], discoveryGroupConfiguration=null], connectorConfig=TransportConfiguration(name=20ea0326-fdaf-11e6-beeb-f53e17d73150, factory=org-hornetq-core-remoting-impl-invm-InVMConnectorFactory) ?server-id=0, backupConfig=null], metaData=(jms-session=,resource-adapter=inbound,)]@3223d7c3]) failed with exception XAException.XAER_PROTO: javax.transaction.xa.XAException
at org.hornetq.core.client.impl.ClientSessionImpl.end(ClientSessionImpl.java:1558)
at org.hornetq.core.client.impl.DelegatingSession.end(DelegatingSession.java:348)
at com.arjuna.ats.internal.jta.resources.arjunacore.XAResourceRecord.topLevelOnePhaseCommit(XAResourceRecord.java:625)
at com.arjuna.ats.arjuna.coordinator.BasicAction.onePhaseCommit(BasicAction.java:2364)
at com.arjuna.ats.arjuna.coordinator.BasicAction.End(BasicAction.java:1518)
at com.arjuna.ats.arjuna.coordinator.TwoPhaseCoordinator.end(TwoPhaseCoordinator.java:96)
at com.arjuna.ats.arjuna.AtomicAction.commit(AtomicAction.java:162)
at com.arjuna.ats.internal.jta.transaction.arjunacore.TransactionImple.commitAndDisassociate(TransactionImple.java:1200)
at com.arjuna.ats.internal.jta.transaction.arjunacore.BaseTransaction.commit(BaseTransaction.java:126)
at com.arjuna.ats.jbossatx.BaseTransactionManagerDelegate.commit(BaseTransactionManagerDelegate.java:75)
at org.jboss.as.ejb3.inflow.MessageEndpointInvocationHandler.afterDelivery(MessageEndpointInvocationHandler.java:71)
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:497)
at org.jboss.as.ejb3.inflow.AbstractInvocationHandler.handle(AbstractInvocationHandler.java:60)
at org.jboss.as.ejb3.inflow.MessageEndpointInvocationHandler.doInvoke(MessageEndpointInvocationHandler.java:135)
at org.jboss.as.ejb3.inflow.AbstractInvocationHandler.invoke(AbstractInvocationHandler.java:73)
at backend.mdb.ProtoelQueueMDB$$$endpoint1.afterDelivery(Unknown Source)
at org.hornetq.ra.inflow.HornetQMessageHandler.onMessage(HornetQMessageHandler.java:330)
at org.hornetq.core.client.impl.ClientConsumerImpl.callOnMessage(ClientConsumerImpl.java:1116)
at org.hornetq.core.client.impl.ClientConsumerImpl.access$500(ClientConsumerImpl.java:56)
at org.hornetq.core.client.impl.ClientConsumerImpl$Runner.run(ClientConsumerImpl.java:1251)
at org.hornetq.utils.OrderedExecutorFactory$OrderedExecutor$1.run(OrderedExecutorFactory.java:104)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
2017-02-28 13:52:39,546 WARN [org.hornetq.ra] (Thread-21 (HornetQ-client-global-threads-244609549)) HQ152006: Unable to call after delivery: javax.resource.spi.LocalTransactionException: javax.transaction.RollbackException: ARJUNA016053: Could not commit transaction.
at org.jboss.as.ejb3.inflow.MessageEndpointInvocationHandler.afterDelivery(MessageEndpointInvocationHandler.java:87)
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:497)
at org.jboss.as.ejb3.inflow.AbstractInvocationHandler.handle(AbstractInvocationHandler.java:60)
at org.jboss.as.ejb3.inflow.MessageEndpointInvocationHandler.doInvoke(MessageEndpointInvocationHandler.java:135)
at org.jboss.as.ejb3.inflow.AbstractInvocationHandler.invoke(AbstractInvocationHandler.java:73)
at backend.mdb.ProtoelQueueMDB$$$endpoint1.afterDelivery(Unknown Source)
at org.hornetq.ra.inflow.HornetQMessageHandler.onMessage(HornetQMessageHandler.java:330)
at org.hornetq.core.client.impl.ClientConsumerImpl.callOnMessage(ClientConsumerImpl.java:1116)
at org.hornetq.core.client.impl.ClientConsumerImpl.access$500(ClientConsumerImpl.java:56)
at org.hornetq.core.client.impl.ClientConsumerImpl$Runner.run(ClientConsumerImpl.java:1251)
at org.hornetq.utils.OrderedExecutorFactory$OrderedExecutor$1.run(OrderedExecutorFactory.java:104)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
Caused by: javax.transaction.RollbackException: ARJUNA016053: Could not commit transaction.
at com.arjuna.ats.internal.jta.transaction.arjunacore.TransactionImple.commitAndDisassociate(TransactionImple.java:1212)
at com.arjuna.ats.internal.jta.transaction.arjunacore.BaseTransaction.commit(BaseTransaction.java:126)
at com.arjuna.ats.jbossatx.BaseTransactionManagerDelegate.commit(BaseTransactionManagerDelegate.java:75)
at org.jboss.as.ejb3.inflow.MessageEndpointInvocationHandler.afterDelivery(MessageEndpointInvocationHandler.java:71)
... 16 more
Suppressed: javax.transaction.xa.XAException
at org.hornetq.core.client.impl.ClientSessionImpl.end(ClientSessionImpl.java:1558)
at org.hornetq.core.client.impl.DelegatingSession.end(DelegatingSession.java:348)
at com.arjuna.ats.internal.jta.resources.arjunacore.XAResourceRecord.topLevelOnePhaseCommit(XAResourceRecord.java:625)
at com.arjuna.ats.arjuna.coordinator.BasicAction.onePhaseCommit(BasicAction.java:2364)
at com.arjuna.ats.arjuna.coordinator.BasicAction.End(BasicAction.java:1518)
at com.arjuna.ats.arjuna.coordinator.TwoPhaseCoordinator.end(TwoPhaseCoordinator.java:96)
at com.arjuna.ats.arjuna.AtomicAction.commit(AtomicAction.java:162)
at com.arjuna.ats.internal.jta.transaction.arjunacore.TransactionImple.commitAndDisassociate(TransactionImple.java:1200)
... 19 more
2017-02-28 13:55:40,285 WARN [org.hornetq.core.server] (Thread-3 (HornetQ-scheduled-threads-1491035066)) HQ222103: transaction with xid XidImpl (2137530707 bq:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.-125.-84.57.-25.88.-75.104.-19.0.0.1.8.0.0.0.0.0.0.0.0 formatID:131077 gtxid:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.-125.-84.57.-25.88.-75.104.-19.0.0.1.7.49 base64:AAAAAAAAAAAAAP__CoEkgoOsOedYtWjtAAABCAAAAAAAAAAAAAAAAAAAAAAAAP__CoEkgoOsOedYtWjtAAABBzEHAgIA timed out
2017-02-28 13:55:45,650 INFO [stdout] (Thread-32 (HornetQ-client-global-threads-244609549)) deleting data for trajectory with ID : 3f661d13-4232-4456-834b-53269558c1f8
2017-02-28 13:56:35,909 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) java.lang.OutOfMemoryError: GC overhead limit exceeded
2017-02-28 13:56:35,910 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at java.util.UUID.fromString(UUID.java:196)
2017-02-28 13:56:35,910 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.postgresql.jdbc3g.AbstractJdbc3gResultSet.getUUID(AbstractJdbc3gResultSet.java:35)
2017-02-28 13:56:37,348 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.postgresql.jdbc2.AbstractJdbc2ResultSet.internalGetObject(AbstractJdbc2ResultSet.java:185)
2017-02-28 13:56:37,348 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.postgresql.jdbc3.AbstractJdbc3ResultSet.internalGetObject(AbstractJdbc3ResultSet.java:36)
2017-02-28 13:56:37,348 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.postgresql.jdbc4.AbstractJdbc4ResultSet.internalGetObject(AbstractJdbc4ResultSet.java:300)
2017-02-28 13:56:37,349 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.postgresql.jdbc2.AbstractJdbc2ResultSet.getObject(AbstractJdbc2ResultSet.java:2704)
2017-02-28 13:56:37,349 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.postgresql.jdbc2.AbstractJdbc2ResultSet.getObject(AbstractJdbc2ResultSet.java:2716)
2017-02-28 13:56:37,349 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at common.util.UuidType.nullSafeGet(UuidType.java:66)
2017-02-28 13:56:37,349 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.hibernate.type.CustomType.nullSafeGet(CustomType.java:127)
2017-02-28 13:56:37,349 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.hibernate.type.ManyToOneType.hydrate(ManyToOneType.java:190)
2017-02-28 13:56:37,349 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.hibernate.persister.entity.AbstractEntityPersister.hydrate(AbstractEntityPersister.java:2969)
2017-02-28 13:56:37,350 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.loadFromResultSet(Loader.java:1695)
2017-02-28 13:56:37,350 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.instanceNotYetLoaded(Loader.java:1627)
2017-02-28 13:56:37,350 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.getRow(Loader.java:1514)
2017-02-28 13:56:37,350 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.getRowFromResultSet(Loader.java:725)
2017-02-28 13:56:37,350 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.processResultSet(Loader.java:952)
2017-02-28 13:56:37,350 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.doQuery(Loader.java:920)
2017-02-28 13:56:37,350 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.doQueryAndInitializeNonLazyCollections(Loader.java:354)
2017-02-28 13:56:37,350 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.doQueryAndInitializeNonLazyCollections(Loader.java:324)
2017-02-28 13:56:37,351 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.loadEntity(Loader.java:2148)
2017-02-28 13:56:37,351 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.entity.AbstractEntityLoader.load(AbstractEntityLoader.java:78)
2017-02-28 13:56:37,351 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.entity.EntityLoader.loadByUniqueKey(EntityLoader.java:161)
2017-02-28 13:56:37,351 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.hibernate.persister.entity.AbstractEntityPersister.loadByUniqueKey(AbstractEntityPersister.java:2385)
2017-02-28 13:56:37,351 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.hibernate.type.EntityType.loadByUniqueKey(EntityType.java:767)
2017-02-28 13:56:37,351 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.hibernate.type.EntityType.resolve(EntityType.java:505)
2017-02-28 13:56:37,352 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.hibernate.engine.internal.TwoPhaseLoad.doInitializeEntity(TwoPhaseLoad.java:170)
2017-02-28 13:56:37,352 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.hibernate.engine.internal.TwoPhaseLoad.initializeEntity(TwoPhaseLoad.java:144)
2017-02-28 13:56:37,352 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.plan.exec.process.internal.AbstractRowReader.performTwoPhaseLoad(AbstractRowReader.java:244)
2017-02-28 13:56:37,352 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.plan.exec.process.internal.AbstractRowReader.finishUp(AbstractRowReader.java:215)
2017-02-28 13:56:37,352 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.plan.exec.process.internal.ResultSetProcessorImpl.extractResults(ResultSetProcessorImpl.java:140)
2017-02-28 13:56:37,353 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.plan.exec.internal.AbstractLoadPlanBasedLoader.executeLoad(AbstractLoadPlanBasedLoader.java:138)
2017-02-28 13:56:37,353 ERROR [stderr] (Thread-32 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.plan.exec.internal.AbstractLoadPlanBasedLoader.executeLoad(AbstractLoadPlanBasedLoader.java:102)
2017-02-28 13:56:41,932 SEVERE [class backend.dao.calc.TrajectoryDAO] (Thread-32 (HornetQ-client-global-threads-244609549)) Error while updating records from the database null
2017-02-28 13:56:41,933 INFO [stdout] (Thread-32 (HornetQ-client-global-threads-244609549)) Send Reply...........
2017-02-28 13:56:50,935 INFO [class backend.mdb.ProtoelQueueMDB] (Thread-32 (HornetQ-client-global-threads-244609549)) ProtoelQueueMDB.sendReply, dest= HornetQQueue[MDBQueueReply] TEXTMESSAGE: [B@4e3b47f2
2017-02-28 13:56:52,447 INFO [class backend.mdb.ProtoelQueueMDB] (Thread-32 (HornetQ-client-global-threads-244609549)) Sending response to client....... 2017-02-28 12:56:52.447
2017-02-28 13:56:54,229 INFO [class backend.mdb.ProtoelQueueMDB] (Thread-32 (HornetQ-client-global-threads-244609549)) Zipped file to delete on server..........null
2017-02-28 14:00:26,902 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) java.lang.OutOfMemoryError: GC overhead limit exceeded
2017-02-28 14:00:26,903 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at java.util.UUID.fromString(UUID.java:196)
2017-02-28 14:00:26,903 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.postgresql.jdbc3g.AbstractJdbc3gResultSet.getUUID(AbstractJdbc3gResultSet.java:35)
2017-02-28 14:00:26,903 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.postgresql.jdbc2.AbstractJdbc2ResultSet.internalGetObject(AbstractJdbc2ResultSet.java:185)
2017-02-28 14:00:26,903 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.postgresql.jdbc3.AbstractJdbc3ResultSet.internalGetObject(AbstractJdbc3ResultSet.java:36)
2017-02-28 14:00:26,903 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.postgresql.jdbc4.AbstractJdbc4ResultSet.internalGetObject(AbstractJdbc4ResultSet.java:300)
2017-02-28 14:00:26,903 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.postgresql.jdbc2.AbstractJdbc2ResultSet.getObject(AbstractJdbc2ResultSet.java:2704)
2017-02-28 14:00:26,903 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.postgresql.jdbc2.AbstractJdbc2ResultSet.getObject(AbstractJdbc2ResultSet.java:2716)
2017-02-28 14:00:26,904 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at common.util.UuidType.nullSafeGet(UuidType.java:66)
2017-02-28 14:00:26,904 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.hibernate.type.CustomType.nullSafeGet(CustomType.java:127)
2017-02-28 14:00:26,904 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.hibernate.type.AbstractType.hydrate(AbstractType.java:106)
2017-02-28 14:00:26,904 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.extractKeysFromResultSet(Loader.java:784)
2017-02-28 14:00:26,904 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.getRowFromResultSet(Loader.java:720)
2017-02-28 14:00:26,904 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.processResultSet(Loader.java:952)
2017-02-28 14:00:26,904 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.doQuery(Loader.java:920)
2017-02-28 14:00:26,904 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.doQueryAndInitializeNonLazyCollections(Loader.java:354)
2017-02-28 14:00:26,905 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.doQueryAndInitializeNonLazyCollections(Loader.java:324)
2017-02-28 14:00:26,905 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.Loader.loadEntity(Loader.java:2148)
2017-02-28 14:00:26,905 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.entity.AbstractEntityLoader.load(AbstractEntityLoader.java:78)
2017-02-28 14:00:26,905 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.entity.EntityLoader.loadByUniqueKey(EntityLoader.java:161)
2017-02-28 14:00:26,905 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.hibernate.persister.entity.AbstractEntityPersister.loadByUniqueKey(AbstractEntityPersister.java:2385)
2017-02-28 14:00:28,255 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.hibernate.type.EntityType.loadByUniqueKey(EntityType.java:767)
2017-02-28 14:00:28,256 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.hibernate.type.EntityType.resolve(EntityType.java:505)
2017-02-28 14:00:28,256 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.hibernate.engine.internal.TwoPhaseLoad.doInitializeEntity(TwoPhaseLoad.java:170)
2017-02-28 14:00:28,256 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.hibernate.engine.internal.TwoPhaseLoad.initializeEntity(TwoPhaseLoad.java:144)
2017-02-28 14:00:28,256 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.plan.exec.process.internal.AbstractRowReader.performTwoPhaseLoad(AbstractRowReader.java:244)
2017-02-28 14:00:28,257 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.plan.exec.process.internal.AbstractRowReader.finishUp(AbstractRowReader.java:215)
2017-02-28 14:00:28,257 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.plan.exec.process.internal.ResultSetProcessorImpl.extractResults(ResultSetProcessorImpl.java:140)
2017-02-28 14:00:28,257 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.plan.exec.internal.AbstractLoadPlanBasedLoader.executeLoad(AbstractLoadPlanBasedLoader.java:138)
2017-02-28 14:00:28,257 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.plan.exec.internal.AbstractLoadPlanBasedLoader.executeLoad(AbstractLoadPlanBasedLoader.java:102)
2017-02-28 14:00:28,257 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.hibernate.loader.collection.plan.AbstractLoadPlanBasedCollectionInitializer.initialize(AbstractLoadPlanBasedCollectionInitializer.java:100)
2017-02-28 14:00:28,257 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.hibernate.persister.collection.AbstractCollectionPersister.initialize(AbstractCollectionPersister.java:693)
2017-02-28 14:00:28,257 ERROR [stderr] (Thread-29 (HornetQ-client-global-threads-244609549)) at org.hibernate.event.internal.DefaultInitializeCollectionEventListener.onInitializeCollection(DefaultInitializeCollectionEventListener.java:92)
2017-02-28 14:00:28,277 SEVERE [class backend.dao.calc.TrajectoryDAO] (Thread-29 (HornetQ-client-global-threads-244609549)) Error while updating records from the database null
2017-02-28 14:00:28,277 INFO [stdout] (Thread-29 (HornetQ-client-global-threads-244609549)) Send Reply...........
2017-02-28 14:00:34,642 INFO [class backend.mdb.ProtoelQueueMDB] (Thread-29 (HornetQ-client-global-threads-244609549)) ProtoelQueueMDB.sendReply, dest= HornetQQueue[MDBQueueReply] TEXTMESSAGE: [B@6b0410ff
2017-02-28 14:00:34,644 INFO [class backend.mdb.ProtoelQueueMDB] (Thread-29 (HornetQ-client-global-threads-244609549)) Sending response to client....... 2017-02-28 13:00:34.644
2017-02-28 14:00:34,651 INFO [class backend.mdb.ProtoelQueueMDB] (Thread-29 (HornetQ-client-global-threads-244609549)) Zipped file to delete on server..........null
2017-02-28 14:00:34,654 WARN [com.arjuna.ats.jta] (Thread-29 (HornetQ-client-global-threads-244609549)) ARJUNA016039: onePhaseCommit on < formatId=131077, gtrid_length=29, bqual_length=36, tx_uid=0:ffff0a812482:-7c53c619:58b568ed:107, node_name=1, branch_uid=0:ffff0a812482:-7c53c619:58b568ed:108, subordinatenodename=null, eis_name=unknown eis name > (DelegatingSession [session=ClientSessionImpl [name=20eb149e-fdaf-11e6-beeb-f53e17d73150, username=null, closed=false, factory = ClientSessionFactoryImpl [serverLocator=ServerLocatorImpl [initialConnectors=[TransportConfiguration(name=091a4744-fdaf-11e6-beeb-f53e17d73150, factory=org-hornetq-core-remoting-impl-invm-InVMConnectorFactory) ?server-id=0], discoveryGroupConfiguration=null], connectorConfig=TransportConfiguration(name=20eac67c-fdaf-11e6-beeb-f53e17d73150, factory=org-hornetq-core-remoting-impl-invm-InVMConnectorFactory) ?server-id=0, backupConfig=null], metaData=(jms-session=,resource-adapter=inbound,)]@41e4bf4d]) failed with exception XAException.XAER_PROTO: javax.transaction.xa.XAException
at org.hornetq.core.client.impl.ClientSessionImpl.end(ClientSessionImpl.java:1558)
at org.hornetq.core.client.impl.DelegatingSession.end(DelegatingSession.java:348)
at com.arjuna.ats.internal.jta.resources.arjunacore.XAResourceRecord.topLevelOnePhaseCommit(XAResourceRecord.java:625)
at com.arjuna.ats.arjuna.coordinator.BasicAction.onePhaseCommit(BasicAction.java:2364)
at com.arjuna.ats.arjuna.coordinator.BasicAction.End(BasicAction.java:1518)
at com.arjuna.ats.arjuna.coordinator.TwoPhaseCoordinator.end(TwoPhaseCoordinator.java:96)
at com.arjuna.ats.arjuna.AtomicAction.commit(AtomicAction.java:162)
at com.arjuna.ats.internal.jta.transaction.arjunacore.TransactionImple.commitAndDisassociate(TransactionImple.java:1200)
at com.arjuna.ats.internal.jta.transaction.arjunacore.BaseTransaction.commit(BaseTransaction.java:126)
at com.arjuna.ats.jbossatx.BaseTransactionManagerDelegate.commit(BaseTransactionManagerDelegate.java:75)
at org.jboss.as.ejb3.inflow.MessageEndpointInvocationHandler.afterDelivery(MessageEndpointInvocationHandler.java:71)
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:497)
at org.jboss.as.ejb3.inflow.AbstractInvocationHandler.handle(AbstractInvocationHandler.java:60)
at org.jboss.as.ejb3.inflow.MessageEndpointInvocationHandler.doInvoke(MessageEndpointInvocationHandler.java:135)
at org.jboss.as.ejb3.inflow.AbstractInvocationHandler.invoke(AbstractInvocationHandler.java:73)
at backend.mdb.ProtoelQueueMDB$$$endpoint1.afterDelivery(Unknown Source)
at org.hornetq.ra.inflow.HornetQMessageHandler.onMessage(HornetQMessageHandler.java:330)
at org.hornetq.core.client.impl.ClientConsumerImpl.callOnMessage(ClientConsumerImpl.java:1116)
at org.hornetq.core.client.impl.ClientConsumerImpl.access$500(ClientConsumerImpl.java:56)
at org.hornetq.core.client.impl.ClientConsumerImpl$Runner.run(ClientConsumerImpl.java:1251)
at org.hornetq.utils.OrderedExecutorFactory$OrderedExecutor$1.run(OrderedExecutorFactory.java:104)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
2017-02-28 14:00:34,655 WARN [org.hornetq.ra] (Thread-29 (HornetQ-client-global-threads-244609549)) HQ152006: Unable to call after delivery: javax.resource.spi.LocalTransactionException: javax.transaction.RollbackException: ARJUNA016053: Could not commit transaction.
at org.jboss.as.ejb3.inflow.MessageEndpointInvocationHandler.afterDelivery(MessageEndpointInvocationHandler.java:87)
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:497)
at org.jboss.as.ejb3.inflow.AbstractInvocationHandler.handle(AbstractInvocationHandler.java:60)
at org.jboss.as.ejb3.inflow.MessageEndpointInvocationHandler.doInvoke(MessageEndpointInvocationHandler.java:135)
at org.jboss.as.ejb3.inflow.AbstractInvocationHandler.invoke(AbstractInvocationHandler.java:73)
at backend.mdb.ProtoelQueueMDB$$$endpoint1.afterDelivery(Unknown Source)
at org.hornetq.ra.inflow.HornetQMessageHandler.onMessage(HornetQMessageHandler.java:330)
at org.hornetq.core.client.impl.ClientConsumerImpl.callOnMessage(ClientConsumerImpl.java:1116)
at org.hornetq.core.client.impl.ClientConsumerImpl.access$500(ClientConsumerImpl.java:56)
at org.hornetq.core.client.impl.ClientConsumerImpl$Runner.run(ClientConsumerImpl.java:1251)
at org.hornetq.utils.OrderedExecutorFactory$OrderedExecutor$1.run(OrderedExecutorFactory.java:104)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
Caused by: javax.transaction.RollbackException: ARJUNA016053: Could not commit transaction.
at com.arjuna.ats.internal.jta.transaction.arjunacore.TransactionImple.commitAndDisassociate(TransactionImple.java:1212)
at com.arjuna.ats.internal.jta.transaction.arjunacore.BaseTransaction.commit(BaseTransaction.java:126)
at com.arjuna.ats.jbossatx.BaseTransactionManagerDelegate.commit(BaseTransactionManagerDelegate.java:75)
at org.jboss.as.ejb3.inflow.MessageEndpointInvocationHandler.afterDelivery(MessageEndpointInvocationHandler.java:71)
... 16 more
Suppressed: javax.transaction.xa.XAException
at org.hornetq.core.client.impl.ClientSessionImpl.end(ClientSessionImpl.java:1558)
at org.hornetq.core.client.impl.DelegatingSession.end(DelegatingSession.java:348)
at com.arjuna.ats.internal.jta.resources.arjunacore.XAResourceRecord.topLevelOnePhaseCommit(XAResourceRecord.java:625)
at com.arjuna.ats.arjuna.coordinator.BasicAction.onePhaseCommit(BasicAction.java:2364)
at com.arjuna.ats.arjuna.coordinator.BasicAction.End(BasicAction.java:1518)
at com.arjuna.ats.arjuna.coordinator.TwoPhaseCoordinator.end(TwoPhaseCoordinator.java:96)
at com.arjuna.ats.arjuna.AtomicAction.commit(AtomicAction.java:162)
at com.arjuna.ats.internal.jta.transaction.arjunacore.TransactionImple.commitAndDisassociate(TransactionImple.java:1200)
... 19 more
2017-02-28 14:05:37,990 INFO [org.jboss.as.server] (Thread-2) WFLYSRV0220: Server shutdown has been requested.
2017-02-28 14:05:53,316 INFO [org.jboss.as.connector.deployers.jdbc] (MSC service thread 1-4) WFLYJCA0019: Stopped Driver service with driver-name = protoel.war_org.postgresql.Driver_9_3
2017-02-28 14:05:55,880 INFO [org.jboss.as.connector.deployers.jdbc] (MSC service thread 1-1) WFLYJCA0019: Stopped Driver service with driver-name = protoel.war_org.h2.Driver_1_4
2017-02-28 14:05:58,458 INFO [org.wildfly.extension.undertow] (ServerService Thread Pool -- 82) WFLYUT0022: Unregistered web context: /protoel
2017-02-28 14:06:03,971 INFO [org.wildfly.extension.undertow] (MSC service thread 1-8) WFLYUT0019: Host default-host stopping
2017-02-28 14:06:03,978 INFO [org.jboss.modcluster] (ServerService Thread Pool -- 83) MODCLUSTER000002: Initiating mod_cluster shutdown
2017-02-28 14:07:15,433 INFO [org.jboss.modules] (main) JBoss Modules version 1.4.3.Final
2017-02-28 14:07:15,650 INFO [org.jboss.msc] (main) JBoss MSC version 1.2.6.Final
2017-02-28 14:07:15,737 INFO [org.jboss.as] (MSC service thread 1-7) WFLYSRV0049: WildFly Full 9.0.1.Final (WildFly Core 1.0.1.Final) starting
2017-02-28 14:07:15,739 DEBUG [org.jboss.as.config] (MSC service thread 1-7) Configured system properties:
[Standalone] =
awt.toolkit = sun.awt.X11.XToolkit
file.encoding = UTF-8
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 = /var/project/wildfly/jboss-modules.jar
java.class.version = 52.0
java.endorsed.dirs = /var/project/java/jdk1.8.0_45/jre/lib/endorsed
java.ext.dirs = /var/project/java/jdk1.8.0_45/jre/lib/ext:/usr/java/packages/lib/ext
java.home = /var/project/java/jdk1.8.0_45/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 = Java(TM) SE Runtime Environment
java.runtime.version = 1.8.0_45-b14
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.vendor.url.bug = http://bugreport.sun.com/bugreport/
java.version = 1.8.0_45
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.8
java.vm.vendor = Oracle Corporation
java.vm.version = 25.45-b02
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.home.dir = /var/project/wildfly
jboss.host.name = wldevotapas
jboss.modules.dir = /var/project/wildfly/modules
jboss.modules.system.pkgs = org.jboss.byteman
jboss.node.name = wldevotapas
jboss.qualified.host.name = wldevotapas
jboss.server.base.dir = /var/project/wildfly/standalone
jboss.server.config.dir = /var/project/wildfly/standalone/configuration
jboss.server.data.dir = /var/project/wildfly/standalone/data
jboss.server.deploy.dir = /var/project/wildfly/standalone/data/content
jboss.server.log.dir = /var/project/wildfly/standalone/log
jboss.server.name = wldevotapas
jboss.server.persist.config = true
jboss.server.temp.dir = /var/project/wildfly/standalone/tmp
line.separator =
logging.configuration = file:/var/project/wildfly/standalone/configuration/logging.properties
module.path = /var/project/wildfly/modules
org.jboss.boot.log.file = /var/project/wildfly/standalone/log/server.log
org.jboss.resolver.warning = true
org.xml.sax.driver = __redirected.__XMLReaderFactory
os.arch = amd64
os.name = Linux
os.version = 2.6.32-504.el6.x86_64
path.separator = :
sun.arch.data.model = 64
sun.boot.class.path = /var/project/java/jdk1.8.0_45/jre/lib/resources.jar:/var/project/java/jdk1.8.0_45/jre/lib/rt.jar:/var/project/java/jdk1.8.0_45/jre/lib/sunrsasign.jar:/var/project/java/jdk1.8.0_45/jre/lib/jsse.jar:/var/project/java/jdk1.8.0_45/jre/lib/jce.jar:/var/project/java/jdk1.8.0_45/jre/lib/charsets.jar:/var/project/java/jdk1.8.0_45/jre/lib/jfr.jar:/var/project/java/jdk1.8.0_45/jre/classes
sun.boot.library.path = /var/project/java/jdk1.8.0_45/jre/lib/amd64
sun.cpu.endian = little
sun.cpu.isalist =
sun.io.unicode.encoding = UnicodeLittle
sun.java.command = /var/project/wildfly/jboss-modules.jar -mp /var/project/wildfly/modules org.jboss.as.standalone -Djboss.home.dir=/var/project/wildfly -Djboss.server.base.dir=/var/project/wildfly/standalone -c standalone-full-ha.xml
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 = /
user.home = /home/wildfly
user.language = en
user.name = wildfly
user.timezone = Europe/Brussels
2017-02-28 14:07:15,740 DEBUG [org.jboss.as.config] (MSC service thread 1-7) VM Arguments: -D[Standalone] -XX:+UseCompressedOops -XX:+UseCompressedOops -Xms3028m -Xmx3128m -XX:MaxPermSize=3048m -Djava.net.preferIPv4Stack=true -Djboss.modules.system.pkgs=org.jboss.byteman -Djava.awt.headless=true -Dorg.jboss.boot.log.file=/var/project/wildfly/standalone/log/server.log -Dlogging.configuration=file:/var/project/wildfly/standalone/configuration/logging.properties
2017-02-28 14:07:17,087 INFO [org.jboss.as.controller.management-deprecated] (ServerService Thread Pool -- 25) WFLYCTL0028: Attribute 'job-repository-type' in the resource at address '/subsystem=batch' is deprecated, and may be removed in future version. See the attribute description in the output of the read-resource-description operation to learn more about the deprecation.
2017-02-28 14:07:17,087 INFO [org.jboss.as.controller.management-deprecated] (ServerService Thread Pool -- 20) WFLYCTL0028: Attribute 'enabled' in the resource at address '/subsystem=datasources/data-source=ExampleDS' is deprecated, and may be removed in future version. See the attribute description in the output of the read-resource-description operation to learn more about the deprecation.
2017-02-28 14:07:17,094 INFO [org.jboss.as.controller.management-deprecated] (ServerService Thread Pool -- 5) WFLYCTL0028: Attribute 'default-stack' in the resource at address '/subsystem=jgroups' is deprecated, and may be removed in future version. See the attribute description in the output of the read-resource-description operation to learn more about the deprecation.
2017-02-28 14:07:17,256 INFO [org.jboss.as.server] (Controller Boot Thread) WFLYSRV0039: Creating http management service using socket-binding (management-http)
2017-02-28 14:07:17,285 INFO [org.xnio] (MSC service thread 1-6) XNIO version 3.3.1.Final
2017-02-28 14:07:17,384 INFO [org.xnio.nio] (MSC service thread 1-6) XNIO NIO Implementation Version 3.3.1.Final
2017-02-28 14:07:17,424 INFO [org.jboss.as.security] (ServerService Thread Pool -- 63) WFLYSEC0002: Activating Security Subsystem
2017-02-28 14:07:17,437 WARN [org.jboss.as.txn] (ServerService Thread Pool -- 64) WFLYTX0013: Node identifier property is set to the default value. Please make sure it is unique.
2017-02-28 14:07:17,438 INFO [org.wildfly.extension.io] (ServerService Thread Pool -- 42) WFLYIO001: Worker 'default' has auto-configured to 16 core threads with 128 task threads based on your 8 available processors
2017-02-28 14:07:17,440 INFO [org.jboss.as.clustering.jgroups] (ServerService Thread Pool -- 48) WFLYCLJG0001: Activating JGroups subsystem.
2017-02-28 14:07:17,442 INFO [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 43) WFLYCLINF0001: Activating Infinispan subsystem.
2017-02-28 14:07:17,446 INFO [org.jboss.as.jsf] (ServerService Thread Pool -- 51) WFLYJSF0007: Activated the following JSF Implementations: [main]
2017-02-28 14:07:17,447 INFO [org.jboss.as.security] (MSC service thread 1-2) WFLYSEC0001: Current PicketBox version=4.9.2.Final
2017-02-28 14:07:17,451 INFO [org.wildfly.iiop.openjdk] (ServerService Thread Pool -- 44) WFLYIIOP0001: Activating IIOP Subsystem
2017-02-28 14:07:17,455 INFO [org.jboss.as.naming] (ServerService Thread Pool -- 56) WFLYNAM0001: Activating Naming Subsystem
2017-02-28 14:07:17,474 INFO [org.jboss.as.webservices] (ServerService Thread Pool -- 66) WFLYWS0002: Activating WebServices Extension
2017-02-28 14:07:17,500 INFO [org.jboss.as.connector] (MSC service thread 1-5) WFLYJCA0009: Starting JCA Subsystem (IronJacamar 1.2.4.Final)
2017-02-28 14:07:17,517 INFO [org.jboss.as.connector.subsystems.datasources] (ServerService Thread Pool -- 38) WFLYJCA0004: Deploying JDBC-compliant driver class org.h2.Driver (version 1.3)
2017-02-28 14:07:17,524 INFO [org.jboss.as.connector.deployers.jdbc] (MSC service thread 1-2) WFLYJCA0018: Started Driver service with driver-name = h2
2017-02-28 14:07:17,528 INFO [org.wildfly.extension.undertow] (ServerService Thread Pool -- 65) WFLYUT0003: Undertow 1.2.9.Final starting
2017-02-28 14:07:17,528 INFO [org.wildfly.extension.undertow] (MSC service thread 1-7) WFLYUT0003: Undertow 1.2.9.Final starting
2017-02-28 14:07:17,532 INFO [org.jboss.remoting] (MSC service thread 1-6) JBoss Remoting version 4.0.9.Final
2017-02-28 14:07:17,566 INFO [org.jboss.as.naming] (MSC service thread 1-2) WFLYNAM0003: Starting Naming Service
2017-02-28 14:07:17,569 INFO [org.jboss.as.mail.extension] (MSC service thread 1-7) WFLYMAIL0001: Bound mail session [java:jboss/mail/Default]
2017-02-28 14:07:17,704 INFO [org.wildfly.extension.undertow] (ServerService Thread Pool -- 65) WFLYUT0014: Creating file handler for path /var/project/wildfly/welcome-content
2017-02-28 14:07:17,714 INFO [org.wildfly.extension.undertow] (MSC service thread 1-7) WFLYUT0012: Started server default-server.
2017-02-28 14:07:17,727 INFO [org.wildfly.extension.undertow] (MSC service thread 1-8) WFLYUT0018: Host default-host starting
2017-02-28 14:07:17,779 INFO [org.wildfly.extension.undertow] (MSC service thread 1-7) WFLYUT0006: Undertow AJP listener ajp listening on /10.129.36.130:8009
2017-02-28 14:07:17,780 INFO [org.wildfly.extension.undertow] (MSC service thread 1-3) WFLYUT0006: Undertow HTTP listener default listening on /10.129.36.130:8080
2017-02-28 14:07:17,796 INFO [org.jboss.modcluster] (ServerService Thread Pool -- 69) MODCLUSTER000001: Initializing mod_cluster version 1.3.1.Final
2017-02-28 14:07:17,832 INFO [org.jboss.modcluster] (ServerService Thread Pool -- 69) MODCLUSTER000032: Listening to proxy advertisements on /224.0.1.105:23364
2017-02-28 14:07:17,998 INFO [org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-5) WFLYJCA0001: Bound data source [java:jboss/datasources/ExampleDS]
2017-02-28 14:07:18,050 INFO [org.wildfly.iiop.openjdk] (MSC service thread 1-4) WFLYIIOP0009: CORBA ORB Service started
2017-02-28 14:07:18,079 INFO [org.jboss.as.server.deployment.scanner] (MSC service thread 1-4) WFLYDS0013: Started FileSystemDeploymentService for directory /var/project/wildfly/standalone/deployments
2017-02-28 14:07:18,084 INFO [org.jboss.as.server.deployment] (MSC service thread 1-1) WFLYSRV0027: Starting deployment of "protoel.war" (runtime-name: "protoel.war")
2017-02-28 14:07:18,598 INFO [org.jboss.ws.common.management] (MSC service thread 1-5) JBWS022052: Starting JBoss Web Services - Stack CXF Server 5.0.0.Final
2017-02-28 14:07:18,673 INFO [org.hornetq.core.server] (ServerService Thread Pool -- 68) HQ221000: live server is starting with configuration HornetQ Configuration (clustered=true,backup=false,sharedStore=true,journalDirectory=/var/project/wildfly/standalone/data/messagingjournal,bindingsDirectory=/var/project/wildfly/standalone/data/messagingbindings,largeMessagesDirectory=/var/project/wildfly/standalone/data/messaginglargemessages,pagingDirectory=/var/project/wildfly/standalone/data/messagingpaging)
2017-02-28 14:07:18,675 INFO [org.hornetq.core.server] (ServerService Thread Pool -- 68) HQ221006: Waiting to obtain live lock
2017-02-28 14:07:18,700 INFO [org.hornetq.core.server] (ServerService Thread Pool -- 68) HQ221012: Using AIO Journal
2017-02-28 14:07:18,756 INFO [org.hornetq.core.server] (ServerService Thread Pool -- 68) HQ221043: Adding protocol support CORE
2017-02-28 14:07:18,761 INFO [org.hornetq.core.server] (ServerService Thread Pool -- 68) HQ221043: Adding protocol support AMQP
2017-02-28 14:07:18,765 INFO [org.hornetq.core.server] (ServerService Thread Pool -- 68) HQ221043: Adding protocol support STOMP
2017-02-28 14:07:18,806 INFO [org.hornetq.core.server] (ServerService Thread Pool -- 68) HQ221034: Waiting to obtain live lock
2017-02-28 14:07:18,806 INFO [org.hornetq.core.server] (ServerService Thread Pool -- 68) HQ221035: Live Server Obtained live lock
2017-02-28 14:07:19,219 INFO [org.jboss.messaging] (MSC service thread 1-3) WFLYMSG0016: Registered HTTP upgrade for hornetq-remoting protocol handled by http-acceptor-throughput acceptor
2017-02-28 14:07:19,219 INFO [org.jboss.messaging] (MSC service thread 1-2) WFLYMSG0016: Registered HTTP upgrade for hornetq-remoting protocol handled by http-acceptor acceptor
2017-02-28 14:07:19,231 WARNING [org.jgroups.protocols.UDP] (ServerService Thread Pool -- 68) JGRP000015: the send buffer of socket DatagramSocket was set to 640KB, but the OS only allocated 124.93KB. This might lead to performance problems. Please set your max send buffer in the OS correctly (e.g. net.core.wmem_max on Linux)
2017-02-28 14:07:19,232 WARNING [org.jgroups.protocols.UDP] (ServerService Thread Pool -- 68) JGRP000015: the receive buffer of socket DatagramSocket was set to 20MB, but the OS only allocated 124.93KB. This might lead to performance problems. Please set your max receive buffer in the OS correctly (e.g. net.core.rmem_max on Linux)
2017-02-28 14:07:19,232 WARNING [org.jgroups.protocols.UDP] (ServerService Thread Pool -- 68) JGRP000015: the send buffer of socket MulticastSocket was set to 640KB, but the OS only allocated 124.93KB. This might lead to performance problems. Please set your max send buffer in the OS correctly (e.g. net.core.wmem_max on Linux)
2017-02-28 14:07:19,233 WARNING [org.jgroups.protocols.UDP] (ServerService Thread Pool -- 68) JGRP000015: the receive buffer of socket MulticastSocket was set to 25MB, but the OS only allocated 124.93KB. This might lead to performance problems. Please set your max receive buffer in the OS correctly (e.g. net.core.rmem_max on Linux)
2017-02-28 14:07:19,238 INFO [stdout] (ServerService Thread Pool -- 68)
2017-02-28 14:07:19,238 INFO [stdout] (ServerService Thread Pool -- 68) -------------------------------------------------------------------
2017-02-28 14:07:19,238 INFO [stdout] (ServerService Thread Pool -- 68) GMS: address=wldevotapas, cluster=hq-cluster, physical address=10.129.36.130:55200
2017-02-28 14:07:19,238 INFO [stdout] (ServerService Thread Pool -- 68) -------------------------------------------------------------------
2017-02-28 14:07:22,305 INFO [org.hornetq.core.server] (ServerService Thread Pool -- 68) HQ221007: Server is now live
2017-02-28 14:07:22,306 INFO [org.hornetq.core.server] (ServerService Thread Pool -- 68) HQ221001: HornetQ Server version 2.4.7.Final (2.4.7.Final, 124) [a925356e-8f58-11e5-8093-09b87cae4629]
2017-02-28 14:07:22,309 INFO [org.hornetq.core.server] (ServerService Thread Pool -- 68) HQ221003: trying to deploy queue jms.queue.MDBQueueReply
2017-02-28 14:07:22,438 INFO [org.jboss.as.messaging] (ServerService Thread Pool -- 71) WFLYMSG0002: Bound messaging object to jndi name java:/ConnectionFactory
2017-02-28 14:07:22,447 INFO [org.hornetq.core.server] (ServerService Thread Pool -- 72) HQ221003: trying to deploy queue jms.queue.MDBQueueRequest
2017-02-28 14:07:22,448 INFO [org.hornetq.core.server] (ServerService Thread Pool -- 73) HQ221003: trying to deploy queue jms.queue.ExpiryQueue
2017-02-28 14:07:22,449 INFO [org.hornetq.core.server] (ServerService Thread Pool -- 70) HQ221003: trying to deploy queue jms.queue.DLQ
2017-02-28 14:07:22,450 INFO [org.jboss.as.messaging] (ServerService Thread Pool -- 69) WFLYMSG0002: Bound messaging object to jndi name java:jboss/exported/jms/RemoteConnectionFactory
2017-02-28 14:07:22,498 INFO [org.jboss.as.connector.deployment] (MSC service thread 1-8) WFLYJCA0007: Registered connection factory java:/JmsXA
2017-02-28 14:07:22,534 INFO [org.hornetq.ra] (MSC service thread 1-8) HornetQ resource adaptor started
2017-02-28 14:07:22,535 INFO [org.jboss.as.connector.services.resourceadapters.ResourceAdapterActivatorService$ResourceAdapterActivator] (MSC service thread 1-8) IJ020002: Deployed: file://RaActivatorhornetq-ra
2017-02-28 14:07:22,538 INFO [org.jboss.as.connector.deployment] (MSC service thread 1-6) WFLYJCA0002: Bound JCA ConnectionFactory [java:/JmsXA]
2017-02-28 14:07:22,539 INFO [org.jboss.as.messaging] (MSC service thread 1-3) WFLYMSG0002: Bound messaging object to jndi name java:jboss/DefaultJMSConnectionFactory
2017-02-28 14:07:22,914 WARN [org.jboss.as.server.deployment] (MSC service thread 1-1) WFLYSRV0059: Class Path entry xercesImpl.jar in /content/protoel.war/WEB-INF/lib/xalan-2.7.0.jar does not point to a valid jar for a Class-Path reference.
2017-02-28 14:07:22,914 WARN [org.jboss.as.server.deployment] (MSC service thread 1-1) WFLYSRV0059: Class Path entry xml-apis.jar in /content/protoel.war/WEB-INF/lib/xalan-2.7.0.jar does not point to a valid jar for a Class-Path reference.
2017-02-28 14:07:22,915 WARN [org.jboss.as.server.deployment] (MSC service thread 1-1) WFLYSRV0059: Class Path entry serializer.jar in /content/protoel.war/WEB-INF/lib/xalan-2.7.0.jar does not point to a valid jar for a Class-Path reference.
2017-02-28 14:07:22,973 WARN [org.jboss.as.server.deployment] (MSC service thread 1-1) WFLYSRV0059: Class Path entry iText-toolbox.jar in /content/protoel.war/WEB-INF/lib/itext-2.1.5.jar does not point to a valid jar for a Class-Path reference.
2017-02-28 14:07:22,973 WARN [org.jboss.as.server.deployment] (MSC service thread 1-1) WFLYSRV0059: Class Path entry iText-toolbox-2.1.5.jar in /content/protoel.war/WEB-INF/lib/itext-2.1.5.jar does not point to a valid jar for a Class-Path reference.
2017-02-28 14:07:22,976 WARN [org.jboss.as.server.deployment] (MSC service thread 1-1) WFLYSRV0059: Class Path entry jaxb-api.jar in /content/protoel.war/WEB-INF/lib/jaxb-impl-2.2.jar does not point to a valid jar for a Class-Path reference.
2017-02-28 14:07:22,976 WARN [org.jboss.as.server.deployment] (MSC service thread 1-1) WFLYSRV0059: Class Path entry activation.jar in /content/protoel.war/WEB-INF/lib/jaxb-impl-2.2.jar does not point to a valid jar for a Class-Path reference.
2017-02-28 14:07:22,976 WARN [org.jboss.as.server.deployment] (MSC service thread 1-1) WFLYSRV0059: Class Path entry jsr173_1.0_api.jar in /content/protoel.war/WEB-INF/lib/jaxb-impl-2.2.jar does not point to a valid jar for a Class-Path reference.
2017-02-28 14:07:22,976 WARN [org.jboss.as.server.deployment] (MSC service thread 1-1) WFLYSRV0059: Class Path entry jaxb1-impl.jar in /content/protoel.war/WEB-INF/lib/jaxb-impl-2.2.jar does not point to a valid jar for a Class-Path reference.
2017-02-28 14:07:22,977 WARN [org.jboss.as.server.deployment] (MSC service thread 1-1) WFLYSRV0059: Class Path entry jaxb-api.jar in /content/protoel.war/WEB-INF/lib/jaxb-xjc-2.2.jar does not point to a valid jar for a Class-Path reference.
2017-02-28 14:07:22,977 WARN [org.jboss.as.server.deployment] (MSC service thread 1-1) WFLYSRV0059: Class Path entry jaxb-impl.jar in /content/protoel.war/WEB-INF/lib/jaxb-xjc-2.2.jar does not point to a valid jar for a Class-Path reference.
2017-02-28 14:07:22,977 WARN [org.jboss.as.server.deployment] (MSC service thread 1-1) WFLYSRV0059: Class Path entry jsr173_1.0_api.jar in /content/protoel.war/WEB-INF/lib/jaxb-xjc-2.2.jar does not point to a valid jar for a Class-Path reference.
2017-02-28 14:07:22,978 WARN [org.jboss.as.server.deployment] (MSC service thread 1-1) WFLYSRV0059: Class Path entry activation.jar in /content/protoel.war/WEB-INF/lib/jaxb-xjc-2.2.jar does not point to a valid jar for a Class-Path reference.
2017-02-28 14:07:23,625 INFO [org.jboss.weld.deployer] (MSC service thread 1-2) WFLYWELD0003: Processing weld deployment protoel.war
2017-02-28 14:07:23,694 INFO [org.hibernate.validator.internal.util.Version] (MSC service thread 1-2) HV000001: Hibernate Validator 5.1.3.Final
2017-02-28 14:07:24,006 INFO [org.jboss.as.connector.deployers.jdbc] (MSC service thread 1-2) WFLYJCA0005: Deploying non-JDBC-compliant driver class org.postgresql.Driver (version 9.3)
2017-02-28 14:07:24,009 INFO [org.jboss.as.connector.deployers.jdbc] (MSC service thread 1-2) WFLYJCA0004: Deploying JDBC-compliant driver class org.h2.Driver (version 1.4)
2017-02-28 14:07:24,010 INFO [org.jboss.weld.deployer] (MSC service thread 1-2) WFLYWELD0006: Starting Services for CDI deployment: protoel.war
2017-02-28 14:07:24,042 INFO [org.jboss.weld.Version] (MSC service thread 1-2) WELD-000900: 2.2.14 (Final)
2017-02-28 14:07:24,083 INFO [org.jboss.as.connector.deployers.jdbc] (MSC service thread 1-4) WFLYJCA0018: Started Driver service with driver-name = protoel.war_org.h2.Driver_1_4
2017-02-28 14:07:24,084 INFO [org.jboss.as.connector.deployers.jdbc] (MSC service thread 1-4) WFLYJCA0018: Started Driver service with driver-name = protoel.war_org.postgresql.Driver_9_3
2017-02-28 14:07:24,084 INFO [org.jboss.weld.deployer] (MSC service thread 1-4) WFLYWELD0009: Starting weld service for deployment protoel.war
2017-02-28 14:07:24,126 INFO [org.jboss.as.ejb3] (MSC service thread 1-1) WFLYEJB0042: Started message driven bean 'ProtoelQueueMDB' with 'hornetq-ra.rar' resource adapter
2017-02-28 14:07:26,026 INFO [org.wildfly.extension.undertow] (ServerService Thread Pool -- 70) WFLYUT0021: Registered web context: /protoel
2017-02-28 14:07:26,104 INFO [org.jboss.as.server] (Controller Boot Thread) WFLYSRV0010: Deployed "protoel.war" (runtime-name : "protoel.war")
2017-02-28 14:07:26,307 INFO [org.jboss.as] (Controller Boot Thread) WFLYSRV0060: Http management interface listening on http://10.129.36.130:9990/management
2017-02-28 14:07:26,308 INFO [org.jboss.as] (Controller Boot Thread) WFLYSRV0051: Admin console listening on http://10.129.36.130:9990
2017-02-28 14:07:26,308 INFO [org.jboss.as] (Controller Boot Thread) WFLYSRV0025: WildFly Full 9.0.1.Final (WildFly Core 1.0.1.Final) started in 11209ms - Started 378 of 594 services (299 services are lazy, passive or on-demand)
2017-02-28 14:09:17,214 INFO [stdout] (Thread-3 (HornetQ-client-global-threads-1770278514)) :: Connecting to remote database.........
2017-02-28 14:09:17,303 INFO [org.hibernate.annotations.common.Version] (Thread-3 (HornetQ-client-global-threads-1770278514)) HCANN000001: Hibernate Commons Annotations {4.0.4.Final}
2017-02-28 14:09:17,309 INFO [org.hibernate.Version] (Thread-3 (HornetQ-client-global-threads-1770278514)) HHH000412: Hibernate Core {4.3.5.Final}
2017-02-28 14:09:17,312 INFO [org.hibernate.cfg.Environment] (Thread-3 (HornetQ-client-global-threads-1770278514)) HHH000206: hibernate.properties not found
2017-02-28 14:09:17,313 INFO [org.hibernate.cfg.Environment] (Thread-3 (HornetQ-client-global-threads-1770278514)) HHH000021: Bytecode provider name : javassist
2017-02-28 14:09:17,330 INFO [org.hibernate.cfg.Configuration] (Thread-3 (HornetQ-client-global-threads-1770278514)) HHH000042: Configuring from file: hibernate.cfg.remote.xml
2017-02-28 14:09:17,659 WARN [org.hibernate.internal.util.xml.DTDEntityResolver] (Thread-3 (HornetQ-client-global-threads-1770278514)) HHH000223: Recognized obsolete hibernate namespace http://hibernate.sourceforge.net/. Use namespace http://www.hibernate.org/dtd/ instead. Refer to Hibernate 3.6 Migration Guide!
2017-02-28 14:09:17,697 INFO [org.hibernate.cfg.Configuration] (Thread-3 (HornetQ-client-global-threads-1770278514)) HHH000041: Configured SessionFactory: null
2017-02-28 14:09:17,841 WARN [org.hibernate.engine.jdbc.connections.internal.DriverManagerConnectionProviderImpl] (Thread-3 (HornetQ-client-global-threads-1770278514)) HHH000402: Using Hibernate built-in connection pool (not for production use!)
2017-02-28 14:09:17,842 INFO [org.hibernate.engine.jdbc.connections.internal.DriverManagerConnectionProviderImpl] (Thread-3 (HornetQ-client-global-threads-1770278514)) HHH000401: using driver [org.postgresql.Driver] at URL [jdbc:postgresql://10.129.36.119:5432/protoel]
2017-02-28 14:09:17,842 INFO [org.hibernate.engine.jdbc.connections.internal.DriverManagerConnectionProviderImpl] (Thread-3 (HornetQ-client-global-threads-1770278514)) HHH000046: Connection properties: {user=protoel, password=****}
2017-02-28 14:09:17,842 INFO [org.hibernate.engine.jdbc.connections.internal.DriverManagerConnectionProviderImpl] (Thread-3 (HornetQ-client-global-threads-1770278514)) HHH000006: Autocommit mode: false
2017-02-28 14:09:17,843 INFO [org.hibernate.engine.jdbc.connections.internal.DriverManagerConnectionProviderImpl] (Thread-3 (HornetQ-client-global-threads-1770278514)) HHH000115: Hibernate connection pool size: 20 (min=1)
2017-02-28 14:09:18,218 INFO [org.hibernate.dialect.Dialect] (Thread-3 (HornetQ-client-global-threads-1770278514)) HHH000400: Using dialect: org.hibernate.dialect.PostgreSQL82Dialect
2017-02-28 14:09:18,227 INFO [org.hibernate.engine.jdbc.internal.LobCreatorBuilder] (Thread-3 (HornetQ-client-global-threads-1770278514)) HHH000424: Disabling contextual LOB creation as createClob() method threw error : java.lang.reflect.InvocationTargetException
2017-02-28 14:09:18,524 INFO [org.hibernate.engine.transaction.internal.TransactionFactoryInitiator] (Thread-3 (HornetQ-client-global-threads-1770278514)) HHH000399: Using default transaction strategy (direct JDBC transactions)
2017-02-28 14:09:18,527 INFO [org.hibernate.hql.internal.ast.ASTQueryTranslatorFactory] (Thread-3 (HornetQ-client-global-threads-1770278514)) HHH000397: Using ASTQueryTranslatorFactory
2017-02-28 14:09:19,626 INFO [stdout] (Thread-3 (HornetQ-client-global-threads-1770278514)) :: Connected to remote database.........
2017-02-28 14:09:19,855 INFO [stdout] (Thread-3 (HornetQ-client-global-threads-1770278514)) deleting data for trajectory with ID : 3f661d13-4232-4456-834b-53269558c1f8
2017-02-28 14:11:07,712 INFO [stdout] (Thread-3 (HornetQ-client-global-threads-1770278514)) deleted data for trajectory with ID : 3f661d13-4232-4456-834b-53269558c1f8
2017-02-28 14:11:07,713 INFO [stdout] (Thread-3 (HornetQ-client-global-threads-1770278514)) deleting data for trajectory with ID : 98dca10d-0c80-4abe-8f01-7e5fbd5895d0
2017-02-28 14:12:50,669 INFO [stdout] (Thread-3 (HornetQ-client-global-threads-1770278514)) deleted data for trajectory with ID : 98dca10d-0c80-4abe-8f01-7e5fbd5895d0
2017-02-28 14:14:17,787 WARN [org.hornetq.core.server] (Thread-1 (HornetQ-scheduled-threads-1425605108)) HQ222103: transaction with xid XidImpl (927123944 bq:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.0.19.0.0.0.0.0.0.0.0 formatID:131077 gtxid:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.0.18.49 base64:AAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAAAEwAAAAAAAAAAAAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAAAEjEHAgIA timed out
2017-02-28 14:14:17,851 INFO [stdout] (Thread-7 (HornetQ-client-global-threads-1770278514)) deleting data for trajectory with ID : 3f661d13-4232-4456-834b-53269558c1f8
2017-02-28 14:16:11,785 INFO [stdout] (Thread-7 (HornetQ-client-global-threads-1770278514)) deleted data for trajectory with ID : 3f661d13-4232-4456-834b-53269558c1f8
2017-02-28 14:16:11,785 INFO [stdout] (Thread-7 (HornetQ-client-global-threads-1770278514)) deleting data for trajectory with ID : 98dca10d-0c80-4abe-8f01-7e5fbd5895d0
2017-02-28 14:19:18,787 WARN [org.hornetq.core.server] (Thread-1 (HornetQ-scheduled-threads-1425605108)) HQ222103: transaction with xid XidImpl (1946109782 bq:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.0.60.0.0.0.0.0.0.0.0 formatID:131077 gtxid:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.0.59.49 base64:AAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAAAPAAAAAAAAAAAAAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAAAOzEHAgIA timed out
2017-02-28 14:19:18,842 INFO [stdout] (Thread-11 (HornetQ-client-global-threads-1770278514)) deleting data for trajectory with ID : 3f661d13-4232-4456-834b-53269558c1f8
2017-02-28 14:21:10,579 INFO [stdout] (Thread-11 (HornetQ-client-global-threads-1770278514)) deleted data for trajectory with ID : 3f661d13-4232-4456-834b-53269558c1f8
2017-02-28 14:21:10,588 INFO [stdout] (Thread-11 (HornetQ-client-global-threads-1770278514)) deleting data for trajectory with ID : 98dca10d-0c80-4abe-8f01-7e5fbd5895d0
2017-02-28 14:24:19,787 WARN [org.hornetq.core.server] (Thread-0 (HornetQ-scheduled-threads-1425605108)) HQ222103: transaction with xid XidImpl (837056786 bq:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.0.89.0.0.0.0.0.0.0.0 formatID:131077 gtxid:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.0.88.49 base64:AAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAAAWQAAAAAAAAAAAAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAAAWDEHAgIA timed out
2017-02-28 14:24:19,828 INFO [stdout] (Thread-15 (HornetQ-client-global-threads-1770278514)) deleting data for trajectory with ID : 3f661d13-4232-4456-834b-53269558c1f8
2017-02-28 14:26:09,677 INFO [stdout] (Thread-15 (HornetQ-client-global-threads-1770278514)) deleted data for trajectory with ID : 3f661d13-4232-4456-834b-53269558c1f8
2017-02-28 14:26:09,677 INFO [stdout] (Thread-15 (HornetQ-client-global-threads-1770278514)) deleting data for trajectory with ID : 98dca10d-0c80-4abe-8f01-7e5fbd5895d0
2017-02-28 14:29:20,787 WARN [org.hornetq.core.server] (Thread-4 (HornetQ-scheduled-threads-1425605108)) HQ222103: transaction with xid XidImpl (2077008590 bq:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.0.118.0.0.0.0.0.0.0.0 formatID:131077 gtxid:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.0.117.49 base64:AAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAAAdgAAAAAAAAAAAAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAAAdTEHAgIA timed out
2017-02-28 14:29:20,828 INFO [stdout] (Thread-19 (HornetQ-client-global-threads-1770278514)) deleting data for trajectory with ID : 3f661d13-4232-4456-834b-53269558c1f8
2017-02-28 14:31:10,893 INFO [stdout] (Thread-19 (HornetQ-client-global-threads-1770278514)) deleted data for trajectory with ID : 3f661d13-4232-4456-834b-53269558c1f8
2017-02-28 14:31:10,893 INFO [stdout] (Thread-19 (HornetQ-client-global-threads-1770278514)) deleting data for trajectory with ID : 98dca10d-0c80-4abe-8f01-7e5fbd5895d0
2017-02-28 14:34:21,787 WARN [org.hornetq.core.server] (Thread-4 (HornetQ-scheduled-threads-1425605108)) HQ222103: transaction with xid XidImpl (1899284926 bq:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.0.-97.0.0.0.0.0.0.0.0 formatID:131077 gtxid:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.0.-98.49 base64:AAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAAAnwAAAAAAAAAAAAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAAAnjEHAgIA timed out
2017-02-28 14:34:21,819 INFO [stdout] (Thread-23 (HornetQ-client-global-threads-1770278514)) deleting data for trajectory with ID : 3f661d13-4232-4456-834b-53269558c1f8
2017-02-28 14:36:14,151 INFO [stdout] (Thread-23 (HornetQ-client-global-threads-1770278514)) deleted data for trajectory with ID : 3f661d13-4232-4456-834b-53269558c1f8
2017-02-28 14:36:14,152 INFO [stdout] (Thread-23 (HornetQ-client-global-threads-1770278514)) deleting data for trajectory with ID : 98dca10d-0c80-4abe-8f01-7e5fbd5895d0
2017-02-28 14:38:13,278 INFO [stdout] (Thread-3 (HornetQ-client-global-threads-1770278514)) ProtoelServiceInterfaceImpl.compute() starts.......
2017-02-28 14:38:13,308 INFO [stdout] (Thread-3 (HornetQ-client-global-threads-1770278514)) :: reading ship types
2017-02-28 14:38:13,308 INFO [stdout] (Thread-3 (HornetQ-client-global-threads-1770278514)) :: getRegShipData
2017-02-28 14:38:14,537 INFO [stdout] (Thread-7 (HornetQ-client-global-threads-1770278514)) deleted data for trajectory with ID : 98dca10d-0c80-4abe-8f01-7e5fbd5895d0
2017-02-28 14:38:14,571 INFO [stdout] (Thread-23 (HornetQ-client-global-threads-1770278514)) deleted data for trajectory with ID : 98dca10d-0c80-4abe-8f01-7e5fbd5895d0
2017-02-28 14:38:14,645 INFO [stdout] (Thread-11 (HornetQ-client-global-threads-1770278514)) deleted data for trajectory with ID : 98dca10d-0c80-4abe-8f01-7e5fbd5895d0
2017-02-28 14:38:14,669 INFO [stdout] (Thread-15 (HornetQ-client-global-threads-1770278514)) deleted data for trajectory with ID : 98dca10d-0c80-4abe-8f01-7e5fbd5895d0
2017-02-28 14:38:14,711 INFO [stdout] (Thread-19 (HornetQ-client-global-threads-1770278514)) deleted data for trajectory with ID : 98dca10d-0c80-4abe-8f01-7e5fbd5895d0
2017-02-28 14:38:14,748 SEVERE [class backend.dao.calc.TrajectoryDAO] (Thread-7 (HornetQ-client-global-threads-1770278514)) Error while deleting records from the database Batch update returned unexpected row count from update [0]; actual row count: 0; expected: 1
2017-02-28 14:38:14,802 INFO [stdout] (Thread-7 (HornetQ-client-global-threads-1770278514)) ProtoelServiceInterfaceImpl.compute() starts.......
2017-02-28 14:38:14,820 INFO [stdout] (Thread-7 (HornetQ-client-global-threads-1770278514)) :: reading ship types
2017-02-28 14:38:14,820 INFO [stdout] (Thread-7 (HornetQ-client-global-threads-1770278514)) :: getRegShipData
2017-02-28 14:38:14,826 SEVERE [class backend.dao.calc.TrajectoryDAO] (Thread-23 (HornetQ-client-global-threads-1770278514)) Error while deleting records from the database Batch update returned unexpected row count from update [0]; actual row count: 0; expected: 1
2017-02-28 14:38:14,850 INFO [stdout] (Thread-23 (HornetQ-client-global-threads-1770278514)) ProtoelServiceInterfaceImpl.compute() starts.......
2017-02-28 14:38:14,851 INFO [stdout] (Thread-23 (HornetQ-client-global-threads-1770278514)) :: reading ship types
2017-02-28 14:38:14,851 INFO [stdout] (Thread-23 (HornetQ-client-global-threads-1770278514)) :: getRegShipData
2017-02-28 14:38:14,887 SEVERE [class backend.dao.calc.TrajectoryDAO] (Thread-11 (HornetQ-client-global-threads-1770278514)) Error while deleting records from the database Batch update returned unexpected row count from update [0]; actual row count: 0; expected: 1
2017-02-28 14:38:14,921 INFO [stdout] (Thread-11 (HornetQ-client-global-threads-1770278514)) ProtoelServiceInterfaceImpl.compute() starts.......
2017-02-28 14:38:14,932 INFO [stdout] (Thread-11 (HornetQ-client-global-threads-1770278514)) :: reading ship types
2017-02-28 14:38:14,933 INFO [stdout] (Thread-11 (HornetQ-client-global-threads-1770278514)) :: getRegShipData
2017-02-28 14:38:14,959 SEVERE [class backend.dao.calc.TrajectoryDAO] (Thread-15 (HornetQ-client-global-threads-1770278514)) Error while deleting records from the database Batch update returned unexpected row count from update [0]; actual row count: 0; expected: 1
2017-02-28 14:38:14,978 INFO [stdout] (Thread-15 (HornetQ-client-global-threads-1770278514)) ProtoelServiceInterfaceImpl.compute() starts.......
2017-02-28 14:38:14,981 INFO [stdout] (Thread-15 (HornetQ-client-global-threads-1770278514)) :: reading ship types
2017-02-28 14:38:14,981 INFO [stdout] (Thread-15 (HornetQ-client-global-threads-1770278514)) :: getRegShipData
2017-02-28 14:38:15,019 SEVERE [class backend.dao.calc.TrajectoryDAO] (Thread-19 (HornetQ-client-global-threads-1770278514)) Error while deleting records from the database Batch update returned unexpected row count from update [0]; actual row count: 0; expected: 1
2017-02-28 14:38:15,049 INFO [stdout] (Thread-19 (HornetQ-client-global-threads-1770278514)) ProtoelServiceInterfaceImpl.compute() starts.......
2017-02-28 14:38:15,050 INFO [stdout] (Thread-19 (HornetQ-client-global-threads-1770278514)) :: reading ship types
2017-02-28 14:38:15,050 INFO [stdout] (Thread-19 (HornetQ-client-global-threads-1770278514)) :: getRegShipData
2017-02-28 14:39:22,787 WARN [org.hornetq.core.server] (Thread-1 (HornetQ-scheduled-threads-1425605108)) HQ222103: transaction with xid XidImpl (629826666 bq:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.0.-68.0.0.0.0.0.0.0.0 formatID:131077 gtxid:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.0.-69.49 base64:AAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAAAvAAAAAAAAAAAAAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAAAuzEHAgIA timed out
2017-02-28 14:39:23,159 INFO [stdout] (Thread-27 (HornetQ-client-global-threads-1770278514)) ProtoelServiceInterfaceImpl.compute() starts.......
2017-02-28 14:39:23,160 INFO [stdout] (Thread-27 (HornetQ-client-global-threads-1770278514)) :: reading ship types
2017-02-28 14:39:23,160 INFO [stdout] (Thread-27 (HornetQ-client-global-threads-1770278514)) :: getRegShipData
2017-02-28 14:44:23,787 WARN [org.hornetq.core.server] (Thread-3 (HornetQ-scheduled-threads-1425605108)) HQ222103: transaction with xid XidImpl (707709284 bq:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.0.-39.0.0.0.0.0.0.0.0 formatID:131077 gtxid:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.0.-40.49 base64:AAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAAA2QAAAAAAAAAAAAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAAA2DEHAgIA timed out
2017-02-28 14:44:23,833 INFO [stdout] (Thread-31 (HornetQ-client-global-threads-1770278514)) ProtoelServiceInterfaceImpl.compute() starts.......
2017-02-28 14:44:23,834 INFO [stdout] (Thread-31 (HornetQ-client-global-threads-1770278514)) :: reading ship types
2017-02-28 14:44:23,834 INFO [stdout] (Thread-31 (HornetQ-client-global-threads-1770278514)) :: getRegShipData
2017-02-28 14:49:24,787 WARN [org.hornetq.core.server] (Thread-2 (HornetQ-scheduled-threads-1425605108)) HQ222103: transaction with xid XidImpl (2136086120 bq:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.1.2.0.0.0.0.0.0.0.0 formatID:131077 gtxid:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.1.1.49 base64:AAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAABAgAAAAAAAAAAAAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAABATEHAgIA timed out
2017-02-28 14:49:25,084 INFO [stdout] (Thread-35 (HornetQ-client-global-threads-1770278514)) ProtoelServiceInterfaceImpl.compute() starts.......
2017-02-28 14:49:25,085 INFO [stdout] (Thread-35 (HornetQ-client-global-threads-1770278514)) :: reading ship types
2017-02-28 14:49:25,085 INFO [stdout] (Thread-35 (HornetQ-client-global-threads-1770278514)) :: getRegShipData
2017-02-28 14:54:25,787 WARN [org.hornetq.core.server] (Thread-1 (HornetQ-scheduled-threads-1425605108)) HQ222103: transaction with xid XidImpl (1297930617 bq:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.1.31.0.0.0.0.0.0.0.0 formatID:131077 gtxid:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.1.30.49 base64:AAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAABHwAAAAAAAAAAAAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAABHjEHAgIA timed out
2017-02-28 14:54:25,825 INFO [stdout] (Thread-39 (HornetQ-client-global-threads-1770278514)) ProtoelServiceInterfaceImpl.compute() starts.......
2017-02-28 14:54:25,826 INFO [stdout] (Thread-39 (HornetQ-client-global-threads-1770278514)) :: reading ship types
2017-02-28 14:54:25,826 INFO [stdout] (Thread-39 (HornetQ-client-global-threads-1770278514)) :: getRegShipData
2017-02-28 14:59:26,787 WARN [org.hornetq.core.server] (Thread-0 (HornetQ-scheduled-threads-1425605108)) HQ222103: transaction with xid XidImpl (424579161 bq:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.1.60.0.0.0.0.0.0.0.0 formatID:131077 gtxid:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.1.59.49 base64:AAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAABPAAAAAAAAAAAAAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAABOzEHAgIA timed out
2017-02-28 14:59:27,307 INFO [stdout] (Thread-43 (HornetQ-client-global-threads-1770278514)) ProtoelServiceInterfaceImpl.compute() starts.......
2017-02-28 14:59:27,308 INFO [stdout] (Thread-43 (HornetQ-client-global-threads-1770278514)) :: reading ship types
2017-02-28 14:59:27,308 INFO [stdout] (Thread-43 (HornetQ-client-global-threads-1770278514)) :: getRegShipData
2017-02-28 14:59:35,380 INFO [class backend.facade.impl.ProtoelServiceInterfaceImpl] (Thread-3 (HornetQ-client-global-threads-1770278514)) Input data inserted in the database for trajectory id:: 500c359b-91f5-450b-971c-41f564d8c5a1
2017-02-28 15:00:18,548 INFO [class backend.facade.impl.ProtoelServiceInterfaceImpl] (Thread-7 (HornetQ-client-global-threads-1770278514)) Input data inserted in the database for trajectory id:: 9d19104a-eaff-48ff-85f9-0d9b6aa526b9
2017-02-28 15:00:27,990 INFO [class backend.facade.impl.ProtoelServiceInterfaceImpl] (Thread-15 (HornetQ-client-global-threads-1770278514)) Input data inserted in the database for trajectory id:: fbcc487e-9666-4f8e-8ba7-f530de778078
2017-02-28 15:00:39,468 INFO [class backend.facade.impl.ProtoelServiceInterfaceImpl] (Thread-11 (HornetQ-client-global-threads-1770278514)) Input data inserted in the database for trajectory id:: edc19f3f-ed9c-4a55-aa4f-b2835a2d79e3
2017-02-28 15:00:40,089 INFO [class backend.facade.impl.ProtoelServiceInterfaceImpl] (Thread-23 (HornetQ-client-global-threads-1770278514)) Input data inserted in the database for trajectory id:: a86e6269-36ec-46e5-833f-1a53fad6d9ce
2017-02-28 15:01:31,753 INFO [class backend.facade.impl.ProtoelServiceInterfaceImpl] (Thread-19 (HornetQ-client-global-threads-1770278514)) Input data inserted in the database for trajectory id:: a1096aa3-ed0d-47a8-a312-1a1dc9029642
2017-02-28 15:04:27,787 WARN [org.hornetq.core.server] (Thread-1 (HornetQ-scheduled-threads-1425605108)) HQ222103: transaction with xid XidImpl (573592252 bq:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.1.99.0.0.0.0.0.0.0.0 formatID:131077 gtxid:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.1.98.49 base64:AAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAABYwAAAAAAAAAAAAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAABYjEHAgIA timed out
2017-02-28 15:04:28,004 INFO [stdout] (pool-11-thread-1) :: Fetching current data
2017-02-28 15:04:28,004 INFO [stdout] (pool-11-thread-2) :: Fetching tide data
2017-02-28 15:04:28,011 INFO [stdout] (pool-11-thread-3) :: Fetching wave data
2017-02-28 15:04:28,034 INFO [stdout] (Thread-46 (HornetQ-client-global-threads-1770278514)) ProtoelServiceInterfaceImpl.compute() starts.......
2017-02-28 15:04:28,035 INFO [stdout] (Thread-46 (HornetQ-client-global-threads-1770278514)) :: reading ship types
2017-02-28 15:04:28,035 INFO [stdout] (Thread-46 (HornetQ-client-global-threads-1770278514)) :: getRegShipData
2017-02-28 15:05:24,090 INFO [stdout] (pool-12-thread-1) :: Fetching current data
2017-02-28 15:05:24,090 INFO [stdout] (pool-12-thread-3) :: Fetching wave data
2017-02-28 15:05:24,090 INFO [stdout] (pool-12-thread-2) :: Fetching tide data
2017-02-28 15:05:35,142 INFO [class backend.facade.impl.ProtoelServiceInterfaceImpl] (Thread-27 (HornetQ-client-global-threads-1770278514)) Input data inserted in the database for trajectory id:: 72cf06a6-e640-4ebc-ab85-6677567e84a7
2017-02-28 15:06:39,725 INFO [stdout] (pool-13-thread-2) :: Fetching tide data
2017-02-28 15:06:39,726 INFO [stdout] (pool-13-thread-3) :: Fetching wave data
2017-02-28 15:06:39,726 INFO [stdout] (pool-13-thread-1) :: Fetching current data
2017-02-28 15:06:40,493 INFO [stdout] (pool-14-thread-2) :: Fetching tide data
2017-02-28 15:06:40,493 INFO [stdout] (pool-14-thread-3) :: Fetching wave data
2017-02-28 15:06:40,493 INFO [stdout] (pool-14-thread-1) :: Fetching current data
2017-02-28 15:06:40,503 INFO [stdout] (pool-15-thread-1) :: Fetching current data
2017-02-28 15:06:40,504 INFO [stdout] (pool-15-thread-2) :: Fetching tide data
2017-02-28 15:06:40,504 INFO [stdout] (pool-15-thread-3) :: Fetching wave data
2017-02-28 15:07:11,042 INFO [stdout] (pool-16-thread-1) :: Fetching current data
2017-02-28 15:07:11,043 INFO [stdout] (pool-16-thread-2) :: Fetching tide data
2017-02-28 15:07:11,044 INFO [stdout] (pool-16-thread-3) :: Fetching wave data
2017-02-28 15:09:28,787 WARN [org.hornetq.core.server] (Thread-2 (HornetQ-scheduled-threads-1425605108)) HQ222103: transaction with xid XidImpl (1327469881 bq:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.1.-126.0.0.0.0.0.0.0.0 formatID:131077 gtxid:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.1.-127.49 base64:AAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAABggAAAAAAAAAAAAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAABgTEHAgIA timed out
2017-02-28 15:09:46,094 INFO [stdout] (Thread-51 (HornetQ-client-global-threads-1770278514)) ProtoelServiceInterfaceImpl.compute() starts.......
2017-02-28 15:09:46,094 INFO [stdout] (Thread-51 (HornetQ-client-global-threads-1770278514)) :: reading ship types
2017-02-28 15:09:46,095 INFO [stdout] (Thread-51 (HornetQ-client-global-threads-1770278514)) :: getRegShipData
2017-02-28 15:14:29,319 WARN [org.hornetq.core.server] (Thread-1 (HornetQ-scheduled-threads-1425605108)) HQ222103: transaction with xid XidImpl (1246098884 bq:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.1.-97.0.0.0.0.0.0.0.0 formatID:131077 gtxid:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.1.-98.49 base64:AAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAABnwAAAAAAAAAAAAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAABnjEHAgIA timed out
2017-02-28 15:19:39,872 WARN [org.hornetq.core.server] (Thread-2 (HornetQ-scheduled-threads-1425605108)) HQ222103: transaction with xid XidImpl (2082119964 bq:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.1.-58.0.0.0.0.0.0.0.0 formatID:131077 gtxid:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.1.-59.49 base64:AAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAABxgAAAAAAAAAAAAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAABxTEHAgIA timed out
2017-02-28 15:34:53,282 WARN [org.hornetq.core.server] (Thread-4 (HornetQ-scheduled-threads-1425605108)) HQ222103: transaction with xid XidImpl (720521062 bq:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.1.-47.0.0.0.0.0.0.0.0 formatID:131077 gtxid:0.0.0.0.0.0.0.0.0.0.-1.-1.10.-127.36.-126.68.-3.-5.-62.88.-75.118.5.0.0.1.-48.49 base64:AAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAAB0QAAAAAAAAAAAAAAAAAAAAAAAP__CoEkgkT9-8JYtXYFAAAB0DEHAgIA timed out
2017-02-28 15:32:54,758 ERROR [org.hornetq.core.client] (Thread-11 (HornetQ-server-HornetQServerImpl::serverUUID=a925356e-8f58-11e5-8093-09b87cae4629-939045562)) HQ214017: Caught unexpected Throwable: java.lang.OutOfMemoryError: Java heap space
at io.netty.buffer.UnpooledHeapByteBuf.copy(UnpooledHeapByteBuf.java:427)
at io.netty.buffer.WrappedByteBuf.copy(WrappedByteBuf.java:697)
at org.hornetq.core.buffers.impl.ChannelBufferWrapper.copy(ChannelBufferWrapper.java:238)
at org.hornetq.core.remoting.impl.invm.InVMConnection.write(InVMConnection.java:147)
at org.hornetq.core.protocol.core.impl.ChannelImpl.send(ChannelImpl.java:278)
at org.hornetq.core.protocol.core.impl.ChannelImpl.send(ChannelImpl.java:205)
at org.hornetq.core.protocol.core.impl.CoreSessionCallback.sendLargeMessageContinuation(CoreSessionCallback.java:65)
at org.hornetq.core.server.impl.ServerConsumerImpl$LargeMessageDeliverer.deliver(ServerConsumerImpl.java:1120)
at org.hornetq.core.server.impl.ServerConsumerImpl$2.run(ServerConsumerImpl.java:997)
at org.hornetq.utils.OrderedExecutorFactory$OrderedExecutor$1.run(OrderedExecutorFactory.java:104)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
2017-02-28 15:47:17,769 WARN [org.hibernate.engine.jdbc.spi.SqlExceptionHelper] (pool-10-thread-1) SQL Error: 0, SQLState: 08001
2017-02-28 15:49:49,029 ERROR [org.hibernate.engine.jdbc.spi.SqlExceptionHelper] (pool-10-thread-1) The connection attempt failed.
2017-02-28 15:50:30,430 WARN [org.hibernate.engine.jdbc.spi.SqlExceptionHelper] (pool-11-thread-2) SQL Error: 0, SQLState: 08006
2017-02-28 15:51:25,086 WARN [org.hibernate.engine.jdbc.spi.SqlExceptionHelper] (pool-11-thread-1) SQL Error: 0, SQLState: 08006
2017-02-28 15:51:13,446 WARN [org.hibernate.engine.jdbc.spi.SqlExceptionHelper] (pool-15-thread-3) SQL Error: 0, SQLState: 08006
2017-02-28 15:51:47,088 WARN [org.hibernate.engine.jdbc.spi.SqlExceptionHelper] (pool-16-thread-2) SQL Error: 0, SQLState: 08006
2017-02-28 15:55:05,484 WARN [org.hibernate.engine.jdbc.spi.SqlExceptionHelper] (pool-15-thread-1) SQL Error: 0, SQLState: 08006
2017-02-28 15:57:30,546 ERROR [org.hibernate.engine.jdbc.spi.SqlExceptionHelper] (pool-16-thread-2) An I/O error occurred while sending to the backend.
2017-02-28 15:57:30,546 ERROR [org.hibernate.engine.jdbc.spi.SqlExceptionHelper] (pool-15-thread-1) An I/O error occurred while sending to the backend.
2017-02-28 15:57:30,547 WARN [org.hibernate.engine.jdbc.spi.SqlExceptionHelper] (pool-16-thread-3) SQL Error: 0, SQLState: 08006
2017-02-28 15:57:30,547 ERROR [org.hibernate.engine.jdbc.spi.SqlExceptionHelper] (pool-16-thread-3) An I/O error occurred while sending to the backend.
2017-02-28 15:57:30,548 WARN [org.hibernate.engine.jdbc.spi.SqlExceptionHelper] (pool-16-thread-1) SQL Error: 0, SQLState: 08006
2017-02-28 15:57:30,548 ERROR [stderr] (Periodic Recovery) Exception in thread "Periodic Recovery" java.lang.OutOfMemoryError: Java heap space
2017-02-28 15:57:30,549 ERROR [org.hibernate.engine.jdbc.spi.SqlExceptionHelper] (pool-16-thread-1) An I/O error occurred while sending to the backend.
2017-02-28 15:57:30,550 ERROR [stderr] (Periodic Recovery) at com.arjuna.ats.arjuna.state.InputObjectState.<init>(InputObjectState.java:59)
2017-02-28 15:57:30,551 ERROR [stderr] (Periodic Recovery) at com.arjuna.ats.arjuna.objectstore.ObjectStoreIterator.<init>(ObjectStoreIterator.java:81)
2017-02-28 15:57:30,551 ERROR [stderr] (Periodic Recovery) at com.arjuna.ats.internal.jta.recovery.arjunacore.CommitMarkableResourceRecordRecoveryModule.periodicWorkFirstPass(CommitMarkableResourceRecordRecoveryModule.java:390)
2017-02-28 15:57:30,551 ERROR [stderr] (Periodic Recovery) at com.arjuna.ats.internal.arjuna.recovery.PeriodicRecovery.doWorkInternal(PeriodicRecovery.java:747)
2017-02-28 15:57:30,551 ERROR [stderr] (Periodic Recovery) at com.arjuna.ats.internal.arjuna.recovery.PeriodicRecovery.run(PeriodicRecovery.java:375)
2017-02-28 15:55:48,667 ERROR [org.jboss.as.controller.management-operation] (ServerService Thread Pool -- 1) WFLYCTL0013: Operation ("clean-obsolete-content") failed - address: ([]): java.lang.OutOfMemoryError: Java heap space
at java.nio.charset.CharsetEncoder.<init>(CharsetEncoder.java:233)
at sun.nio.cs.UTF_8$Encoder.<init>(UTF_8.java:558)
at sun.nio.cs.UTF_8$Encoder.<init>(UTF_8.java:554)
at sun.nio.cs.UTF_8.newEncoder(UTF_8.java:72)
at java.lang.StringCoding$StringEncoder.<init>(StringCoding.java:282)
at java.lang.StringCoding$StringEncoder.<init>(StringCoding.java:273)
at java.lang.StringCoding.encode(StringCoding.java:338)
at java.lang.String.getBytes(String.java:906)
at java.io.UnixFileSystem.list(Native Method)
at java.io.File.list(File.java:1122)
at java.io.File.listFiles(File.java:1207)
at org.jboss.as.repository.ContentRepository$Factory$ContentRepositoryImpl.listLocalContents(ContentRepository.java:427)
at org.jboss.as.repository.ContentRepository$Factory$ContentRepositoryImpl.cleanObsoleteContent(ContentRepository.java:390)
at org.jboss.as.server.operations.CleanObsoleteContentHandler.execute(CleanObsoleteContentHandler.java:76)
at org.jboss.as.controller.AbstractOperationContext.executeStep(AbstractOperationContext.java:803)
at org.jboss.as.controller.AbstractOperationContext.doCompleteStep(AbstractOperationContext.java:601)
at org.jboss.as.controller.AbstractOperationContext.completeStepInternal(AbstractOperationContext.java:354)
at org.jboss.as.controller.AbstractOperationContext.executeOperation(AbstractOperationContext.java:330)
at org.jboss.as.controller.OperationContextImpl.executeOperation(OperationContextImpl.java:1183)
at org.jboss.as.controller.ModelControllerImpl.internalExecute(ModelControllerImpl.java:362)
at org.jboss.as.controller.ModelControllerImpl.execute(ModelControllerImpl.java:205)
at org.jboss.as.controller.ModelControllerImpl$3.execute(ModelControllerImpl.java:626)
at org.jboss.as.controller.ModelControllerImpl$3.execute(ModelControllerImpl.java:616)
at org.jboss.as.server.deployment.ContentRepositoryCleaner.cleanObsoleteContent(ContentRepositoryCleaner.java:132)
at org.jboss.as.server.deployment.ContentRepositoryCleaner$ContentRepositoryCleanerTask.run(ContentRepositoryCleaner.java:67)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
2017-02-28 15:57:30,550 WARN [org.hibernate.engine.jdbc.spi.SqlExceptionHelper] (pool-13-thread-2) SQL Error: 0, SQLState: 08006
2017-02-28 15:57:30,551 ERROR [stderr] (Thread-23 (HornetQ-client-global-threads-1770278514)) java.util.concurrent.ExecutionException: org.hibernate.TransactionException: rollback failed
2017-02-28 15:57:30,552 ERROR [org.hibernate.engine.jdbc.spi.SqlExceptionHelper] (pool-13-thread-2) An I/O error occurred while sending to the backend.
2017-02-28 15:51:49,707 ERROR [org.hibernate.engine.jdbc.spi.SqlExceptionHelper] (pool-11-thread-1) An I/O error occurred while sending to the backend.
2017-02-28 15:57:30,552 ERROR [stderr] (Thread-23 (HornetQ-client-global-threads-1770278514)) at java.util.concurrent.FutureTask.report(FutureTask.java:122)
2017-02-28 15:57:30,552 ERROR [stderr] (Thread-23 (HornetQ-client-global-threads-1770278514)) at java.util.concurrent.FutureTask.get(FutureTask.java:192)
2017-02-28 15:55:20,919 WARN [org.hibernate.engine.jdbc.spi.SqlExceptionHelper] (pool-13-thread-3) SQL Error: 0, SQLState: 08006
2017-02-28 15:57:30,552 ERROR [stderr] (Thread-23 (HornetQ-client-global-threads-1770278514)) at backend.core.Computation.prepareComputation(Computation.java:276)
2017-02-28 15:57:30,553 ERROR [org.hibernate.engine.jdbc.spi.SqlExceptionHelper] (pool-13-thread-3) An I/O error occurred while sending to the backend.
2017-02-28 15:57:30,553 ERROR [org.jboss.as.server] (ServerService Thread Pool -- 1) WFLYSRV0216: Error cleaning obsolete content WFLYCTL0158: Operation handler failed: java.lang.OutOfMemoryError: Java heap space
2017-02-28 15:57:30,553 ERROR [stderr] (Thread-23 (HornetQ-client-global-threads-1770278514)) at backend.core.Computation.<init>(Computation.java:108)
2017-02-28 15:56:01,671 WARN [org.hornetq.core.server] (hornetq-failure-check-thread) HQ222082: error on connection failure check: java.lang.OutOfMemoryError: Java heap space
-
5. Re: Wildfly 9.0 server log shows transaction timed out
jbertram Mar 2, 2017 9:55 AM (in response to ajitkumar2807)Did you produce this after you disabled transactions on your MDB as I recommended in my previous comment?
-
6. Re: Wildfly 9.0 server log shows transaction timed out
ajitkumar2807 Mar 3, 2017 2:31 AM (in response to jbertram)No. Its was earlier when I had the issues. I have updated my MDB class by adding @ TransactionAttribute...like below: Is it fine:
@TransactionAttribute(value = javax.ejb.TransactionAttributeType.NOT_SUPPORTED)
@MessageDriven(name = "ProtoelQueueMDB", activationConfig = {
@ActivationConfigProperty(propertyName = "destinationLookup", propertyValue = "queue/MDBQueueRequest"),
@ActivationConfigProperty(propertyName = "destinationType", propertyValue = "javax.jms.Queue"),
@ActivationConfigProperty(propertyName = "acknowledgeMode", propertyValue = "Auto-acknowledge") })
public class ProtoelQueueMDB implements MessageListener {
private final static Logger LOGGER = Logger.getLogger(ProtoelQueueMDB.class.toString());
/**
* This method is the listener message which listens on the queue and will be invoked when the message arrives on the queue.
*
* @see MessageListener#onMessage(Message)
*/
public void onMessage(Message rcvMessage) {
TextMessage msg = null;
try {
if (rcvMessage instanceof TextMessage) {
ProtoelEnvironment.setFilePathProvider(new DefaultFilePathProvider());
ProtoelEnvironment.setDefaultSystemTimezone(TimeZone.getDefault().getID());
TimeZone.setDefault(TimeZone.getTimeZone(ConstFX.UTC));
msg = (TextMessage) rcvMessage;
ProtoelServiceInterface protoelService = new ProtoelServiceInterfaceImpl();
ProtoelEnvironment.setRunMode(ProtoelEnvironment.RunMode.SERVER);
Query query = protoelService.parseRequest(msg.getText());
sendReply(query.getRemoteResponse());
deleteOutputFiles(query);
} else {
LOGGER.warning("Message of wrong type: " + rcvMessage.getClass().getName());
String response = "Error: Wrong message type";
sendReply(response.getBytes());
}
} catch (Exception | OutOfMemoryError e) {
e.printStackTrace();
LOGGER.info("Error: " + e.getMessage());
String response = "Exception: While processing request from client " + e.getMessage();
try {
sendReply(response.getBytes());
} catch (Exception e1) {
// TODO Auto-generated catch block
e1.printStackTrace();
}
}
}
-
7. Re: Wildfly 9.0 server log shows transaction timed out
jbertram Mar 3, 2017 9:15 AM (in response to ajitkumar2807)1 of 1 people found this helpfulNow that transactions for your MDB are disabled are you still seeing the same issues as before?