[arquillian-issues] [JBoss JIRA] (ARQ-2090) Arquillian test takes more than 5 minutes

nicolas duminil (JIRA) issues at jboss.org
Tue Apr 4 05:46:01 EDT 2017


     [ https://issues.jboss.org/browse/ARQ-2090?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ]

nicolas duminil updated ARQ-2090:
---------------------------------
    Description: 
The execution of an Arquillian test (an empty test) takes more than 5 minutes. here is the test:

{{@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 at -323862990 ] for method [ com.ibm.ws.amm.scan.util.info.impl.MethodInfoImpl at -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 at -323862990 ] for method [ com.ibm.ws.amm.scan.util.info.impl.MethodInfoImpl at 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 at -323862990 ] for method [ com.ibm.ws.amm.scan.util.info.impl.MethodInfoImpl at 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

  was:
The execution of an Arquillian test (an empty test) takes more than 5 minutes. here is the test:

@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");
    System.out.println("Loading pom.xml");
    PomEquippedResolveStage mavenResolver =  Maven.resolver().loadPomFromFile("pom.xml");
    //slf4jLogger.info("pom.xml loaded. Now importing dependencies");
    System.out.println("pom.xml loaded. Now importing dependencies");
    File[] libs = mavenResolver.importRuntimeAndTestDependencies().resolve().withTransitivity().asFile();
    //slf4jLogger.info("Dependencies loaded. Creating web archive");
    System.out.println("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");
    System.out.println("Web archive created. Now, adding files to the archive");
    for (File file : libs) 
      war.addAsLibrary(file);
    //slf4jLogger.info("Web archive created");
    System.out.println("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 at -323862990 ] for method [ com.ibm.ws.amm.scan.util.info.impl.MethodInfoImpl at -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 at -323862990 ] for method [ com.ibm.ws.amm.scan.util.info.impl.MethodInfoImpl at 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 at -323862990 ] for method [ com.ibm.ws.amm.scan.util.info.impl.MethodInfoImpl at 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



> 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:
> {{@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 at -323862990 ] for method [ com.ibm.ws.amm.scan.util.info.impl.MethodInfoImpl at -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 at -323862990 ] for method [ com.ibm.ws.amm.scan.util.info.impl.MethodInfoImpl at 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 at -323862990 ] for method [ com.ibm.ws.amm.scan.util.info.impl.MethodInfoImpl at 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



--
This message was sent by Atlassian JIRA
(v7.2.3#72005)


More information about the arquillian-issues mailing list