[eclipselink-users] Odd behavior of eclipselink entity manager

["David Sills" <DSills@xxxxxxxxxxxxxxxxx>]

Thanks in advance for any help.

 

I’m trying to work through integrating EclipseLink into an application using Spring 3 and Tomcat 6 and Derby embedded. I’ve been using TopLink for a while without issues. Arranging reading was also not an issue, and EclipseLink performed beautifully.

 

When I tried writing a JPA entity, however, something very odd happens. Nothing. Increasing the logging to FINEST for Eclipse and DEBUG for everything else suggests that the Spring transactionality is working fine, but the odd sequence of lines below appears. It looks as though the Entity Manager is being opened, the line “[EL Finest]: 2009-06-06 02:38:56.97--UnitOfWork(2289825)--Thread(Thread[http-8080-1,5,main])--PERSIST operation called on: com.datasourceinc.sats.entity.Test1@4

6dc34”, and then the Entity Manager is closed, and the transaction committed, but no SQL is issued and nothing happens. Any ideas would be most welcome, and of course, all questions and requests for configuration files will be happily answered.

 

David Sills

 

2009-06-06 02:38:56,345 DEBUG [org.springframework.beans.factory.support.Default

ListableBeanFactory] - &lt;Returning cached instance of singleton bean 'org.springf

ramework.transaction.interceptor.TransactionInterceptor#0'&gt;

2009-06-06 02:38:56,360 DEBUG [org.springframework.transaction.annotation.Annota

tionTransactionAttributeSource] - &lt;Adding transactional method [create] with att

ribute [PROPAGATION_REQUIRED,ISOLATION_DEFAULT]&gt;

2009-06-06 02:38:56,392 DEBUG [org.springframework.jdbc.datasource.DataSourceTra

nsactionManager] - &lt;Creating new transaction with name [com.datasourceinc.spring

mvc.entity.SessionFacade.create]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT&gt;

2009-06-06 02:38:56,392 DEBUG [org.springframework.jdbc.datasource.DataSourceTra

nsactionManager] - &lt;Acquired Connection [jdbc:derby:database/sats, UserName=APP,

 Apache Derby Embedded JDBC Driver] for JDBC transaction&gt;

2009-06-06 02:38:56,423 DEBUG [org.springframework.jdbc.datasource.DataSourceTra

nsactionManager] - &lt;Switching JDBC Connection [jdbc:derby:database/sats, UserNam

e=APP, Apache Derby Embedded JDBC Driver] to manual commit&gt;

2009-06-06 02:38:56,454 DEBUG [org.springframework.orm.jpa.EntityManagerFactoryU

tils] - &lt;Opening JPA EntityManager&gt;

[EL Finest]: 2009-06-06 02:38:56.454--ServerSession(29366994)--Thread(Thread[htt

p-8080-1,5,main])--Begin deploying Persistence Unit sats-satsDS; state Predeploy

ed; factoryCount 1

[EL Finest]: 2009-06-06 02:38:56.517--ServerSession(29366994)--Thread(Thread[htt

p-8080-1,5,main])--property=eclipselink.logging.level; value=FINEST; translated

value=FINEST

[EL Finest]: 2009-06-06 02:38:56.517--ServerSession(29366994)--Thread(Thread[htt

p-8080-1,5,main])--property=eclipselink.logging.level; value=FINEST; translated

value=FINEST

[EL Finest]: 2009-06-06 02:38:56.517--ServerSession(29366994)--Thread(Thread[htt

p-8080-1,5,main])--property=eclipselink.target-database; value=Derby; translated

 value=org.eclipse.persistence.platform.database.DerbyPlatform

[EL Finest]: 2009-06-06 02:38:56.532--ServerSession(29366994)--Thread(Thread[htt

p-8080-1,5,main])--property=eclipselink.session.customizer; value=com.datasource

inc.springmvc.entity.JpaEclipseLinkSessionCustomizer

JpaEclipseLinkSessionCustomizer: configured null

JpaEclipseLinkSessionCustomizer: configured null

[EL Info]: 2009-06-06 02:38:56.548--ServerSession(29366994)--Thread(Thread[http-

8080-1,5,main])--EclipseLink, version: Eclipse Persistence Services - 1.1.0.r363

4

