Discussion:
[jboss-user] [EJB3] - EAP 6.1: CMP EntityBeans locked in new Transaction
Daniel Straub
2013-07-24 21:54:55 UTC
Permalink
Daniel Straub [https://community.jboss.org/people/dastraub] created the discussion

"EAP 6.1: CMP EntityBeans locked in new Transaction"

To view the discussion, visit: https://community.jboss.org/message/829611#829611

--------------------------------------------------------------
A costumer of me tries to run a EJB2.1 application on EAP 6.1 (so I don't know all the issuse or reasons, why they don't migrate the application).
They have the following scenario:

- call a statefull sessionbeans method, accessing some cmp-entitybeans (tx-attribute requires-new))
- in this method call they access a new instance of this sfb (via InitialContex.lookup/create) and call a other method, for some reasons a new transaction is requiered  (tx-attribute requires-new)
- in this second method call they access the same cmp-entitybeans as in method 1, but the access is locked from the transaction of the previous method

Tthis scenario worked with JBoss 4.3, but not in EAP 6.1.

Here is the log + thread dump :




23:26:35,696 INFO  org.jboss.as org.jboss.as (Controller Boot Thread) JBAS015874: JBoss EAP 6.1.0.GA (AS 7.2.0.Final-redhat-8) started in 1900ms - Started 197 of 253 services (55 services are passive or on-demand)
...

23:27:30,337 INFO  batchlayer.BatchLayerBean batchlayer.BatchLayerBean (EJB default - 2)

================ doAll in TX 0:ffffc0a8010a:5a755c78:51f04697:e

