0 Replies Latest reply on Dec 4, 2015 6:45 AM by hr.stoyanov

[wf 9.0.2] WFLYCTL0159: Operation handler failed to complete

hr.stoyanov Dec 4, 2015 6:45 AM

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>

</xa-pool>

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

<password>admin</password>

</security>

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

</timeout>

</xa-datasource>

...

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

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

</driver>

</drivers>

...

<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}">

...

<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,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

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