Hi Matt,
I have now switched from Linux to Windows Server 2003, fresh
downloaded db2express installation and setup openanzo like described
in the wiki.
The server starts fine and works fine until an arbitrary point in time
(in my case after 3 client starts incl. updateRepositories).
When I started the openanzo client the third time, added some
statements and called the anzoClient.updateRepository method, the
client waits and waits and waits. Here is the stack trace of the
waiting thread when I suspend it in Eclipse
#################################
Following exception on the client side:
#################################
Thread [main] (Suspended)
Unsafe.park(boolean, long) line: not available [native method]
LockSupport.park(Object) line: not available
AbstractQueuedSynchronizer$ConditionObject.await() line: not
available
JMSConnectionBackend.requestResponse(IOperationContext, String,
Message, long) line: 714
JMSUpdateServiceProxy.update(IOperationContext, boolean, String,
String, Writer, String) line: 155
JMSUpdateServiceProxy.update(IOperationContext, boolean, IUpdates)
line: 126
Replicator.update() line: 140
AnzoClient.updateRepository() line: 635
...
-----------------------------------------------------------------
and here are the stacks of the other threads
----------------------------------------------------------------
org.eclipse.equinox.launcher.Main at localhost:1747 (Suspended)
Daemon System Thread [Attach Listener] (Suspended)
Daemon System Thread [Signal Dispatcher] (Suspended)
Daemon System Thread [Finalizer] (Suspended)
Object.wait(long) line: not available [native method]
ReferenceQueue<T>.remove(long) line: not available
ReferenceQueue<T>.remove() line: not available
Finalizer$FinalizerThread.run() line: not available
Daemon System Thread [Reference Handler] (Suspended)
Object.wait(long) line: not available [native method]
Reference$Lock(Object).wait() line: 485
Reference$ReferenceHandler.run() line: not available
Thread [main] (Suspended)
Unsafe.park(boolean, long) line: not available [native method]
LockSupport.park(Object) line: not available
AbstractQueuedSynchronizer$ConditionObject.await() line: not
available
JMSConnectionBackend.requestResponse(IOperationContext, String,
Message, long) line: 714
JMSUpdateServiceProxy.update(IOperationContext, boolean, String,
String, Writer, String) line: 155
JMSUpdateServiceProxy.update(IOperationContext, boolean, IUpdates)
line: 126
Replicator.update() line: 140
AnzoClient.updateRepository() line: 635
... (not shown)
Daemon Thread [State Data Manager] (Suspended)
Thread.sleep(long) line: not available [native method]
StateManager.run() line: 297
Thread.run() line: not available
Daemon Thread [Framework Event Dispatcher] (Suspended)
Object.wait(long) line: not available [native method]
EventManager$EventThread(Object).wait() line: 485
EventManager$EventThread.getNextEvent() line: 355
EventManager$EventThread.run() line: 293
Daemon Thread [Start Level Event Dispatcher] (Suspended)
Object.wait(long) line: not available [native method]
EventManager$EventThread(Object).wait() line: 485
EventManager$EventThread.getNextEvent() line: 355
EventManager$EventThread.run() line: 293
Thread [ActiveMQ Transport: tcp:///
192.168.111.48:61616] (Suspended)
SocketInputStream.socketRead0(FileDescriptor, byte[], int, int, int)
line: not available [native method]
SocketInputStream.read(byte[], int, int) line: not available
TcpBufferedInputStream.fill() line: 50
TcpBufferedInputStream.read() line: 58
DataInputStream.readInt() line: not available
OpenWireFormat.unmarshal(DataInput) line: 269
TcpTransport.readCommand() line: 203
TcpTransport.doRun() line: 195
TcpTransport.run() line: 183
Thread.run() line: not available
Daemon Thread [InactivityMonitor WriteCheck] (Suspended)
Object.wait(long) line: not available [native method]
TimerThread.mainLoop() line: not available
TimerThread.run() line: not available
Daemon Thread [InactivityMonitor ReadCheck] (Suspended)
Object.wait(long) line: not available [native method]
TimerThread.mainLoop() line: not available
TimerThread.run() line: not available
Daemon Thread [MessageExecutor] (Suspended)
Unsafe.park(boolean, long) line: not available [native method]
LockSupport.park(Object) line: not available
AbstractQueuedSynchronizer$ConditionObject.await() line: not
available
JMSConnectionBackend$2.run() line: 490
Daemon Thread [NamedGraphUpdateMessageProcessor] (Suspended)
Unsafe.park(boolean, long) line: not available [native method]
LockSupport.parkNanos(Object, long) line: not available
AbstractQueuedSynchronizer$ConditionObject.await(long, TimeUnit)
line: not available
NamedGraphUpdateManager$NamedGraphUpdateMessageProcessor.run() line:
186
#################################
Following exception on the server side:
#################################
2008-09-05 12:19:15,663 0 [ WARN] [main] [OpName=] [OpId=]
[OpUser=] [RunAs=]
org.openanzo.servicecontainer.BaseContainerComponent -
http://openanzo.org/serviceContainer/component/AnzoClientComponent
missing optional dependency interface
org.openanzo.servicecontainer.services.IExecutionService
2008-09-05 12:19:17,117 1454 [ WARN] [main] [OpName=] [OpId=]
[OpUser=] [RunAs=]
org.openanzo.server.repository.rdb.services.NodeCentricResetService -
Initializing database from files: [resource:/org/openanzo/model/
initialize.trig]
2008-09-05 12:19:21,061 5398 [ WARN] [main] [OpName=] [OpId=]
[OpUser=] [RunAs=] org.openanzo.util.LogUtils - Anzo Common -
Assembly Manifest Details:
2008-09-05 12:19:21,061 5398 [ WARN] [main] [OpName=] [OpId=]
[OpUser=] [RunAs=] org.openanzo.util.LogUtils - Created-By: Apache
Maven
2008-09-05 12:19:21,061 5398 [ WARN] [main] [OpName=] [OpId=]
[OpUser=] [RunAs=] org.openanzo.util.LogUtils - Build-Jdk: 1.6.0
2008-09-05 12:19:21,062 5399 [ WARN] [main] [OpName=] [OpId=]
[OpUser=] [RunAs=] org.openanzo.util.LogUtils - Built-By: cruise
2008-09-05 12:19:21,062 5399 [ WARN] [main] [OpName=] [OpId=]
[OpUser=] [RunAs=] org.openanzo.util.LogUtils - Implementation-
Version: 3.0-SNAPSHOT
2008-09-05 12:19:21,062 5399 [ WARN] [main] [OpName=] [OpId=]
[OpUser=] [RunAs=] org.openanzo.util.LogUtils - Implementation-
Build: r3068
2008-09-09 13:42:42,640 0 [ WARN] [main] [OpName=] [OpId=]
[OpUser=] [RunAs=] org.openanzo.server.security.SecretKeyEncoderImpl
- Could not find keystore at 'C:\tmp\anzo\keystore'. Creating a new
keystore at that location.
2008-09-09 13:42:42,734 94 [ WARN] [main] [OpName=] [OpId=]
[OpUser=] [RunAs=] org.openanzo.server.security.SecretKeyEncoderImpl
- Could not find key 'service-container-key' within keystore.
Generating a new key.
2008-09-09 13:42:42,953 313 [ WARN] [main] [OpName=] [OpId=]
[OpUser=] [RunAs=] org.openanzo.server.security.SecretKeyEncoderImpl
- Storing new key in the keystore.
2008-09-09 13:42:43,093 453 [ WARN] [main] [OpName=] [OpId=]
[OpUser=] [RunAs=]
org.openanzo.servicecontainer.BaseContainerComponent -
http://openanzo.org/serviceContainer/component/AnzoClientComponent
missing optional dependency interface
org.openanzo.servicecontainer.services.IExecutionService
2008-09-09 13:42:43,109 469 [ WARN] [main] [OpName=] [OpId=]
[OpUser=] [RunAs=] org.openanzo.indexer.lucene.LuceneIndexerBase -
Creating new index at location:/tmp/anzo/index-literals.lucene
2008-09-09 13:42:47,718 5078 [ WARN] [main] [OpName=] [OpId=]
[OpUser=] [RunAs=]
org.openanzo.server.repository.rdb.services.NodeCentricResetService -
Initializing database from files: [resource:/org/openanzo/model/
initialize.trig]
2008-09-09 13:42:50,906 8266 [ WARN] [main] [OpName=] [OpId=]
[OpUser=] [RunAs=] org.openanzo.util.LogUtils - Anzo Common -
Assembly Manifest Details:
2008-09-09 13:42:50,906 8266 [ WARN] [main] [OpName=] [OpId=]
[OpUser=] [RunAs=] org.openanzo.util.LogUtils - Created-By: Apache
Maven
2008-09-09 13:42:50,906 8266 [ WARN] [main] [OpName=] [OpId=]
[OpUser=] [RunAs=] org.openanzo.util.LogUtils - Build-Jdk: 1.6.0
2008-09-09 13:42:50,906 8266 [ WARN] [main] [OpName=] [OpId=]
[OpUser=] [RunAs=] org.openanzo.util.LogUtils - Built-By: cruise
2008-09-09 13:42:50,906 8266 [ WARN] [main] [OpName=] [OpId=]
[OpUser=] [RunAs=] org.openanzo.util.LogUtils - Implementation-
Version: 3.0-SNAPSHOT
2008-09-09 13:42:50,906 8266 [ WARN] [main] [OpName=] [OpId=]
[OpUser=] [RunAs=] org.openanzo.util.LogUtils - Implementation-
Build: r3068
2008-09-09 13:49:52,625 429985 [ERROR] [
http://openanzo.org/
service/CombusUpdateServiceListener] [OpName=update]
[OpId=3af44c71-01bd-4847-99f8-fdee186f5470] [OpUser=ldap://
uid=arath,ou=users,dc=openanzo,dc=org] [RunAs=]
org.openanzo.server.repository.update.ServerUpdatesProcessor - Error
Processing Update:
org.openanzo.jdbc.utils.RdbException: ErrorCode[256:262181]
[RDB_ERROR] Failed to execute an sql operation:
[abortTransactionAddStatements] SQL:[DELETE FROM STATEMENTS S WHERE
COMMITTED=?] Params:[transactionId=1152921504606848094] Templates:[]
Root Cause: com.ibm.db2.jcc.b.SqlException DB2 SQL Error:
SQLCODE=-805, SQLSTATE=51002, SQLERRMC=NULLID.SYSLH103
0X5359534C564C3031, DRIVER=3.50.152
at
org.openanzo.server.repository.rdb.sql.InsertStatementsRdbWrapper.abortTransactionAddStatements(InsertStatementsRdbWrapper.java:
2019)
at
org.openanzo.server.repository.rdb.services.NodeCentricServerQuadStore.abort(NodeCentricServerQuadStore.java:
296)
at
org.openanzo.server.repository.rdb.services.DispatchingDeltaQuadStore.abort(DispatchingDeltaQuadStore.java:
97)
at
org.openanzo.server.repository.update.ServerUpdatesProcessor.handleTransactionEnd(ServerUpdatesProcessor.java:
456)
at
org.openanzo.server.repository.update.ServerUpdatesProcessor.handleTransaction(ServerUpdatesProcessor.java:
309)
at org.openanzo.server.repository.update.ServerUpdatesProcessor
$1.handleTransaction(ServerUpdatesProcessor.java:250)
at
org.openanzo.serialization.XMLUpdatesReader.parseUpdateTransactions(XMLUpdatesReader.java:
151)
at
org.openanzo.serialization.XMLUpdatesReader.read(XMLUpdatesReader.java:
83)
at
org.openanzo.server.repository.update.ServerUpdatesProcessor.read(ServerUpdatesProcessor.java:
245)
at
org.openanzo.server.repository.update.ServerUpdatesProcessor.update(ServerUpdatesProcessor.java:
200)
at
org.openanzo.server.repository.rdb.services.NodeCentricUpdateService.updateInternal(NodeCentricUpdateService.java:
118)
at
org.openanzo.server.services.impl.BaseUpdateService.update(BaseUpdateService.java:
118)
at
org.openanzo.server.endpoint.combus.CombusUpdateServiceListener.handleMessage(CombusUpdateServiceListener.java:
132)
at org.openanzo.server.endpoint.combus.BaseServiceListener
$ProcessThread.run(BaseServiceListener.java:281)
Caused by: com.ibm.db2.jcc.b.SqlException: DB2 SQL Error:
SQLCODE=-805, SQLSTATE=51002, SQLERRMC=NULLID.SYSLH103
0X5359534C564C3031, DRIVER=3.50.152
at com.ibm.db2.jcc.b.wc.a(wc.java:55)
at com.ibm.db2.jcc.b.wc.a(wc.java:126)
at com.ibm.db2.jcc.b.tk.c(tk.java:1901)
at com.ibm.db2.jcc.t4.db.o(db.java:767)
at com.ibm.db2.jcc.t4.db.g(db.java:141)
at com.ibm.db2.jcc.t4.db.a(db.java:38)
at com.ibm.db2.jcc.t4.t.a(t.java:32)
at com.ibm.db2.jcc.t4.sb.h(sb.java:141)
at com.ibm.db2.jcc.b.tk.N(tk.java:1387)
at com.ibm.db2.jcc.b.uk.Kb(uk.java:2461)
at com.ibm.db2.jcc.b.uk.e(uk.java:3101)
at com.ibm.db2.jcc.b.uk.zb(uk.java:568)
at com.ibm.db2.jcc.b.uk.executeUpdate(uk.java:551)
at
org.apache.commons.dbcp.DelegatingPreparedStatement.executeUpdate(DelegatingPreparedStatement.java:
101)
at
org.apache.commons.dbcp.DelegatingPreparedStatement.executeUpdate(DelegatingPreparedStatement.java:
101)
at
org.openanzo.server.repository.rdb.sql.InsertStatementsRdbWrapper.abortTransactionAddStatements(InsertStatementsRdbWrapper.java:
2014)
... 13 more
2008-09-09 13:49:52,640 430000 [ERROR] [
http://openanzo.org/
service/CombusUpdateServiceListener] [OpName=update]
[OpId=3af44c71-01bd-4847-99f8-fdee186f5470] [OpUser=ldap://
uid=arath,ou=users,dc=openanzo,dc=org] [RunAs=]
org.openanzo.server.repository.update.ServerUpdatesProcessor - Error
Processing Update:
org.openanzo.common.exceptions.AnzoException: ErrorCode[320:262157]
[DATASOURCE_ERROR] [RDB_ERROR] JDBC connection already in a
transaction.
at
org.openanzo.server.repository.rdb.services.NodeCentricBackend.begin(NodeCentricBackend.java:
705)
at
org.openanzo.server.repository.rdb.services.DispatchingDeltaQuadStore.unlockNamedGraphs(DispatchingDeltaQuadStore.java:
236)
at
org.openanzo.server.repository.update.ServerUpdatesProcessor.abort(ServerUpdatesProcessor.java:
274)
at
org.openanzo.server.repository.update.ServerUpdatesProcessor.handleTransaction(ServerUpdatesProcessor.java:
321)
at org.openanzo.server.repository.update.ServerUpdatesProcessor
$1.handleTransaction(ServerUpdatesProcessor.java:250)
at
org.openanzo.serialization.XMLUpdatesReader.parseUpdateTransactions(XMLUpdatesReader.java:
151)
at
org.openanzo.serialization.XMLUpdatesReader.read(XMLUpdatesReader.java:
83)
at
org.openanzo.server.repository.update.ServerUpdatesProcessor.read(ServerUpdatesProcessor.java:
245)
at
org.openanzo.server.repository.update.ServerUpdatesProcessor.update(ServerUpdatesProcessor.java:
200)
at
org.openanzo.server.repository.rdb.services.NodeCentricUpdateService.updateInternal(NodeCentricUpdateService.java:
118)
at
org.openanzo.server.services.impl.BaseUpdateService.update(BaseUpdateService.java:
118)
at
org.openanzo.server.endpoint.combus.CombusUpdateServiceListener.handleMessage(CombusUpdateServiceListener.java:
132)
at org.openanzo.server.endpoint.combus.BaseServiceListener
$ProcessThread.run(BaseServiceListener.java:281)
2008-09-09 13:49:52,656 430016 [ERROR] [
http://openanzo.org/
service/CombusUpdateServiceListener] [OpName=update]
[OpId=3af44c71-01bd-4847-99f8-fdee186f5470] [OpUser=ldap://
uid=arath,ou=users,dc=openanzo,dc=org] [RunAs=]
org.openanzo.server.endpoint.combus.BaseServiceListener - Exception
while ServiceListener [
http://openanzo.org/serviceContainer/component/
CombusUpdateServiceListener] was precessing request.
org.openanzo.jdbc.utils.RdbException: ErrorCode[256:262181]
[RDB_ERROR] Failed to execute an sql operation:
[abortTransactionAddStatements] SQL:[DELETE FROM STATEMENTS S WHERE
COMMITTED=?] Params:[transactionId=1152921504606848094] Templates:[]
Root Cause: com.ibm.db2.jcc.b.SqlException DB2 SQL Error:
SQLCODE=-805, SQLSTATE=51002, SQLERRMC=NULLID.SYSLH103
0X5359534C564C3031, DRIVER=3.50.152
Caused by: com.ibm.db2.jcc.b.SqlException: DB2 SQL Error:
SQLCODE=-805, SQLSTATE=51002, SQLERRMC=NULLID.SYSLH103
0X5359534C564C3031, DRIVER=3.50.152
at com.ibm.db2.jcc.b.wc.a(wc.java:55)
at com.ibm.db2.jcc.b.wc.a(wc.java:126)
at com.ibm.db2.jcc.b.tk.c(tk.java:1901)
at com.ibm.db2.jcc.t4.db.o(db.java:767)
at com.ibm.db2.jcc.t4.db.g(db.java:141)
at com.ibm.db2.jcc.t4.db.a(db.java:38)
at com.ibm.db2.jcc.t4.t.a(t.java:32)
at com.ibm.db2.jcc.t4.sb.h(sb.java:141)
at com.ibm.db2.jcc.b.tk.N(tk.java:1387)
at com.ibm.db2.jcc.b.uk.Kb(uk.java:2461)
at com.ibm.db2.jcc.b.uk.e(uk.java:3101)
at com.ibm.db2.jcc.b.uk.zb(uk.java:568)
at com.ibm.db2.jcc.b.uk.executeUpdate(uk.java:551)
at
org.apache.commons.dbcp.DelegatingPreparedStatement.executeUpdate(DelegatingPreparedStatement.java:
101)
at
org.apache.commons.dbcp.DelegatingPreparedStatement.executeUpdate(DelegatingPreparedStatement.java:
101)
at
org.openanzo.server.repository.rdb.sql.InsertStatementsRdbWrapper.abortTransactionAddStatements(InsertStatementsRdbWrapper.java:
2014)
... 8 more
The interesting thing on the client side is that it will not stall
when I do a anzoClient.replicate();
I hope this report helps to identify the problem with the client=>
server communication and the updateRepository problem.
Thank you and kind regards,
Andreas