23:27:30,376 DEBUG org.jboss.as.cmp.jdbc.JDBCJBossQLQuery.StElt#findAll org.jboss.as.cmp.jdbc.JDBCJBossQLQuery.StElt#findAll (EJB default - 2) Executing SQL: SELECT t0_p.elementtype, t0_p.element, t0_p.subelementtype, t0_p.subelement, t0_p.datetype, t0_p.validfrom, t0_p.validuntil, t0_p.range, t0_p.status, t0_p.rulekey, t0_p.info FROM ST_ELT t0_p
23:27:30,392 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#elementtype org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#elementtype (EJB default - 2) result: i=1, type=java.lang.String, value=M
23:27:30,392 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#element org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#element (EJB default - 2) result: i=2, type=java.lang.String, value=Merkmal1                     
23:27:30,392 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#subelementtype org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#subelementtype (EJB default - 2) result: i=3, type=java.lang.String, value=null
23:27:30,393 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#subelement org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#subelement (EJB default - 2) result: i=4, type=java.lang.String, value=null
23:27:30,393 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#datetype org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#datetype (EJB default - 2) result: i=5, type=java.lang.String, value=WIRKDAT  
23:27:30,393 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#validfrom org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#validfrom (EJB default - 2) result: i=6, type=java.sql.Timestamp, value=1970-01-01 01:00:00.0
23:27:30,394 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#validuntil org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#validuntil (EJB default - 2) result: i=7, type=java.sql.Timestamp, value=1970-01-01 01:00:00.0
23:27:30,396 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#range org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#range (EJB default - 2) result: i=8, type=java.lang.Integer, value=0
23:27:30,397 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Add preload data: entity=StElt pk=***@6cc4a8f0 field=range
23:27:30,398 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#status org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#status (EJB default - 2) result: i=9, type=java.lang.String, value=AKTIV    
23:27:30,398 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Add preload data: entity=StElt pk=***@6cc4a8f0 field=status
23:27:30,398 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#rulekey org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#rulekey (EJB default - 2) result: i=10, type=java.lang.Integer, value=100
23:27:30,398 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Add preload data: entity=StElt pk=***@6cc4a8f0 field=rulekey
23:27:30,398 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#info org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#info (EJB default - 2) result: i=11, type=java.lang.String, value=null
23:27:30,398 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Add preload data: entity=StElt pk=***@6cc4a8f0 field=info
23:27:30,399 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#elementtype org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#elementtype (EJB default - 2) result: i=1, type=java.lang.String, value=M
23:27:30,399 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#element org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#element (EJB default - 2) result: i=2, type=java.lang.String, value=Merkmal2                     
23:27:30,399 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#subelementtype org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#subelementtype (EJB default - 2) result: i=3, type=java.lang.String, value=null
23:27:30,399 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#subelement org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#subelement (EJB default - 2) result: i=4, type=java.lang.String, value=null
23:27:30,399 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#datetype org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#datetype (EJB default - 2) result: i=5, type=java.lang.String, value=WIRKDAT  
23:27:30,399 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#validfrom org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#validfrom (EJB default - 2) result: i=6, type=java.sql.Timestamp, value=1970-01-01 01:00:00.0
23:27:30,399 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#validuntil org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#validuntil (EJB default - 2) result: i=7, type=java.sql.Timestamp, value=1970-01-01 01:00:00.0
23:27:30,400 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#range org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#range (EJB default - 2) result: i=8, type=java.lang.Integer, value=0
23:27:30,400 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Add preload data: entity=StElt pk=***@6cc4a8f0 field=range
23:27:30,400 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Overriding cached value 0 with 0. pk=***@6cc4a8f0, field=range
23:27:30,400 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#status org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#status (EJB default - 2) result: i=9, type=java.lang.String, value=AKTIV    
23:27:30,400 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Add preload data: entity=StElt pk=***@6cc4a8f0 field=status
23:27:30,400 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Overriding cached value AKTIV      with AKTIV     . pk=***@6cc4a8f0, field=status
23:27:30,400 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#rulekey org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#rulekey (EJB default - 2) result: i=10, type=java.lang.Integer, value=101
23:27:30,401 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Add preload data: entity=StElt pk=***@6cc4a8f0 field=rulekey
23:27:30,401 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Overriding cached value 100 with 101. pk=***@6cc4a8f0, field=rulekey
23:27:30,401 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#info org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#info (EJB default - 2) result: i=11, type=java.lang.String, value=null
23:27:30,401 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Add preload data: entity=StElt pk=***@6cc4a8f0 field=info
23:27:30,401 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Overriding cached value ***@ace10d9 with null. pk=***@6cc4a8f0, field=info
23:27:30,401 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Add finder results: entity=StElt results=[***@6cc4a8f0, ***@6cc4a8f0] readahead=[JDBCReadAheadMetaData : strategy=on-find, pageSize=10, eagerLoadGroup=*, left-join[]]
23:27:30,404 TRACE org.jboss.as.cmp.jdbc.JDBCStoreManager org.jboss.as.cmp.jdbc.JDBCStoreManager (EJB default - 2) RESET PERSISTENCE CONTEXT: id=***@6cc4a8f0
23:27:30,405 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) load data: entity=StElt pk=***@6cc4a8f0
23:27:30,405 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Preloading data: entity=StElt pk=***@6cc4a8f0 cmpField=rulekey
23:27:30,405 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Preloading data: entity=StElt pk=***@6cc4a8f0 cmpField=info
23:27:30,405 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Preloading data: entity=StElt pk=***@6cc4a8f0 cmpField=status
23:27:30,406 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Preloading data: entity=StElt pk=***@6cc4a8f0 cmpField=range
23:27:30,407 TRACE org.jboss.as.ejb3 org.jboss.as.ejb3 (EJB default - 2) Trying to acquire lock: ***@43401ab6[State = 0, empty queue][Unlocked] for entity bean ***@2599c538 during invocation: ***@1262f2d1
23:27:30,407 TRACE org.jboss.as.ejb3 org.jboss.as.ejb3 (EJB default - 2) Acquired lock: ***@43401ab6[State = 1, empty queue][Locked by 0:ffffc0a8010a:5a755c78:51f04697:e] for entity bean instance: ***@2599c538 during invocation: ***@1262f2d1
23:27:30,408 TRACE org.jboss.as.ejb3 org.jboss.as.ejb3 (EJB default - 2) Registered tx synchronization: org.jboss.as.ejb3.component.entity.interceptors.EntityBeanSynchronizationInterceptor$***@3026a5f8 for tx: 0:ffffc0a8010a:5a755c78:51f04697:e associated with stateful component instance: ***@2599c538
23:27:30,408 TRACE org.jboss.as.ejb3 org.jboss.as.ejb3 (EJB default - 2) Trying to acquire lock: ***@43401ab6[State = 1, empty queue][Locked by 0:ffffc0a8010a:5a755c78:51f04697:e] for entity bean ***@2599c538 during invocation: ***@395a557a
23:27:30,408 TRACE org.jboss.as.ejb3 org.jboss.as.ejb3 (EJB default - 2) Acquired lock: ***@43401ab6[State = 2, empty queue][Locked by 0:ffffc0a8010a:5a755c78:51f04697:e] for entity bean instance: ***@2599c538 during invocation: ***@395a557a
23:27:30,408 DEBUG org.jboss.as.ejb3 org.jboss.as.ejb3 (EJB default - 2) Looking for stateful component instance with session id: {[-35, 123, -20, -115, -21, -64, 75, -109, -104, -98, 102, 94, -108, -31, 96, -72]}
23:27:30,409 TRACE org.jboss.as.ejb3 org.jboss.as.ejb3 (EJB default - 2) Trying to acquire lock: ***@10ef63f9[State = 0, empty queue][Unlocked] for stateful component instance:  Instance of BatchLayer {{[-35, 123, -20, -115, -21, -64, 75, -109, -104, -98, 102, 94, -108, -31, 96, -72]}} during invocation: ***@548c791e
23:27:30,409 TRACE org.jboss.as.ejb3 org.jboss.as.ejb3 (EJB default - 2) Acquired lock: ***@10ef63f9[State = 1, empty queue][Locked by 0:ffffc0a8010a:5a755c78:51f04697:17] for stateful component instance:  Instance of BatchLayer {{[-35, 123, -20, -115, -21, -64, 75, -109, -104, -98, 102, 94, -108, -31, 96, -72]}} during invocation: ***@548c791e
23:27:30,409 TRACE org.jboss.as.ejb3 org.jboss.as.ejb3 (EJB default - 2) Registered tx synchronization: org.jboss.as.ejb3.component.stateful.StatefulSessionSynchronizationInterceptor$***@5263cbef for tx: 0:ffffc0a8010a:5a755c78:51f04697:17 associated with stateful component instance:  Instance of BatchLayer {{[-35, 123, -20, -115, -21, -64, 75, -109, -104, -98, 102, 94, -108, -31, 96, -72]}}
23:27:30,409 INFO  batchlayer.BatchLayerBean batchlayer.BatchLayerBean (EJB default - 2)

