********************************************************************************
Beginning Test:  com/sun/ts/tests/jta/ee/txpropagationtest/Client.java#test1_from_ejb
********************************************************************************

02-08-2023 13:47:34:  Harness - harness.executeMode is set to "0"
02-08-2023 13:47:34:  Harness - StandardDeployment14.init()
02-08-2023 13:47:34:  Harness - StandardDeployment14:  Using porting set #1
02-08-2023 13:47:34:  Harness - DeployTestUtil.loadDMFactories called
02-08-2023 13:47:34:  Harness - DeployTestUtil.loadDMFactories using jarfile: target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/openejb-core-9.0.0-SNAPSHOT.jar
02-08-2023 13:47:34:  Harness - loadDeploymentFactories loading factories from file:openejb-core-9.0.0-SNAPSHOT.jar
02-08-2023 13:47:34:  Harness - Looking for manifest entry: J2EE-DeploymentFactory-Implementation-Class
02-08-2023 13:47:34:  Harness - loadDeploymentFactories about to load classes :org.apache.openejb.config.VmDeploymentFactory
02-08-2023 13:47:34:  Harness - Registered DeploymentFactory: OpenEJB - VM
02-08-2023 13:47:34:  Harness - amd Obtained FRESH DeploymentManager
OpenEJBDeploymentManager - connected
02-08-2023 13:47:34:  Harness - Deployed Modules: 

