]
nicolas duminil commented on ARQ-2090:
--------------------------------------
The post above doesn't concenrn WLP (WebSphere Liberty Profile) but WAS 8.5.5. WLP is
not production ready and hence we don't use it. And running the same test with IBM
Java 7 has exactly the same result.
Without Arquillian test the build is instantly, as shown above in the console output. The
part which takes the 5 minutes starts with the message "Running
be.alphacredit.tests.TestXSDValidationArquillian" at11:09:59. It takes one minute to
load the POM, import the dependencies, create the archive and add the dependedncies to the
archive. At 11:11:00 the message "Web archive created" shows rhe return from the
method createTestArchive().
Then during 31 seconds different warnings are displayed. At 11:11:31 the message
"INFO: Target server for deployment is
WebSphere:cell=cac40Node01Cell,node=cac40Node01,server=server1" is displayed and then
the deployment of the archive on the remote application server takes 3 minutes and 8
seconds until the message "INFO: Application was started on the following targets:
WebSphere:cell=cac40Node01Cell,node=cac40Node01,server=server1" is displayed.
Further, when it comes to the real deployment, in the pre-integration-test phase of maven,
the same archive (well almost the same) takes a couple of seconds. The remote server is
local, it runs on the same machine.
So the question is why the Arquillian deployment takes so long and one of the possible
answers is that the server is scanning the archive for annotations. This is what
meta-data=complete is supposed to avoid, but it doesn't. Hence my question: does
anyone know why ?
Kind regards,
Nicolas DUMINIL
Arquillian test takes more than 5 minutes
-----------------------------------------
Key: ARQ-2090
URL:
https://issues.jboss.org/browse/ARQ-2090
Project: Arquillian
Issue Type: Bug
Components: WebSphere Containers
Environment: arquillian-was-remote-8.5:1.0.0-Final, WebSphere 8.5.5 on Windows
10,
Java: IBM J9 VM (build 2.6, JRE 1.6.0 Windows 8 amd64-64 Compressed References
20130301_140166 (JIT enabled, AOT enabled)
Reporter: nicolas duminil
Assignee: Gerhard Poul
The execution of an Arquillian test (an empty test) takes more than 5 minutes. here is
the test:
-{{(a)RunWith(Arquillian.class)
public class TestXSDValidationArquillian
{
private static final Logger slf4jLogger =
LoggerFactory.getLogger(TestXSDValidationArquillian.class);
@Deployment
public static Archive<?> createTestArchive()
{
slf4jLogger.info("Loading pom.xml");
PomEquippedResolveStage mavenResolver =
Maven.resolver().loadPomFromFile("pom.xml");
slf4jLogger.info("pom.xml loaded. Now importing dependencies");
File[] libs =
mavenResolver.importRuntimeAndTestDependencies().resolve().withTransitivity().asFile();
slf4jLogger.info("Dependencies loaded. Creating web archive");
WebArchive war = ShrinkWrap.create(WebArchive.class,
"arquillian-test.war");
slf4jLogger.info("Web archive created. Now, adding files to the archive");
for (File file : libs)
war.addAsLibrary(file);
slf4jLogger.info("Web archive created");
return war;
}-
@Test
public void test1(){}
}}
An here is the console output:
-------------------------------------------------------
T E S T S
-------------------------------------------------------
Running be.alphacredit.tests.TestXSDValidationArquillian
04-Apr-2017 11:09:59 null null
WARNING: ADMC0046W
04-Apr-2017 11:10:00 null null
WARNING: Could not find tmx4jTransform.jar in null/etc/tmx4jTransform.jar -
Interoperability to older versions of WebSphere is disabled
04-Apr-2017 11:10:00 null null
INFO: ssl.disable.url.hostname.verification.CWPKI0027I
Loading pom.xml
pom.xml loaded. Now importing dependencies
04-Apr-2017 11:10:02 org.jboss.shrinkwrap.resolver.impl.maven.logging.LogTransferListener
transferFailed
WARNING: Failed downloading
org/jboss/arquillian/container/arquillian-was-remote-8.5/1.0.0.Final-SNAPSHOT/maven-metadata.xml
from
http://repo1.maven.org/maven2/. Reason:
org.eclipse.aether.transfer.MetadataNotFoundException: Could not find metadata
org.jboss.arquillian.container:arquillian-was-remote-8.5:1.0.0.Final-SNAPSHOT/maven-metadata.xml
in central (
http://repo1.maven.org/maven2)
04-Apr-2017 11:10:02 org.jboss.shrinkwrap.resolver.impl.maven.logging.LogTransferListener
transferFailed
WARNING: Failed downloading
org/jboss/arquillian/container/arquillian-parent-was/1.0.0.Final-SNAPSHOT/maven-metadata.xml
from
http://repo1.maven.org/maven2/. Reason:
org.eclipse.aether.transfer.MetadataNotFoundException: Could not find metadata
org.jboss.arquillian.container:arquillian-parent-was:1.0.0.Final-SNAPSHOT/maven-metadata.xml
in central (
http://repo1.maven.org/maven2)
Dependencies loaded. Creating web archive
Web archive created. Now, adding files to the archive
Web archive created
04-Apr-2017 11:11:00 com.ibm.ws.amm.scan.util.AnnotationInfoDefaultVisitor
visitAnnotation
WARNING: [ com.ibm.ws.amm.scan.util.InfoVisitor@-323862990 ] for method [
com.ibm.ws.amm.scan.util.info.impl.MethodInfoImpl@-126388353 (
com.ibm.ws.amm.scan.util.info.impl.test.AnnotationTypeReaderAnno.nestedAnno ) ] Name [
null ] Description [
Lcom/ibm/ws/amm/scan/util/info/impl/test/AnnotationTypeReaderNestedAnno; ] Call in
violation of protocol
04-Apr-2017 11:11:03 com.ibm.ws.amm.scan.util.AnnotationInfoDefaultVisitor
visitAnnotation
WARNING: [ com.ibm.ws.amm.scan.util.InfoVisitor@-323862990 ] for method [
com.ibm.ws.amm.scan.util.info.impl.MethodInfoImpl@1495822839 (
javax.persistence.AssociationOverride.joinTable ) ] Name [ null ] Description [
Ljavax/persistence/JoinTable; ] Call in violation of protocol
04-Apr-2017 11:11:03 com.ibm.ws.amm.scan.util.AnnotationInfoDefaultVisitor
visitAnnotation
WARNING: [ com.ibm.ws.amm.scan.util.InfoVisitor@-323862990 ] for method [
com.ibm.ws.amm.scan.util.info.impl.MethodInfoImpl@1522521260 (
javax.servlet.annotation.ServletSecurity.value ) ] Name [ null ] Description [
Ljavax/servlet/annotation/HttpConstraint; ] Call in violation of protocol
04-Apr-2017 11:11:31
org.jboss.arquillian.container.was.remote_8_5.WebSphereRemoteContainer deploy
INFO: Target server for deployment is
WebSphere:cell=cac40Node01Cell,node=cac40Node01,server=server1
04-Apr-2017 11:14:39
org.jboss.arquillian.container.was.remote_8_5.WebSphereRemoteContainer deploy
INFO: Application was started on the following targets:
WebSphere:cell=cac40Node01Cell,node=cac40Node01,server=server1
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 291.094 sec
Results :
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0
As one may see, test starts at 11:09:59 and finishes at 11:14:39 and takes 291.094
seconds. I have googled and found some posts concerning the
metadata-complete="true" that I added to my web.xml, as follows:
<?xml version="1.0" encoding="UTF-8"?>
<web-app id="WebApp_ID" version="3.0"
xmlns="http://java.sun.com/xml/ns/javaee"
xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
xsi:schemaLocation="http://java.sun.com/xml/ns/javaee
http://java.sun.com/xml/ns/javaee/web-app_3_0.xsd"
metadata-complete="true"/>
but it didn't help. It seems to be related to the IBM Java 6 but this is the JVM that
one is supposed to use with IBM WebSphere. Any idea of what might be the problem here ?
Kind regards,
Nicolas DUMINIL