[EL Config]: 2009-06-06 02:38:56.579--ServerSession(29366994)--Connection(221467

97)--Thread(Thread[http-8080-1,5,main])--connecting(DatabaseLogin(

        platform=&gt;DerbyPlatform

        user name=&gt; ""

        connector=&gt;JNDIConnector datasource name=&gt;null

))

[EL Config]: 2009-06-06 02:38:56.595--ServerSession(29366994)--Connection(333309

51)--Thread(Thread[http-8080-1,5,main])--Connected: jdbc:derby:database/sats

        User: APP

        Database: Apache Derby  Version: 10.5.1.1 - (764942)

        Driver: Apache Derby Embedded JDBC Driver  Version: 10.5.1.1 - (764942)

[EL Config]: 2009-06-06 02:38:56.595--ServerSession(29366994)--Connection(206802

2)--Thread(Thread[http-8080-1,5,main])--connecting(DatabaseLogin(

        platform=&gt;DerbyPlatform

        user name=&gt; ""

        connector=&gt;JNDIConnector datasource name=&gt;null

))

[EL Config]: 2009-06-06 02:38:56.595--ServerSession(29366994)--Connection(284128

51)--Thread(Thread[http-8080-1,5,main])--Connected: jdbc:derby:database/sats

        User: APP

        Database: Apache Derby  Version: 10.5.1.1 - (764942)

        Driver: Apache Derby Embedded JDBC Driver  Version: 10.5.1.1 - (764942)

[EL Finest]: 2009-06-06 02:38:56.689--ServerSession(29366994)--Thread(Thread[htt

p-8080-1,5,main])--sequencing connected, state is NoPreallocation_State

[EL Finest]: 2009-06-06 02:38:56.689--ServerSession(29366994)--Thread(Thread[htt

p-8080-1,5,main])--sequence SEQ_GEN_IDENTITY: preallocation size 1

[EL Info]: 2009-06-06 02:38:56.86--ServerSession(29366994)--Thread(Thread[http-8

080-1,5,main])--file:/C:/apache-tomcat-6.0.18/temp/7-sats/WEB-INF/lib/sats.jar-s

ats-satsDS login successful

[EL Finest]: 2009-06-06 02:38:56.86--ServerSession(29366994)--Thread(Thread[http

-8080-1,5,main])--End deploying Persistence Unit sats-satsDS; state Deployed; fa

ctoryCount 1

2009-06-06 02:38:56,923 DEBUG [org.springframework.orm.jpa.EntityManagerFactoryU

tils] - &lt;Registering transaction synchronization for JPA EntityManager&gt;

[EL Finer]: 2009-06-06 02:38:56.97--ServerSession(29366994)--Thread(Thread[http-

8080-1,5,main])--client acquired

[EL Finest]: 2009-06-06 02:38:56.97--UnitOfWork(2289825)--Thread(Thread[http-808

0-1,5,main])--PERSIST operation called on: com.datasourceinc.sats.entity.Test1@4

6dc34.

2009-06-06 02:38:56,970 DEBUG [org.springframework.orm.jpa.EntityManagerFactoryU

tils] - &lt;Closing JPA EntityManager&gt;

[EL Finer]: 2009-06-06 02:38:56.97--UnitOfWork(2289825)--Thread(Thread[http-8080

-1,5,main])--release unit of work

[EL Finer]: 2009-06-06 02:38:56.97--ClientSession(15717886)--Thread(Thread[http-

8080-1,5,main])--client released

2009-06-06 02:38:56,970 DEBUG [org.springframework.jdbc.datasource.DataSourceTra

nsactionManager] - &lt;Initiating transaction commit&gt;

2009-06-06 02:38:56,985 DEBUG [org.springframework.jdbc.datasource.DataSourceTra

nsactionManager] - &lt;Committing JDBC transaction on Connection [jdbc:derby:databa

se/sats, UserName=APP, Apache Derby Embedded JDBC Driver]&gt;

2009-06-06 02:38:56,985 DEBUG [org.springframework.jdbc.datasource.DataSourceTra

nsactionManager] - &lt;Releasing JDBC Connection [jdbc:derby:database/sats, UserNam

e=APP, Apache Derby Embedded JDBC Driver] after transaction&gt;

2009-06-06 02:38:56,985 DEBUG [org.springframework.jdbc.datasource.DataSourceUti

ls] - &lt;Returning JDBC Connection to DataSource&gt;