================ next in new TX 0:ffffc0a8010a:5a755c78:51f04697:17

23:27:30,410 DEBUG org.jboss.as.cmp.jdbc.JDBCJBossQLQuery.StElt#findAll org.jboss.as.cmp.jdbc.JDBCJBossQLQuery.StElt#findAll (EJB default - 2) Executing SQL: SELECT t0_p.elementtype, t0_p.element, t0_p.subelementtype, t0_p.subelement, t0_p.datetype, t0_p.validfrom, t0_p.validuntil, t0_p.range, t0_p.status, t0_p.rulekey, t0_p.info FROM ST_ELT t0_p
23:27:30,412 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#elementtype org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#elementtype (EJB default - 2) result: i=1, type=java.lang.String, value=M
23:27:30,412 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#element org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#element (EJB default - 2) result: i=2, type=java.lang.String, value=Merkmal1                     
23:27:30,412 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#subelementtype org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#subelementtype (EJB default - 2) result: i=3, type=java.lang.String, value=null
23:27:30,412 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#subelement org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#subelement (EJB default - 2) result: i=4, type=java.lang.String, value=null
23:27:30,412 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#datetype org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#datetype (EJB default - 2) result: i=5, type=java.lang.String, value=WIRKDAT  
23:27:30,412 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#validfrom org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#validfrom (EJB default - 2) result: i=6, type=java.sql.Timestamp, value=1970-01-01 01:00:00.0
23:27:30,412 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#validuntil org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#validuntil (EJB default - 2) result: i=7, type=java.sql.Timestamp, value=1970-01-01 01:00:00.0
23:27:30,412 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#range org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#range (EJB default - 2) result: i=8, type=java.lang.Integer, value=0
23:27:30,413 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Add preload data: entity=StElt pk=***@6cc4a8f0 field=range
23:27:30,413 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#status org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#status (EJB default - 2) result: i=9, type=java.lang.String, value=AKTIV    
23:27:30,413 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Add preload data: entity=StElt pk=***@6cc4a8f0 field=status
23:27:30,413 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#rulekey org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#rulekey (EJB default - 2) result: i=10, type=java.lang.Integer, value=100
23:27:30,413 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Add preload data: entity=StElt pk=***@6cc4a8f0 field=rulekey
23:27:30,413 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#info org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#info (EJB default - 2) result: i=11, type=java.lang.String, value=null
23:27:30,413 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Add preload data: entity=StElt pk=***@6cc4a8f0 field=info
23:27:30,413 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#elementtype org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#elementtype (EJB default - 2) result: i=1, type=java.lang.String, value=M
23:27:30,413 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#element org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#element (EJB default - 2) result: i=2, type=java.lang.String, value=Merkmal2                     
23:27:30,414 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#subelementtype org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#subelementtype (EJB default - 2) result: i=3, type=java.lang.String, value=null
23:27:30,414 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#subelement org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#subelement (EJB default - 2) result: i=4, type=java.lang.String, value=null
23:27:30,414 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#datetype org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#datetype (EJB default - 2) result: i=5, type=java.lang.String, value=WIRKDAT  
23:27:30,414 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#validfrom org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#validfrom (EJB default - 2) result: i=6, type=java.sql.Timestamp, value=1970-01-01 01:00:00.0
23:27:30,414 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#validuntil org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#validuntil (EJB default - 2) result: i=7, type=java.sql.Timestamp, value=1970-01-01 01:00:00.0
23:27:30,414 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#range org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#range (EJB default - 2) result: i=8, type=java.lang.Integer, value=0
23:27:30,414 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Add preload data: entity=StElt pk=***@6cc4a8f0 field=range
23:27:30,414 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Overriding cached value 0 with 0. pk=***@6cc4a8f0, field=range
23:27:30,414 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#status org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#status (EJB default - 2) result: i=9, type=java.lang.String, value=AKTIV    
23:27:30,414 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Add preload data: entity=StElt pk=***@6cc4a8f0 field=status
23:27:30,415 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Overriding cached value AKTIV      with AKTIV     . pk=***@6cc4a8f0, field=status
23:27:30,415 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#rulekey org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#rulekey (EJB default - 2) result: i=10, type=java.lang.Integer, value=101
23:27:30,415 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Add preload data: entity=StElt pk=***@6cc4a8f0 field=rulekey
23:27:30,415 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Overriding cached value 100 with 101. pk=***@6cc4a8f0, field=rulekey
23:27:30,415 TRACE org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#info org.jboss.as.cmp.jdbc.bridge.JDBCCMP2xFieldBridge.StElt#info (EJB default - 2) result: i=11, type=java.lang.String, value=null
23:27:30,415 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Add preload data: entity=StElt pk=***@6cc4a8f0 field=info
23:27:30,415 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Overriding cached value ***@ace10d9 with null. pk=***@6cc4a8f0, field=info
23:27:30,415 TRACE org.jboss.as.cmp.jdbc.ReadAheadCache.StElt org.jboss.as.cmp.jdbc.ReadAheadCache.StElt (EJB default - 2) Add finder results: entity=StElt results=[***@6cc4a8f0, ***@6cc4a8f0] readahead=[JDBCReadAheadMetaData : strategy=on-find, pageSize=10, eagerLoadGroup=*, left-join[]]
23:27:30,416 TRACE org.jboss.as.ejb3 org.jboss.as.ejb3 (EJB default - 2) Trying to acquire lock: ***@43401ab6[State = 1, empty queue][Locked by 0:ffffc0a8010a:5a755c78:51f04697:e] for entity bean ***@2599c538 during invocation: ***@5e196d07
2013-07-24 23:27:34
Full thread dump Java HotSpot(TM) 64-Bit Server VM (20.45-b01-451 mixed mode):