02-08-2023 13:47:34:  Harness - Using porting.ts.deploy2.class.1
[] CONNECT ATTEMPT 249 on port: 40549
[] CONNECT ATTEMPTS FAILED ( 249 ATTEMPTS)
[] START SERVER
OPENEJB_HOME = /home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT
SYSTEM_INFO  = Java 11.0.10; Linux/4.14.225-169.362.amzn2.aarch64
/home/ec2-user/jdk11/bin/java
-XX:+HeapDumpOnOutOfMemoryError
-Djava.locale.providers=COMPAT,SPI
--add-opens=java.base/java.lang=ALL-UNNAMED
--add-opens=java.base/java.io=ALL-UNNAMED
--add-opens=java.base/java.util=ALL-UNNAMED
--add-opens=java.base/java.util.concurrent=ALL-UNNAMED
--add-opens=java.rmi/sun.rmi.transport=ALL-UNNAMED
-Dopenejb.deployer.jndiname=openejb/DeployerBusinessRemote
-Djava.util.logging.config.file=/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/conf/logging.properties
-javaagent:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/openejb-javaagent.jar
-Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager
-Djava.io.tmpdir=/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/temp
-Dcatalina.base=/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT
-Dcatalina.home=/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT
-Dcatalina.ext.dirs=/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib
-Dorg.apache.catalina.STRICT_SERVLET_COMPLIANCE=true
-Dorg.apache.tomcat.util.http.ServerCookie.ALLOW_HTTP_SEPARATORS_IN_V0=true
-Djavax.net.ssl.keyStore=/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/src/test/keystores/clientcert.jks
-Djavax.net.ssl.keyStorePassword=changeit
-Djavax.net.ssl.trustStore=/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/src/test/keystores/ssl-truststore
-Djava.protocol.handler.pkgs=javax.net.ssl
-ea
-classpath
/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/bin/bootstrap.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/bin/tomcat-juli.jar
org.apache.catalina.startup.Bootstrap
start
[] CONNECT ATTEMPT 0 on port: 40549
08-Feb-2023 13:47:34.978 INFO [main] org.apache.openejb.persistence.PersistenceBootstrap.getDefaultProvider Default JPA Provider changed to org.eclipse.persistence.jpa.PersistenceProvider specified by jar:file:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/openejb-core-eclipselink-9.0.0-SNAPSHOT.jar!/META-INF/org.apache.openejb.persistence.PersistenceBootstrap.provider
08-Feb-2023 13:47:35.327 WARNING [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke Match [Server/Service/Engine/Host/Valve] failed to set property [resolveHosts] to [false]
08-Feb-2023 13:47:35.348 INFO [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke Server version name:   Apache Tomcat (TomEE)/10.0.27 (9.0.0-SNAPSHOT)
08-Feb-2023 13:47:35.348 INFO [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke Server built:          Oct 3 2022 14:18:31 UTC
08-Feb-2023 13:47:35.348 INFO [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke Server version number: 10.0.27.0
08-Feb-2023 13:47:35.349 INFO [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke OS Name:               Linux
08-Feb-2023 13:47:35.349 INFO [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke OS Version:            4.14.225-169.362.amzn2.aarch64
08-Feb-2023 13:47:35.349 INFO [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke Architecture:          aarch64
08-Feb-2023 13:47:35.349 INFO [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke Java Home:             /home/ec2-user/jdk-11.0.10+9
08-Feb-2023 13:47:35.350 INFO [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke JVM Version:           11.0.10+9
08-Feb-2023 13:47:35.350 INFO [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke JVM Vendor:            AdoptOpenJDK
08-Feb-2023 13:47:35.350 INFO [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke CATALINA_BASE:         /home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT
08-Feb-2023 13:47:35.350 INFO [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke CATALINA_HOME:         /home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT
08-Feb-2023 13:47:35.351 INFO [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke Command line argument: -XX:+HeapDumpOnOutOfMemoryError
08-Feb-2023 13:47:35.351 INFO [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke Command line argument: -Djava.locale.providers=COMPAT,SPI
08-Feb-2023 13:47:35.352 INFO [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke Command line argument: --add-opens=java.base/java.lang=ALL-UNNAMED
08-Feb-2023 13:47:35.352 INFO [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke Command line argument: --add-opens=java.base/java.io=ALL-UNNAMED
08-Feb-2023 13:47:35.353 INFO [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke Command line argument: --add-opens=java.base/java.util=ALL-UNNAMED
08-Feb-2023 13:47:35.353 INFO [main] jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke Command line argument: --add-opens=java.base/java.util.concurrent=ALL-UNNAMED
08-Feb-2023 13:47:35.353 INFO [main] jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke Command line argument: --add-opens=java.rmi/sun.rmi.transport=ALL-UNNAMED
08-Feb-2023 13:47:35.353 INFO [main] jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke Command line argument: -Dopenejb.deployer.jndiname=openejb/DeployerBusinessRemote
08-Feb-2023 13:47:35.354 INFO [main] jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke Command line argument: -Djava.util.logging.config.file=/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/conf/logging.properties
08-Feb-2023 13:47:35.355 INFO [main] jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke Command line argument: -javaagent:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/openejb-javaagent.jar
08-Feb-2023 13:47:35.355 INFO [main] jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke Command line argument: -Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager
08-Feb-2023 13:47:35.355 INFO [main] jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke Command line argument: -Djava.io.tmpdir=/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/temp
08-Feb-2023 13:47:35.355 INFO [main] jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke Command line argument: -Dcatalina.base=/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT
08-Feb-2023 13:47:35.356 INFO [main] jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke Command line argument: -Dcatalina.home=/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT
08-Feb-2023 13:47:35.356 INFO [main] jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke Command line argument: -Dcatalina.ext.dirs=/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib
08-Feb-2023 13:47:35.356 INFO [main] jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke Command line argument: -Dorg.apache.catalina.STRICT_SERVLET_COMPLIANCE=true
08-Feb-2023 13:47:35.357 INFO [main] jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke Command line argument: -Dorg.apache.tomcat.util.http.ServerCookie.ALLOW_HTTP_SEPARATORS_IN_V0=true
08-Feb-2023 13:47:35.357 INFO [main] jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke Command line argument: -Djavax.net.ssl.keyStore=/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/src/test/keystores/clientcert.jks
08-Feb-2023 13:47:35.357 INFO [main] jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke Command line argument: -Djavax.net.ssl.keyStorePassword=changeit
08-Feb-2023 13:47:35.358 INFO [main] jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke Command line argument: -Djavax.net.ssl.trustStore=/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/src/test/keystores/ssl-truststore
08-Feb-2023 13:47:35.358 INFO [main] jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke Command line argument: -Djava.protocol.handler.pkgs=javax.net.ssl
08-Feb-2023 13:47:35.358 INFO [main] jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke Command line argument: -ea
08-Feb-2023 13:47:35.360 INFO [main] jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke The Apache Tomcat Native library which allows using OpenSSL was not found on the java.library.path: [/usr/java/packages/lib:/lib:/usr/lib]
[] CONNECT ATTEMPT 1 on port: 40549
08-Feb-2023 13:47:35.848 INFO [main] jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke The ["http-nio-44199"] connector has been configured to support HTTP upgrade to [h2c]
08-Feb-2023 13:47:35.848 INFO [main] jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke Initializing ProtocolHandler ["http-nio-44199"]
08-Feb-2023 13:47:35.891 INFO [main] jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke Initializing ProtocolHandler ["https-jsse-nio-41987"]
08-Feb-2023 13:47:36.138 WARNING [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke The trusted certificate with alias [utnuserfirstobjectca [jdk]] and DN [CN=UTN-USERFirst-Object, OU=http://www.usertrust.com, O=The USERTRUST Network, L=Salt Lake City, ST=UT, C=US] is not valid due to [NotAfter: Tue Jul 09 18:40:36 UTC 2019]. Certificates signed by this trusted certificate WILL be accepted
08-Feb-2023 13:47:36.139 WARNING [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke The trusted certificate with alias [globalsignr2ca [jdk]] and DN [CN=GlobalSign, O=GlobalSign, OU=GlobalSign Root CA - R2] is not valid due to [NotAfter: Wed Dec 15 08:00:00 UTC 2021]. Certificates signed by this trusted certificate WILL be accepted
08-Feb-2023 13:47:36.140 WARNING [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke The trusted certificate with alias [identrustdstx3 [jdk]] and DN [CN=DST Root CA X3, O=Digital Signature Trust Co.] is not valid due to [NotAfter: Thu Sep 30 14:01:15 UTC 2021]. Certificates signed by this trusted certificate WILL be accepted
08-Feb-2023 13:47:36.143 WARNING [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke The trusted certificate with alias [addtrustexternalca [jdk]] and DN [CN=AddTrust External CA Root, OU=AddTrust External TTP Network, O=AddTrust AB, C=SE] is not valid due to [NotAfter: Sat May 30 10:48:38 UTC 2020]. Certificates signed by this trusted certificate WILL be accepted
08-Feb-2023 13:47:36.144 WARNING [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke The trusted certificate with alias [verisigntsaca [jdk]] and DN [CN=Thawte Timestamping CA, OU=Thawte Certification, O=Thawte, L=Durbanville, ST=Western Cape, C=ZA] is not valid due to [NotAfter: Fri Jan 01 23:59:59 UTC 2021]. Certificates signed by this trusted certificate WILL be accepted
08-Feb-2023 13:47:36.144 WARNING [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke The trusted certificate with alias [luxtrustglobalrootca [jdk]] and DN [CN=LuxTrust Global Root, O=LuxTrust s.a., C=LU] is not valid due to [NotAfter: Wed Mar 17 09:51:37 UTC 2021]. Certificates signed by this trusted certificate WILL be accepted
08-Feb-2023 13:47:36.145 WARNING [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke The trusted certificate with alias [soneraclass2ca [jdk]] and DN [CN=Sonera Class2 CA, O=Sonera, C=FI] is not valid due to [NotAfter: Tue Apr 06 07:29:40 UTC 2021]. Certificates signed by this trusted certificate WILL be accepted
08-Feb-2023 13:47:36.146 WARNING [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke The trusted certificate with alias [thawtepremiumserverca [jdk]] and DN [EMAILADDRESS=premium-server@thawte.com, CN=Thawte Premium Server CA, OU=Certification Services Division, O=Thawte Consulting cc, L=Cape Town, ST=Western Cape, C=ZA] is not valid due to [NotAfter: Fri Jan 01 23:59:59 UTC 2021]. Certificates signed by this trusted certificate WILL be accepted
08-Feb-2023 13:47:36.146 WARNING [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke The trusted certificate with alias [geotrustglobalca [jdk]] and DN [CN=GeoTrust Global CA, O=GeoTrust Inc., C=US] is not valid due to [NotAfter: Sat May 21 04:00:00 UTC 2022]. Certificates signed by this trusted certificate WILL be accepted
08-Feb-2023 13:47:36.147 WARNING [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke The trusted certificate with alias [quovadisrootca [jdk]] and DN [CN=QuoVadis Root Certification Authority, OU=Root Certification Authority, O=QuoVadis Limited, C=BM] is not valid due to [NotAfter: Wed Mar 17 18:33:33 UTC 2021]. Certificates signed by this trusted certificate WILL be accepted
08-Feb-2023 13:47:36.147 WARNING [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke The trusted certificate with alias [addtrustclass1ca [jdk]] and DN [CN=AddTrust Class 1 CA Root, OU=AddTrust TTP Network, O=AddTrust AB, C=SE] is not valid due to [NotAfter: Sat May 30 10:38:31 UTC 2020]. Certificates signed by this trusted certificate WILL be accepted
08-Feb-2023 13:47:36.147 WARNING [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke The trusted certificate with alias [keynectisrootca [jdk]] and DN [CN=KEYNECTIS ROOT CA, OU=ROOT, O=KEYNECTIS, C=FR] is not valid due to [NotAfter: Tue May 26 00:00:00 UTC 2020]. Certificates signed by this trusted certificate WILL be accepted
08-Feb-2023 13:47:36.148 WARNING [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke The trusted certificate with alias [addtrustqualifiedca [jdk]] and DN [CN=AddTrust Qualified CA Root, OU=AddTrust TTP Network, O=AddTrust AB, C=SE] is not valid due to [NotAfter: Sat May 30 10:44:50 UTC 2020]. Certificates signed by this trusted certificate WILL be accepted
[] CONNECT ATTEMPT 2 on port: 40549
08-Feb-2023 13:47:36.663 INFO [main] org.apache.openejb.util.OptionsLog.info Using 'tomee.remote.support=true'
08-Feb-2023 13:47:36.676 INFO [main] org.apache.openejb.util.OptionsLog.info Using 'openejb.jdbc.datasource-creator=org.apache.tomee.jdbc.TomEEDataSourceCreator'
08-Feb-2023 13:47:36.692 INFO [main] org.apache.openejb.util.OptionsLog.info Using 'openejb.environment.default=true'
08-Feb-2023 13:47:36.706 INFO [main] org.apache.openejb.util.OptionsLog.info Using 'openejb.deploymentId.format={appId}/{ejbJarId}/{ejbName}'
08-Feb-2023 13:47:36.714 INFO [main] org.apache.openejb.util.OptionsLog.info Using 'openejb.vendor.config=glassfish'
08-Feb-2023 13:47:36.791 INFO [main] org.apache.openejb.OpenEJB$Instance.<init> ********************************************************************************
08-Feb-2023 13:47:36.792 INFO [main] org.apache.openejb.OpenEJB$Instance.<init> OpenEJB http://tomee.apache.org/
08-Feb-2023 13:47:36.792 INFO [main] org.apache.openejb.OpenEJB$Instance.<init> Startup: Wed Feb 08 13:47:36 UTC 2023
08-Feb-2023 13:47:36.793 INFO [main] org.apache.openejb.OpenEJB$Instance.<init> Copyright 1999-2021 (C) Apache TomEE Project, All Rights Reserved.
08-Feb-2023 13:47:36.793 INFO [main] org.apache.openejb.OpenEJB$Instance.<init> Version: 9.0.0-SNAPSHOT
08-Feb-2023 13:47:36.793 INFO [main] org.apache.openejb.OpenEJB$Instance.<init> Build date: 20230103
08-Feb-2023 13:47:36.793 INFO [main] org.apache.openejb.OpenEJB$Instance.<init> Build time: 09:10
08-Feb-2023 13:47:36.794 INFO [main] org.apache.openejb.OpenEJB$Instance.<init> ********************************************************************************
08-Feb-2023 13:47:36.795 INFO [main] org.apache.openejb.OpenEJB$Instance.<init> openejb.home = /home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT
08-Feb-2023 13:47:36.795 INFO [main] org.apache.openejb.OpenEJB$Instance.<init> openejb.base = /home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT
08-Feb-2023 13:47:36.799 INFO [main] org.apache.openejb.cdi.CdiBuilder.initializeOWB Created new singletonService org.apache.openejb.cdi.ThreadSingletonServiceImpl@669253b7
08-Feb-2023 13:47:36.802 INFO [main] org.apache.openejb.cdi.CdiBuilder.initializeOWB Succeeded in installing singleton service
08-Feb-2023 13:47:36.842 INFO [main] org.apache.openejb.util.OptionsLog.info Using 'openejb.environment.default=true'
08-Feb-2023 13:47:36.842 INFO [main] org.apache.openejb.util.OptionsLog.info Using 'openejb.deploymentId.format={appId}/{ejbJarId}/{ejbName}'
08-Feb-2023 13:47:36.842 INFO [main] org.apache.openejb.util.OptionsLog.info Using 'openejb.vendor.config=glassfish'
08-Feb-2023 13:47:36.847 INFO [main] org.apache.openejb.config.ConfigurationFactory.init TomEE configuration file is '/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/conf/tomee.xml'
08-Feb-2023 13:47:36.895 INFO [main] org.apache.openejb.config.ConfigurationFactory.configureService Configuring Service(id=Tomcat Security Service, type=SecurityService, provider-id=Tomcat Security Service)
08-Feb-2023 13:47:36.898 INFO [main] org.apache.openejb.config.ConfigurationFactory.configureService Configuring Service(id=Default Transaction Manager, type=TransactionManager, provider-id=Default Transaction Manager)
08-Feb-2023 13:47:36.900 INFO [main] org.apache.openejb.config.ConfigurationFactory.configureService Configuring Service(id=jdbc/securityAPIDB, type=Resource, provider-id=Default JDBC Database)
08-Feb-2023 13:47:36.900 INFO [main] org.apache.openejb.config.ConfigurationFactory.configureService Configuring Service(id=jdbc/DB1, type=Resource, provider-id=Default JDBC Database)
08-Feb-2023 13:47:36.901 INFO [main] org.apache.openejb.config.ConfigurationFactory.configureService Configuring Service(id=jdbc/DB1Unmanaged, type=Resource, provider-id=Default JDBC Database)
08-Feb-2023 13:47:36.902 INFO [main] org.apache.openejb.config.ConfigurationFactory.configureService Configuring Service(id=jdbc/DB, type=Resource, provider-id=Default JDBC Database)
08-Feb-2023 13:47:36.902 INFO [main] org.apache.openejb.config.ConfigurationFactory.configureService Configuring Service(id=jdbc/DB_no_tx, type=Resource, provider-id=Default JDBC Database)
08-Feb-2023 13:47:36.903 INFO [main] org.apache.openejb.config.ConfigurationFactory.configureService Configuring Service(id=MailSession, type=Resource, provider-id=Default Mail Session)
08-Feb-2023 13:47:36.906 INFO [main] org.apache.openejb.config.ConfigurationFactory.configureService Configuring Service(id=CmpContainer, type=Container, provider-id=Default CMP Container)
08-Feb-2023 13:47:36.907 INFO [main] org.apache.openejb.config.ConfigurationFactory.configureService Configuring Service(id=StatefulContainer, type=Container, provider-id=Default Stateful Container)
08-Feb-2023 13:47:36.910 INFO [main] org.apache.openejb.config.ConfigurationFactory.configureService Configuring Service(id=StatelessContainer, type=Container, provider-id=Default Stateless Container)
08-Feb-2023 13:47:36.912 INFO [main] org.apache.openejb.config.ConfigurationFactory.configureService Configuring Service(id=SingletonContainer, type=Container, provider-id=Default Singleton Container)
08-Feb-2023 13:47:36.914 INFO [main] org.apache.openejb.util.OptionsLog.info Using 'openejb.system.apps=true'
08-Feb-2023 13:47:36.947 INFO [main] org.apache.openejb.assembler.classic.Assembler.createRecipe Creating TransactionManager(id=Default Transaction Manager)
08-Feb-2023 13:47:37.009 INFO [main] org.apache.openejb.assembler.classic.Assembler.createRecipe Creating SecurityService(id=Tomcat Security Service)
08-Feb-2023 13:47:37.038 INFO [main] org.apache.openejb.assembler.classic.Assembler.createRecipe Creating Resource(id=jdbc/securityAPIDB)
08-Feb-2023 13:47:37.197 INFO [main] org.apache.openejb.assembler.classic.Assembler.createRecipe Creating Resource(id=jdbc/DB1)
08-Feb-2023 13:47:37.233 INFO [main] org.apache.openejb.assembler.classic.Assembler.createRecipe Creating Resource(id=jdbc/DB1Unmanaged)
08-Feb-2023 13:47:37.280 INFO [main] org.apache.openejb.assembler.classic.Assembler.createRecipe Creating Resource(id=jdbc/DB)
08-Feb-2023 13:47:37.380 INFO [main] org.apache.openejb.assembler.classic.Assembler.createRecipe Creating Resource(id=jdbc/DB_no_tx)
08-Feb-2023 13:47:37.405 INFO [main] org.apache.openejb.assembler.classic.Assembler.createRecipe Creating Resource(id=MailSession)
08-Feb-2023 13:47:37.447 INFO [main] org.apache.openejb.assembler.classic.Assembler.createRecipe Creating Container(id=CmpContainer)
08-Feb-2023 13:47:37.460 WARNING [main] org.apache.openejb.assembler.classic.Assembler.unusedProperty unused property 'Engine' for resource 'CmpContainer'
08-Feb-2023 13:47:37.460 WARNING [main] org.apache.openejb.assembler.classic.Assembler.unusedProperty unused property 'ConnectorName' for resource 'CmpContainer'
08-Feb-2023 13:47:37.464 INFO [main] org.apache.openejb.assembler.classic.Assembler.createRecipe Creating Container(id=StatefulContainer)
08-Feb-2023 13:47:37.487 INFO [main] org.apache.openejb.core.stateful.SimplePassivater.init Using directory /home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/temp for stateful session passivation
08-Feb-2023 13:47:37.500 INFO [main] org.apache.openejb.assembler.classic.Assembler.createRecipe Creating Container(id=StatelessContainer)
08-Feb-2023 13:47:37.506 INFO [main] org.apache.openejb.assembler.classic.Assembler.createRecipe Creating Container(id=SingletonContainer)
08-Feb-2023 13:47:37.510 INFO [main] org.apache.openejb.assembler.classic.Assembler.createApplication Assembling app: openejb
[] CONNECT ATTEMPT 3 on port: 40549
08-Feb-2023 13:47:37.571 INFO [main] org.apache.openejb.util.OptionsLog.info Using 'openejb.jndiname.format={deploymentId}{interfaceType.openejbLegacyName}'
08-Feb-2023 13:47:37.597 INFO [main] org.apache.openejb.assembler.classic.JndiBuilder.bind Jndi(name=openejb/DeployerBusinessRemote) --> Ejb(deployment-id=openejb/Deployer)
08-Feb-2023 13:47:37.610 INFO [main] org.apache.openejb.assembler.classic.JndiBuilder.bind Jndi(name=global/openejb/openejb/openejb/Deployer!org.apache.openejb.assembler.Deployer) --> Ejb(deployment-id=openejb/Deployer)
08-Feb-2023 13:47:37.615 INFO [main] org.apache.openejb.assembler.classic.JndiBuilder.bind Jndi(name=global/openejb/openejb/openejb/Deployer) --> Ejb(deployment-id=openejb/Deployer)
08-Feb-2023 13:47:37.624 INFO [main] org.apache.openejb.assembler.classic.JndiBuilder.bind Jndi(name=openejb/ConfigurationInfoBusinessRemote) --> Ejb(deployment-id=openejb/ConfigurationInfo)
08-Feb-2023 13:47:37.632 INFO [main] org.apache.openejb.assembler.classic.JndiBuilder.bind Jndi(name=global/openejb/openejb/openejb/Deployer!org.apache.openejb.assembler.classic.cmd.ConfigurationInfo) --> Ejb(deployment-id=openejb/ConfigurationInfo)
08-Feb-2023 13:47:37.658 INFO [main] org.apache.openejb.assembler.classic.Assembler.startEjbs Created Ejb(deployment-id=openejb/ConfigurationInfo, ejb-name=openejb/Deployer, container=SingletonContainer)
08-Feb-2023 13:47:37.660 INFO [main] org.apache.openejb.assembler.classic.Assembler.startEjbs Created Ejb(deployment-id=openejb/Deployer, ejb-name=openejb/Deployer, container=SingletonContainer)
08-Feb-2023 13:47:37.660 INFO [main] org.apache.openejb.assembler.classic.Assembler.startEjbs Started Ejb(deployment-id=openejb/ConfigurationInfo, ejb-name=openejb/Deployer, container=SingletonContainer)
08-Feb-2023 13:47:37.660 INFO [main] org.apache.openejb.assembler.classic.Assembler.startEjbs Started Ejb(deployment-id=openejb/Deployer, ejb-name=openejb/Deployer, container=SingletonContainer)
08-Feb-2023 13:47:37.666 INFO [main] org.apache.openejb.assembler.classic.Assembler.deployMBean Deployed MBean(openejb.user.mbeans:application=openejb,group=org.apache.openejb.assembler.monitoring,name=JMXDeployer)
08-Feb-2023 13:47:37.668 WARNING [main] org.apache.batchee.container.services.ServicesManager.init You didn't specify org.apache.batchee.jmx.application and JMX is already registered, skipping
08-Feb-2023 13:47:37.669 INFO [main] org.apache.openejb.assembler.classic.Assembler.createApplication Deployed Application(path=openejb)
08-Feb-2023 13:47:37.669 INFO [main] org.apache.openejb.assembler.classic.Assembler.createApplication Naming context of deployed Application(path=openejb) is set to read only
08-Feb-2023 13:47:37.703 INFO [main] org.apache.openejb.server.ServiceManager.addProperties Using legacy configuration path for new service: /home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/conf/development.cxf.properties
08-Feb-2023 13:47:37.712 INFO [main] org.apache.openejb.server.ServiceManager.initServer Creating ServerService(id=cxf)
08-Feb-2023 13:47:37.902 INFO [main] org.apache.openejb.server.ServiceManager.addProperties Using legacy configuration path for new service: /home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/conf/cxf-rs.properties
08-Feb-2023 13:47:37.902 INFO [main] org.apache.openejb.server.ServiceManager.addProperties Using legacy configuration path for new service: /home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/conf/development.cxf-rs.properties
08-Feb-2023 13:47:37.903 INFO [main] org.apache.openejb.server.ServiceManager.initServer Creating ServerService(id=cxf-rs)
08-Feb-2023 13:47:37.918 INFO [main] org.apache.openejb.server.ServiceManager.addProperties Using legacy configuration path for new service: /home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/conf/derbynet.properties
08-Feb-2023 13:47:37.919 INFO [main] org.apache.openejb.server.ServiceManager.addProperties Using legacy configuration path for new service: /home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/conf/development.derbynet.properties
08-Feb-2023 13:47:37.919 INFO [main] org.apache.openejb.server.ServiceManager.initServer Creating ServerService(id=derbynet)
08-Feb-2023 13:47:37.922 INFO [main] org.apache.openejb.server.ServiceManager.addProperties Using legacy configuration path for new service: /home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/conf/development.hsql.properties
08-Feb-2023 13:47:38.099 INFO [main] org.apache.openejb.server.SimpleServiceManager.start   ** Bound Services **
08-Feb-2023 13:47:38.102 INFO [main] org.apache.openejb.server.SimpleServiceManager.printRow   NAME                 IP              PORT  
08-Feb-2023 13:47:38.105 INFO [main] org.apache.openejb.server.SimpleServiceManager.printRow   derbynet             0.0.0.0         4205  
08-Feb-2023 13:47:38.118 INFO [main] org.apache.openejb.server.SimpleServiceManager.start -------
08-Feb-2023 13:47:38.118 INFO [main] org.apache.openejb.server.SimpleServiceManager.start Ready!
08-Feb-2023 13:47:38.119 INFO [main] jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke Server initialization in [3092] milliseconds
08-Feb-2023 13:47:38.184 INFO [main] org.apache.tomee.catalina.OpenEJBNamingContextListener.bindResource Importing a Tomcat Resource with id 'UserDatabase' of type 'org.apache.catalina.UserDatabase'.
08-Feb-2023 13:47:38.185 INFO [main] org.apache.openejb.assembler.classic.Assembler.createRecipe Creating Resource(id=UserDatabase)
08-Feb-2023 13:47:38.190 INFO [main] jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke Starting service [Catalina]
08-Feb-2023 13:47:38.191 INFO [main] jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke Starting Servlet engine: [Apache Tomcat (TomEE)/10.0.27 (9.0.0-SNAPSHOT)]
08-Feb-2023 13:47:38.281 INFO [main] jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke Starting ProtocolHandler ["http-nio-44199"]
08-Feb-2023 13:47:38.300 INFO [main] jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke Starting ProtocolHandler ["https-jsse-nio-41987"]
08-Feb-2023 13:47:38.306 INFO [main] jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke Server startup in [186] milliseconds
[] CONNECT ATTEMPT 4 on port: 40549
08-Feb-2023 13:47:38.549 WARNING [main] jdk.internal.reflect.NativeMethodAccessorImpl.invoke Invalid shutdown command [] received
[] CONNECTED IN 4
OpenEJB - Initialized Deployment helper
OpenEJB - initialized JMSAdmin helper
02-08-2023 13:47:38:  Harness - AutoDeployment.init()
02-08-2023 13:47:38:  Harness - AutoDeployment:  Using porting set #2
02-08-2023 13:47:38:  Harness - Using porting.ts.deploy2.class.2
02-08-2023 13:47:38:  Harness - ss:  modified runtime.xml
Loading /home/ec2-user/jakartaee91tck/src/com/sun/ts/lib/harness/commonarchives.properties
getCommonApps - relativeTestDir = com/sun/ts/tests/jta/ee/txpropagationtest
Loading /home/ec2-user/jakartaee91tck/src/com/sun/ts/lib/harness/rebuildable.properties
Loading /home/ec2-user/jakartaee91tck/src/vehicle.properties
02-08-2023 13:47:38:  Harness - Undeploying apps...
02-08-2023 13:47:38:  Harness - StandardDeployment14.isDeployed()
02-08-2023 13:47:38:  Harness - Deployed Modules: 

02-08-2023 13:47:38:  Harness - StandardDeployment14.isDeployed()
02-08-2023 13:47:38:  Harness - Deployed Modules: 

02-08-2023 13:47:38:  Harness - StandardDeployment14.isDeployed()
02-08-2023 13:47:38:  Harness - Deployed Modules: 

Undeployed apps from - /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest
02-08-2023 13:47:38:  Harness - Search for s1as runtime files match:`jta_ejb_vehicle.ear`
02-08-2023 13:47:38:  Harness - Valid runtime files after sweep:
02-08-2023 13:47:38:  Harness - /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_ee_txpropagate1_ejb.jar.sun-ejb-jar.xml
02-08-2023 13:47:38:  Harness - /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_ejb_vehicle_client.jar.sun-application-client.xml
02-08-2023 13:47:38:  Harness - /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_ejb_vehicle_ejb.jar.sun-ejb-jar.xml
02-08-2023 13:47:38:  Harness - Search for s1as runtime files match:`jta_jsp_vehicle.ear`
02-08-2023 13:47:38:  Harness - Valid runtime files after sweep:
02-08-2023 13:47:38:  Harness - /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_ee_txpropagate3_ejb.jar.sun-ejb-jar.xml
02-08-2023 13:47:38:  Harness - /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_jsp_vehicle_web.war.sun-web.xml
02-08-2023 13:47:39:  Harness - Search for s1as runtime files match:`jta_servlet_vehicle.ear`
02-08-2023 13:47:39:  Harness - Valid runtime files after sweep:
02-08-2023 13:47:39:  Harness - /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_ee_txpropagate2_ejb.jar.sun-ejb-jar.xml
02-08-2023 13:47:39:  Harness - /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_servlet_vehicle_web.war.sun-web.xml
02-08-2023 13:47:39:  Harness - Deploying apps for forward rebuildable...
02-08-2023 13:47:39:  Harness - Search for s1as runtime files match:`jta_ejb_vehicle.ear`
02-08-2023 13:47:39:  Harness - Valid runtime files after sweep:
02-08-2023 13:47:39:  Harness - /home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/harnesstmp//tmp/jta_ee_txpropagate1_ejb.jar.sun-ejb-jar.xml
02-08-2023 13:47:39:  Harness - /home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/harnesstmp//tmp/jta_ejb_vehicle_client.jar.sun-application-client.xml
02-08-2023 13:47:39:  Harness - /home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/harnesstmp//tmp/jta_ejb_vehicle_ejb.jar.sun-ejb-jar.xml
02-08-2023 13:47:39:  Harness - StandardDeployment14.deploy()
02-08-2023 13:47:39:  Harness - Starting to distribute:  /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_ejb_vehicle.ear
OpenEJB - module: /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_ejb_vehicle.ear
02-08-2023 13:47:39:  Harness - file: /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_ejb_vehicle.ear
02-08-2023 13:47:39:  Harness - plan: java.io.ByteArrayInputStream@4d1d10d6
02-08-2023 13:47:39:  Harness - amd Obtained CACHED DeploymentManager
OpenEJBDeploymentManager - connected
02-08-2023 13:47:39:  Harness - amd Obtained CACHED DeploymentManager
OpenEJBDeploymentManager - connected
Feb 08, 2023 1:47:39 PM org.apache.openejb.client.EventLogger log
INFO: RemoteInitialContextCreated{providerUri=http://localhost:44199/tomee/ejb}
08-Feb-2023 13:47:39.883 INFO [http-nio-44199-exec-3] org.apache.openejb.util.JarExtractor.extract Extracting jar: /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_ejb_vehicle.ear
08-Feb-2023 13:47:39.893 INFO [http-nio-44199-exec-3] org.apache.openejb.util.JarExtractor.extract Extracted path: /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_ejb_vehicle
08-Feb-2023 13:47:40.019 INFO [http-nio-44199-exec-3] org.apache.openejb.util.OptionsLog.info Using 'openejb.deployments.classpath.filter.systemapps=false'
08-Feb-2023 13:47:40.146 INFO [http-nio-44199-exec-3] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:40.165 INFO [http-nio-44199-exec-3] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:40.167 INFO [http-nio-44199-exec-3] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:40.423 INFO [http-nio-44199-exec-3] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:41.207 INFO [http-nio-44199-exec-3] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:41.246 INFO [http-nio-44199-exec-3] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:41.255 INFO [http-nio-44199-exec-3] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:41.274 INFO [http-nio-44199-exec-3] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:41.276 INFO [http-nio-44199-exec-3] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:41.281 INFO [http-nio-44199-exec-3] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:41.388 INFO [http-nio-44199-exec-3] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:41.407 INFO [http-nio-44199-exec-3] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:41.457 INFO [http-nio-44199-exec-3] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:41.464 INFO [http-nio-44199-exec-3] org.apache.openejb.config.DeploymentsResolver.loadFromClasspath Searched 13 classpath urls in 1418 milliseconds.  Average 109 milliseconds per url.
WARNING: An illegal reflective access operation has occurred
WARNING: Illegal reflective access by org.apache.openejb.ClassLoaderUtil (file:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/openejb-core-9.0.0-SNAPSHOT.jar) to field sun.net.www.protocol.jar.JarFileFactory.fileCache
WARNING: Please consider reporting this to the maintainers of org.apache.openejb.ClassLoaderUtil
WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations
WARNING: All illegal access operations will be denied in a future release
08-Feb-2023 13:47:41.473 INFO [http-nio-44199-exec-3] org.apache.openejb.util.OptionsLog.info Using 'openejb.environment.default=true'
08-Feb-2023 13:47:41.473 INFO [http-nio-44199-exec-3] org.apache.openejb.util.OptionsLog.info Using 'openejb.deploymentId.format={appId}/{ejbJarId}/{ejbName}'
08-Feb-2023 13:47:41.473 INFO [http-nio-44199-exec-3] org.apache.openejb.util.OptionsLog.info Using 'openejb.vendor.config=glassfish'
08-Feb-2023 13:47:41.474 INFO [http-nio-44199-exec-3] org.apache.openejb.config.ConfigurationFactory.configureApplication Configuring enterprise application: /home/ec2-user/jakartaeetck-9.1.0-2021-04-20.1739/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_ejb_vehicle
08-Feb-2023 13:47:41.482 INFO [http-nio-44199-exec-3] org.apache.openejb.util.OptionsLog.info Using 'openejb.classloader.forced-skip=com.sun.ts.tests.jaspic.tssv.,com.sun.javatest'
08-Feb-2023 13:47:41.482 INFO [http-nio-44199-exec-3] org.apache.openejb.util.OptionsLog.info Using 'openejb.classloader.forced-load=com.sun.ts.tests.'
08-Feb-2023 13:47:41.482 INFO [http-nio-44199-exec-3] org.apache.openejb.util.OptionsLog.info Using 'openejb.classloader.filterable-resources=META-INF/services/jakarta.validation.spi.ValidationProvider,META-INF/services/jakarta.ws.rs.client.ClientBuilder,META-INF/services/jakarta.json.spi.JsonProvider,META-INF/services/javax.cache.spi.CachingProvider,META-INF/javamail.default.providers,META-INF/javamail.default.address.map,META-INF/javamail.charset.map,META-INF/mailcap,org/slf4j/impl/StaticLoggerBinder.class'
08-Feb-2023 13:47:41.553 INFO [http-nio-44199-exec-3] org.apache.openejb.config.InitEjbDeployments.deploy Auto-deploying ejb com_sun_ts_tests_common_vehicle_ejb_EJBVehicle: EjbDeployment(deployment-id=jta_ejb_vehicle/jta_ejb_vehicle_ejb/com_sun_ts_tests_common_vehicle_ejb_EJBVehicle)
08-Feb-2023 13:47:41.554 INFO [http-nio-44199-exec-3] org.apache.openejb.config.InitEjbDeployments.deploy Auto-deploying ejb jta_ejb_TxRequired_TxBeanEJB1: EjbDeployment(deployment-id=jta_ejb_vehicle/jta_ee_txpropagate1_ejb/jta_ejb_TxRequired_TxBeanEJB1)
08-Feb-2023 13:47:41.557 INFO [http-nio-44199-exec-3] org.apache.openejb.config.AutoConfig.processResourceRef Auto-linking resource-ref 'jdbc/DB1' in bean jta_ejb_vehicle/jta_ejb_vehicle_ejb/com_sun_ts_tests_common_vehicle_ejb_EJBVehicle to Resource(id=jdbc/DB1)
08-Feb-2023 13:47:41.557 INFO [http-nio-44199-exec-3] org.apache.openejb.config.AutoConfig.processResourceRef Auto-linking resource-ref 'jdbc/DB1' in bean jta_ejb_vehicle/jta_ee_txpropagate1_ejb/jta_ejb_TxRequired_TxBeanEJB1 to Resource(id=jdbc/DB1)
08-Feb-2023 13:47:41.558 INFO [http-nio-44199-exec-3] org.apache.openejb.util.OptionsLog.info Using 'openejb.descriptors.output=false'
08-Feb-2023 13:47:41.558 INFO [http-nio-44199-exec-3] org.apache.openejb.util.OptionsLog.info Using 'openejb.descriptors.output=false'
08-Feb-2023 13:47:41.558 INFO [http-nio-44199-exec-3] org.apache.openejb.util.OptionsLog.info Using 'openejb.descriptors.output=false'
08-Feb-2023 13:47:41.571 INFO [http-nio-44199-exec-3] org.apache.openejb.config.AppInfoBuilder.build Enterprise application "/home/ec2-user/jakartaeetck-9.1.0-2021-04-20.1739/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_ejb_vehicle" loaded.
08-Feb-2023 13:47:41.575 INFO [http-nio-44199-exec-3] org.apache.openejb.assembler.classic.Assembler.createAppClassLoader Creating dedicated application classloader for jta_ejb_vehicle
08-Feb-2023 13:47:41.575 INFO [http-nio-44199-exec-3] org.apache.openejb.assembler.classic.Assembler.createApplication Assembling app: /home/ec2-user/jakartaeetck-9.1.0-2021-04-20.1739/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_ejb_vehicle
08-Feb-2023 13:47:41.593 INFO [http-nio-44199-exec-3] org.apache.openejb.assembler.classic.JndiBuilder.bind Jndi(name=jta_ejb_vehicle/jta_ejb_vehicle_ejb/com_sun_ts_tests_common_vehicle_ejb_EJBVehicleRemoteHome) --> Ejb(deployment-id=jta_ejb_vehicle/jta_ejb_vehicle_ejb/com_sun_ts_tests_common_vehicle_ejb_EJBVehicle)
08-Feb-2023 13:47:41.593 INFO [http-nio-44199-exec-3] org.apache.openejb.assembler.classic.JndiBuilder.bind Jndi(name=global/jta_ejb_vehicle/jta_ejb_vehicle_ejb/com_sun_ts_tests_common_vehicle_ejb_EJBVehicle!com.sun.ts.tests.common.vehicle.ejb.EJBVehicleHome) --> Ejb(deployment-id=jta_ejb_vehicle/jta_ejb_vehicle_ejb/com_sun_ts_tests_common_vehicle_ejb_EJBVehicle)
08-Feb-2023 13:47:41.594 INFO [http-nio-44199-exec-3] org.apache.openejb.assembler.classic.JndiBuilder.bind Jndi(name=global/jta_ejb_vehicle/jta_ejb_vehicle_ejb/com_sun_ts_tests_common_vehicle_ejb_EJBVehicle) --> Ejb(deployment-id=jta_ejb_vehicle/jta_ejb_vehicle_ejb/com_sun_ts_tests_common_vehicle_ejb_EJBVehicle)
08-Feb-2023 13:47:41.599 INFO [http-nio-44199-exec-3] org.apache.openejb.assembler.classic.JndiBuilder.bind Jndi(name=jta_ejb_vehicle/jta_ee_txpropagate1_ejb/jta_ejb_TxRequired_TxBeanEJB1RemoteHome) --> Ejb(deployment-id=jta_ejb_vehicle/jta_ee_txpropagate1_ejb/jta_ejb_TxRequired_TxBeanEJB1)
08-Feb-2023 13:47:41.599 INFO [http-nio-44199-exec-3] org.apache.openejb.assembler.classic.JndiBuilder.bind Jndi(name=global/jta_ejb_vehicle/jta_ee_txpropagate1_ejb/jta_ejb_TxRequired_TxBeanEJB1!com.sun.ts.tests.jta.ee.txpropagationtest.TxBeanHome) --> Ejb(deployment-id=jta_ejb_vehicle/jta_ee_txpropagate1_ejb/jta_ejb_TxRequired_TxBeanEJB1)
08-Feb-2023 13:47:41.599 INFO [http-nio-44199-exec-3] org.apache.openejb.assembler.classic.JndiBuilder.bind Jndi(name=global/jta_ejb_vehicle/jta_ee_txpropagate1_ejb/jta_ejb_TxRequired_TxBeanEJB1) --> Ejb(deployment-id=jta_ejb_vehicle/jta_ee_txpropagate1_ejb/jta_ejb_TxRequired_TxBeanEJB1)
08-Feb-2023 13:47:41.658 INFO [http-nio-44199-exec-3] org.apache.openejb.assembler.classic.ValidatorBuilder.getConfig Ignoring XML Configuration for validator org.apache.bval.jsr.ConfigurationImpl
08-Feb-2023 13:47:41.702 INFO [http-nio-44199-exec-3] org.apache.openejb.assembler.classic.Assembler.startEjbs Created Ejb(deployment-id=jta_ejb_vehicle/jta_ejb_vehicle_ejb/com_sun_ts_tests_common_vehicle_ejb_EJBVehicle, ejb-name=com_sun_ts_tests_common_vehicle_ejb_EJBVehicle, container=StatefulContainer)
08-Feb-2023 13:47:41.713 INFO [http-nio-44199-exec-3] org.apache.openejb.assembler.classic.Assembler.startEjbs Created Ejb(deployment-id=jta_ejb_vehicle/jta_ee_txpropagate1_ejb/jta_ejb_TxRequired_TxBeanEJB1, ejb-name=jta_ejb_TxRequired_TxBeanEJB1, container=StatefulContainer)
08-Feb-2023 13:47:41.714 INFO [http-nio-44199-exec-3] org.apache.openejb.assembler.classic.Assembler.startEjbs Started Ejb(deployment-id=jta_ejb_vehicle/jta_ejb_vehicle_ejb/com_sun_ts_tests_common_vehicle_ejb_EJBVehicle, ejb-name=com_sun_ts_tests_common_vehicle_ejb_EJBVehicle, container=StatefulContainer)
08-Feb-2023 13:47:41.714 INFO [http-nio-44199-exec-3] org.apache.openejb.assembler.classic.Assembler.startEjbs Started Ejb(deployment-id=jta_ejb_vehicle/jta_ee_txpropagate1_ejb/jta_ejb_TxRequired_TxBeanEJB1, ejb-name=jta_ejb_TxRequired_TxBeanEJB1, container=StatefulContainer)
08-Feb-2023 13:47:41.716 WARNING [http-nio-44199-exec-3] org.apache.batchee.container.services.ServicesManager.init You didn't specify org.apache.batchee.jmx.application and JMX is already registered, skipping
08-Feb-2023 13:47:41.718 INFO [http-nio-44199-exec-3] org.apache.openejb.assembler.classic.Assembler.createApplication Deployed Application(path=/home/ec2-user/jakartaeetck-9.1.0-2021-04-20.1739/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_ejb_vehicle)
08-Feb-2023 13:47:41.718 INFO [http-nio-44199-exec-3] org.apache.openejb.assembler.classic.Assembler.createApplication Naming context of deployed Application(path=/home/ec2-user/jakartaeetck-9.1.0-2021-04-20.1739/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_ejb_vehicle) is set to read only
02-08-2023 13:47:41:  Harness - $$$$$$$$$$ Deployment SUCCEEDED for "/home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_ejb_vehicle.ear"
OpenEJB - Distribute returned moduleID /home/ec2-user/jakartaeetck-9.1.0-2021-04-20.1739/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_ejb_vehicle
02-08-2023 13:47:41:  Harness - amd Obtained CACHED DeploymentManager
OpenEJBDeploymentManager - connected
02-08-2023 13:47:41:  Harness - amd Obtained CACHED DeploymentManager
OpenEJBDeploymentManager - connected
02-08-2023 13:47:41:  Harness - Search for s1as runtime files match:`jta_jsp_vehicle.ear`
02-08-2023 13:47:41:  Harness - Valid runtime files after sweep:
02-08-2023 13:47:41:  Harness - /home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/harnesstmp//tmp/jta_ee_txpropagate3_ejb.jar.sun-ejb-jar.xml
02-08-2023 13:47:41:  Harness - /home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/harnesstmp//tmp/jta_jsp_vehicle_web.war.sun-web.xml
02-08-2023 13:47:42:  Harness - StandardDeployment14.deploy()
02-08-2023 13:47:42:  Harness - Starting to distribute:  /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_jsp_vehicle.ear
OpenEJB - module: /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_jsp_vehicle.ear
02-08-2023 13:47:42:  Harness - file: /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_jsp_vehicle.ear
02-08-2023 13:47:42:  Harness - plan: java.io.ByteArrayInputStream@47fb6611
02-08-2023 13:47:42:  Harness - amd Obtained CACHED DeploymentManager
OpenEJBDeploymentManager - connected
02-08-2023 13:47:42:  Harness - amd Obtained CACHED DeploymentManager
OpenEJBDeploymentManager - connected
08-Feb-2023 13:47:42.036 INFO [http-nio-44199-exec-5] org.apache.openejb.util.JarExtractor.extract Extracting jar: /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_jsp_vehicle.ear
08-Feb-2023 13:47:42.037 INFO [http-nio-44199-exec-5] org.apache.openejb.util.JarExtractor.extract Extracted path: /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_jsp_vehicle
08-Feb-2023 13:47:42.055 INFO [http-nio-44199-exec-5] org.apache.openejb.util.JarExtractor.extract Extracting jar: /home/ec2-user/jakartaeetck-9.1.0-2021-04-20.1739/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_jsp_vehicle/jta_jsp_vehicle_web.war
08-Feb-2023 13:47:42.062 INFO [http-nio-44199-exec-5] org.apache.openejb.util.JarExtractor.extract Extracted path: /home/ec2-user/jakartaeetck-9.1.0-2021-04-20.1739/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_jsp_vehicle/jta_jsp_vehicle_web
08-Feb-2023 13:47:42.139 INFO [http-nio-44199-exec-5] org.apache.openejb.util.OptionsLog.info Using 'openejb.deployments.classpath.filter.systemapps=false'
08-Feb-2023 13:47:42.289 INFO [http-nio-44199-exec-5] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:42.307 INFO [http-nio-44199-exec-5] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:42.309 INFO [http-nio-44199-exec-5] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:42.540 INFO [http-nio-44199-exec-5] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:43.232 INFO [http-nio-44199-exec-5] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:43.260 INFO [http-nio-44199-exec-5] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:43.271 INFO [http-nio-44199-exec-5] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:43.286 INFO [http-nio-44199-exec-5] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:43.287 INFO [http-nio-44199-exec-5] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:43.290 INFO [http-nio-44199-exec-5] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:43.366 INFO [http-nio-44199-exec-5] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:43.380 INFO [http-nio-44199-exec-5] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:43.418 INFO [http-nio-44199-exec-5] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:43.418 INFO [http-nio-44199-exec-5] org.apache.openejb.config.DeploymentsResolver.loadFromClasspath Searched 13 classpath urls in 1263 milliseconds.  Average 97 milliseconds per url.
08-Feb-2023 13:47:43.420 INFO [http-nio-44199-exec-5] org.apache.openejb.util.OptionsLog.info Using 'openejb.environment.default=true'
08-Feb-2023 13:47:43.421 INFO [http-nio-44199-exec-5] org.apache.openejb.util.OptionsLog.info Using 'openejb.deploymentId.format={appId}/{ejbJarId}/{ejbName}'
08-Feb-2023 13:47:43.421 INFO [http-nio-44199-exec-5] org.apache.openejb.util.OptionsLog.info Using 'openejb.vendor.config=glassfish'
08-Feb-2023 13:47:43.421 INFO [http-nio-44199-exec-5] org.apache.openejb.config.ConfigurationFactory.configureApplication Configuring enterprise application: /home/ec2-user/jakartaeetck-9.1.0-2021-04-20.1739/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_jsp_vehicle
08-Feb-2023 13:47:43.460 INFO [http-nio-44199-exec-5] org.apache.openejb.config.InitEjbDeployments.deploy Auto-deploying ejb jta_ejb_TxRequired_TxBeanEJB3: EjbDeployment(deployment-id=jta_jsp_vehicle/jta_ee_txpropagate3_ejb/jta_ejb_TxRequired_TxBeanEJB3)
08-Feb-2023 13:47:43.463 INFO [http-nio-44199-exec-5] org.apache.openejb.config.AutoConfig.processResourceRef Auto-linking resource-ref 'jdbc/DB1' in bean jta_jsp_vehicle/jta_ee_txpropagate3_ejb/jta_ejb_TxRequired_TxBeanEJB3 to Resource(id=jdbc/DB1)
08-Feb-2023 13:47:43.464 INFO [http-nio-44199-exec-5] org.apache.openejb.config.ConfigurationFactory.configureService Configuring Service(id=Default Managed Container, type=Container, provider-id=Default Managed Container)
08-Feb-2023 13:47:43.464 INFO [http-nio-44199-exec-5] org.apache.openejb.config.AutoConfig.createContainer Auto-creating a container for bean jta_jsp_vehicle/jta_jsp_vehicle_web/jta_jsp_vehicle_web.Comp50684564: Container(type=MANAGED, id=Default Managed Container)
08-Feb-2023 13:47:43.465 INFO [http-nio-44199-exec-5] org.apache.openejb.config.AutoConfig.processResourceRef Auto-linking resource-ref 'jdbc/DB1' in bean jta_jsp_vehicle/jta_jsp_vehicle_web/jta_jsp_vehicle_web.Comp50684564 to Resource(id=jdbc/DB1)
08-Feb-2023 13:47:43.474 INFO [http-nio-44199-exec-5] org.apache.openejb.config.ConfigurationFactory.configureService Configuring Service(id=comp/DefaultManagedExecutorService, type=Resource, provider-id=Default Executor Service)
08-Feb-2023 13:47:43.475 INFO [http-nio-44199-exec-5] org.apache.openejb.config.AutoConfig.logAutoCreateResource Auto-creating a Resource with id 'comp/DefaultManagedExecutorService' of type 'jakarta.enterprise.concurrent.ManagedExecutorService' for 'jta_jsp_vehicle/jta_jsp_vehicle_web/jta_jsp_vehicle_web.Comp50684564'.
08-Feb-2023 13:47:43.475 INFO [http-nio-44199-exec-5] org.apache.openejb.config.AutoConfig.processResourceEnvRef Auto-linking resource-env-ref 'java:comp/DefaultManagedExecutorService' in bean jta_jsp_vehicle/jta_jsp_vehicle_web/jta_jsp_vehicle_web.Comp50684564 to Resource(id=comp/DefaultManagedExecutorService)
08-Feb-2023 13:47:43.476 INFO [http-nio-44199-exec-5] org.apache.openejb.config.ConfigurationFactory.configureService Configuring Service(id=comp/DefaultManagedScheduledExecutorService, type=Resource, provider-id=Default Scheduled Executor Service)
08-Feb-2023 13:47:43.477 INFO [http-nio-44199-exec-5] org.apache.openejb.config.AutoConfig.logAutoCreateResource Auto-creating a Resource with id 'comp/DefaultManagedScheduledExecutorService' of type 'jakarta.enterprise.concurrent.ManagedScheduledExecutorService' for 'jta_jsp_vehicle/jta_jsp_vehicle_web/jta_jsp_vehicle_web.Comp50684564'.
08-Feb-2023 13:47:43.477 INFO [http-nio-44199-exec-5] org.apache.openejb.config.AutoConfig.processResourceEnvRef Auto-linking resource-env-ref 'java:comp/DefaultManagedScheduledExecutorService' in bean jta_jsp_vehicle/jta_jsp_vehicle_web/jta_jsp_vehicle_web.Comp50684564 to Resource(id=comp/DefaultManagedScheduledExecutorService)
08-Feb-2023 13:47:43.478 INFO [http-nio-44199-exec-5] org.apache.openejb.config.ConfigurationFactory.configureService Configuring Service(id=comp/DefaultManagedThreadFactory, type=Resource, provider-id=Default Managed Thread Factory)
08-Feb-2023 13:47:43.478 INFO [http-nio-44199-exec-5] org.apache.openejb.config.AutoConfig.logAutoCreateResource Auto-creating a Resource with id 'comp/DefaultManagedThreadFactory' of type 'jakarta.enterprise.concurrent.ManagedThreadFactory' for 'jta_jsp_vehicle/jta_jsp_vehicle_web/jta_jsp_vehicle_web.Comp50684564'.
08-Feb-2023 13:47:43.478 INFO [http-nio-44199-exec-5] org.apache.openejb.config.AutoConfig.processResourceEnvRef Auto-linking resource-env-ref 'java:comp/DefaultManagedThreadFactory' in bean jta_jsp_vehicle/jta_jsp_vehicle_web/jta_jsp_vehicle_web.Comp50684564 to Resource(id=comp/DefaultManagedThreadFactory)
08-Feb-2023 13:47:43.479 INFO [http-nio-44199-exec-5] org.apache.openejb.config.ConfigurationFactory.configureService Configuring Service(id=comp/DefaultContextService, type=Resource, provider-id=Default Context Service)
08-Feb-2023 13:47:43.479 INFO [http-nio-44199-exec-5] org.apache.openejb.config.AutoConfig.logAutoCreateResource Auto-creating a Resource with id 'comp/DefaultContextService' of type 'jakarta.enterprise.concurrent.ContextService' for 'jta_jsp_vehicle/jta_jsp_vehicle_web/jta_jsp_vehicle_web.Comp50684564'.
08-Feb-2023 13:47:43.479 INFO [http-nio-44199-exec-5] org.apache.openejb.config.AutoConfig.processResourceEnvRef Auto-linking resource-env-ref 'java:comp/DefaultContextService' in bean jta_jsp_vehicle/jta_jsp_vehicle_web/jta_jsp_vehicle_web.Comp50684564 to Resource(id=comp/DefaultContextService)
08-Feb-2023 13:47:43.480 INFO [http-nio-44199-exec-5] org.apache.openejb.config.ConfigurationFactory.configureService Configuring Service(id=comp/DefaultJMSConnectionFactory, type=Resource, provider-id=Default JMS Connection Factory)
08-Feb-2023 13:47:43.480 INFO [http-nio-44199-exec-5] org.apache.openejb.config.AutoConfig.logAutoCreateResource Auto-creating a Resource with id 'comp/DefaultJMSConnectionFactory' of type 'jakarta.jms.ConnectionFactory' for 'jta_jsp_vehicle/jta_jsp_vehicle_web/jta_jsp_vehicle_web.Comp50684564'.
08-Feb-2023 13:47:43.488 INFO [http-nio-44199-exec-5] org.apache.openejb.config.ConfigurationFactory.configureService Configuring Service(id=Default JMS Resource Adapter, type=Resource, provider-id=Default JMS Resource Adapter)
08-Feb-2023 13:47:43.489 INFO [http-nio-44199-exec-5] org.apache.openejb.config.ConfigurationFactory.configureService Configuring Service(id=Default Unmanaged JDBC Database, type=Resource, provider-id=Default Unmanaged JDBC Database)
08-Feb-2023 13:47:43.489 INFO [http-nio-44199-exec-5] org.apache.openejb.config.AutoConfig.processResourceEnvRef Auto-linking resource-env-ref 'java:comp/DefaultJMSConnectionFactory' in bean jta_jsp_vehicle/jta_jsp_vehicle_web/jta_jsp_vehicle_web.Comp50684564 to Resource(id=comp/DefaultJMSConnectionFactory)
08-Feb-2023 13:47:43.490 INFO [http-nio-44199-exec-5] org.apache.openejb.util.OptionsLog.info Using 'openejb.descriptors.output=false'
08-Feb-2023 13:47:43.490 INFO [http-nio-44199-exec-5] org.apache.openejb.util.OptionsLog.info Using 'openejb.descriptors.output=false'
08-Feb-2023 13:47:43.491 INFO [http-nio-44199-exec-5] org.apache.openejb.util.OptionsLog.info Using 'openejb.descriptors.output=false'
08-Feb-2023 13:47:43.493 INFO [http-nio-44199-exec-5] org.apache.openejb.config.AppInfoBuilder.build Enterprise application "/home/ec2-user/jakartaeetck-9.1.0-2021-04-20.1739/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_jsp_vehicle" loaded.
08-Feb-2023 13:47:43.496 INFO [http-nio-44199-exec-5] org.apache.openejb.assembler.classic.Assembler.createAppClassLoader Creating dedicated application classloader for jta_jsp_vehicle
08-Feb-2023 13:47:43.498 INFO [http-nio-44199-exec-5] org.apache.openejb.assembler.classic.Assembler.createRecipe Creating Resource(id=comp/DefaultContextService)
08-Feb-2023 13:47:43.503 INFO [http-nio-44199-exec-5] org.apache.openejb.assembler.classic.Assembler.createRecipe Creating Resource(id=Default Unmanaged JDBC Database)
08-Feb-2023 13:47:43.785 INFO [http-nio-44199-exec-5] org.apache.openejb.assembler.classic.Assembler.createRecipe Creating Resource(id=Default JMS Resource Adapter)
08-Feb-2023 13:47:43.804 INFO [http-nio-44199-exec-5] org.apache.openejb.assembler.classic.Assembler.doCreateResource Thread pool size for 'Default JMS Resource Adapter' is (30)
08-Feb-2023 13:47:43.814 INFO [http-nio-44199-exec-5] org.apache.openejb.resource.activemq.ActiveMQ5Factory.createBroker ActiveMQ5Factory creating broker
08-Feb-2023 13:47:43.924 INFO [http-nio-44199-exec-5] org.apache.activemq.broker.BrokerService.<clinit> Loaded the Bouncy Castle security provider at position: 13
08-Feb-2023 13:47:43.969 INFO [http-nio-44199-exec-5] org.apache.openejb.resource.activemq.ActiveMQ5Factory.createBroker Using ActiveMQ startup timeout of 10000ms
08-Feb-2023 13:47:43.970 INFO [ActiveMQFactory start and checkpoint] org.apache.openejb.resource.activemq.ActiveMQ5Factory$1.run Starting ActiveMQ BrokerService
08-Feb-2023 13:47:43.974 WARNING [ActiveMQFactory start and checkpoint] org.apache.activemq.broker.BrokerService.checkMemorySystemUsageLimits Memory Usage for the Broker (1024mb) is more than the maximum available for the JVM: 978 mb - resetting to 70% of maximum available: 684
08-Feb-2023 13:47:43.975 INFO [ActiveMQFactory start and checkpoint] org.apache.activemq.broker.BrokerService.doStartPersistenceAdapter Using Persistence Adapter: MemoryPersistenceAdapter
08-Feb-2023 13:47:44.126 INFO [ActiveMQFactory start and checkpoint] org.apache.activemq.broker.BrokerService.doStartBroker Apache ActiveMQ 9.0.0-SNAPSHOT (localhost, ID:ip-172-31-89-166.ec2.internal-34159-1675864063996-0:1) is starting
08-Feb-2023 13:47:44.132 INFO [ActiveMQFactory start and checkpoint] org.apache.activemq.transport.TransportServerThreadSupport.doStart Listening for connections at: tcp://localhost:61616
08-Feb-2023 13:47:44.132 INFO [ActiveMQFactory start and checkpoint] org.apache.activemq.broker.TransportConnector.start Connector tcp://localhost:61616 started
08-Feb-2023 13:47:44.133 INFO [ActiveMQFactory start and checkpoint] org.apache.activemq.broker.BrokerService.doStartBroker Apache ActiveMQ 9.0.0-SNAPSHOT (localhost, ID:ip-172-31-89-166.ec2.internal-34159-1675864063996-0:1) started
08-Feb-2023 13:47:44.133 INFO [ActiveMQFactory start and checkpoint] org.apache.activemq.broker.BrokerService.doStartBroker For help or more information please see: http://activemq.apache.org
08-Feb-2023 13:47:44.134 WARNING [ActiveMQFactory start and checkpoint] org.apache.activemq.broker.BrokerService.checkUsageLimit Temporary Store limit is 51200 mb (current store usage is 0 mb). The data directory: /home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT only has 28981 mb of usable space. - resetting to maximum available disk space: 28981 mb
08-Feb-2023 13:47:44.152 INFO [ActiveMQFactory start and checkpoint] org.apache.openejb.resource.activemq.ActiveMQ5Factory$1.run Starting ActiveMQ checkpoint
08-Feb-2023 13:47:44.153 INFO [http-nio-44199-exec-5] org.apache.openejb.resource.activemq.ActiveMQ5Factory.createBroker ActiveMQ broker started
08-Feb-2023 13:47:44.166 INFO [http-nio-44199-exec-5] org.apache.openejb.assembler.classic.Assembler.createRecipe Creating Resource(id=comp/DefaultJMSConnectionFactory)
08-Feb-2023 13:47:44.175 INFO [http-nio-44199-exec-5] org.apache.openejb.assembler.classic.Assembler.doCreateResource Creating ConnectionManager for Resource(id=comp/DefaultJMSConnectionFactory)
08-Feb-2023 13:47:44.184 INFO [http-nio-44199-exec-5] org.apache.geronimo.connector.outbound.GenericConnectionManager$InterceptorsImpl.<init> No runtime TransactionSupport
08-Feb-2023 13:47:44.197 INFO [http-nio-44199-exec-5] org.apache.openejb.assembler.classic.Assembler.createRecipe Creating Container(id=Default Managed Container)
08-Feb-2023 13:47:44.203 INFO [http-nio-44199-exec-5] org.apache.openejb.core.managed.SimplePassivater.init Using directory /home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/temp for stateful session passivation
08-Feb-2023 13:47:44.207 INFO [http-nio-44199-exec-5] org.apache.openejb.assembler.classic.Assembler.createApplication Assembling app: /home/ec2-user/jakartaeetck-9.1.0-2021-04-20.1739/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_jsp_vehicle
08-Feb-2023 13:47:44.229 INFO [http-nio-44199-exec-5] org.apache.openejb.assembler.classic.JndiBuilder.bind Jndi(name=jta_jsp_vehicle/jta_ee_txpropagate3_ejb/jta_ejb_TxRequired_TxBeanEJB3RemoteHome) --> Ejb(deployment-id=jta_jsp_vehicle/jta_ee_txpropagate3_ejb/jta_ejb_TxRequired_TxBeanEJB3)
08-Feb-2023 13:47:44.230 INFO [http-nio-44199-exec-5] org.apache.openejb.assembler.classic.JndiBuilder.bind Jndi(name=global/jta_jsp_vehicle/jta_ee_txpropagate3_ejb/jta_ejb_TxRequired_TxBeanEJB3!com.sun.ts.tests.jta.ee.txpropagationtest.TxBeanHome) --> Ejb(deployment-id=jta_jsp_vehicle/jta_ee_txpropagate3_ejb/jta_ejb_TxRequired_TxBeanEJB3)
08-Feb-2023 13:47:44.231 INFO [http-nio-44199-exec-5] org.apache.openejb.assembler.classic.JndiBuilder.bind Jndi(name=global/jta_jsp_vehicle/jta_ee_txpropagate3_ejb/jta_ejb_TxRequired_TxBeanEJB3) --> Ejb(deployment-id=jta_jsp_vehicle/jta_ee_txpropagate3_ejb/jta_ejb_TxRequired_TxBeanEJB3)
08-Feb-2023 13:47:44.232 INFO [http-nio-44199-exec-5] org.apache.openejb.assembler.classic.ValidatorBuilder.getConfig Ignoring XML Configuration for validator org.apache.bval.jsr.ConfigurationImpl
08-Feb-2023 13:47:44.236 INFO [http-nio-44199-exec-5] org.apache.openejb.assembler.classic.Assembler.startEjbs Created Ejb(deployment-id=jta_jsp_vehicle/jta_ee_txpropagate3_ejb/jta_ejb_TxRequired_TxBeanEJB3, ejb-name=jta_ejb_TxRequired_TxBeanEJB3, container=StatefulContainer)
08-Feb-2023 13:47:44.237 INFO [http-nio-44199-exec-5] org.apache.openejb.assembler.classic.Assembler.startEjbs Started Ejb(deployment-id=jta_jsp_vehicle/jta_ee_txpropagate3_ejb/jta_ejb_TxRequired_TxBeanEJB3, ejb-name=jta_ejb_TxRequired_TxBeanEJB3, container=StatefulContainer)
08-Feb-2023 13:47:44.238 INFO [http-nio-44199-exec-5] org.apache.tomee.catalina.TomcatWebAppBuilder.deployWebApps using default host: localhost
08-Feb-2023 13:47:44.240 INFO [http-nio-44199-exec-5] org.apache.tomee.catalina.TomcatWebAppBuilder.init ------------------------- localhost -> /jta_jsp_vehicle_web
08-Feb-2023 13:47:44.240 INFO [http-nio-44199-exec-5] org.apache.openejb.util.OptionsLog.info Using 'openejb.crosscontext=true'
08-Feb-2023 13:47:44.322 INFO [http-nio-44199-exec-5] org.apache.openejb.cdi.CdiBuilder.initSingleton Existing thread singleton service in SystemInstance(): org.apache.openejb.cdi.ThreadSingletonServiceImpl@669253b7
08-Feb-2023 13:47:44.443 INFO [http-nio-44199-exec-5] org.apache.openejb.cdi.OpenEJBLifecycle.startApplication OpenWebBeans Container is starting...
08-Feb-2023 13:47:44.447 INFO [http-nio-44199-exec-5] org.apache.webbeans.plugins.PluginLoader.startUp Adding OpenWebBeansPlugin : [CdiPlugin]
08-Feb-2023 13:47:44.845 INFO [http-nio-44199-exec-5] org.apache.webbeans.config.BeansDeployer.validateInjectionPoints All injection points were validated successfully.
08-Feb-2023 13:47:44.968 INFO [http-nio-44199-exec-5] org.apache.openejb.cdi.OpenEJBLifecycle.startApplication OpenWebBeans Container has started, it took 525 ms.
08-Feb-2023 13:47:45.171 INFO [http-nio-44199-exec-5] org.apache.tomee.microprofile.openapi.MicroProfileOpenApiRegistration.onStartup Registering OpenAPI servlet on /openapi for application /jta_jsp_vehicle_web
08-Feb-2023 13:47:45.255 INFO [http-nio-44199-exec-5] org.apache.jasper.servlet.TldScanner.scanJars At least one JAR was scanned for TLDs yet contained no TLDs. Enable debug logging for this logger for a complete list of JARs that were scanned but no TLDs were found in them. Skipping unneeded JARs during scanning can improve startup time and JSP compilation time.
08-Feb-2023 13:47:46.327 WARNING [http-nio-44199-exec-5] org.apache.batchee.container.services.ServicesManager.init You didn't specify org.apache.batchee.jmx.application and JMX is already registered, skipping
08-Feb-2023 13:47:46.327 INFO [http-nio-44199-exec-5] org.apache.openejb.assembler.classic.Assembler.createApplication Deployed Application(path=/home/ec2-user/jakartaeetck-9.1.0-2021-04-20.1739/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_jsp_vehicle)
08-Feb-2023 13:47:46.327 INFO [http-nio-44199-exec-5] org.apache.openejb.assembler.classic.Assembler.createApplication Naming context of deployed Application(path=/home/ec2-user/jakartaeetck-9.1.0-2021-04-20.1739/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_jsp_vehicle) is set to read only
02-08-2023 13:47:46:  Harness - $$$$$$$$$$ Deployment SUCCEEDED for "/home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_jsp_vehicle.ear"
OpenEJB - Distribute returned moduleID /home/ec2-user/jakartaeetck-9.1.0-2021-04-20.1739/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_jsp_vehicle
02-08-2023 13:47:46:  Harness - amd Obtained CACHED DeploymentManager
OpenEJBDeploymentManager - connected
02-08-2023 13:47:46:  Harness - amd Obtained CACHED DeploymentManager
OpenEJBDeploymentManager - connected
02-08-2023 13:47:46:  Harness - Search for s1as runtime files match:`jta_servlet_vehicle.ear`
02-08-2023 13:47:46:  Harness - Valid runtime files after sweep:
02-08-2023 13:47:46:  Harness - /home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/harnesstmp//tmp/jta_ee_txpropagate2_ejb.jar.sun-ejb-jar.xml
02-08-2023 13:47:46:  Harness - /home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/harnesstmp//tmp/jta_servlet_vehicle_web.war.sun-web.xml
02-08-2023 13:47:46:  Harness - StandardDeployment14.deploy()
02-08-2023 13:47:46:  Harness - Starting to distribute:  /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_servlet_vehicle.ear
OpenEJB - module: /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_servlet_vehicle.ear
02-08-2023 13:47:46:  Harness - file: /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_servlet_vehicle.ear
02-08-2023 13:47:46:  Harness - plan: java.io.ByteArrayInputStream@55b7c956
02-08-2023 13:47:46:  Harness - amd Obtained CACHED DeploymentManager
OpenEJBDeploymentManager - connected
02-08-2023 13:47:46:  Harness - amd Obtained CACHED DeploymentManager
OpenEJBDeploymentManager - connected
08-Feb-2023 13:47:46.449 INFO [http-nio-44199-exec-7] org.apache.openejb.util.JarExtractor.extract Extracting jar: /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_servlet_vehicle.ear
08-Feb-2023 13:47:46.451 INFO [http-nio-44199-exec-7] org.apache.openejb.util.JarExtractor.extract Extracted path: /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_servlet_vehicle
08-Feb-2023 13:47:46.472 INFO [http-nio-44199-exec-7] org.apache.openejb.util.JarExtractor.extract Extracting jar: /home/ec2-user/jakartaeetck-9.1.0-2021-04-20.1739/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_servlet_vehicle/jta_servlet_vehicle_web.war
08-Feb-2023 13:47:46.474 INFO [http-nio-44199-exec-7] org.apache.openejb.util.JarExtractor.extract Extracted path: /home/ec2-user/jakartaeetck-9.1.0-2021-04-20.1739/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_servlet_vehicle/jta_servlet_vehicle_web
08-Feb-2023 13:47:46.507 INFO [http-nio-44199-exec-7] org.apache.openejb.util.OptionsLog.info Using 'openejb.deployments.classpath.filter.systemapps=false'
08-Feb-2023 13:47:46.593 INFO [http-nio-44199-exec-7] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:46.619 INFO [http-nio-44199-exec-7] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:46.621 INFO [http-nio-44199-exec-7] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:47.015 INFO [http-nio-44199-exec-7] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:47.958 INFO [http-nio-44199-exec-7] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:47.979 INFO [http-nio-44199-exec-7] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:47.985 INFO [http-nio-44199-exec-7] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:47.995 INFO [http-nio-44199-exec-7] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:47.997 INFO [http-nio-44199-exec-7] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:47.999 INFO [http-nio-44199-exec-7] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:48.061 INFO [http-nio-44199-exec-7] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:48.073 INFO [http-nio-44199-exec-7] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:48.104 INFO [http-nio-44199-exec-7] org.apache.openejb.util.OptionsLog.info Using 'openejb.default.deployment-module=org.apache.openejb.config.WebModule'
08-Feb-2023 13:47:48.105 INFO [http-nio-44199-exec-7] org.apache.openejb.config.DeploymentsResolver.loadFromClasspath Searched 13 classpath urls in 1591 milliseconds.  Average 122 milliseconds per url.
08-Feb-2023 13:47:48.105 INFO [http-nio-44199-exec-7] org.apache.openejb.util.OptionsLog.info Using 'openejb.environment.default=true'
08-Feb-2023 13:47:48.105 INFO [http-nio-44199-exec-7] org.apache.openejb.util.OptionsLog.info Using 'openejb.deploymentId.format={appId}/{ejbJarId}/{ejbName}'
08-Feb-2023 13:47:48.106 INFO [http-nio-44199-exec-7] org.apache.openejb.util.OptionsLog.info Using 'openejb.vendor.config=glassfish'
08-Feb-2023 13:47:48.106 INFO [http-nio-44199-exec-7] org.apache.openejb.config.ConfigurationFactory.configureApplication Configuring enterprise application: /home/ec2-user/jakartaeetck-9.1.0-2021-04-20.1739/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_servlet_vehicle
08-Feb-2023 13:47:48.130 INFO [http-nio-44199-exec-7] org.apache.openejb.config.InitEjbDeployments.deploy Auto-deploying ejb jta_ejb_TxRequired_TxBeanEJB2: EjbDeployment(deployment-id=jta_servlet_vehicle/jta_ee_txpropagate2_ejb/jta_ejb_TxRequired_TxBeanEJB2)
08-Feb-2023 13:47:48.132 INFO [http-nio-44199-exec-7] org.apache.openejb.config.AutoConfig.processResourceRef Auto-linking resource-ref 'jdbc/DB1' in bean jta_servlet_vehicle/jta_ee_txpropagate2_ejb/jta_ejb_TxRequired_TxBeanEJB2 to Resource(id=jdbc/DB1)
08-Feb-2023 13:47:48.133 INFO [http-nio-44199-exec-7] org.apache.openejb.config.AutoConfig.processResourceRef Auto-linking resource-ref 'jdbc/DB1' in bean jta_servlet_vehicle/jta_servlet_vehicle_web/jta_servlet_vehicle_web.Comp950284714 to Resource(id=jdbc/DB1)
08-Feb-2023 13:47:48.133 INFO [http-nio-44199-exec-7] org.apache.openejb.config.AutoConfig.processResourceEnvRef Auto-linking resource-env-ref 'java:comp/DefaultManagedExecutorService' in bean jta_servlet_vehicle/jta_servlet_vehicle_web/jta_servlet_vehicle_web.Comp950284714 to Resource(id=comp/DefaultManagedExecutorService)
08-Feb-2023 13:47:48.133 INFO [http-nio-44199-exec-7] org.apache.openejb.config.AutoConfig.processResourceEnvRef Auto-linking resource-env-ref 'java:comp/DefaultManagedScheduledExecutorService' in bean jta_servlet_vehicle/jta_servlet_vehicle_web/jta_servlet_vehicle_web.Comp950284714 to Resource(id=comp/DefaultManagedScheduledExecutorService)
08-Feb-2023 13:47:48.133 INFO [http-nio-44199-exec-7] org.apache.openejb.config.AutoConfig.processResourceEnvRef Auto-linking resource-env-ref 'java:comp/DefaultManagedThreadFactory' in bean jta_servlet_vehicle/jta_servlet_vehicle_web/jta_servlet_vehicle_web.Comp950284714 to Resource(id=comp/DefaultManagedThreadFactory)
08-Feb-2023 13:47:48.134 INFO [http-nio-44199-exec-7] org.apache.openejb.config.AutoConfig.processResourceEnvRef Auto-linking resource-env-ref 'java:comp/DefaultContextService' in bean jta_servlet_vehicle/jta_servlet_vehicle_web/jta_servlet_vehicle_web.Comp950284714 to Resource(id=comp/DefaultContextService)
08-Feb-2023 13:47:48.134 INFO [http-nio-44199-exec-7] org.apache.openejb.config.AutoConfig.processResourceEnvRef Auto-linking resource-env-ref 'java:comp/DefaultJMSConnectionFactory' in bean jta_servlet_vehicle/jta_servlet_vehicle_web/jta_servlet_vehicle_web.Comp950284714 to Resource(id=comp/DefaultJMSConnectionFactory)
08-Feb-2023 13:47:48.135 INFO [http-nio-44199-exec-7] org.apache.openejb.util.OptionsLog.info Using 'openejb.descriptors.output=false'
08-Feb-2023 13:47:48.135 INFO [http-nio-44199-exec-7] org.apache.openejb.util.OptionsLog.info Using 'openejb.descriptors.output=false'
08-Feb-2023 13:47:48.135 INFO [http-nio-44199-exec-7] org.apache.openejb.util.OptionsLog.info Using 'openejb.descriptors.output=false'
08-Feb-2023 13:47:48.136 INFO [http-nio-44199-exec-7] org.apache.openejb.config.AppInfoBuilder.build Enterprise application "/home/ec2-user/jakartaeetck-9.1.0-2021-04-20.1739/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_servlet_vehicle" loaded.
08-Feb-2023 13:47:48.142 INFO [http-nio-44199-exec-7] org.apache.openejb.assembler.classic.Assembler.createAppClassLoader Creating dedicated application classloader for jta_servlet_vehicle
08-Feb-2023 13:47:48.143 INFO [http-nio-44199-exec-7] org.apache.openejb.assembler.classic.Assembler.createApplication Assembling app: /home/ec2-user/jakartaeetck-9.1.0-2021-04-20.1739/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_servlet_vehicle
08-Feb-2023 13:47:48.153 INFO [http-nio-44199-exec-7] org.apache.openejb.assembler.classic.JndiBuilder.bind Jndi(name=jta_servlet_vehicle/jta_ee_txpropagate2_ejb/jta_ejb_TxRequired_TxBeanEJB2RemoteHome) --> Ejb(deployment-id=jta_servlet_vehicle/jta_ee_txpropagate2_ejb/jta_ejb_TxRequired_TxBeanEJB2)
08-Feb-2023 13:47:48.153 INFO [http-nio-44199-exec-7] org.apache.openejb.assembler.classic.JndiBuilder.bind Jndi(name=global/jta_servlet_vehicle/jta_ee_txpropagate2_ejb/jta_ejb_TxRequired_TxBeanEJB2!com.sun.ts.tests.jta.ee.txpropagationtest.TxBeanHome) --> Ejb(deployment-id=jta_servlet_vehicle/jta_ee_txpropagate2_ejb/jta_ejb_TxRequired_TxBeanEJB2)
08-Feb-2023 13:47:48.153 INFO [http-nio-44199-exec-7] org.apache.openejb.assembler.classic.JndiBuilder.bind Jndi(name=global/jta_servlet_vehicle/jta_ee_txpropagate2_ejb/jta_ejb_TxRequired_TxBeanEJB2) --> Ejb(deployment-id=jta_servlet_vehicle/jta_ee_txpropagate2_ejb/jta_ejb_TxRequired_TxBeanEJB2)
08-Feb-2023 13:47:48.154 INFO [http-nio-44199-exec-7] org.apache.openejb.assembler.classic.ValidatorBuilder.getConfig Ignoring XML Configuration for validator org.apache.bval.jsr.ConfigurationImpl
08-Feb-2023 13:47:48.159 INFO [http-nio-44199-exec-7] org.apache.openejb.assembler.classic.Assembler.startEjbs Created Ejb(deployment-id=jta_servlet_vehicle/jta_ee_txpropagate2_ejb/jta_ejb_TxRequired_TxBeanEJB2, ejb-name=jta_ejb_TxRequired_TxBeanEJB2, container=StatefulContainer)
08-Feb-2023 13:47:48.159 INFO [http-nio-44199-exec-7] org.apache.openejb.assembler.classic.Assembler.startEjbs Started Ejb(deployment-id=jta_servlet_vehicle/jta_ee_txpropagate2_ejb/jta_ejb_TxRequired_TxBeanEJB2, ejb-name=jta_ejb_TxRequired_TxBeanEJB2, container=StatefulContainer)
08-Feb-2023 13:47:48.160 INFO [http-nio-44199-exec-7] org.apache.tomee.catalina.TomcatWebAppBuilder.deployWebApps using default host: localhost
08-Feb-2023 13:47:48.161 INFO [http-nio-44199-exec-7] org.apache.tomee.catalina.TomcatWebAppBuilder.init ------------------------- localhost -> /jta_servlet_vehicle_web
08-Feb-2023 13:47:48.161 INFO [http-nio-44199-exec-7] org.apache.openejb.util.OptionsLog.info Using 'openejb.crosscontext=true'
08-Feb-2023 13:47:48.185 INFO [http-nio-44199-exec-7] org.apache.openejb.cdi.CdiBuilder.initSingleton Existing thread singleton service in SystemInstance(): org.apache.openejb.cdi.ThreadSingletonServiceImpl@669253b7
08-Feb-2023 13:47:48.192 INFO [http-nio-44199-exec-7] org.apache.openejb.cdi.OpenEJBLifecycle.startApplication OpenWebBeans Container is starting...
08-Feb-2023 13:47:48.194 INFO [http-nio-44199-exec-7] org.apache.webbeans.plugins.PluginLoader.startUp Adding OpenWebBeansPlugin : [CdiPlugin]
08-Feb-2023 13:47:48.337 INFO [http-nio-44199-exec-7] org.apache.webbeans.config.BeansDeployer.validateInjectionPoints All injection points were validated successfully.
08-Feb-2023 13:47:48.368 SEVERE [http-nio-44199-exec-7] org.apache.tomee.microprofile.metrics.MPMetricsCDIExtension.afterDeploymentValidation Can't initialize Metrics Registrar: SRMET00009: Gauge with id MetricID{name='classloader.loadedClasses.count', tags=[]} already exists
08-Feb-2023 13:47:48.371 INFO [http-nio-44199-exec-7] org.apache.openejb.cdi.OpenEJBLifecycle.startApplication OpenWebBeans Container has started, it took 178 ms.
08-Feb-2023 13:47:48.427 INFO [http-nio-44199-exec-7] org.apache.tomee.microprofile.openapi.MicroProfileOpenApiRegistration.onStartup Registering OpenAPI servlet on /openapi for application /jta_servlet_vehicle_web
08-Feb-2023 13:47:48.491 INFO [http-nio-44199-exec-7] org.apache.jasper.servlet.TldScanner.scanJars At least one JAR was scanned for TLDs yet contained no TLDs. Enable debug logging for this logger for a complete list of JARs that were scanned but no TLDs were found in them. Skipping unneeded JARs during scanning can improve startup time and JSP compilation time.
08-Feb-2023 13:47:48.528 WARNING [http-nio-44199-exec-7] org.apache.batchee.container.services.ServicesManager.init You didn't specify org.apache.batchee.jmx.application and JMX is already registered, skipping
08-Feb-2023 13:47:48.528 INFO [http-nio-44199-exec-7] org.apache.openejb.assembler.classic.Assembler.createApplication Deployed Application(path=/home/ec2-user/jakartaeetck-9.1.0-2021-04-20.1739/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_servlet_vehicle)
08-Feb-2023 13:47:48.528 INFO [http-nio-44199-exec-7] org.apache.openejb.assembler.classic.Assembler.createApplication Naming context of deployed Application(path=/home/ec2-user/jakartaeetck-9.1.0-2021-04-20.1739/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_servlet_vehicle) is set to read only
02-08-2023 13:47:48:  Harness - $$$$$$$$$$ Deployment SUCCEEDED for "/home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_servlet_vehicle.ear"
OpenEJB - Distribute returned moduleID /home/ec2-user/jakartaeetck-9.1.0-2021-04-20.1739/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_servlet_vehicle
02-08-2023 13:47:48:  Harness - amd Obtained CACHED DeploymentManager
OpenEJBDeploymentManager - connected
02-08-2023 13:47:48:  Harness - amd Obtained CACHED DeploymentManager
OpenEJBDeploymentManager - connected
Deployed apps from - /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest
Undeploying apps...
StandardDeployment14.isDeployed()
Deployed Modules: 

StandardDeployment14.isDeployed()
Deployed Modules: 

StandardDeployment14.isDeployed()
Deployed Modules: 

Search for s1as runtime files match:`jta_ejb_vehicle.ear`
Valid runtime files after sweep:
/home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_ee_txpropagate1_ejb.jar.sun-ejb-jar.xml
/home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_ejb_vehicle_client.jar.sun-application-client.xml
/home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_ejb_vehicle_ejb.jar.sun-ejb-jar.xml
Search for s1as runtime files match:`jta_jsp_vehicle.ear`
Valid runtime files after sweep:
/home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_ee_txpropagate3_ejb.jar.sun-ejb-jar.xml
/home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_jsp_vehicle_web.war.sun-web.xml
Search for s1as runtime files match:`jta_servlet_vehicle.ear`
Valid runtime files after sweep:
/home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_ee_txpropagate2_ejb.jar.sun-ejb-jar.xml
/home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_servlet_vehicle_web.war.sun-web.xml
Deploying apps for forward rebuildable...
Search for s1as runtime files match:`jta_ejb_vehicle.ear`
Valid runtime files after sweep:
/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/harnesstmp//tmp/jta_ee_txpropagate1_ejb.jar.sun-ejb-jar.xml
/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/harnesstmp//tmp/jta_ejb_vehicle_client.jar.sun-application-client.xml
/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/harnesstmp//tmp/jta_ejb_vehicle_ejb.jar.sun-ejb-jar.xml
StandardDeployment14.deploy()
Starting to distribute:  /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_ejb_vehicle.ear
file: /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_ejb_vehicle.ear
plan: java.io.ByteArrayInputStream@4d1d10d6
amd Obtained CACHED DeploymentManager
amd Obtained CACHED DeploymentManager
$$$$$$$$$$ Deployment SUCCEEDED for "/home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_ejb_vehicle.ear"
amd Obtained CACHED DeploymentManager
amd Obtained CACHED DeploymentManager
Search for s1as runtime files match:`jta_jsp_vehicle.ear`
Valid runtime files after sweep:
/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/harnesstmp//tmp/jta_ee_txpropagate3_ejb.jar.sun-ejb-jar.xml
/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/harnesstmp//tmp/jta_jsp_vehicle_web.war.sun-web.xml
StandardDeployment14.deploy()
Starting to distribute:  /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_jsp_vehicle.ear
file: /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_jsp_vehicle.ear
plan: java.io.ByteArrayInputStream@47fb6611
amd Obtained CACHED DeploymentManager
amd Obtained CACHED DeploymentManager
$$$$$$$$$$ Deployment SUCCEEDED for "/home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_jsp_vehicle.ear"
amd Obtained CACHED DeploymentManager
amd Obtained CACHED DeploymentManager
Search for s1as runtime files match:`jta_servlet_vehicle.ear`
Valid runtime files after sweep:
/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/harnesstmp//tmp/jta_ee_txpropagate2_ejb.jar.sun-ejb-jar.xml
/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/harnesstmp//tmp/jta_servlet_vehicle_web.war.sun-web.xml
StandardDeployment14.deploy()
Starting to distribute:  /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_servlet_vehicle.ear
file: /home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_servlet_vehicle.ear
plan: java.io.ByteArrayInputStream@55b7c956
amd Obtained CACHED DeploymentManager
amd Obtained CACHED DeploymentManager
$$$$$$$$$$ Deployment SUCCEEDED for "/home/ec2-user/jakartaee91tck/dist/com/sun/ts/tests/jta/ee/txpropagationtest/jta_servlet_vehicle.ear"
amd Obtained CACHED DeploymentManager
amd Obtained CACHED DeploymentManager
02-08-2023 13:47:48:  Harness - harness.executeMode is set to "0"
02-08-2023 13:47:48:  Harness - keywords (to be passed to tests) set to:  all
02-08-2023 13:47:48:  Harness - sClassPathFromExecProps = ::::
command: com.sun.ts.lib.harness.ExecTSTestCmd SYSTEMROOT= /home/ec2-user/jdk-11.0.10+9/bin/java -Dopenejb.server.uri=http://localhost:44199/tomee/ejb -DResource/javax.sql.DataSource=datasource:org.apache.derby.jdbc.ClientDataSource:jdbc:derby://localhost:43163/derbydb;create=true;user=cts;password=cts -DResource/jakarta.jms.ConnectionFactory=connectionfactory:org.apache.activemq.ActiveMQConnectionFactory:tcp://localhost:61616 -DResource/org.omg.CORBA.ORB=orb:/ -Djdbc/DB1=link:Resource/javax.sql.DataSource -Djava.protocol.handler.pkgs=javax.net.ssl -Djavax.net.ssl.keyStore=/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/src/test/keystores/clientcert.jks -Djavax.net.ssl.keyStorePassword=changeit -Djavax.net.ssl.trustStore=/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/src/test/keystores/ssl-truststore -Djavax.net.ssl.trustStorePassword=changeit -cp :/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/apps/jta_ejb_vehicle/jta_ejb_vehicle_client.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/jakartaee-api-9.1-M2-tomcat.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/geronimo-mail_2.1_provider-1.0.0.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/geronimo-mail_2.1_spec-1.0.0-M1.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/jakarta.faces-3.0.2.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/el-api.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/jaspic-api.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/jsp-api.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/servlet-api.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/taglibs-shade-9.0.0-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/websocket-api.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/tomee-tck-9.0.0-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/openejb-core-9.0.0-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/openejb-core-eclipselink-9.0.0-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/activemq-client-5.16.5.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/activemq-jdbc-store-5.16.5.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/bval-jsr-2.0.6-jakarta.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/catalina.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/commons-cli-1.5.0.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/commons-collections-3.2.2.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/commons-dbcp2-shade-9.0.0-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/commons-lang3-3.12.0.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/commons-logging-1.2.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/commons-pool2-2.11.1.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/cts-9.1.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/dbprocedures-9.1.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/derby-10.14.2.0.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/derbyclient-10.14.2.0.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/derbynet-10.14.2.0.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/eclipselink-3.0.3.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/el-api.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/geronimo-connector-3.1.5-jakarta.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/geronimo-jms_1.1_spec-1.1.1.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/geronimo-mail_2.1_provider-1.0.0.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/geronimo-mail_2.1_spec-1.0.0-M1.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/geronimo-transaction-3.1.5-jakarta.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/hawtbuf-1.11.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/howl-1.0.1-1.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/hsqldb-2.7.1.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/istack-commons-runtime-4.0.1.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/jackson-annotations-2.14.1.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/jackson-core-2.14.1.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/jackson-databind-2.14.1.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/jakarta.activation-1.2.1.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/jakartaee-api-9.1-M2-tomcat.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/jasper-el.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/jasper.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/jaspic-api.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/jaxb-runtime-3.0.2.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/jboss-logging-3.5.0.Final.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/jsp-api.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/mbean-annotation-api-9.0.0-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/openejb-api-9.0.0-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/openejb-core-9.0.0-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/openejb-core-eclipselink-9.0.0-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/openejb-cxf-9.0.0-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/openejb-cxf-rs-9.0.0-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/openejb-cxf-transport-9.0.0-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/openejb-javaagent.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/openejb-jee-9.0.0-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/openejb-jee-accessors-9.0.0-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/openejb-jpa-integration-9.0.0-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/openejb-loader-9.0.0-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/openjpa-3.2.2-jakarta.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/openwebbeans-ee-2.0.27-jakarta.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/openwebbeans-ee-common-2.0.27-jakarta.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/openwebbeans-ejb-2.0.27-jakarta.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/openwebbeans-el22-2.0.27-jakarta.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/openwebbeans-impl-2.0.27-jakarta.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/openwebbeans-spi-2.0.27-jakarta.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/openwebbeans-web-2.0.27-jakarta.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/quartz-openejb-shade-2.2.4.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/serp-1.15.1.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/servlet-api.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/slf4j-api-1.7.36.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/stax-ex-1.8.3.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/swizzle-stream-1.6.2.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/sxc-shade-9.0.0-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/tomcat-api.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/tomcat-juli.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/tomcat-util-scan.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/tomcat-util.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/tomcat-websocket.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/tomee-catalina-9.0.0-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/tomee-security-9.0.0-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/tsharness-9.1.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/tssv-9.1.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/txw2-3.0.2.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/websocket-api.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/whitebox-9.1.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/xbean-asm9-shaded-4.22.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/xbean-bundleutils-4.22.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/xbean-finder-shaded-4.22.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/xbean-naming-4.22.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/xbean-reflect-4.22.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/yoko-osgi-1.4.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/yoko-rmi-impl-1.4.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/yoko-rmi-spec-1.4.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/lib/yoko-spec-corba-1.4.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/commons-logging-1.2.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/eclipselink-3.0.3.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/derby-10.14.2.0.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/derbyclient-10.14.2.0.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/openejb-client-9.0.0-SNAPSHOT.jar:/home/ec2-user/jakartaee91tck/lib/javatest.jar:/home/ec2-user/jakartaee91tck/lib/tsharness.jar:/home/ec2-user/jakartaee91tck/lib/cts.jar:/home/ec2-user/jakartaee91tck/lib/dbprocedures.jar:/home/ec2-user/jakartaee91tck/lib/commons-httpclient-3.1.jar:/home/ec2-user/jakartaee91tck/lib/jdom-1.1.3.jar:/home/ec2-user/jakartaee91tck/lib/jaxb-api.jar:/home/ec2-user/jakartaee91tck/lib/jaxb-impl.jar:/home/ec2-user/jakartaee91tck/lib/jaxb-xjc.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/jasper-el.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/cxf-rt-rs-mp-client-shade-9.0.0-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/cxf-shade-9.0.0-SNAPSHOT.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/neethi-3.0.3.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/wsdl4j-1.6.3.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/woodstox-core-6.4.0.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/stax2-api-4.2.1.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/xmlschema-core-2.2.5.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/johnzon-core-1.2.19-jakarta.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/johnzon-jaxrs-1.2.19-jakarta.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/johnzon-jsonb-1.2.19-jakarta.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/johnzon-jsonp-strict-1.2.19-jakarta.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/johnzon-mapper-1.2.19-jakarta.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/tomcat-api.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/tomcat-coyote.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/tomcat-dbcp.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/tomcat-i18n-cs.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/tomcat-i18n-de.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/tomcat-i18n-es.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/tomcat-i18n-fr.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/tomcat-i18n-ja.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/tomcat-i18n-ko.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/tomcat-i18n-pt-BR.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/tomcat-i18n-ru.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/tomcat-i18n-zh-CN.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/tomcat-jdbc.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/tomcat-jni.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/tomcat-util-scan.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/tomcat-util.jar:/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/lib/tomcat-websocket.jar -Dopenejb.client.moduleId=jta_ejb_vehicle_client org.apache.openejb.client.Main -p /home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/harnesstmp//tmp/tstest.jte -t test1 -vehicle ejb -ap /home/ec2-user/jakartaee91tck/bin/tssql.stmt
Feb 08, 2023 1:47:49 PM org.apache.openejb.client.EventLogger log
INFO: RemoteInitialContextCreated{providerUri=http://localhost:44199/tomee/ejb}
Feb 08, 2023 1:47:49 PM org.apache.openejb.client.EventLogger log
INFO: RemoteInitialContextCreated{providerUri=http://localhost:44199/tomee/ejb}
Feb 08, 2023 1:47:49 PM org.apache.openejb.client.EventLogger log
INFO: RemoteInitialContextCreated{providerUri=http://localhost:44199/tomee/ejb}
Feb 08, 2023 1:47:49 PM org.apache.openejb.client.EventLogger log
INFO: RemoteInitialContextCreated{providerUri=http://localhost:44199/tomee/ejb}
************************************************************
* props file set to "/tmp/ec2-user-cts-props.txt"
************************************************************
02-08-2023 13:47:49:  TRACE: #######  Value of harness.socket.retry.count is "10"
02-08-2023 13:47:49:  TRACE: #######  Value of harness.log.port is "40037"
02-08-2023 13:47:49:  TRACE: #######  Actual bind value of harness.log.port is "40037"
02-08-2023 13:47:49:  TRACE: in ServiceEETest.run() method
02-08-2023 13:47:49:  TRACE: Vehicle to be used for this test is:  ejb
02-08-2023 13:47:49:  TRACE: %%%%%%% isSecuredEjbClient = false
Feb 08, 2023 1:47:49 PM org.apache.openejb.client.EventLogger log
INFO: RemoteInitialContextCreated{providerUri=http://localhost:44199/tomee/ejb}
************************************************************
* props file set to "/home/ec2-user/gbuild-aws/node/target/apache-tomee/temp/temp7518587632352042655dir/gbuild/work/workspace-1/project-11189/target/apache-tomee-plume-9.0.0-SNAPSHOT/temp/ec2-user-cts-props.txt"
************************************************************
02-08-2023 13:47:49:  SVR-TRACE: ejbcreate
02-08-2023 13:47:49:  TRACE: in ejbvehicle: home.create() ok; call runTest()
02-08-2023 13:47:49:  SVR-TRACE: in runTest()
02-08-2023 13:47:49:  SVR-TRACE: in custom vehicle so call on EETest.
02-08-2023 13:47:49:  SVR-TRACE: *** in EETest.run(argv,p)
02-08-2023 13:47:49:  SVR-TRACE: TESTCLASS=com.sun.ts.tests.jta.ee.txpropagationtest.Client
02-08-2023 13:47:49:  SVR-TRACE: ** IN getRunMethod: testClass=com.sun.ts.tests.jta.ee.txpropagationtest.Client
02-08-2023 13:47:49:  SVR-TRACE: ** IN getRunMethod: testname=test1
02-08-2023 13:47:49:  SVR-TRACE: ** GOT RUN METHOD!
02-08-2023 13:47:49:  SVR-TRACE: **runmethod=test1
02-08-2023 13:47:49:  SVR-TRACE: ABOUT TO GET SETUP METHOD!
02-08-2023 13:47:49:  SVR-TRACE: No setupMethod annotation present
02-08-2023 13:47:49:  SVR-TRACE: getSetupMethod - checking for testcase specific setup method:  test1_setup
02-08-2023 13:47:49:  SVR-TRACE: getSetupMethod - checking for default class specific setup method
02-08-2023 13:47:49:  SVR-TRACE: GOT SETUP METHOD!
02-08-2023 13:47:49:  SVR-TRACE: No cleanupMethod annotation present
02-08-2023 13:47:49:  SVR-TRACE: getCleanupMethod - checking for testcase specific cleanup method:  test1_cleanup
02-08-2023 13:47:49:  SVR-TRACE: getCleanupMethod - checking for default class specific cleanup method
02-08-2023 13:47:49:  SVR-TRACE: GOT CLEANUP METHOD!
02-08-2023 13:47:49:  SVR-TRACE: ABOUT TO INVOKE SETUP METHOD!
02-08-2023 13:47:49:  SVR: Setup tests
02-08-2023 13:47:49:  SVR: Obtain naming context
02-08-2023 13:47:49:  SVR: Lookup TxBean: java:comp/env/ejb/MyEjbReference
02-08-2023 13:47:49:  SVR: Lookup java:comp/UserTransaction
02-08-2023 13:47:49:  SVR: Create DBSupport class
02-08-2023 13:47:49:  SVR-TRACE: DBSupport
02-08-2023 13:47:49:  SVR-TRACE: ds1: org.apache.openejb.resource.jdbc.managed.local.ManagedDataSource@47f08b81
02-08-2023 13:47:49:  SVR: First DataSource lookup OK!
02-08-2023 13:47:49:  SVR-TRACE: ds2: org.apache.openejb.resource.jdbc.managed.local.ManagedDataSource@47f08b81
02-08-2023 13:47:49:  SVR: Second DataSource lookup OK!
02-08-2023 13:47:49:  SVR: Lookup environment variables
02-08-2023 13:47:49:  SVR-TRACE: tName1: JTA_Tab1
02-08-2023 13:47:49:  SVR-TRACE: tName2: JTA_Tab2
02-08-2023 13:47:49:  SVR-TRACE: tSize: 5
02-08-2023 13:47:49:  SVR-TRACE: fromKey1: 2
02-08-2023 13:47:49:  SVR-TRACE: fromKey2: 2
02-08-2023 13:47:49:  SVR-TRACE: toKey2: 3
02-08-2023 13:47:49:  SVR: Create EJB instance of java:comp/env/ejb/MyEjbReference
02-08-2023 13:47:49:  SVR-TRACE: setSessionContext
02-08-2023 13:47:49:  SVR-TRACE: ejbCreate
02-08-2023 13:47:49:  SVR-TRACE: ds1: org.apache.openejb.resource.jdbc.managed.local.ManagedDataSource@47f08b81
02-08-2023 13:47:49:  SVR: JTA_Tab1 DataSource lookup OK!
02-08-2023 13:47:49:  SVR-TRACE: ds2: org.apache.openejb.resource.jdbc.managed.local.ManagedDataSource@47f08b81
02-08-2023 13:47:49:  SVR: JTA_Tab2 DataSource lookup OK!
02-08-2023 13:47:49:  SVR: Setup ok
02-08-2023 13:47:49:  SVR-TRACE: INVOKED SETUP METHOD!
02-08-2023 13:47:49:  SVR-TRACE: ABOUT TO INVOKE EETEST RUN METHOD!
02-08-2023 13:47:49:  SVR-TRACE: test1
02-08-2023 13:47:49:  SVR: Transaction propagation from Servlet, EJB or JSP
02-08-2023 13:47:49:  SVR: Insert/Delete followed by a commit to a single table
02-08-2023 13:47:49:  SVR: Database access is performed from TxBean EJB
02-08-2023 13:47:49:  SVR: Creating the table
02-08-2023 13:47:49:  SVR-TRACE: dbConnect
02-08-2023 13:47:49:  SVR-TRACE: conTable1
02-08-2023 13:47:49:  SVR-TRACE: con1: ManagedConnection{null}
02-08-2023 13:47:49:  SVR: Made the JDBC connection to JTA_Tab1 DB
02-08-2023 13:47:49:  SVR-TRACE: createData
02-08-2023 13:47:49:  SVR-TRACE: createTable1
02-08-2023 13:47:49:  SVR-TRACE: dropTable1
02-08-2023 13:47:49:  SVR-TRACE: All rows deleted from table JTA_Tab1
02-08-2023 13:47:49:  SVR: Adding the JTA_Tab1 table rows
02-08-2023 13:47:49:  SVR: Created the table JTA_Tab1 
02-08-2023 13:47:49:  SVR-TRACE: dbUnConnect
02-08-2023 13:47:49:  SVR-TRACE: Closed JTA_Tab1 connection
02-08-2023 13:47:49:  SVR: Insert and delete some rows
02-08-2023 13:47:49:  SVR-TRACE: dbConnect
02-08-2023 13:47:49:  SVR-TRACE: conTable1
02-08-2023 13:47:49:  SVR-TRACE: con1: ManagedConnection{null}
02-08-2023 13:47:49:  SVR: Made the JDBC connection to JTA_Tab1 DB
02-08-2023 13:47:49:  SVR: Inserting 2 new rows
02-08-2023 13:47:49:  SVR-TRACE: insert
02-08-2023 13:47:49:  SVR-TRACE: Inserted a row into the table JTA_Tab1
02-08-2023 13:47:49:  SVR-TRACE: insert
02-08-2023 13:47:49:  SVR-TRACE: Inserted a row into the table JTA_Tab1
02-08-2023 13:47:49:  SVR: Deleting a row
02-08-2023 13:47:49:  SVR-TRACE: delete
02-08-2023 13:47:49:  SVR-TRACE: Deleted row(s) 2 thru 2 from the table JTA_Tab1
02-08-2023 13:47:49:  SVR-TRACE: dbUnConnect
02-08-2023 13:47:49:  SVR-TRACE: Closed JTA_Tab1 connection
02-08-2023 13:47:49:  SVR: Get test results
02-08-2023 13:47:49:  SVR-TRACE: dbConnect
02-08-2023 13:47:49:  SVR-TRACE: conTable1
02-08-2023 13:47:49:  SVR-TRACE: con1: ManagedConnection{null}
02-08-2023 13:47:49:  SVR: Made the JDBC connection to JTA_Tab1 DB
02-08-2023 13:47:49:  SVR-TRACE: getResults
02-08-2023 13:47:49:  SVR: Obtained JTA_Tab1 table ResultSet
02-08-2023 13:47:49:  SVR: Verifying the test results
02-08-2023 13:47:49:  SVR-TRACE: dbUnConnect
02-08-2023 13:47:49:  SVR-TRACE: Closed JTA_Tab1 connection
02-08-2023 13:47:49:  SVR-TRACE: dbConnect
02-08-2023 13:47:49:  SVR-TRACE: conTable1
02-08-2023 13:47:49:  SVR-TRACE: con1: ManagedConnection{null}
02-08-2023 13:47:49:  SVR: Made the JDBC connection to JTA_Tab1 DB
02-08-2023 13:47:49:  SVR-TRACE: destroyData
02-08-2023 13:47:49:  SVR-TRACE: dropTable1
02-08-2023 13:47:49:  SVR: Deleted all rows from table JTA_Tab1
02-08-2023 13:47:49:  SVR-TRACE: dbUnConnect
02-08-2023 13:47:49:  SVR-TRACE: Closed JTA_Tab1 connection
02-08-2023 13:47:49:  SVR-TRACE: ejbRemove
02-08-2023 13:47:49:  SVR: Cleanup ok
02-08-2023 13:47:49:  SVR: Test running in ejb vehicle passed
02-08-2023 13:47:50:  TRACE: SLEPT FOR:  1000
STATUS:Passed.
Passed.
********************************************************************************
Finished Test:  PASSED........com/sun/ts/tests/jta/ee/txpropagationtest/Client.java#test1_from_ejb
********************************************************************************