persistence@glassfish.java.net

2 ejb dev tests failing

From: Mitesh Meswani <mitesh.meswani_at_Sun.COM>
Date: Fri, 24 Feb 2006 20:45:48 -0800

Hi Ken, Gordon,

Two extended em tests from the ejb dev tests
(appserv-tests/devtests/ejb/ejb30/persistence/extendedem) are failing
when running with this
<http://fisheye5.cenqua.com/changelog/glassfish/entity-persistence?cs=MAIN:gyorke:20060224184527>
checkin. Attached is the server.log
Could you please take a look

Thanks,
Mitesh


[#|2006-02-24T20:18:55.987-0800|INFO|sun-appserver-pe9.0|javax.enterprise.tools.launcher|_ThreadID=10;_ThreadName=main;|
/export/jdk/jre/../bin/java
-client
-Xmx512m
-XX:NewRatio=2
-Dcom.sun.aas.defaultLogFile=/export/assrc/publish/glassfish/domains/domain1/logs/server.log
-Djava.endorsed.dirs=/export/assrc/publish/glassfish/lib/endorsed
-Djava.security.policy=/export/assrc/publish/glassfish/domains/domain1/config/server.policy
-Djava.security.auth.login.config=/export/assrc/publish/glassfish/domains/domain1/config/login.conf
-Dsun.rmi.dgc.server.gcInterval=3600000
-Dsun.rmi.dgc.client.gcInterval=3600000
-Djavax.net.ssl.keyStore=/export/assrc/publish/glassfish/domains/domain1/config/keystore.jks
-Djavax.net.ssl.trustStore=/export/assrc/publish/glassfish/domains/domain1/config/cacerts.jks
-Djava.ext.dirs=/export/jdk/jre/../jre/lib/ext:/export/assrc/publish/glassfish/domains/domain1/lib/ext:/export/assrc/publish/glassfish/derby/lib
-Djdbc.drivers=org.apache.derby.jdbc.ClientDriver
-Djavax.management.builder.initial=com.sun.enterprise.admin.server.core.jmx.AppServerMBeanServerBuilder
-Dcom.sun.enterprise.config.config_environment_factory_class=com.sun.enterprise.config.serverbeans.AppserverConfigEnvironmentFactory
-Dcom.sun.enterprise.taglibs=appserv-jstl.jar,jsf-impl.jar
-Dcom.sun.enterprise.taglisteners=jsf-impl.jar
-Dcom.sun.aas.classloader.optionalOverrideableChain=appserv-ws.jar,commons-logging.jar,commons-launcher.jar,struts.jar
-Dcom.sun.aas.classloader.appserverChainJars=admin-cli.jar,admin-cli-ee.jar,dbschema.jar,j2ee-svc.jar
-Djavax.xml.parsers.SAXParserFactory=com.sun.org.apache.xerces.internal.jaxp.SAXParserFactoryImpl
-Dcom.sun.aas.classloader.serverClassPath.ee=%HADB_HOME%/lib/hadbjdbc4.jar,/export/assrc/publish/glassfish/lib/SUNWjdmk/5.1/lib/jdmkrt.jar,%HADB_HOME%/lib/dbstate.jar,%HADB_HOME%/lib/hadbm.jar,%HADB_HOME%/lib/hadbmgt.jar,%MFWK_HOME%/lib/mfwk_instrum_tk.jar
-Dcom.sun.aas.configName=server-config
-Dorg.xml.sax.parser=org.xml.sax.helpers.XMLReaderAdapter
-Ddomain.name=domain1
-Djmx.invoke.getters=true
-Djavax.xml.parsers.DocumentBuilderFactory=com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderFactoryImpl
-Dcom.sun.aas.promptForIdentity=true
-Dorg.xml.sax.driver=com.sun.org.apache.xerces.internal.parsers.SAXParser
-Dcom.sun.aas.classloader.optionalOverrideableChain.ee=
-Dcom.sun.aas.instanceRoot=/export/assrc/publish/glassfish/domains/domain1
-Djavax.xml.transform.TransformerFactory=com.sun.org.apache.xalan.internal.xsltc.trax.TransformerFactoryImpl
-Dcom.sun.aas.domainName=domain1
-Dcom.sun.aas.classloader.sharedChainJars=javaee.jar,/export/jdk/jre/../lib/tools.jar,install/applications/jmsra/imqjmsra.jar,commons-launcher.jar,/export/assrc/publish/glassfish/imq/lib/jaxm-api.jar,/export/assrc/publish/glassfish/imq/lib/fscontext.jar,/export/assrc/publish/glassfish/imq/lib/imqbroker.jar,/export/assrc/publish/glassfish/imq/lib/imqjmx.jar,/export/assrc/publish/glassfish/imq/lib/imqxm.jar,/export/assrc/publish/glassfish/lib/ant/lib/ant.jar,appserv-ws.jar,mail.jar,jsf-api.jar,jsf-impl.jar,appserv-jstl.jar,appserv-env.jar,jmxremote_optional.jar,/export/assrc/publish/glassfish/lib/SUNWjdmk/5.1/lib/jdmkrt.jar,commons-logging.jar,activation.jar,appserv-rt.jar,appserv-admin.jar,appserv-cmp.jar
-Dcom.sun.aas.classloader.sharedChainJars.ee=appserv-se.jar,appserv-ee.jar,%HADB_HOME%/lib/dbstate.jar,%HADB_HOME%/lib/hadbjdbc4.jar,jgroups-all.jar,%MFWK_HOME%/lib/mfwk_instrum_tk.jar
-Djava.util.logging.manager=com.sun.enterprise.server.logging.ServerLogManager
-Dcom.sun.enterprise.overrideablejavaxpackages=javax.xml.bind,javax.help
-Dcom.sun.aas.classloader.serverClassPath=/export/assrc/publish/glassfish/lib/install/applications/jmsra/imqjmsra.jar,/export/assrc/publish/glassfish/imq/lib/jaxm-api.jar,/export/assrc/publish/glassfish/imq/lib/fscontext.jar,/export/assrc/publish/glassfish/imq/lib/imqbroker.jar,/export/assrc/publish/glassfish/imq/lib/imqjmx.jar,/export/assrc/publish/glassfish/lib/ant/lib/ant.jar,/export/assrc/publish/glassfish/lib/SUNWjdmk/5.1/lib/jdmkrt.jar
-Dcom.sun.aas.classloader.appserverChainJars.ee=
-Dcom.sun.aas.configRoot=/export/assrc/publish/glassfish/config
-Djava.library.path=/export/jdk/jre/lib/i386/client:/export/jdk/jre/lib/i386:/export/jdk/jre/../lib/i386:/export/assrc/publish/glassfish/lib:/usr/lib/lwp:/export/jdk/jre/lib/i386/client:/export/jdk/jre/lib/i386:/export/jdk/jre/../lib/i386:/export/assrc/publish/glassfish/lib:/export/assrc/publish/glassfish/lib:/export/assrc/publish/glassfish/lib:/usr/export/instantclient:/usr/lib
-Dcom.sun.aas.instanceName=server
-Dcom.sun.aas.processLauncher=SE
-Dcom.sun.aas.ClassPathPrefix=
-Dcom.sun.aas.ClassPathSuffix=
-Dcom.sun.aas.ServerClassPath=
-cp
:/export/assrc/publish/glassfish/lib/appserv-launch.jar
com.sun.enterprise.server.PELaunch
start|#]

[#|2006-02-24T20:18:58.240-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.core|_ThreadID=10;_ThreadName=main;|CORE5098: AS Socket Service Initialization has been completed.|#]

[#|2006-02-24T20:18:59.503-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.admin|_ThreadID=10;_ThreadName=main;|ADM0001:MBeanServer initialized successfully|#]

[#|2006-02-24T20:19:01.672-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.core.security|_ThreadID=10;_ThreadName=main;com.sun.enterprise.security.provider.PolicyWrapper;|SEC1143: Loading policy provider com.sun.enterprise.security.provider.PolicyWrapper.|#]

[#|2006-02-24T20:19:01.783-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.core.selfmanagement|_ThreadID=10;_ThreadName=main;|sgmt.service_initialized|#]

[#|2006-02-24T20:19:06.147-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.admin|_ThreadID=10;_ThreadName=main;|ADM1079: Initialization of AMX MBeans successful|#]

[#|2006-02-24T20:19:06.672-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.admin|_ThreadID=10;_ThreadName=main;service:jmx:rmi:///jndi/rmi://mitesh-linux:8686/jmxrmi;|ADM1504: Here is the JMXServiceURL for the Standard JMXConnectorServer: [service:jmx:rmi:///jndi/rmi://mitesh-linux:8686/jmxrmi]. This is where the remote administrative clients should connect using the standard JMX connectors|#]

[#|2006-02-24T20:19:06.672-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.admin|_ThreadID=10;_ThreadName=main;true;|ADM1506: Status of Standard JMX Connector: Active = [true]|#]

[#|2006-02-24T20:19:06.735-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.deployment|_ThreadID=10;_ThreadName=main;|[AutoDeploy] Selecting file /export/assrc/publish/glassfish/lib/install/applications/MEjbApp.ear for autodeployment.|#]

[#|2006-02-24T20:19:09.324-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.deployment|_ThreadID=10;_ThreadName=main;|deployed with moduleid = MEjbApp|#]

[#|2006-02-24T20:19:09.649-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.admin|_ThreadID=10;_ThreadName=main;success;|ADM1042:Status of dynamic reconfiguration event processing:[success]|#]

[#|2006-02-24T20:19:09.752-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.admin|_ThreadID=10;_ThreadName=main;success;|ADM1042:Status of dynamic reconfiguration event processing:[success]|#]

[#|2006-02-24T20:19:09.753-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.deployment|_ThreadID=10;_ThreadName=main;|[AutoDeploy] Successfully autodeployed : /export/assrc/publish/glassfish/lib/install/applications/MEjbApp.ear.|#]

[#|2006-02-24T20:19:09.756-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.deployment|_ThreadID=10;_ThreadName=main;|[AutoDeploy] Selecting file /export/assrc/publish/glassfish/lib/install/applications/__ejb_container_timer_app.ear for autodeployment.|#]

[#|2006-02-24T20:19:14.111-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.deployment|_ThreadID=10;_ThreadName=main;|deployed with moduleid = __ejb_container_timer_app|#]

[#|2006-02-24T20:19:14.460-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.admin|_ThreadID=10;_ThreadName=main;success;|ADM1042:Status of dynamic reconfiguration event processing:[success]|#]

[#|2006-02-24T20:19:14.583-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.admin|_ThreadID=10;_ThreadName=main;success;|ADM1042:Status of dynamic reconfiguration event processing:[success]|#]

[#|2006-02-24T20:19:14.585-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.deployment|_ThreadID=10;_ThreadName=main;|[AutoDeploy] Successfully autodeployed : /export/assrc/publish/glassfish/lib/install/applications/__ejb_container_timer_app.ear.|#]

[#|2006-02-24T20:19:14.588-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.deployment|_ThreadID=10;_ThreadName=main;|[AutoDeploy] Selecting file /export/assrc/publish/glassfish/lib/install/applications/__JWSappclients.ear for autodeployment.|#]

[#|2006-02-24T20:19:14.939-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.deployment|_ThreadID=10;_ThreadName=main;|deployed with moduleid = __JWSappclients|#]

[#|2006-02-24T20:19:15.029-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.admin|_ThreadID=10;_ThreadName=main;success;|ADM1042:Status of dynamic reconfiguration event processing:[success]|#]

[#|2006-02-24T20:19:15.105-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.admin|_ThreadID=10;_ThreadName=main;success;|ADM1042:Status of dynamic reconfiguration event processing:[success]|#]

[#|2006-02-24T20:19:15.106-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.deployment|_ThreadID=10;_ThreadName=main;|[AutoDeploy] Successfully autodeployed : /export/assrc/publish/glassfish/lib/install/applications/__JWSappclients.ear.|#]

[#|2006-02-24T20:19:15.169-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.core.selfmanagement|_ThreadID=10;_ThreadName=main;|SMGT0007: Self Management Rules service is enabled|#]

[#|2006-02-24T20:19:15.194-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.core|_ThreadID=10;_ThreadName=main;|Application server startup complete.|#]

[#|2006-02-24T20:20:01.393-0800|WARNING|sun-appserver-pe9.0|javax.enterprise.system.container.web|_ThreadID=11;_ThreadName=Thread-5;_RequestID=7ed74654-626c-4f70-a5d8-7ba88889b808;|WEB0334: http-file-cache attribute hash-init-size not supported|#]

[#|2006-02-24T20:20:01.396-0800|WARNING|sun-appserver-pe9.0|javax.enterprise.system.container.web|_ThreadID=11;_ThreadName=Thread-5;_RequestID=7ed74654-626c-4f70-a5d8-7ba88889b808;|WEB0335: http-listener attribute family not supported|#]

[#|2006-02-24T20:20:01.397-0800|WARNING|sun-appserver-pe9.0|javax.enterprise.system.container.web|_ThreadID=11;_ThreadName=Thread-5;_RequestID=7ed74654-626c-4f70-a5d8-7ba88889b808;|WEB0336: http-listener attribute blocking-enabled not supported|#]

[#|2006-02-24T20:20:01.397-0800|WARNING|sun-appserver-pe9.0|javax.enterprise.system.container.web|_ThreadID=11;_ThreadName=Thread-5;_RequestID=7ed74654-626c-4f70-a5d8-7ba88889b808;|WEB0335: http-listener attribute family not supported|#]

[#|2006-02-24T20:20:01.398-0800|WARNING|sun-appserver-pe9.0|javax.enterprise.system.container.web|_ThreadID=11;_ThreadName=Thread-5;_RequestID=7ed74654-626c-4f70-a5d8-7ba88889b808;|WEB0336: http-listener attribute blocking-enabled not supported|#]

[#|2006-02-24T20:20:01.398-0800|WARNING|sun-appserver-pe9.0|javax.enterprise.system.container.web|_ThreadID=11;_ThreadName=Thread-5;_RequestID=7ed74654-626c-4f70-a5d8-7ba88889b808;|WEB0335: http-listener attribute family not supported|#]

[#|2006-02-24T20:20:01.398-0800|WARNING|sun-appserver-pe9.0|javax.enterprise.system.container.web|_ThreadID=11;_ThreadName=Thread-5;_RequestID=7ed74654-626c-4f70-a5d8-7ba88889b808;|WEB0336: http-listener attribute blocking-enabled not supported|#]

[#|2006-02-24T20:20:01.399-0800|WARNING|sun-appserver-pe9.0|javax.enterprise.system.container.web|_ThreadID=11;_ThreadName=Thread-5;_RequestID=7ed74654-626c-4f70-a5d8-7ba88889b808;|WEB0339: http-protocol attribute version not supported|#]

[#|2006-02-24T20:20:01.399-0800|WARNING|sun-appserver-pe9.0|javax.enterprise.system.container.web|_ThreadID=11;_ThreadName=Thread-5;_RequestID=7ed74654-626c-4f70-a5d8-7ba88889b808;|WEB0338: http-protocol attribute ssl-enabled not supported|#]

[#|2006-02-24T20:20:01.563-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.container.web|_ThreadID=11;_ThreadName=Thread-5;|WEB0302: Starting Sun-Java-System/Application-Server.|#]

[#|2006-02-24T20:20:01.649-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.container.web|_ThreadID=11;_ThreadName=Thread-5;__default-admingui;__asadmin;/;|WEB0100: Loading web module [__default-admingui] in virtual server [__asadmin] at [/]|#]

[#|2006-02-24T20:20:01.759-0800|WARNING|sun-appserver-pe9.0|javax.enterprise.system.container.web|_ThreadID=11;_ThreadName=Thread-5;_RequestID=7ed74654-626c-4f70-a5d8-7ba88889b808;|WEB0500: default-locale attribute of locale-charset-info element has been deprecated and is being ignored. Use default-charset attribute of parameter-encoding element instead|#]

[#|2006-02-24T20:20:01.858-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.container.web|_ThreadID=11;_ThreadName=Thread-5;adminapp;__asadmin;/web1;|WEB0100: Loading web module [adminapp] in virtual server [__asadmin] at [/web1]|#]

[#|2006-02-24T20:20:01.881-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.container.web|_ThreadID=11;_ThreadName=Thread-5;admingui;__asadmin;/asadmin;|WEB0100: Loading web module [admingui] in virtual server [__asadmin] at [/asadmin]|#]

[#|2006-02-24T20:20:01.884-0800|WARNING|sun-appserver-pe9.0|javax.enterprise.system.container.web|_ThreadID=11;_ThreadName=Thread-5;_RequestID=7ed74654-626c-4f70-a5d8-7ba88889b808;|WEB0500: default-locale attribute of locale-charset-info element has been deprecated and is being ignored. Use default-charset attribute of parameter-encoding element instead|#]

[#|2006-02-24T20:20:02.843-0800|INFO|sun-appserver-pe9.0|javax.enterprise.resource.webcontainer.jsf.config|_ThreadID=11;_ThreadName=Thread-5;;|Initializing Sun's JavaServer Faces implementation (1.2-b15) for context ''|#]

[#|2006-02-24T20:20:04.923-0800|INFO|sun-appserver-pe9.0|javax.enterprise.resource.webcontainer.jsf.config|_ThreadID=11;_ThreadName=Thread-5;;|Initializing Sun's JavaServer Faces implementation (1.2-b15) for context ''|#]

[#|2006-02-24T20:20:05.768-0800|SEVERE|sun-appserver-pe9.0|javax.enterprise.system.container.web|_ThreadID=11;_ThreadName=Thread-5;_RequestID=7ed74654-626c-4f70-a5d8-7ba88889b808;|WEB0605: No Realm has been configured to authenticate against|#]

[#|2006-02-24T20:20:06.108-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.container.web|_ThreadID=11;_ThreadName=Thread-5;8080;|WEB0712: Starting Sun-Java-System/Application-Server HTTP/1.1 on 8080|#]

[#|2006-02-24T20:20:06.257-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.container.web|_ThreadID=11;_ThreadName=Thread-5;8181;|WEB0712: Starting Sun-Java-System/Application-Server HTTP/1.1 on 8181|#]

[#|2006-02-24T20:20:06.332-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.container.web|_ThreadID=11;_ThreadName=Thread-5;4848;|WEB0712: Starting Sun-Java-System/Application-Server HTTP/1.1 on 4848|#]

[#|2006-02-24T20:20:06.487-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.core|_ThreadID=11;_ThreadName=Thread-5;|About to load the system app: __JWSappclients|#]

[#|2006-02-24T20:20:06.532-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.container.web|_ThreadID=11;_ThreadName=Thread-5;__JWSappclients:sys.war;server;/__JWSappclients;|WEB0100: Loading web module [__JWSappclients:sys.war] in virtual server [server] at [/__JWSappclients]|#]

[#|2006-02-24T20:20:07.173-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.admin|_ThreadID=12;_ThreadName=httpWorkerThread-4848-3;/var/tmp/s1astempdomain1server851580169/ejb-ejb30-persistence-extendedemApp.ear;|ADM1006:Uploading the file to:[/var/tmp/s1astempdomain1server851580169/ejb-ejb30-persistence-extendedemApp.ear]|#]

[#|2006-02-24T20:20:08.363-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.deployment|_ThreadID=13;_ThreadName=Thread-29;|deployed with moduleid = ejb-ejb30-persistence-extendedemApp|#]

[#|2006-02-24T20:20:08.656-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.admin|_ThreadID=14;_ThreadName=httpWorkerThread-4848-0;success;|ADM1042:Status of dynamic reconfiguration event processing:[success]|#]

[#|2006-02-24T20:20:09.673-0800|INFO|sun-appserver-pe9.0|javax.enterprise.resource.corba.ee._INITIALIZING_.rpc.transport|_ThreadID=15;_ThreadName=httpWorkerThread-4848-4;all interfaces;3700;|"IOP00710299: (INTERNAL) Successfully created IIOP listener on the specified host/port: all interfaces/3700"|#]

[#|2006-02-24T20:20:09.675-0800|INFO|sun-appserver-pe9.0|javax.enterprise.resource.corba.ee._INITIALIZING_.rpc.transport|_ThreadID=15;_ThreadName=httpWorkerThread-4848-4;all interfaces;3820;|"IOP00710299: (INTERNAL) Successfully created IIOP listener on the specified host/port: all interfaces/3820"|#]

[#|2006-02-24T20:20:09.683-0800|INFO|sun-appserver-pe9.0|javax.enterprise.resource.corba.ee._INITIALIZING_.rpc.transport|_ThreadID=15;_ThreadName=httpWorkerThread-4848-4;all interfaces;3920;|"IOP00710299: (INTERNAL) Successfully created IIOP listener on the specified host/port: all interfaces/3920"|#]

[#|2006-02-24T20:20:11.206-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.core.transaction|_ThreadID=15;_ThreadName=httpWorkerThread-4848-4;3700;|JTS5014: Recoverable JTS instance, serverId = [3700]|#]

[#|2006-02-24T20:20:11.291-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.core|_ThreadID=15;_ThreadName=httpWorkerThread-4848-4;|About to load the system app: MEjbApp|#]

[#|2006-02-24T20:20:11.624-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.core.classloading|_ThreadID=15;_ThreadName=httpWorkerThread-4848-4;MEjbApp;|LDR5010: All ejb(s) of [MEjbApp] loaded successfully!|#]

[#|2006-02-24T20:20:11.625-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.core|_ThreadID=15;_ThreadName=httpWorkerThread-4848-4;|About to load the system app: __ejb_container_timer_app|#]

[#|2006-02-24T20:20:12.442-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.container.ejb|_ThreadID=15;_ThreadName=httpWorkerThread-4848-4;jdbc/__TimerPool;|EJB5109:EJB Timer Service started successfully for datasource [jdbc/__TimerPool]|#]

[#|2006-02-24T20:20:12.442-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.core.classloading|_ThreadID=15;_ThreadName=httpWorkerThread-4848-4;__ejb_container_timer_app;|LDR5010: All ejb(s) of [__ejb_container_timer_app] loaded successfully!|#]

[#|2006-02-24T20:20:13.941-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.stream.out|_ThreadID=15;_ThreadName=httpWorkerThread-4848-4;|[TopLink Info]: 2006.02.24 08:20:13.925--ServerSession(27595620)--TopLink, version: Oracle TopLink Essentials - 10g release 4 (10.1.4.0.0) (Build 060216Dev)
|#]

[#|2006-02-24T20:20:13.951-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.stream.out|_ThreadID=15;_ThreadName=httpWorkerThread-4848-4;|[TopLink Info]: 2006.02.24 08:20:13.951--ServerSession(27595620)--Server: unknown
|#]

[#|2006-02-24T20:20:14.389-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.stream.out|_ThreadID=15;_ThreadName=httpWorkerThread-4848-4;|[TopLink Info]: 2006.02.24 08:20:14.388--ServerSession(27595620)--file:/export/assrc/publish/glassfish/domains/domain1/applications/j2ee-apps/ejb-ejb30-persistence-extendedemApp/ejb-ejb30-persistence-extendedem-par3.jar-em login successful
|#]

[#|2006-02-24T20:20:14.407-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.stream.out|_ThreadID=15;_ThreadName=httpWorkerThread-4848-4;|[TopLink Info]: 2006.02.24 08:20:14.407--ServerSession(31198473)--TopLink, version: Oracle TopLink Essentials - 10g release 4 (10.1.4.0.0) (Build 060216Dev)
|#]

[#|2006-02-24T20:20:14.408-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.stream.out|_ThreadID=15;_ThreadName=httpWorkerThread-4848-4;|[TopLink Info]: 2006.02.24 08:20:14.407--ServerSession(31198473)--Server: unknown
|#]

[#|2006-02-24T20:20:14.411-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.stream.out|_ThreadID=15;_ThreadName=httpWorkerThread-4848-4;|[TopLink Info]: 2006.02.24 08:20:14.410--ServerSession(31198473)--file:/export/assrc/publish/glassfish/domains/domain1/applications/j2ee-apps/ejb-ejb30-persistence-extendedemApp/ejb-ejb30-persistence-extendedem-par2.jar-em2 login successful
|#]

[#|2006-02-24T20:20:14.422-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.stream.out|_ThreadID=15;_ThreadName=httpWorkerThread-4848-4;|[TopLink Info]: 2006.02.24 08:20:14.422--ServerSession(18497841)--TopLink, version: Oracle TopLink Essentials - 10g release 4 (10.1.4.0.0) (Build 060216Dev)
|#]

[#|2006-02-24T20:20:14.423-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.stream.out|_ThreadID=15;_ThreadName=httpWorkerThread-4848-4;|[TopLink Info]: 2006.02.24 08:20:14.423--ServerSession(18497841)--Server: unknown
|#]

[#|2006-02-24T20:20:14.424-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.stream.out|_ThreadID=15;_ThreadName=httpWorkerThread-4848-4;|[TopLink Info]: 2006.02.24 08:20:14.424--ServerSession(18497841)--file:/export/assrc/publish/glassfish/domains/domain1/applications/j2ee-apps/ejb-ejb30-persistence-extendedemApp/lib/ejb-ejb30-persistence-extendedem-par1.jar-em login successful
|#]

[#|2006-02-24T20:20:14.709-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.core.naming|_ThreadID=15;_ThreadName=httpWorkerThread-4848-4;java:comp/env/com.sun.s1asdev.ejb.ejb30.persistence.extendedem.SfulBean/txEM;|naming.bind|#]

[#|2006-02-24T20:20:14.709-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.core.naming|_ThreadID=15;_ThreadName=httpWorkerThread-4848-4;java:comp/env/com.sun.s1asdev.ejb.ejb30.persistence.extendedem.SfulBean/extendedEM;|naming.bind|#]

[#|2006-02-24T20:20:14.785-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.container.ejb|_ThreadID=15;_ThreadName=httpWorkerThread-4848-4;|**RemoteBusinessJndiName: com.sun.s1asdev.ejb.ejb30.persistence.extendedem.Sful; remoteBusIntf: com.sun.s1asdev.ejb.ejb30.persistence.extendedem.Sful|#]

[#|2006-02-24T20:20:14.809-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.core.classloading|_ThreadID=15;_ThreadName=httpWorkerThread-4848-4;ejb-ejb30-persistence-extendedemApp;|LDR5010: All ejb(s) of [ejb-ejb30-persistence-extendedemApp] loaded successfully!|#]

[#|2006-02-24T20:20:15.035-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.deployment|_ThreadID=15;_ThreadName=httpWorkerThread-4848-4;|Registering ad hoc servlet: WebPathPath: context root = "/__appclient", path = "/ejb-ejb30-persistence-extendedemApp/ejb-ejb30-persistence-extendedem-client'|#]

[#|2006-02-24T20:20:15.113-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.deployment|_ThreadID=15;_ThreadName=httpWorkerThread-4848-4;|Java Web Start services started for application com.sun.enterprise.appclient.jws.ApplicationContentOrigin_at_db3158 registration name=ejb-ejb30-persistence-extendedemApp
    com.sun.enterprise.appclient.jws.NestedAppclientContentOrigin_at_84b1e0 registration name=ejb-ejb30-persistence-extendedemApp, context root=/ejb-ejb30-persistence-extendedemApp/ejb-ejb30-persistence-extendedem-client, module name=
, parent=ejb-ejb30-persistence-extendedemApp|#]

[#|2006-02-24T20:20:15.115-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.admin|_ThreadID=15;_ThreadName=httpWorkerThread-4848-4;success;|ADM1042:Status of dynamic reconfiguration event processing:[success]|#]

[#|2006-02-24T20:20:15.207-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.admin|_ThreadID=12;_ThreadName=httpWorkerThread-4848-3;/export/assrc/publish/glassfish/domains/domain1/generated/xml/j2ee-apps/ejb-ejb30-persistence-extendedemApp/ejb-ejb30-persistence-extendedemAppClient.jar;|ADM1040:Client-jar location:[/export/assrc/publish/glassfish/domains/domain1/generated/xml/j2ee-apps/ejb-ejb30-persistence-extendedemApp/ejb-ejb30-persistence-extendedemAppClient.jar]|#]

[#|2006-02-24T20:20:20.597-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.stream.out|_ThreadID=16;_ThreadName=p: thread-pool-1; w: 3;|Created Person: {(name = duke)}|#]

[#|2006-02-24T20:20:20.948-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.stream.out|_ThreadID=17;_ThreadName=p: thread-pool-1; w: 2;|
Found Person: {(name = duke)}|#]

[#|2006-02-24T20:20:20.975-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.stream.out|_ThreadID=17;_ThreadName=p: thread-pool-1; w: 2;|
[TopLink Warning]: 2006.02.24 08:20:20.971--ClientSession(28047307)--Exception [TOPLINK-23005] (Oracle TopLink Essentials - 10g release 4 (10.1.4.0.0) (Build 060216Dev)): oracle.toplink.essentials.exceptions.TransactionException
Exception Description: Error binding to externally managed transaction
Internal Exception: java.lang.IllegalStateException: Operation not allowed
|#]

[#|2006-02-24T20:20:20.977-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.container.ejb|_ThreadID=17;_ThreadName=p: thread-pool-1; w: 2;SfulBean;|EJB5018: An exception was thrown during an ejb invocation on [SfulBean]|#]

[#|2006-02-24T20:20:20.977-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.container.ejb|_ThreadID=17;_ThreadName=p: thread-pool-1; w: 2;|
javax.ejb.EJBException
        at com.sun.ejb.containers.BaseContainer.processSystemException(BaseContainer.java:3725)
        at com.sun.ejb.containers.BaseContainer.checkExceptionNoTx(BaseContainer.java:3556)
        at com.sun.ejb.containers.BaseContainer.postInvokeTx(BaseContainer.java:3404)
        at com.sun.ejb.containers.StatefulSessionContainer.postInvokeTx(StatefulSessionContainer.java:1292)
        at com.sun.ejb.containers.BaseContainer.postInvoke(BaseContainer.java:1234)
        at com.sun.ejb.containers.EJBObjectInvocationHandler.invoke(EJBObjectInvocationHandler.java:197)
        at com.sun.ejb.containers.EJBObjectInvocationHandlerDelegate.invoke(EJBObjectInvocationHandlerDelegate.java:67)
        at $Proxy34.nonTxFindPerson(Unknown Source)
        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:585)
        at com.sun.corba.ee.impl.presentation.rmi.ReflectiveTie._invoke(Unknown Source)
        at com.sun.corba.ee.impl.protocol.CorbaServerRequestDispatcherImpl.dispatchToServant(Unknown Source)
        at com.sun.corba.ee.impl.protocol.CorbaServerRequestDispatcherImpl.dispatch(Unknown Source)
        at com.sun.corba.ee.impl.protocol.CorbaMessageMediatorImpl.handleRequestRequest(Unknown Source)
        at com.sun.corba.ee.impl.protocol.CorbaMessageMediatorImpl.handleRequest(Unknown Source)
        at com.sun.corba.ee.impl.protocol.CorbaMessageMediatorImpl.handleInput(Unknown Source)
        at com.sun.corba.ee.impl.protocol.giopmsgheaders.RequestMessage_1_2.callback(Unknown Source)
        at com.sun.corba.ee.impl.protocol.CorbaMessageMediatorImpl.handleRequest(Unknown Source)
        at com.sun.corba.ee.impl.transport.SocketOrChannelConnectionImpl.dispatch(Unknown Source)
        at com.sun.corba.ee.impl.transport.SocketOrChannelConnectionImpl.doWork(Unknown Source)
        at com.sun.corba.ee.impl.orbutil.threadpool.ThreadPoolImpl$WorkerThread.run(Unknown Source)
Caused by: Exception [TOPLINK-23004] (Oracle TopLink Essentials - 10g release 4 (10.1.4.0.0) (Build 060216Dev)): oracle.toplink.essentials.exceptions.TransactionException
Exception Description: Error obtaining the Transaction Manager
Internal Exception: Exception [TOPLINK-23005] (Oracle TopLink Essentials - 10g release 4 (10.1.4.0.0) (Build 060216Dev)): oracle.toplink.essentials.exceptions.TransactionException
Exception Description: Error binding to externally managed transaction
Internal Exception: java.lang.IllegalStateException: Operation not allowed
        at oracle.toplink.essentials.exceptions.TransactionException.errorBindingToExternalTransaction(TransactionException.java:79)
        at oracle.toplink.essentials.transaction.AbstractTransactionController.bindToCurrentTransaction(AbstractTransactionController.java:102)
        at oracle.toplink.essentials.transaction.AbstractTransactionController.registerSynchronizationListener(AbstractTransactionController.java:394)
        at oracle.toplink.essentials.internal.sessions.UnitOfWorkImpl.registerWithTransactionIfRequired(UnitOfWorkImpl.java:3336)
        at oracle.toplink.essentials.internal.ejb.cmp3.transaction.base.JTATransactionWrapper.registerUnitOfWorkWithTxn(JTATransactionWrapper.java:114)
        at oracle.toplink.essentials.internal.ejb.cmp3.base.EntityManagerImpl.getActivePersistenceContext(EntityManagerImpl.java:453)
        at oracle.toplink.essentials.internal.ejb.cmp3.base.EntityManagerImpl.getActiveSession(EntityManagerImpl.java:322)
        at oracle.toplink.essentials.internal.ejb.cmp3.base.EntityManagerImpl.findInternal(EntityManagerImpl.java:199)
        at oracle.toplink.essentials.internal.ejb.cmp3.EntityManagerImpl.find(EntityManagerImpl.java:114)
        at com.sun.enterprise.util.EntityManagerWrapper.find(EntityManagerWrapper.java:229)
        at com.sun.s1asdev.ejb.ejb30.persistence.extendedem.SfulBean.nonTxFindPerson(SfulBean.java:56)
        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:585)
        at com.sun.enterprise.security.application.EJBSecurityManager.runMethod(EJBSecurityManager.java:1001)
        at com.sun.enterprise.security.SecurityUtil.invoke(SecurityUtil.java:165)
        at com.sun.ejb.containers.BaseContainer.invokeTargetBeanMethod(BaseContainer.java:2761)
        at com.sun.ejb.containers.BaseContainer.intercept(BaseContainer.java:3842)
        at com.sun.ejb.containers.EJBObjectInvocationHandler.invoke(EJBObjectInvocationHandler.java:190)
        ... 17 more
Caused by: Exception [TOPLINK-23005] (Oracle TopLink Essentials - 10g release 4 (10.1.4.0.0) (Build 060216Dev)): oracle.toplink.essentials.exceptions.TransactionException
Exception Description: Error binding to externally managed transaction
Internal Exception: java.lang.IllegalStateException: Operation not allowed
        at oracle.toplink.essentials.exceptions.TransactionException.errorBeginningExternalTransaction(TransactionException.java:87)
        at oracle.toplink.essentials.transaction.AbstractTransactionController.beginTransaction(AbstractTransactionController.java:125)
        at oracle.toplink.essentials.internal.sessions.AbstractSession.beginExternalTransaction(AbstractSession.java:322)
        at oracle.toplink.essentials.internal.sessions.AbstractSession.beginTransaction(AbstractSession.java:353)
        at oracle.toplink.essentials.internal.sessions.UnitOfWorkImpl.beginTransaction(UnitOfWorkImpl.java:400)
        at oracle.toplink.essentials.transaction.AbstractTransactionController.bindToCurrentTransaction(AbstractTransactionController.java:86)
        ... 35 more
Caused by: java.lang.IllegalStateException: Operation not allowed
        at com.sun.ejb.containers.PMTransactionManagerImpl.begin(PMTransactionManagerImpl.java:80)
        at oracle.toplink.essentials.transaction.JTATransactionController.beginTransaction_impl(JTATransactionController.java:130)
        at oracle.toplink.essentials.transaction.AbstractTransactionController.beginTransaction(AbstractTransactionController.java:121)
        ... 39 more
|#]

[#|2006-02-24T20:20:23.741-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.deployment|_ThreadID=12;_ThreadName=httpWorkerThread-4848-3;|Java Web Start services ended for application: com.sun.enterprise.appclient.jws.ApplicationContentOrigin_at_db3158 registration name=ejb-ejb30-persistence-extendedemApp
    com.sun.enterprise.appclient.jws.NestedAppclientContentOrigin_at_84b1e0 registration name=ejb-ejb30-persistence-extendedemApp, context root=/ejb-ejb30-persistence-extendedemApp/ejb-ejb30-persistence-extendedem-client, module name=
, parent=ejb-ejb30-persistence-extendedemApp|#]

[#|2006-02-24T20:20:23.789-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.stream.out|_ThreadID=12;_ThreadName=httpWorkerThread-4848-3;|[TopLink Info]: 2006.02.24 08:20:23.789--ServerSession(31198473)--file:/export/assrc/publish/glassfish/domains/domain1/applications/j2ee-apps/ejb-ejb30-persistence-extendedemApp/ejb-ejb30-persistence-extendedem-par2.jar-em2 logout successful
|#]

[#|2006-02-24T20:20:23.791-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.stream.out|_ThreadID=12;_ThreadName=httpWorkerThread-4848-3;|[TopLink Info]: 2006.02.24 08:20:23.791--ServerSession(27595620)--file:/export/assrc/publish/glassfish/domains/domain1/applications/j2ee-apps/ejb-ejb30-persistence-extendedemApp/ejb-ejb30-persistence-extendedem-par3.jar-em logout successful
|#]

[#|2006-02-24T20:20:23.792-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.stream.out|_ThreadID=12;_ThreadName=httpWorkerThread-4848-3;|[TopLink Info]: 2006.02.24 08:20:23.792--ServerSession(18497841)--file:/export/assrc/publish/glassfish/domains/domain1/applications/j2ee-apps/ejb-ejb30-persistence-extendedemApp/lib/ejb-ejb30-persistence-extendedem-par1.jar-em logout successful
|#]

[#|2006-02-24T20:20:23.795-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.core|_ThreadID=12;_ThreadName=httpWorkerThread-4848-3;ejb-ejb30-persistence-extendedemApp;|CORE5022: All ejb(s) of [ejb-ejb30-persistence-extendedemApp] were unloaded successfully!|#]

[#|2006-02-24T20:20:23.796-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.admin|_ThreadID=12;_ThreadName=httpWorkerThread-4848-3;success;|ADM1042:Status of dynamic reconfiguration event processing:[success]|#]

[#|2006-02-24T20:20:23.875-0800|INFO|sun-appserver-pe9.0|javax.enterprise.system.tools.admin|_ThreadID=14;_ThreadName=httpWorkerThread-4848-0;success;|ADM1042:Status of dynamic reconfiguration event processing:[success]|#]