"EJB default - 2" prio=5 tid=7f8e12896000 nid=0x11611a000 waiting on condition https://community.jboss.org/message/829611#829611#829611/116113000 EAP 6.1: CMP EntityBeans locked in new Transaction
   java.lang.Thread.State: WAITING (parking)
          at sun.misc.Unsafe.park(Native Method)
          - parking to wait for  <7face9498> (a org.jboss.as.ejb3.tx.OwnableReentrantLock)
          at java.util.concurrent.locks.LockSupport.park(LockSupport.java:156)
          at java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:811)
          at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireQueued(AbstractQueuedSynchronizer.java:842)
          at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:1178)
          at org.jboss.as.ejb3.tx.OwnableReentrantLock.lock(OwnableReentrantLock.java:86)
          at org.jboss.as.ejb3.component.entity.interceptors.EntityBeanSynchronizationInterceptor.processInvocation(EntityBeanSynchronizationInterceptor.java:80)
          at org.jboss.as.cmp.component.interceptors.CmpEntityBeanSynchronizationInterceptor.processInvocation(CmpEntityBeanSynchronizationInterceptor.java:67)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:21)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61)
          at org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:53)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ejb3.component.entity.interceptors.EntityBeanAssociatingInterceptor.processInvocation(EntityBeanAssociatingInterceptor.java:79)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ejb3.tx.CMTTxInterceptor.invokeInCallerTx(CMTTxInterceptor.java:226)
          at org.jboss.as.ejb3.tx.CMTTxInterceptor.required(CMTTxInterceptor.java:317)
          at org.jboss.as.ejb3.tx.CMTTxInterceptor.processInvocation(CMTTxInterceptor.java:214)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ejb3.component.interceptors.CurrentInvocationContextInterceptor.processInvocation(CurrentInvocationContextInterceptor.java:41)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ejb3.component.interceptors.ShutDownInterceptorFactory$1.processInvocation(ShutDownInterceptorFactory.java:64)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ejb3.component.interceptors.LoggingInterceptor.processInvocation(LoggingInterceptor.java:59)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ejb3.component.interceptors.EjbExceptionTransformingInterceptorFactories$2.processInvocation(EjbExceptionTransformingInterceptorFactories.java:89)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ee.component.NamespaceContextInterceptor.processInvocation(NamespaceContextInterceptor.java:50)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ejb3.component.interceptors.AdditionalSetupInterceptor.processInvocation(AdditionalSetupInterceptor.java:55)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ee.component.TCCLInterceptor.processInvocation(TCCLInterceptor.java:45)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61)
          at org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:165)
          at org.jboss.as.ee.component.ViewDescription$1.processInvocation(ViewDescription.java:182)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ejb3.component.entity.interceptors.EntityBeanPrimaryKeyInterceptor.processInvocation(EntityBeanPrimaryKeyInterceptor.java:52)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61)
          at org.jboss.as.ee.component.ProxyInvocationHandler.invoke(ProxyInvocationHandler.java:72)
          at daten.StElt$$$view4.getSubelement(Unknown Source)
          at batchlayer.BatchLayerBean.next(BatchLayerBean.java:146)
          at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
          at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
          at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
          at java.lang.reflect.Method.invoke(Method.java:597)
          at org.jboss.as.ee.component.ManagedReferenceMethodInterceptorFactory$ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptorFactory.java:72)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53)
          at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:58)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53)
          at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:58)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ejb3.component.invocationmetrics.ExecutionTimeInterceptor.processInvocation(ExecutionTimeInterceptor.java:43)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.jpa.interceptor.SBInvocationInterceptor.processInvocation(SBInvocationInterceptor.java:47)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.jpa.interceptor.SFSBInvocationInterceptor.processInvocation(SFSBInvocationInterceptor.java:58)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ejb3.component.stateful.StatefulSessionSynchronizationInterceptor.processInvocation(StatefulSessionSynchronizationInterceptor.java:156)
          - locked <7faab4428> (a java.lang.Object)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:21)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61)
          at org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:53)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ejb3.component.stateful.StatefulComponentInstanceInterceptor.processInvocation(StatefulComponentInstanceInterceptor.java:67)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ejb3.tx.CMTTxInterceptor.invokeInOurTx(CMTTxInterceptor.java:248)
          at org.jboss.as.ejb3.tx.CMTTxInterceptor.requiresNew(CMTTxInterceptor.java:339)
          at org.jboss.as.ejb3.tx.CMTTxInterceptor.processInvocation(CMTTxInterceptor.java:216)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ejb3.remote.EJBRemoteTransactionPropagatingInterceptor.processInvocation(EJBRemoteTransactionPropagatingInterceptor.java:79)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ejb3.component.interceptors.CurrentInvocationContextInterceptor.processInvocation(CurrentInvocationContextInterceptor.java:41)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ejb3.component.interceptors.ShutDownInterceptorFactory$1.processInvocation(ShutDownInterceptorFactory.java:64)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ejb3.component.interceptors.LoggingInterceptor.processInvocation(LoggingInterceptor.java:59)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ejb3.component.interceptors.EjbExceptionTransformingInterceptorFactories$1.processInvocation(EjbExceptionTransformingInterceptorFactories.java:65)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ee.component.NamespaceContextInterceptor.processInvocation(NamespaceContextInterceptor.java:50)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ejb3.component.interceptors.AdditionalSetupInterceptor.processInvocation(AdditionalSetupInterceptor.java:55)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ee.component.TCCLInterceptor.processInvocation(TCCLInterceptor.java:45)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61)
          at org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:165)
          at org.jboss.as.ejb3.remote.LocalEjbReceiver.processInvocation(LocalEjbReceiver.java:222)
          at org.jboss.ejb.client.EJBClientInvocationContext.sendRequest(EJBClientInvocationContext.java:181)
          at org.jboss.ejb.client.EJBObjectInterceptor.handleInvocation(EJBObjectInterceptor.java:58)
          at org.jboss.ejb.client.EJBClientInvocationContext.sendRequest(EJBClientInvocationContext.java:183)
          at org.jboss.ejb.client.EJBHomeInterceptor.handleInvocation(EJBHomeInterceptor.java:83)
          at org.jboss.ejb.client.EJBClientInvocationContext.sendRequest(EJBClientInvocationContext.java:183)
          at org.jboss.ejb.client.TransactionInterceptor.handleInvocation(TransactionInterceptor.java:42)
          at org.jboss.ejb.client.EJBClientInvocationContext.sendRequest(EJBClientInvocationContext.java:183)
          at org.jboss.ejb.client.ReceiverInterceptor.handleInvocation(ReceiverInterceptor.java:125)
          at org.jboss.ejb.client.EJBClientInvocationContext.sendRequest(EJBClientInvocationContext.java:183)
          at org.jboss.ejb.client.EJBInvocationHandler.sendRequestWithPossibleRetries(EJBInvocationHandler.java:253)
          at org.jboss.ejb.client.EJBInvocationHandler.doInvoke(EJBInvocationHandler.java:198)
          at org.jboss.ejb.client.EJBInvocationHandler.doInvoke(EJBInvocationHandler.java:181)
          at org.jboss.ejb.client.EJBInvocationHandler.invoke(EJBInvocationHandler.java:144)
          at com.sun.proxy.$Proxy10.next(Unknown Source)
          at batchlayer.BatchLayerBean.doAll(BatchLayerBean.java:119)
          at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
          at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
          at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
          at java.lang.reflect.Method.invoke(Method.java:597)
          at org.jboss.as.ee.component.ManagedReferenceMethodInterceptorFactory$ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptorFactory.java:72)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53)
          at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:58)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53)
          at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:58)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ejb3.component.invocationmetrics.ExecutionTimeInterceptor.processInvocation(ExecutionTimeInterceptor.java:43)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.jpa.interceptor.SBInvocationInterceptor.processInvocation(SBInvocationInterceptor.java:47)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.jpa.interceptor.SFSBInvocationInterceptor.processInvocation(SFSBInvocationInterceptor.java:58)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ejb3.component.stateful.StatefulSessionSynchronizationInterceptor.processInvocation(StatefulSessionSynchronizationInterceptor.java:156)
          - locked <7fa9a35f8> (a java.lang.Object)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:21)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61)
          at org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:53)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ejb3.component.stateful.StatefulComponentInstanceInterceptor.processInvocation(StatefulComponentInstanceInterceptor.java:67)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ejb3.tx.CMTTxInterceptor.invokeInOurTx(CMTTxInterceptor.java:248)
          at org.jboss.as.ejb3.tx.CMTTxInterceptor.requiresNew(CMTTxInterceptor.java:344)
          at org.jboss.as.ejb3.tx.CMTTxInterceptor.processInvocation(CMTTxInterceptor.java:216)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ejb3.remote.EJBRemoteTransactionPropagatingInterceptor.processInvocation(EJBRemoteTransactionPropagatingInterceptor.java:79)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ejb3.component.interceptors.CurrentInvocationContextInterceptor.processInvocation(CurrentInvocationContextInterceptor.java:41)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ejb3.component.interceptors.ShutDownInterceptorFactory$1.processInvocation(ShutDownInterceptorFactory.java:64)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ejb3.component.interceptors.LoggingInterceptor.processInvocation(LoggingInterceptor.java:59)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ejb3.component.interceptors.EjbExceptionTransformingInterceptorFactories$1.processInvocation(EjbExceptionTransformingInterceptorFactories.java:65)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ee.component.NamespaceContextInterceptor.processInvocation(NamespaceContextInterceptor.java:50)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ejb3.component.interceptors.AdditionalSetupInterceptor.processInvocation(AdditionalSetupInterceptor.java:55)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.as.ee.component.TCCLInterceptor.processInvocation(TCCLInterceptor.java:45)
          at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
          at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61)
          at org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:165)
          at org.jboss.as.ejb3.remote.protocol.versionone.MethodInvocationMessageHandler.invokeMethod(MethodInvocationMessageHandler.java:329)
          at org.jboss.as.ejb3.remote.protocol.versionone.MethodInvocationMessageHandler.access$100(MethodInvocationMessageHandler.java:70)
          at org.jboss.as.ejb3.remote.protocol.versionone.MethodInvocationMessageHandler$1.run(MethodInvocationMessageHandler.java:203)
          at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:439)
          at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
          at java.util.concurrent.FutureTask.run(FutureTask.java:138)
          at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:895)
          at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:918)
          at java.lang.Thread.run(Thread.java:680)
          at org.jboss.threads.JBossThread.run(JBossThread.java:122)
--------------------------------------------------------------

Reply to this message by going to Community
[https://community.jboss.org/message/829611#829611]

Start a new discussion in EJB3 at Community
[https://community.jboss.org/choose-container!input.jspa?contentType=1&containerType=14&container=2029]
Loading...