0 Replies Latest reply on Dec 4, 2015 6:45 AM by Hristo Stoyanov

    [wf 9.0.2] WFLYCTL0159: Operation handler failed to complete

    Hristo Stoyanov Master

      Getting very unhelpful deployment error message: WFLYCTL0159: Operation handler failed to complete. Any idea? How can I get a better diagnostics?

       

      The WAR app uses a XA datasource, which when verified from the admin console works. I am also using Apache proxy/mod_cluster :

      ========================================================================================================

      ...

                     <xa-datasource jndi-name="java:jboss/datasources/S4GDS" pool-name="S4GDS"  use-java-context="true">

                          <xa-datasource-property name="ServerName">localhost</xa-datasource-property>

                          <xa-datasource-property name="PortNumber">5432</xa-datasource-property>

                          <xa-datasource-property name="DatabaseName">default</xa-datasource-property>

                          <driver>postgres</driver>

                          <xa-pool>

                              <min-pool-size>0</min-pool-size>

                              <initial-pool-size>1</initial-pool-size>

                              <max-pool-size>100</max-pool-size>

                              <prefill>true</prefill>

                          </xa-pool>

                          <security>

                              <user-name>s4g</user-name>

                              <password>admin</password>

                          </security>

                          <timeout>

                              <blocking-timeout-millis>5000</blocking-timeout-millis>

                          </timeout>

                      </xa-datasource>                                              

       

                        

                          ...

                           <driver name="postgres" module="org.postgres">

                              <xa-datasource-class>org.postgresql.xa.PGXADataSource</xa-datasource-class>

                              <datasource-class>org.postgresql.ds.PGSimpleDataSource</datasource-class>

                          </driver>                   

                      </drivers>

      ...

      <!-- Config: mod cluser -->

              <subsystem xmlns="urn:jboss:domain:modcluster:2.0">

                  <mod-cluster-config connector="ajp"  proxies="the-proxy">

                      <dynamic-load-provider>

                         <load-metric type="busyness"/>

                      </dynamic-load-provider>

                  </mod-cluster-config>

              </subsystem>

       

      ...

          <socket-binding-group name="standard-sockets" default-interface="public" port-offset="${jboss.socket.binding.port-offset:0}">

             ...

              <!-- Config: mod cluser -->

              <outbound-socket-binding name="the-proxy">

                   <remote-destination host="localhost" port="6666"/>

              </outbound-socket-binding>

          </socket-binding-group>

      ===============================================================

       

      2015-12-04 10:59:17,954 INFO  [org.jboss.as.server.deployment] (MSC service thread 1-7) WFLYSRV0027: Starting deployment of "s4g-web.war" (runtime-name: "s4g-web.war")

      2015-12-04 10:59:20,118 INFO  [org.jboss.as.jpa] (MSC service thread 1-6) WFLYJPA0002: Read persistence.xml for s4g

      2015-12-04 10:59:20,370 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-1) WFLYSRV0018: Deployment "deployment.s4g-web.war" is using a private module ("org.infinispan:main") which may be changed or removed in future versions without notice.

      2015-12-04 10:59:20,370 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-1) WFLYSRV0018: Deployment "deployment.s4g-web.war" is using a private module ("org.infinispan:main") which may be changed or removed in future versions without notice.

      2015-12-04 10:59:20,371 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-1) WFLYSRV0018: Deployment "deployment.s4g-web.war" is using a private module ("org.infinispan.commons:main") which may be changed or removed in future versions without notice.

      2015-12-04 10:59:20,371 WARN  [org.jboss.as.dependency.private] (MSC service thread 1-1) WFLYSRV0018: Deployment "deployment.s4g-web.war" is using a private module ("org.infinispan.commons:main") which may be changed or removed in future versions without notice.

      2015-12-04 10:59:20,394 INFO  [org.jboss.as.jpa] (ServerService Thread Pool -- 92) WFLYJPA0010: Starting Persistence Unit (phase 1 of 2) Service 's4g-web.war#s4g'

      2015-12-04 10:59:20,394 INFO  [org.hibernate.jpa.internal.util.LogHelper] (ServerService Thread Pool -- 92) HHH000204: Processing PersistenceUnitInfo [

        name: s4g

        ...]

      2015-12-04 10:59:20,396 INFO  [org.jboss.weld.deployer] (MSC service thread 1-5) WFLYWELD0003: Processing weld deployment s4g-web.war

      2015-12-04 10:59:20,416 INFO  [org.jboss.as.ejb3.deployment.processors.EjbJndiBindingsDeploymentUnitProcessor] (MSC service thread 1-5) JNDI bindings for session bean named ScreensManagerImpl in deployment unit deployment "s4g-web.war" are as follows:

       

       

        java:global/s4g-web/ScreensManagerImpl!com.peruncs.s4g.web.gwt.client.shared.ScreensManager

        java:app/s4g-web/ScreensManagerImpl!com.peruncs.s4g.web.gwt.client.shared.ScreensManager

        java:module/ScreensManagerImpl!com.peruncs.s4g.web.gwt.client.shared.ScreensManager

        java:global/s4g-web/ScreensManagerImpl

        java:app/s4g-web/ScreensManagerImpl

        java:module/ScreensManagerImpl

       

       

      2015-12-04 10:59:20,518 INFO  [org.jboss.weld.deployer] (MSC service thread 1-2) WFLYWELD0006: Starting Services for CDI deployment: s4g-web.war

      2015-12-04 10:59:20,526 INFO  [org.jboss.weld.deployer] (MSC service thread 1-4) WFLYWELD0009: Starting weld service for deployment s4g-web.war

      2015-12-04 10:59:20,553 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 93) WFLYCLINF0002: Started S4GLocalCache cache from S4GCacheContainer container

      2015-12-04 10:59:20,575 INFO  [org.jboss.as.jpa] (ServerService Thread Pool -- 92) WFLYJPA0010: Starting Persistence Unit (phase 2 of 2) Service 's4g-web.war#s4g'

      2015-12-04 10:59:20,598 INFO  [org.hibernate.dialect.Dialect] (ServerService Thread Pool -- 92) HHH000400: Using dialect: org.hibernate.dialect.PostgreSQL9Dialect

      2015-12-04 10:59:20,600 INFO  [org.hibernate.engine.jdbc.internal.LobCreatorBuilder] (ServerService Thread Pool -- 92) HHH000424: Disabling contextual LOB creation as createClob() method threw error : java.lang.reflect.InvocationTargetException

      2015-12-04 10:59:20,643 INFO  [org.hibernate.hql.internal.ast.ASTQueryTranslatorFactory] (ServerService Thread Pool -- 92) HHH000397: Using ASTQueryTranslatorFactory

      2015-12-04 10:59:20,704 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 92) WFLYCLINF0002: Started s4g-web.war#s4g.com.peruncs.s4g.web.gwt.server.SymbolkListItem cache from hibernate container

      2015-12-04 10:59:20,708 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 92) WFLYCLINF0002: Started pending-puts cache from hibernate container

      2015-12-04 10:59:20,753 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 92) WFLYCLINF0002: Started s4g-web.war#s4g.com.peruncs.s4g.web.gwt.server.Screen cache from hibernate container

      2015-12-04 10:59:20,762 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 92) WFLYCLINF0002: Started s4g-web.war#s4g.com.peruncs.s4g.web.gwt.server.BellWeather cache from hibernate container

      2015-12-04 10:59:20,770 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 92) WFLYCLINF0002: Started s4g-web.war#s4g.com.peruncs.s4g.web.gwt.server.SymbolList cache from hibernate container

      2015-12-04 10:59:20,779 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 92) WFLYCLINF0002: Started s4g-web.war#s4g.com.peruncs.s4g.web.gwt.server.Preferences cache from hibernate container

      2015-12-04 10:59:20,787 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 92) WFLYCLINF0002: Started s4g-web.war#s4g.com.peruncs.s4g.web.gwt.server.FinancialDetailBase cache from hibernate container

      2015-12-04 10:59:20,799 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 92) WFLYCLINF0002: Started s4g-web.war#s4g.com.peruncs.s4g.web.gwt.server.StockListSymbol cache from hibernate container

      2015-12-04 10:59:20,817 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 92) WFLYCLINF0002: Started s4g-web.war#s4g.com.peruncs.s4g.web.gwt.server.Indicator cache from hibernate container

      2015-12-04 10:59:20,937 INFO  [org.jboss.weld.Event] (MSC service thread 1-4) WELD-000411: Observer method [BackedAnnotatedMethod] public org.jboss.errai.security.keycloak.extension.AuthenticationServiceWrapperExtension.processAuthenticationServiceTypes(@Observes ProcessAnnotatedType<Object>) receives events for all

      annotated types. Consider restricting events using @WithAnnotations or a generic type with bounds.

      2015-12-04 10:59:20,950 INFO  [org.jboss.weld.Event] (MSC service thread 1-4) WELD-000411: Observer method [BackedAnnotatedMethod] public org.jboss.errai.security.server.SecurityAnnotationExtension.addParameterLogger(@Observes ProcessAnnotatedType<Object>) receives events for all annotated types. Consider restricting

      events using @WithAnnotations or a generic type with bounds.

      2015-12-04 10:59:20,953 INFO  [org.jboss.weld.Event] (MSC service thread 1-4) WELD-000411: Observer method [BackedAnnotatedMethod] public org.jboss.errai.cdi.server.CDIExtensionPoints.observeResources(@Observes ProcessAnnotatedType<Object>) receives events for all annotated types. Consider restricting events using @W

      ithAnnotations or a generic type with bounds.

      2015-12-04 10:59:20,959 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-4) starting errai cdi ...

      2015-12-04 10:59:21,199 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-4) discovered errai service: [BackedAnnotatedType] public @Dependent @Service class org.jboss.errai.security.server.NonCachingUserServiceImpl

      2015-12-04 10:59:21,257 INFO  [org.jboss.errai.cdi.server.CDIExtensionPoints] (MSC service thread 1-4) discovered errai service: [BackedAnnotatedType] public @Service @SessionScoped class org.jboss.errai.security.keycloak.KeycloakAuthenticationService

      2015-12-04 10:59:21,271 WARN  [org.jboss.weld.Bootstrap] (weld-worker-1) WELD-001125: Illegal bean type java.util.Comparator<javax.enterprise.inject.spi.AnnotatedField<? super T>> ignored on [EnhancedAnnotatedTypeImpl] private static  class org.apache.deltaspike.core.util.Annotateds$AnnotatedFieldComparator

      2015-12-04 10:59:21,272 WARN  [org.jboss.weld.Bootstrap] (weld-worker-3) WELD-001125: Illegal bean type java.util.Comparator<javax.enterprise.inject.spi.AnnotatedMethod<? super T>> ignored on [EnhancedAnnotatedTypeImpl] private static  class org.apache.deltaspike.core.util.Annotateds$AnnotatedMethodComparator

      2015-12-04 10:59:21,277 WARN  [org.jboss.weld.Bootstrap] (weld-worker-3) WELD-001125: Illegal bean type java.util.Comparator<javax.enterprise.inject.spi.AnnotatedConstructor<? super T>> ignored on [EnhancedAnnotatedTypeImpl] private static  class org.apache.deltaspike.core.util.Annotateds$AnnotatedConstructorComparat

      or

      2015-12-04 10:59:21,280 WARN  [org.jboss.weld.Bootstrap] (weld-worker-3) WELD-001125: Illegal bean type java.util.Comparator<javax.enterprise.inject.spi.AnnotatedCallable<? super T>> ignored on [EnhancedAnnotatedTypeImpl] private static  class org.apache.deltaspike.core.util.Annotateds$AnnotatedCallableComparator

      2015-12-04 10:59:21,537 INFO  [org.jboss.errai.common.metadata.MetaDataScanner] (Thread-128) added class scanning extensions: org.jboss.errai.common.metadata.JbossVFsTypeHandler

      2015-12-04 10:59:21,866 INFO  [org.jboss.errai.reflections.Reflections] (Thread-128) Reflections took 326 ms to scan 15 urls, producing 546 keys and 2907 values [using 2 cores]

      2015-12-04 10:59:22,005 ERROR [org.jboss.as.server] (management-handler-thread - 6) WFLYSRV0021: Deploy of deployment "s4g-web.war" was rolled back with the following failure message: "WFLYCTL0159: Operation handler failed to complete"

      2015-12-04 10:59:22,018 INFO  [org.jboss.as.jpa] (ServerService Thread Pool -- 98) WFLYJPA0011: Stopping Persistence Unit (phase 2 of 2) Service 's4g-web.war#s4g'

      2015-12-04 10:59:22,021 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 98) WFLYCLINF0003: Stopped s4g-web.war#s4g.com.peruncs.s4g.web.gwt.server.SymbolkListItem cache from hibernate container

      2015-12-04 10:59:22,023 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 98) WFLYCLINF0003: Stopped s4g-web.war#s4g.com.peruncs.s4g.web.gwt.server.Screen cache from hibernate container

      2015-12-04 10:59:22,025 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 98) WFLYCLINF0003: Stopped s4g-web.war#s4g.com.peruncs.s4g.web.gwt.server.BellWeather cache from hibernate container

      2015-12-04 10:59:22,028 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 98) WFLYCLINF0003: Stopped s4g-web.war#s4g.com.peruncs.s4g.web.gwt.server.SymbolList cache from hibernate container

      2015-12-04 10:59:22,033 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 98) WFLYCLINF0003: Stopped s4g-web.war#s4g.com.peruncs.s4g.web.gwt.server.Preferences cache from hibernate container

      2015-12-04 10:59:22,035 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 98) WFLYCLINF0003: Stopped s4g-web.war#s4g.com.peruncs.s4g.web.gwt.server.FinancialDetailBase cache from hibernate container

      2015-12-04 10:59:22,036 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 98) WFLYCLINF0003: Stopped s4g-web.war#s4g.com.peruncs.s4g.web.gwt.server.StockListSymbol cache from hibernate container

      2015-12-04 10:59:22,038 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 98) WFLYCLINF0003: Stopped s4g-web.war#s4g.com.peruncs.s4g.web.gwt.server.Indicator cache from hibernate container

      2015-12-04 10:59:22,042 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 98) WFLYCLINF0002: Started local-query cache from hibernate container

      2015-12-04 10:59:22,049 INFO  [org.jboss.weld.deployer] (MSC service thread 1-1) WFLYWELD0010: Stopping weld service for deployment s4g-web.war

      2015-12-04 10:59:22,049 INFO  [org.jboss.as.jpa] (ServerService Thread Pool -- 98) WFLYJPA0011: Stopping Persistence Unit (phase 1 of 2) Service 's4g-web.war#s4g'

      2015-12-04 10:59:22,058 INFO  [org.infinispan.eviction.impl.PassivationManagerImpl] (ServerService Thread Pool -- 98) ISPN000029: Passivating all entries to disk

      2015-12-04 10:59:22,058 INFO  [org.infinispan.eviction.impl.PassivationManagerImpl] (ServerService Thread Pool -- 98) ISPN000030: Passivated 0 entries in 0 milliseconds

      2015-12-04 10:59:22,062 INFO  [org.jboss.as.clustering.infinispan] (MSC service thread 1-4) WFLYCLINF0003: Stopped local-query cache from hibernate container

      2015-12-04 10:59:22,064 INFO  [org.jboss.as.clustering.infinispan] (MSC service thread 1-4) WFLYCLINF0003: Stopped pending-puts cache from hibernate container

      2015-12-04 10:59:22,065 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 98) WFLYCLINF0003: Stopped S4GLocalCache cache from S4GCacheContainer container

      2015-12-04 10:59:22,123 INFO  [org.jboss.as.server.deployment] (MSC service thread 1-6) WFLYSRV0028: Stopped deployment s4g-web.war (runtime-name: s4g-web.war) in 117ms

      2015-12-04 10:59:22,124 INFO  [org.jboss.as.controller] (management-handler-thread - 6) WFLYCTL0183: Service status report