persistence@glassfish.java.net

Re: 2 ejb dev tests failing

From: Kenneth Saks <Kenneth.Saks_at_Sun.COM>
Date: Sat, 25 Feb 2006 11:25:12 -0500

Mitesh Meswani wrote:

> 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

There haven't been any recent changes to these tests. Looks like the
provider is incorrectly expecting a transaction during a
non-transactional find operation. Gordon, you'll need to run "ant
startDerby" before running any of the tests under ejb30/persistence
tests. Let me know if you need any more info.

 --ken

>
>
> 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]|#]
>
>
>