[JBoss JIRA] (WFLY-4196) HTTP protocol violation
by Stuart Douglas (JIRA)
[ https://issues.jboss.org/browse/WFLY-4196?page=com.atlassian.jira.plugin.... ]
Stuart Douglas edited comment on WFLY-4196 at 12/22/14 8:04 PM:
----------------------------------------------------------------
The call that is used to set the length is response.setContentLengthLong(contentLength)
With regard to clearing the header it should be possible to call setHeader("Content-Length", null);
In order to activate the built in handler you also need to attach it to a host (note that the predicate part is used to determine which requests have the filter applied):
/subsystem=undertow/server=default-server/host=default-host/filter-ref=gzipfilter:add(predicate="path-suffix[.css, .js]")
I will have a bit more of a think about how to best handle situations like this. In particular there are a few issues:
- If the default servlet does not set the content-length header then chunked encoding will be used, which is less efficient, and means that a browser can't display a progress bar when downloading files.
- It is not really possible for compression filters to set a content length unless they are prepared to buffer the whole resource, as the content length can't be determined until the whole response has been compressed. If the filter is buffering the whole resource then it should just set a content length
- We can't wait till the filter is done to set the content length, this is done by the default servlet that knows how big the file it is serving is. On possibility would be to just not set the content length header if it detects that the output stream has been wrapped. Another possibility would be to automatically clear the content-length if a transfer or content encoding header is set, although both of these could potentially cause problems.
was (Author: swd847):
The call that is used to set the length is response.setContentLengthLong(contentLength)
With regard to clearing the header it should be possible to call setHeader("Content-Length", null);
In order to activate the built in handler you also need to attach it to a host (note that the predicate part is used to determine which requests have the filter applied):
/subsystem=undertow/server=default-server/host=default-host/filter-ref=gzipfilter:add(predicate="path-suffix[.css] or path-suffix[.js]")
I will have a bit more of a think about how to best handle situations like this. In particular there are a few issues:
- If the default servlet does not set the content-length header then chunked encoding will be used, which is less efficient, and means that a browser can't display a progress bar when downloading files.
- It is not really possible for compression filters to set a content length unless they are prepared to buffer the whole resource, as the content length can't be determined until the whole response has been compressed. If the filter is buffering the whole resource then it should just set a content length
- We can't wait till the filter is done to set the content length, this is done by the default servlet that knows how big the file it is serving is. On possibility would be to just not set the content length header if it detects that the output stream has been wrapped. Another possibility would be to automatically clear the content-length if a transfer or content encoding header is set, although both of these could potentially cause problems.
> HTTP protocol violation
> -----------------------
>
> Key: WFLY-4196
> URL: https://issues.jboss.org/browse/WFLY-4196
> Project: WildFly
> Issue Type: Bug
> Components: Web (Undertow)
> Affects Versions: 8.1.0.Final, 8.2.0.Final
> Reporter: Nicolas Cazottes
> Assignee: Stuart Douglas
> Priority: Blocker
> Attachments: bug-wildfly-gzip-war-1.0.0-SNAPSHOT.war, fiddler_protocol_violation.jpg
>
>
> If you deploy the given war in wildfly and open this url http://localhost:8080/bug/images/download.png : it seems to work correctly but if you run it with fiddler2 active, fiddler reports a protocol violation on the Content-Length header value.
> Actually, If the content is some js or css, the browser does not correctly reads it and the web page is corrupted.
> The explanation is that the web application uses a filter to compress the content in gzip format.
> For information, this application works correctly with jboss as 7 or before (that embed tomcat). I discovered the problem while trying to upgrade my application.
--
This message was sent by Atlassian JIRA
(v6.3.11#6341)
11 years, 6 months
[JBoss JIRA] (WFLY-4196) HTTP protocol violation
by Stuart Douglas (JIRA)
[ https://issues.jboss.org/browse/WFLY-4196?page=com.atlassian.jira.plugin.... ]
Stuart Douglas commented on WFLY-4196:
--------------------------------------
The call that is used to set the length is response.setContentLengthLong(contentLength)
With regard to clearing the header it should be possible to call setHeader("Content-Length", null);
In order to activate the built in handler you also need to attach it to a host (note that the predicate part is used to determine which requests have the filter applied):
/subsystem=undertow/server=default-server/host=default-host/filter-ref=gzipfilter:add(predicate="path-suffix[.css] or path-suffix[.js]")
I will have a bit more of a think about how to best handle situations like this. In particular there are a few issues:
- If the default servlet does not set the content-length header then chunked encoding will be used, which is less efficient, and means that a browser can't display a progress bar when downloading files.
- It is not really possible for compression filters to set a content length unless they are prepared to buffer the whole resource, as the content length can't be determined until the whole response has been compressed. If the filter is buffering the whole resource then it should just set a content length
- We can't wait till the filter is done to set the content length, this is done by the default servlet that knows how big the file it is serving is. On possibility would be to just not set the content length header if it detects that the output stream has been wrapped. Another possibility would be to automatically clear the content-length if a transfer or content encoding header is set, although both of these could potentially cause problems.
> HTTP protocol violation
> -----------------------
>
> Key: WFLY-4196
> URL: https://issues.jboss.org/browse/WFLY-4196
> Project: WildFly
> Issue Type: Bug
> Components: Web (Undertow)
> Affects Versions: 8.1.0.Final, 8.2.0.Final
> Reporter: Nicolas Cazottes
> Assignee: Stuart Douglas
> Priority: Blocker
> Attachments: bug-wildfly-gzip-war-1.0.0-SNAPSHOT.war, fiddler_protocol_violation.jpg
>
>
> If you deploy the given war in wildfly and open this url http://localhost:8080/bug/images/download.png : it seems to work correctly but if you run it with fiddler2 active, fiddler reports a protocol violation on the Content-Length header value.
> Actually, If the content is some js or css, the browser does not correctly reads it and the web page is corrupted.
> The explanation is that the web application uses a filter to compress the content in gzip format.
> For information, this application works correctly with jboss as 7 or before (that embed tomcat). I discovered the problem while trying to upgrade my application.
--
This message was sent by Atlassian JIRA
(v6.3.11#6341)
11 years, 6 months
[JBoss JIRA] (WFLY-4199) App redeploy exceptions
by Stuart Douglas (JIRA)
[ https://issues.jboss.org/browse/WFLY-4199?page=com.atlassian.jira.plugin.... ]
Stuart Douglas commented on WFLY-4199:
--------------------------------------
I can't reproduce this, although it looks like it may be some kind of VFS or other deployment issue, as it appears the deployment root is not being set up correctly.
Are you using Windows by any chance?
> App redeploy exceptions
> -----------------------
>
> Key: WFLY-4199
> URL: https://issues.jboss.org/browse/WFLY-4199
> Project: WildFly
> Issue Type: Bug
> Components: Web (Undertow), Web Services
> Reporter: Eduardo Martins
> Assignee: Stuart Douglas
>
> I'm noticing intermittent occurrences of exceptions when redeploying quickstarts, and unfortunately the chance seems quite high. The exceptions,a at least on my end, may be reproduced by using app "thread-racing" of the following branches of my quickstarts fork:
> Web Services) https://github.com/emmartins/quickstart/tree/redeploy-exceptions , where the following exception occur at an alarming 8 out of 10 redeploys:
> {code}
> 19:41:38,502 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0001: Content added at location /Users/emmartins/wildfly/git/wildfly/dist/target/wildfly-9.0.0.Alpha2-SNAPSHOT/standalone/data/content/b5/1306d722adbe53ba6b7445f1b2d72facd66201/content
> 19:41:38,504 INFO [org.wildfly.extension.undertow] (MSC service thread 1-3) WFLYUT0022: Unregistered web context: /wildfly-thread-racing
> 19:41:38,519 INFO [org.jboss.weld.deployer] (MSC service thread 1-4) WFLYWELD0010: Stopping weld service for deployment wildfly-thread-racing.war
> 19:41:38,527 INFO [org.jboss.as.server.deployment] (MSC service thread 1-12) WFLYSRV0028: Stopped deployment wildfly-thread-racing.war (runtime-name: wildfly-thread-racing.war) in 24ms
> 19:41:38,528 INFO [org.jboss.as.server.deployment] (MSC service thread 1-3) WFLYSRV0027: Starting deployment of "wildfly-thread-racing.war" (runtime-name: "wildfly-thread-racing.war")
> 19:41:38,556 ERROR [org.jboss.msc.service.fail] (MSC service thread 1-14) MSC000001: Failed to start service jboss.deployment.unit."wildfly-thread-racing.war".PARSE: org.jboss.msc.service.StartException in service jboss.deployment.unit."wildfly-thread-racing.war".PARSE: WFLYSRV0153: Failed to process phase PARSE of deployment "wildfly-thread-racing.war"
> at org.jboss.as.server.deployment.DeploymentUnitPhaseService.start(DeploymentUnitPhaseService.java:163)
> at org.jboss.msc.service.ServiceControllerImpl$StartTask.startService(ServiceControllerImpl.java:1948)
> at org.jboss.msc.service.ServiceControllerImpl$StartTask.run(ServiceControllerImpl.java:1881)
> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> at java.lang.Thread.run(Thread.java:745)
> Caused by: java.lang.NullPointerException
> at org.jboss.as.webservices.deployers.WebservicesDescriptorDeploymentProcessor.getWebServicesDescriptorURL(WebservicesDescriptorDeploymentProcessor.java:70)
> at org.jboss.as.webservices.deployers.WebservicesDescriptorDeploymentProcessor.deploy(WebservicesDescriptorDeploymentProcessor.java:52)
> at org.jboss.as.server.deployment.DeploymentUnitPhaseService.start(DeploymentUnitPhaseService.java:156)
> ... 5 more
> 19:41:38,559 INFO [org.jboss.as.server.deployment] (MSC service thread 1-6) WFLYSRV0028: Stopped deployment wildfly-thread-racing.war (runtime-name: wildfly-thread-racing.war) in 30ms
> 19:41:38,560 INFO [org.jboss.as.server.deployment] (MSC service thread 1-12) WFLYSRV0027: Starting deployment of "wildfly-thread-racing.war" (runtime-name: "wildfly-thread-racing.war")
> 19:41:38,593 WARN [org.jboss.weld.deployer] (MSC service thread 1-13) WFLYWELD0012: Warning while parsing vfs:/content/wildfly-thread-racing.war/WEB-INF/beans.xml:22 cvc-complex-type.4: Attribute 'bean-discovery-mode' must appear on element 'beans'.
> 19:41:38,609 INFO [org.jboss.weld.deployer] (MSC service thread 1-2) WFLYWELD0003: Processing weld deployment wildfly-thread-racing.war
> 19:41:38,633 INFO [org.jboss.as.messaging] (MSC service thread 1-2) WFLYMSG0002: Bound messaging object to jndi name java:global/threadRacing/stages/jms/requestQueue
> 19:41:38,637 INFO [org.jboss.weld.deployer] (MSC service thread 1-9) WFLYWELD0006: Starting Services for CDI deployment: wildfly-thread-racing.war
> 19:41:38,641 INFO [org.jboss.weld.deployer] (MSC service thread 1-5) WFLYWELD0009: Starting weld service for deployment wildfly-thread-racing.war
> 19:41:38,643 INFO [org.jboss.as.ejb3] (MSC service thread 1-10) WFLYEJB0042: Started message driven bean 'JMSRaceStageMessageListener' with 'hornetq-ra.rar' resource adapter
> 19:41:38,753 INFO [io.undertow.websockets.jsr] (MSC service thread 1-7) UT026003: Adding annotated server endpoint class org.jboss.as.quickstarts.threadracing.stage.websocket.ServerEndpoint for path /ws
> 19:41:38,754 INFO [io.undertow.websockets.jsr] (MSC service thread 1-7) UT026004: Adding annotated client endpoint class org.jboss.as.quickstarts.threadracing.stage.websocket.ClientEndpoint
> 19:41:38,758 INFO [org.wildfly.extension.undertow] (MSC service thread 1-7) WFLYUT0021: Registered web context: /wildfly-thread-racing
> 19:41:38,770 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0013: Redeployed "wildfly-thread-racing.war"
> 19:41:38,770 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0016: Replaced deployment "wildfly-thread-racing.war" with deployment "wildfly-thread-racing.war"
> 19:41:38,771 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0002: Content removed from location /Users/emmartins/wildfly/git/wildfly/dist/target/wildfly-9.0.0.Alpha2-SNAPSHOT/standalone/data/content/98/04cfcd3addc74805031f222ee036ff47b62f5d/content
> {code}
> Web) https://github.com/emmartins/quickstart/tree/redeploy-exceptions2 , where the following exception occur about half of redeploys:
> {code}
> 20:27:05,715 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0001: Content added at location /Users/emmartins/wildfly/git/wildfly/dist/target/wildfly-9.0.0.Alpha2-SNAPSHOT/standalone/data/content/c4/abc434ff307278c10061fb9dbbd3fcd0aff116/content
> 20:27:05,717 INFO [org.wildfly.extension.undertow] (MSC service thread 1-13) WFLYUT0022: Unregistered web context: /wildfly-thread-racing
> 20:27:05,734 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 77) WFLYJPA0011: Stopping Persistence Unit (phase 2 of 2) Service 'wildfly-thread-racing.war#RacePU'
> 20:27:05,735 INFO [org.jboss.weld.deployer] (MSC service thread 1-4) WFLYWELD0010: Stopping weld service for deployment wildfly-thread-racing.war
> 20:27:05,735 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 77) WFLYJPA0011: Stopping Persistence Unit (phase 1 of 2) Service 'wildfly-thread-racing.war#RacePU'
> 20:27:05,745 INFO [org.jboss.as.server.deployment] (MSC service thread 1-9) WFLYSRV0028: Stopped deployment wildfly-thread-racing.war (runtime-name: wildfly-thread-racing.war) in 28ms
> 20:27:05,746 INFO [org.jboss.as.server.deployment] (MSC service thread 1-14) WFLYSRV0027: Starting deployment of "wildfly-thread-racing.war" (runtime-name: "wildfly-thread-racing.war")
> 20:27:05,775 ERROR [org.jboss.msc.service.fail] (MSC service thread 1-8) MSC000001: Failed to start service jboss.deployment.unit."wildfly-thread-racing.war".PARSE: org.jboss.msc.service.StartException in service jboss.deployment.unit."wildfly-thread-racing.war".PARSE: WFLYSRV0153: Failed to process phase PARSE of deployment "wildfly-thread-racing.war"
> at org.jboss.as.server.deployment.DeploymentUnitPhaseService.start(DeploymentUnitPhaseService.java:163)
> at org.jboss.msc.service.ServiceControllerImpl$StartTask.startService(ServiceControllerImpl.java:1948)
> at org.jboss.msc.service.ServiceControllerImpl$StartTask.run(ServiceControllerImpl.java:1881)
> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> at java.lang.Thread.run(Thread.java:745)
> Caused by: java.lang.NullPointerException
> at org.wildfly.extension.undertow.deployment.JBossWebParsingDeploymentProcessor.deploy(JBossWebParsingDeploymentProcessor.java:61)
> at org.jboss.as.server.deployment.DeploymentUnitPhaseService.start(DeploymentUnitPhaseService.java:156)
> ... 5 more
> 20:27:05,780 INFO [org.jboss.as.server.deployment] (MSC service thread 1-15) WFLYSRV0028: Stopped deployment wildfly-thread-racing.war (runtime-name: wildfly-thread-racing.war) in 33ms
> 20:27:05,782 INFO [org.jboss.as.server.deployment] (MSC service thread 1-11) WFLYSRV0027: Starting deployment of "wildfly-thread-racing.war" (runtime-name: "wildfly-thread-racing.war")
> 20:27:05,819 INFO [org.jboss.as.jpa] (MSC service thread 1-10) WFLYJPA0002: Read persistence.xml for RacePU
> 20:27:05,833 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 77) WFLYJPA0010: Starting Persistence Unit (phase 1 of 2) Service 'wildfly-thread-racing.war#RacePU'
> 20:27:05,833 INFO [org.hibernate.jpa.internal.util.LogHelper] (ServerService Thread Pool -- 77) HHH000204: Processing PersistenceUnitInfo [
> name: RacePU
> ...]
> 20:27:05,838 INFO [org.jboss.weld.deployer] (MSC service thread 1-12) WFLYWELD0003: Processing weld deployment wildfly-thread-racing.war
> 20:27:05,841 INFO [org.jboss.as.ejb3.deployment.processors.EjbJndiBindingsDeploymentUnitProcessor] (MSC service thread 1-12) JNDI bindings for session bean named RaceResults in deployment unit deployment "wildfly-thread-racing.war" are as follows:
> java:global/wildfly-thread-racing/RaceResults!org.jboss.as.quickstarts.threadracing.results.RaceResults
> java:app/wildfly-thread-racing/RaceResults!org.jboss.as.quickstarts.threadracing.results.RaceResults
> java:module/RaceResults!org.jboss.as.quickstarts.threadracing.results.RaceResults
> java:global/wildfly-thread-racing/RaceResults
> java:app/wildfly-thread-racing/RaceResults
> java:module/RaceResults
> 20:27:05,872 INFO [org.jboss.as.messaging] (MSC service thread 1-12) WFLYMSG0002: Bound messaging object to jndi name java:global/threadRacing/stages/jms/requestQueue
> 20:27:05,878 INFO [org.jboss.weld.deployer] (MSC service thread 1-4) WFLYWELD0006: Starting Services for CDI deployment: wildfly-thread-racing.war
> 20:27:05,883 INFO [org.jboss.weld.deployer] (MSC service thread 1-12) WFLYWELD0009: Starting weld service for deployment wildfly-thread-racing.war
> 20:27:05,885 INFO [org.jboss.as.ejb3] (MSC service thread 1-13) WFLYEJB0042: Started message driven bean 'JMSRaceStageMessageListener' with 'hornetq-ra.rar' resource adapter
> 20:27:05,887 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 77) WFLYJPA0010: Starting Persistence Unit (phase 2 of 2) Service 'wildfly-thread-racing.war#RacePU'
> 20:27:05,893 INFO [org.hibernate.dialect.Dialect] (ServerService Thread Pool -- 77) HHH000400: Using dialect: org.hibernate.dialect.H2Dialect
> 20:27:05,893 WARN [org.hibernate.dialect.H2Dialect] (ServerService Thread Pool -- 77) HHH000431: Unable to determine H2 database version, certain features may not work
> 20:27:05,899 INFO [org.hibernate.hql.internal.ast.ASTQueryTranslatorFactory] (ServerService Thread Pool -- 77) HHH000397: Using ASTQueryTranslatorFactory
> 20:27:05,921 INFO [org.hibernate.dialect.Dialect] (ServerService Thread Pool -- 77) HHH000400: Using dialect: org.hibernate.dialect.H2Dialect
> 20:27:05,922 WARN [org.hibernate.dialect.H2Dialect] (ServerService Thread Pool -- 77) HHH000431: Unable to determine H2 database version, certain features may not work
> 20:27:06,057 INFO [io.undertow.websockets.jsr] (MSC service thread 1-15) UT026003: Adding annotated server endpoint class org.jboss.as.quickstarts.threadracing.WebSocketRace for path /race
> 20:27:06,085 INFO [org.jboss.resteasy.spi.ResteasyDeployment] (MSC service thread 1-15) Deploying javax.ws.rs.core.Application: class org.jboss.as.quickstarts.threadracing.stage.jaxrs.BoxApplication$Proxy$_$$_WeldClientProxy
> 20:27:06,086 INFO [org.jboss.resteasy.spi.ResteasyDeployment] (MSC service thread 1-15) Adding class resource org.jboss.as.quickstarts.threadracing.stage.jaxrs.BoxService from Application class org.jboss.as.quickstarts.threadracing.stage.jaxrs.BoxApplication$Proxy$_$$_WeldClientProxy
> 20:27:06,088 INFO [org.wildfly.extension.undertow] (MSC service thread 1-15) WFLYUT0021: Registered web context: /wildfly-thread-racing
> 20:27:06,102 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0013: Redeployed "wildfly-thread-racing.war"
> 20:27:06,102 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0016: Replaced deployment "wildfly-thread-racing.war" with deployment "wildfly-thread-racing.war"
> 20:27:06,103 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0002: Content removed from location /Users/emmartins/wildfly/git/wildfly/dist/target/wildfly-9.0.0.Alpha2-SNAPSHOT/standalone/data/content/fe/8d3392468fc3e5e8b15d722d003fe3e0f851af/content
> {code}
--
This message was sent by Atlassian JIRA
(v6.3.11#6341)
11 years, 6 months
[JBoss JIRA] (WFLY-4196) HTTP protocol violation
by Nicolas Cazottes (JIRA)
[ https://issues.jboss.org/browse/WFLY-4196?page=com.atlassian.jira.plugin.... ]
Nicolas Cazottes commented on WFLY-4196:
----------------------------------------
I did some search in the source code and in debug mode and there is no call to the HttpServletResponse.setHeader or HttpServletResponse.addHeader methods for the Content-Length header.
Another point is that the server returns a value for the Content-Length of 3854 bytes where as the real (compressed size is smaller and is of 3760 bytes).
So I think that undertow determines the size of the Content-Length before the filter applies and should instead wait the end of the filter to set the value of the Content-Length header.
What do you mean by clearing the Content-Length header ? I do not see any API to remove an HTTP Header in HttpServletResponse.
For the test of the gzip subsystem configured in undertow, if I activate it via the command /subsystem=undertow/configuration=filter/gzip=gzipfilter/:add, fiddler does not detect any compression on the wire at all. Is it the correct way of activating it ?
> HTTP protocol violation
> -----------------------
>
> Key: WFLY-4196
> URL: https://issues.jboss.org/browse/WFLY-4196
> Project: WildFly
> Issue Type: Bug
> Components: Web (Undertow)
> Affects Versions: 8.1.0.Final, 8.2.0.Final
> Reporter: Nicolas Cazottes
> Assignee: Stuart Douglas
> Priority: Blocker
> Attachments: bug-wildfly-gzip-war-1.0.0-SNAPSHOT.war, fiddler_protocol_violation.jpg
>
>
> If you deploy the given war in wildfly and open this url http://localhost:8080/bug/images/download.png : it seems to work correctly but if you run it with fiddler2 active, fiddler reports a protocol violation on the Content-Length header value.
> Actually, If the content is some js or css, the browser does not correctly reads it and the web page is corrupted.
> The explanation is that the web application uses a filter to compress the content in gzip format.
> For information, this application works correctly with jboss as 7 or before (that embed tomcat). I discovered the problem while trying to upgrade my application.
--
This message was sent by Atlassian JIRA
(v6.3.11#6341)
11 years, 6 months
[JBoss JIRA] (WFLY-4199) App redeploy exceptions
by Eduardo Martins (JIRA)
[ https://issues.jboss.org/browse/WFLY-4199?page=com.atlassian.jira.plugin.... ]
Eduardo Martins commented on WFLY-4199:
---------------------------------------
Start WildFly with full config and use mvn wilfly:deploy
> App redeploy exceptions
> -----------------------
>
> Key: WFLY-4199
> URL: https://issues.jboss.org/browse/WFLY-4199
> Project: WildFly
> Issue Type: Bug
> Components: Web (Undertow), Web Services
> Reporter: Eduardo Martins
> Assignee: Stuart Douglas
>
> I'm noticing intermittent occurrences of exceptions when redeploying quickstarts, and unfortunately the chance seems quite high. The exceptions,a at least on my end, may be reproduced by using app "thread-racing" of the following branches of my quickstarts fork:
> Web Services) https://github.com/emmartins/quickstart/tree/redeploy-exceptions , where the following exception occur at an alarming 8 out of 10 redeploys:
> {code}
> 19:41:38,502 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0001: Content added at location /Users/emmartins/wildfly/git/wildfly/dist/target/wildfly-9.0.0.Alpha2-SNAPSHOT/standalone/data/content/b5/1306d722adbe53ba6b7445f1b2d72facd66201/content
> 19:41:38,504 INFO [org.wildfly.extension.undertow] (MSC service thread 1-3) WFLYUT0022: Unregistered web context: /wildfly-thread-racing
> 19:41:38,519 INFO [org.jboss.weld.deployer] (MSC service thread 1-4) WFLYWELD0010: Stopping weld service for deployment wildfly-thread-racing.war
> 19:41:38,527 INFO [org.jboss.as.server.deployment] (MSC service thread 1-12) WFLYSRV0028: Stopped deployment wildfly-thread-racing.war (runtime-name: wildfly-thread-racing.war) in 24ms
> 19:41:38,528 INFO [org.jboss.as.server.deployment] (MSC service thread 1-3) WFLYSRV0027: Starting deployment of "wildfly-thread-racing.war" (runtime-name: "wildfly-thread-racing.war")
> 19:41:38,556 ERROR [org.jboss.msc.service.fail] (MSC service thread 1-14) MSC000001: Failed to start service jboss.deployment.unit."wildfly-thread-racing.war".PARSE: org.jboss.msc.service.StartException in service jboss.deployment.unit."wildfly-thread-racing.war".PARSE: WFLYSRV0153: Failed to process phase PARSE of deployment "wildfly-thread-racing.war"
> at org.jboss.as.server.deployment.DeploymentUnitPhaseService.start(DeploymentUnitPhaseService.java:163)
> at org.jboss.msc.service.ServiceControllerImpl$StartTask.startService(ServiceControllerImpl.java:1948)
> at org.jboss.msc.service.ServiceControllerImpl$StartTask.run(ServiceControllerImpl.java:1881)
> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> at java.lang.Thread.run(Thread.java:745)
> Caused by: java.lang.NullPointerException
> at org.jboss.as.webservices.deployers.WebservicesDescriptorDeploymentProcessor.getWebServicesDescriptorURL(WebservicesDescriptorDeploymentProcessor.java:70)
> at org.jboss.as.webservices.deployers.WebservicesDescriptorDeploymentProcessor.deploy(WebservicesDescriptorDeploymentProcessor.java:52)
> at org.jboss.as.server.deployment.DeploymentUnitPhaseService.start(DeploymentUnitPhaseService.java:156)
> ... 5 more
> 19:41:38,559 INFO [org.jboss.as.server.deployment] (MSC service thread 1-6) WFLYSRV0028: Stopped deployment wildfly-thread-racing.war (runtime-name: wildfly-thread-racing.war) in 30ms
> 19:41:38,560 INFO [org.jboss.as.server.deployment] (MSC service thread 1-12) WFLYSRV0027: Starting deployment of "wildfly-thread-racing.war" (runtime-name: "wildfly-thread-racing.war")
> 19:41:38,593 WARN [org.jboss.weld.deployer] (MSC service thread 1-13) WFLYWELD0012: Warning while parsing vfs:/content/wildfly-thread-racing.war/WEB-INF/beans.xml:22 cvc-complex-type.4: Attribute 'bean-discovery-mode' must appear on element 'beans'.
> 19:41:38,609 INFO [org.jboss.weld.deployer] (MSC service thread 1-2) WFLYWELD0003: Processing weld deployment wildfly-thread-racing.war
> 19:41:38,633 INFO [org.jboss.as.messaging] (MSC service thread 1-2) WFLYMSG0002: Bound messaging object to jndi name java:global/threadRacing/stages/jms/requestQueue
> 19:41:38,637 INFO [org.jboss.weld.deployer] (MSC service thread 1-9) WFLYWELD0006: Starting Services for CDI deployment: wildfly-thread-racing.war
> 19:41:38,641 INFO [org.jboss.weld.deployer] (MSC service thread 1-5) WFLYWELD0009: Starting weld service for deployment wildfly-thread-racing.war
> 19:41:38,643 INFO [org.jboss.as.ejb3] (MSC service thread 1-10) WFLYEJB0042: Started message driven bean 'JMSRaceStageMessageListener' with 'hornetq-ra.rar' resource adapter
> 19:41:38,753 INFO [io.undertow.websockets.jsr] (MSC service thread 1-7) UT026003: Adding annotated server endpoint class org.jboss.as.quickstarts.threadracing.stage.websocket.ServerEndpoint for path /ws
> 19:41:38,754 INFO [io.undertow.websockets.jsr] (MSC service thread 1-7) UT026004: Adding annotated client endpoint class org.jboss.as.quickstarts.threadracing.stage.websocket.ClientEndpoint
> 19:41:38,758 INFO [org.wildfly.extension.undertow] (MSC service thread 1-7) WFLYUT0021: Registered web context: /wildfly-thread-racing
> 19:41:38,770 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0013: Redeployed "wildfly-thread-racing.war"
> 19:41:38,770 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0016: Replaced deployment "wildfly-thread-racing.war" with deployment "wildfly-thread-racing.war"
> 19:41:38,771 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0002: Content removed from location /Users/emmartins/wildfly/git/wildfly/dist/target/wildfly-9.0.0.Alpha2-SNAPSHOT/standalone/data/content/98/04cfcd3addc74805031f222ee036ff47b62f5d/content
> {code}
> Web) https://github.com/emmartins/quickstart/tree/redeploy-exceptions2 , where the following exception occur about half of redeploys:
> {code}
> 20:27:05,715 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0001: Content added at location /Users/emmartins/wildfly/git/wildfly/dist/target/wildfly-9.0.0.Alpha2-SNAPSHOT/standalone/data/content/c4/abc434ff307278c10061fb9dbbd3fcd0aff116/content
> 20:27:05,717 INFO [org.wildfly.extension.undertow] (MSC service thread 1-13) WFLYUT0022: Unregistered web context: /wildfly-thread-racing
> 20:27:05,734 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 77) WFLYJPA0011: Stopping Persistence Unit (phase 2 of 2) Service 'wildfly-thread-racing.war#RacePU'
> 20:27:05,735 INFO [org.jboss.weld.deployer] (MSC service thread 1-4) WFLYWELD0010: Stopping weld service for deployment wildfly-thread-racing.war
> 20:27:05,735 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 77) WFLYJPA0011: Stopping Persistence Unit (phase 1 of 2) Service 'wildfly-thread-racing.war#RacePU'
> 20:27:05,745 INFO [org.jboss.as.server.deployment] (MSC service thread 1-9) WFLYSRV0028: Stopped deployment wildfly-thread-racing.war (runtime-name: wildfly-thread-racing.war) in 28ms
> 20:27:05,746 INFO [org.jboss.as.server.deployment] (MSC service thread 1-14) WFLYSRV0027: Starting deployment of "wildfly-thread-racing.war" (runtime-name: "wildfly-thread-racing.war")
> 20:27:05,775 ERROR [org.jboss.msc.service.fail] (MSC service thread 1-8) MSC000001: Failed to start service jboss.deployment.unit."wildfly-thread-racing.war".PARSE: org.jboss.msc.service.StartException in service jboss.deployment.unit."wildfly-thread-racing.war".PARSE: WFLYSRV0153: Failed to process phase PARSE of deployment "wildfly-thread-racing.war"
> at org.jboss.as.server.deployment.DeploymentUnitPhaseService.start(DeploymentUnitPhaseService.java:163)
> at org.jboss.msc.service.ServiceControllerImpl$StartTask.startService(ServiceControllerImpl.java:1948)
> at org.jboss.msc.service.ServiceControllerImpl$StartTask.run(ServiceControllerImpl.java:1881)
> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> at java.lang.Thread.run(Thread.java:745)
> Caused by: java.lang.NullPointerException
> at org.wildfly.extension.undertow.deployment.JBossWebParsingDeploymentProcessor.deploy(JBossWebParsingDeploymentProcessor.java:61)
> at org.jboss.as.server.deployment.DeploymentUnitPhaseService.start(DeploymentUnitPhaseService.java:156)
> ... 5 more
> 20:27:05,780 INFO [org.jboss.as.server.deployment] (MSC service thread 1-15) WFLYSRV0028: Stopped deployment wildfly-thread-racing.war (runtime-name: wildfly-thread-racing.war) in 33ms
> 20:27:05,782 INFO [org.jboss.as.server.deployment] (MSC service thread 1-11) WFLYSRV0027: Starting deployment of "wildfly-thread-racing.war" (runtime-name: "wildfly-thread-racing.war")
> 20:27:05,819 INFO [org.jboss.as.jpa] (MSC service thread 1-10) WFLYJPA0002: Read persistence.xml for RacePU
> 20:27:05,833 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 77) WFLYJPA0010: Starting Persistence Unit (phase 1 of 2) Service 'wildfly-thread-racing.war#RacePU'
> 20:27:05,833 INFO [org.hibernate.jpa.internal.util.LogHelper] (ServerService Thread Pool -- 77) HHH000204: Processing PersistenceUnitInfo [
> name: RacePU
> ...]
> 20:27:05,838 INFO [org.jboss.weld.deployer] (MSC service thread 1-12) WFLYWELD0003: Processing weld deployment wildfly-thread-racing.war
> 20:27:05,841 INFO [org.jboss.as.ejb3.deployment.processors.EjbJndiBindingsDeploymentUnitProcessor] (MSC service thread 1-12) JNDI bindings for session bean named RaceResults in deployment unit deployment "wildfly-thread-racing.war" are as follows:
> java:global/wildfly-thread-racing/RaceResults!org.jboss.as.quickstarts.threadracing.results.RaceResults
> java:app/wildfly-thread-racing/RaceResults!org.jboss.as.quickstarts.threadracing.results.RaceResults
> java:module/RaceResults!org.jboss.as.quickstarts.threadracing.results.RaceResults
> java:global/wildfly-thread-racing/RaceResults
> java:app/wildfly-thread-racing/RaceResults
> java:module/RaceResults
> 20:27:05,872 INFO [org.jboss.as.messaging] (MSC service thread 1-12) WFLYMSG0002: Bound messaging object to jndi name java:global/threadRacing/stages/jms/requestQueue
> 20:27:05,878 INFO [org.jboss.weld.deployer] (MSC service thread 1-4) WFLYWELD0006: Starting Services for CDI deployment: wildfly-thread-racing.war
> 20:27:05,883 INFO [org.jboss.weld.deployer] (MSC service thread 1-12) WFLYWELD0009: Starting weld service for deployment wildfly-thread-racing.war
> 20:27:05,885 INFO [org.jboss.as.ejb3] (MSC service thread 1-13) WFLYEJB0042: Started message driven bean 'JMSRaceStageMessageListener' with 'hornetq-ra.rar' resource adapter
> 20:27:05,887 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 77) WFLYJPA0010: Starting Persistence Unit (phase 2 of 2) Service 'wildfly-thread-racing.war#RacePU'
> 20:27:05,893 INFO [org.hibernate.dialect.Dialect] (ServerService Thread Pool -- 77) HHH000400: Using dialect: org.hibernate.dialect.H2Dialect
> 20:27:05,893 WARN [org.hibernate.dialect.H2Dialect] (ServerService Thread Pool -- 77) HHH000431: Unable to determine H2 database version, certain features may not work
> 20:27:05,899 INFO [org.hibernate.hql.internal.ast.ASTQueryTranslatorFactory] (ServerService Thread Pool -- 77) HHH000397: Using ASTQueryTranslatorFactory
> 20:27:05,921 INFO [org.hibernate.dialect.Dialect] (ServerService Thread Pool -- 77) HHH000400: Using dialect: org.hibernate.dialect.H2Dialect
> 20:27:05,922 WARN [org.hibernate.dialect.H2Dialect] (ServerService Thread Pool -- 77) HHH000431: Unable to determine H2 database version, certain features may not work
> 20:27:06,057 INFO [io.undertow.websockets.jsr] (MSC service thread 1-15) UT026003: Adding annotated server endpoint class org.jboss.as.quickstarts.threadracing.WebSocketRace for path /race
> 20:27:06,085 INFO [org.jboss.resteasy.spi.ResteasyDeployment] (MSC service thread 1-15) Deploying javax.ws.rs.core.Application: class org.jboss.as.quickstarts.threadracing.stage.jaxrs.BoxApplication$Proxy$_$$_WeldClientProxy
> 20:27:06,086 INFO [org.jboss.resteasy.spi.ResteasyDeployment] (MSC service thread 1-15) Adding class resource org.jboss.as.quickstarts.threadracing.stage.jaxrs.BoxService from Application class org.jboss.as.quickstarts.threadracing.stage.jaxrs.BoxApplication$Proxy$_$$_WeldClientProxy
> 20:27:06,088 INFO [org.wildfly.extension.undertow] (MSC service thread 1-15) WFLYUT0021: Registered web context: /wildfly-thread-racing
> 20:27:06,102 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0013: Redeployed "wildfly-thread-racing.war"
> 20:27:06,102 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0016: Replaced deployment "wildfly-thread-racing.war" with deployment "wildfly-thread-racing.war"
> 20:27:06,103 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0002: Content removed from location /Users/emmartins/wildfly/git/wildfly/dist/target/wildfly-9.0.0.Alpha2-SNAPSHOT/standalone/data/content/fe/8d3392468fc3e5e8b15d722d003fe3e0f851af/content
> {code}
--
This message was sent by Atlassian JIRA
(v6.3.11#6341)
11 years, 6 months
[JBoss JIRA] (WFLY-4199) App redeploy exceptions
by Stuart Douglas (JIRA)
[ https://issues.jboss.org/browse/WFLY-4199?page=com.atlassian.jira.plugin.... ]
Stuart Douglas commented on WFLY-4199:
--------------------------------------
How are you redeploying? (Management API, deployment scanner etc)
> App redeploy exceptions
> -----------------------
>
> Key: WFLY-4199
> URL: https://issues.jboss.org/browse/WFLY-4199
> Project: WildFly
> Issue Type: Bug
> Components: Web (Undertow), Web Services
> Reporter: Eduardo Martins
> Assignee: Stuart Douglas
>
> I'm noticing intermittent occurrences of exceptions when redeploying quickstarts, and unfortunately the chance seems quite high. The exceptions,a at least on my end, may be reproduced by using app "thread-racing" of the following branches of my quickstarts fork:
> Web Services) https://github.com/emmartins/quickstart/tree/redeploy-exceptions , where the following exception occur at an alarming 8 out of 10 redeploys:
> {code}
> 19:41:38,502 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0001: Content added at location /Users/emmartins/wildfly/git/wildfly/dist/target/wildfly-9.0.0.Alpha2-SNAPSHOT/standalone/data/content/b5/1306d722adbe53ba6b7445f1b2d72facd66201/content
> 19:41:38,504 INFO [org.wildfly.extension.undertow] (MSC service thread 1-3) WFLYUT0022: Unregistered web context: /wildfly-thread-racing
> 19:41:38,519 INFO [org.jboss.weld.deployer] (MSC service thread 1-4) WFLYWELD0010: Stopping weld service for deployment wildfly-thread-racing.war
> 19:41:38,527 INFO [org.jboss.as.server.deployment] (MSC service thread 1-12) WFLYSRV0028: Stopped deployment wildfly-thread-racing.war (runtime-name: wildfly-thread-racing.war) in 24ms
> 19:41:38,528 INFO [org.jboss.as.server.deployment] (MSC service thread 1-3) WFLYSRV0027: Starting deployment of "wildfly-thread-racing.war" (runtime-name: "wildfly-thread-racing.war")
> 19:41:38,556 ERROR [org.jboss.msc.service.fail] (MSC service thread 1-14) MSC000001: Failed to start service jboss.deployment.unit."wildfly-thread-racing.war".PARSE: org.jboss.msc.service.StartException in service jboss.deployment.unit."wildfly-thread-racing.war".PARSE: WFLYSRV0153: Failed to process phase PARSE of deployment "wildfly-thread-racing.war"
> at org.jboss.as.server.deployment.DeploymentUnitPhaseService.start(DeploymentUnitPhaseService.java:163)
> at org.jboss.msc.service.ServiceControllerImpl$StartTask.startService(ServiceControllerImpl.java:1948)
> at org.jboss.msc.service.ServiceControllerImpl$StartTask.run(ServiceControllerImpl.java:1881)
> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> at java.lang.Thread.run(Thread.java:745)
> Caused by: java.lang.NullPointerException
> at org.jboss.as.webservices.deployers.WebservicesDescriptorDeploymentProcessor.getWebServicesDescriptorURL(WebservicesDescriptorDeploymentProcessor.java:70)
> at org.jboss.as.webservices.deployers.WebservicesDescriptorDeploymentProcessor.deploy(WebservicesDescriptorDeploymentProcessor.java:52)
> at org.jboss.as.server.deployment.DeploymentUnitPhaseService.start(DeploymentUnitPhaseService.java:156)
> ... 5 more
> 19:41:38,559 INFO [org.jboss.as.server.deployment] (MSC service thread 1-6) WFLYSRV0028: Stopped deployment wildfly-thread-racing.war (runtime-name: wildfly-thread-racing.war) in 30ms
> 19:41:38,560 INFO [org.jboss.as.server.deployment] (MSC service thread 1-12) WFLYSRV0027: Starting deployment of "wildfly-thread-racing.war" (runtime-name: "wildfly-thread-racing.war")
> 19:41:38,593 WARN [org.jboss.weld.deployer] (MSC service thread 1-13) WFLYWELD0012: Warning while parsing vfs:/content/wildfly-thread-racing.war/WEB-INF/beans.xml:22 cvc-complex-type.4: Attribute 'bean-discovery-mode' must appear on element 'beans'.
> 19:41:38,609 INFO [org.jboss.weld.deployer] (MSC service thread 1-2) WFLYWELD0003: Processing weld deployment wildfly-thread-racing.war
> 19:41:38,633 INFO [org.jboss.as.messaging] (MSC service thread 1-2) WFLYMSG0002: Bound messaging object to jndi name java:global/threadRacing/stages/jms/requestQueue
> 19:41:38,637 INFO [org.jboss.weld.deployer] (MSC service thread 1-9) WFLYWELD0006: Starting Services for CDI deployment: wildfly-thread-racing.war
> 19:41:38,641 INFO [org.jboss.weld.deployer] (MSC service thread 1-5) WFLYWELD0009: Starting weld service for deployment wildfly-thread-racing.war
> 19:41:38,643 INFO [org.jboss.as.ejb3] (MSC service thread 1-10) WFLYEJB0042: Started message driven bean 'JMSRaceStageMessageListener' with 'hornetq-ra.rar' resource adapter
> 19:41:38,753 INFO [io.undertow.websockets.jsr] (MSC service thread 1-7) UT026003: Adding annotated server endpoint class org.jboss.as.quickstarts.threadracing.stage.websocket.ServerEndpoint for path /ws
> 19:41:38,754 INFO [io.undertow.websockets.jsr] (MSC service thread 1-7) UT026004: Adding annotated client endpoint class org.jboss.as.quickstarts.threadracing.stage.websocket.ClientEndpoint
> 19:41:38,758 INFO [org.wildfly.extension.undertow] (MSC service thread 1-7) WFLYUT0021: Registered web context: /wildfly-thread-racing
> 19:41:38,770 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0013: Redeployed "wildfly-thread-racing.war"
> 19:41:38,770 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0016: Replaced deployment "wildfly-thread-racing.war" with deployment "wildfly-thread-racing.war"
> 19:41:38,771 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0002: Content removed from location /Users/emmartins/wildfly/git/wildfly/dist/target/wildfly-9.0.0.Alpha2-SNAPSHOT/standalone/data/content/98/04cfcd3addc74805031f222ee036ff47b62f5d/content
> {code}
> Web) https://github.com/emmartins/quickstart/tree/redeploy-exceptions2 , where the following exception occur about half of redeploys:
> {code}
> 20:27:05,715 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0001: Content added at location /Users/emmartins/wildfly/git/wildfly/dist/target/wildfly-9.0.0.Alpha2-SNAPSHOT/standalone/data/content/c4/abc434ff307278c10061fb9dbbd3fcd0aff116/content
> 20:27:05,717 INFO [org.wildfly.extension.undertow] (MSC service thread 1-13) WFLYUT0022: Unregistered web context: /wildfly-thread-racing
> 20:27:05,734 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 77) WFLYJPA0011: Stopping Persistence Unit (phase 2 of 2) Service 'wildfly-thread-racing.war#RacePU'
> 20:27:05,735 INFO [org.jboss.weld.deployer] (MSC service thread 1-4) WFLYWELD0010: Stopping weld service for deployment wildfly-thread-racing.war
> 20:27:05,735 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 77) WFLYJPA0011: Stopping Persistence Unit (phase 1 of 2) Service 'wildfly-thread-racing.war#RacePU'
> 20:27:05,745 INFO [org.jboss.as.server.deployment] (MSC service thread 1-9) WFLYSRV0028: Stopped deployment wildfly-thread-racing.war (runtime-name: wildfly-thread-racing.war) in 28ms
> 20:27:05,746 INFO [org.jboss.as.server.deployment] (MSC service thread 1-14) WFLYSRV0027: Starting deployment of "wildfly-thread-racing.war" (runtime-name: "wildfly-thread-racing.war")
> 20:27:05,775 ERROR [org.jboss.msc.service.fail] (MSC service thread 1-8) MSC000001: Failed to start service jboss.deployment.unit."wildfly-thread-racing.war".PARSE: org.jboss.msc.service.StartException in service jboss.deployment.unit."wildfly-thread-racing.war".PARSE: WFLYSRV0153: Failed to process phase PARSE of deployment "wildfly-thread-racing.war"
> at org.jboss.as.server.deployment.DeploymentUnitPhaseService.start(DeploymentUnitPhaseService.java:163)
> at org.jboss.msc.service.ServiceControllerImpl$StartTask.startService(ServiceControllerImpl.java:1948)
> at org.jboss.msc.service.ServiceControllerImpl$StartTask.run(ServiceControllerImpl.java:1881)
> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> at java.lang.Thread.run(Thread.java:745)
> Caused by: java.lang.NullPointerException
> at org.wildfly.extension.undertow.deployment.JBossWebParsingDeploymentProcessor.deploy(JBossWebParsingDeploymentProcessor.java:61)
> at org.jboss.as.server.deployment.DeploymentUnitPhaseService.start(DeploymentUnitPhaseService.java:156)
> ... 5 more
> 20:27:05,780 INFO [org.jboss.as.server.deployment] (MSC service thread 1-15) WFLYSRV0028: Stopped deployment wildfly-thread-racing.war (runtime-name: wildfly-thread-racing.war) in 33ms
> 20:27:05,782 INFO [org.jboss.as.server.deployment] (MSC service thread 1-11) WFLYSRV0027: Starting deployment of "wildfly-thread-racing.war" (runtime-name: "wildfly-thread-racing.war")
> 20:27:05,819 INFO [org.jboss.as.jpa] (MSC service thread 1-10) WFLYJPA0002: Read persistence.xml for RacePU
> 20:27:05,833 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 77) WFLYJPA0010: Starting Persistence Unit (phase 1 of 2) Service 'wildfly-thread-racing.war#RacePU'
> 20:27:05,833 INFO [org.hibernate.jpa.internal.util.LogHelper] (ServerService Thread Pool -- 77) HHH000204: Processing PersistenceUnitInfo [
> name: RacePU
> ...]
> 20:27:05,838 INFO [org.jboss.weld.deployer] (MSC service thread 1-12) WFLYWELD0003: Processing weld deployment wildfly-thread-racing.war
> 20:27:05,841 INFO [org.jboss.as.ejb3.deployment.processors.EjbJndiBindingsDeploymentUnitProcessor] (MSC service thread 1-12) JNDI bindings for session bean named RaceResults in deployment unit deployment "wildfly-thread-racing.war" are as follows:
> java:global/wildfly-thread-racing/RaceResults!org.jboss.as.quickstarts.threadracing.results.RaceResults
> java:app/wildfly-thread-racing/RaceResults!org.jboss.as.quickstarts.threadracing.results.RaceResults
> java:module/RaceResults!org.jboss.as.quickstarts.threadracing.results.RaceResults
> java:global/wildfly-thread-racing/RaceResults
> java:app/wildfly-thread-racing/RaceResults
> java:module/RaceResults
> 20:27:05,872 INFO [org.jboss.as.messaging] (MSC service thread 1-12) WFLYMSG0002: Bound messaging object to jndi name java:global/threadRacing/stages/jms/requestQueue
> 20:27:05,878 INFO [org.jboss.weld.deployer] (MSC service thread 1-4) WFLYWELD0006: Starting Services for CDI deployment: wildfly-thread-racing.war
> 20:27:05,883 INFO [org.jboss.weld.deployer] (MSC service thread 1-12) WFLYWELD0009: Starting weld service for deployment wildfly-thread-racing.war
> 20:27:05,885 INFO [org.jboss.as.ejb3] (MSC service thread 1-13) WFLYEJB0042: Started message driven bean 'JMSRaceStageMessageListener' with 'hornetq-ra.rar' resource adapter
> 20:27:05,887 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 77) WFLYJPA0010: Starting Persistence Unit (phase 2 of 2) Service 'wildfly-thread-racing.war#RacePU'
> 20:27:05,893 INFO [org.hibernate.dialect.Dialect] (ServerService Thread Pool -- 77) HHH000400: Using dialect: org.hibernate.dialect.H2Dialect
> 20:27:05,893 WARN [org.hibernate.dialect.H2Dialect] (ServerService Thread Pool -- 77) HHH000431: Unable to determine H2 database version, certain features may not work
> 20:27:05,899 INFO [org.hibernate.hql.internal.ast.ASTQueryTranslatorFactory] (ServerService Thread Pool -- 77) HHH000397: Using ASTQueryTranslatorFactory
> 20:27:05,921 INFO [org.hibernate.dialect.Dialect] (ServerService Thread Pool -- 77) HHH000400: Using dialect: org.hibernate.dialect.H2Dialect
> 20:27:05,922 WARN [org.hibernate.dialect.H2Dialect] (ServerService Thread Pool -- 77) HHH000431: Unable to determine H2 database version, certain features may not work
> 20:27:06,057 INFO [io.undertow.websockets.jsr] (MSC service thread 1-15) UT026003: Adding annotated server endpoint class org.jboss.as.quickstarts.threadracing.WebSocketRace for path /race
> 20:27:06,085 INFO [org.jboss.resteasy.spi.ResteasyDeployment] (MSC service thread 1-15) Deploying javax.ws.rs.core.Application: class org.jboss.as.quickstarts.threadracing.stage.jaxrs.BoxApplication$Proxy$_$$_WeldClientProxy
> 20:27:06,086 INFO [org.jboss.resteasy.spi.ResteasyDeployment] (MSC service thread 1-15) Adding class resource org.jboss.as.quickstarts.threadracing.stage.jaxrs.BoxService from Application class org.jboss.as.quickstarts.threadracing.stage.jaxrs.BoxApplication$Proxy$_$$_WeldClientProxy
> 20:27:06,088 INFO [org.wildfly.extension.undertow] (MSC service thread 1-15) WFLYUT0021: Registered web context: /wildfly-thread-racing
> 20:27:06,102 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0013: Redeployed "wildfly-thread-racing.war"
> 20:27:06,102 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0016: Replaced deployment "wildfly-thread-racing.war" with deployment "wildfly-thread-racing.war"
> 20:27:06,103 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0002: Content removed from location /Users/emmartins/wildfly/git/wildfly/dist/target/wildfly-9.0.0.Alpha2-SNAPSHOT/standalone/data/content/fe/8d3392468fc3e5e8b15d722d003fe3e0f851af/content
> {code}
--
This message was sent by Atlassian JIRA
(v6.3.11#6341)
11 years, 6 months
[JBoss JIRA] (WFLY-4199) App redeploy exceptions
by Eduardo Martins (JIRA)
[ https://issues.jboss.org/browse/WFLY-4199?page=com.atlassian.jira.plugin.... ]
Eduardo Martins updated WFLY-4199:
----------------------------------
Description:
I'm noticing intermittent occurrences of exceptions when redeploying quickstarts, and unfortunately the chance seems quite high. The exceptions,a at least on my end, may be reproduced by using app "thread-racing" of the following branches of my quickstarts fork:
Web Services) https://github.com/emmartins/quickstart/tree/redeploy-exceptions , where the following exception occur at an alarming 8 out of 10 redeploys:
{code}
19:41:38,502 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0001: Content added at location /Users/emmartins/wildfly/git/wildfly/dist/target/wildfly-9.0.0.Alpha2-SNAPSHOT/standalone/data/content/b5/1306d722adbe53ba6b7445f1b2d72facd66201/content
19:41:38,504 INFO [org.wildfly.extension.undertow] (MSC service thread 1-3) WFLYUT0022: Unregistered web context: /wildfly-thread-racing
19:41:38,519 INFO [org.jboss.weld.deployer] (MSC service thread 1-4) WFLYWELD0010: Stopping weld service for deployment wildfly-thread-racing.war
19:41:38,527 INFO [org.jboss.as.server.deployment] (MSC service thread 1-12) WFLYSRV0028: Stopped deployment wildfly-thread-racing.war (runtime-name: wildfly-thread-racing.war) in 24ms
19:41:38,528 INFO [org.jboss.as.server.deployment] (MSC service thread 1-3) WFLYSRV0027: Starting deployment of "wildfly-thread-racing.war" (runtime-name: "wildfly-thread-racing.war")
19:41:38,556 ERROR [org.jboss.msc.service.fail] (MSC service thread 1-14) MSC000001: Failed to start service jboss.deployment.unit."wildfly-thread-racing.war".PARSE: org.jboss.msc.service.StartException in service jboss.deployment.unit."wildfly-thread-racing.war".PARSE: WFLYSRV0153: Failed to process phase PARSE of deployment "wildfly-thread-racing.war"
at org.jboss.as.server.deployment.DeploymentUnitPhaseService.start(DeploymentUnitPhaseService.java:163)
at org.jboss.msc.service.ServiceControllerImpl$StartTask.startService(ServiceControllerImpl.java:1948)
at org.jboss.msc.service.ServiceControllerImpl$StartTask.run(ServiceControllerImpl.java:1881)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.NullPointerException
at org.jboss.as.webservices.deployers.WebservicesDescriptorDeploymentProcessor.getWebServicesDescriptorURL(WebservicesDescriptorDeploymentProcessor.java:70)
at org.jboss.as.webservices.deployers.WebservicesDescriptorDeploymentProcessor.deploy(WebservicesDescriptorDeploymentProcessor.java:52)
at org.jboss.as.server.deployment.DeploymentUnitPhaseService.start(DeploymentUnitPhaseService.java:156)
... 5 more
19:41:38,559 INFO [org.jboss.as.server.deployment] (MSC service thread 1-6) WFLYSRV0028: Stopped deployment wildfly-thread-racing.war (runtime-name: wildfly-thread-racing.war) in 30ms
19:41:38,560 INFO [org.jboss.as.server.deployment] (MSC service thread 1-12) WFLYSRV0027: Starting deployment of "wildfly-thread-racing.war" (runtime-name: "wildfly-thread-racing.war")
19:41:38,593 WARN [org.jboss.weld.deployer] (MSC service thread 1-13) WFLYWELD0012: Warning while parsing vfs:/content/wildfly-thread-racing.war/WEB-INF/beans.xml:22 cvc-complex-type.4: Attribute 'bean-discovery-mode' must appear on element 'beans'.
19:41:38,609 INFO [org.jboss.weld.deployer] (MSC service thread 1-2) WFLYWELD0003: Processing weld deployment wildfly-thread-racing.war
19:41:38,633 INFO [org.jboss.as.messaging] (MSC service thread 1-2) WFLYMSG0002: Bound messaging object to jndi name java:global/threadRacing/stages/jms/requestQueue
19:41:38,637 INFO [org.jboss.weld.deployer] (MSC service thread 1-9) WFLYWELD0006: Starting Services for CDI deployment: wildfly-thread-racing.war
19:41:38,641 INFO [org.jboss.weld.deployer] (MSC service thread 1-5) WFLYWELD0009: Starting weld service for deployment wildfly-thread-racing.war
19:41:38,643 INFO [org.jboss.as.ejb3] (MSC service thread 1-10) WFLYEJB0042: Started message driven bean 'JMSRaceStageMessageListener' with 'hornetq-ra.rar' resource adapter
19:41:38,753 INFO [io.undertow.websockets.jsr] (MSC service thread 1-7) UT026003: Adding annotated server endpoint class org.jboss.as.quickstarts.threadracing.stage.websocket.ServerEndpoint for path /ws
19:41:38,754 INFO [io.undertow.websockets.jsr] (MSC service thread 1-7) UT026004: Adding annotated client endpoint class org.jboss.as.quickstarts.threadracing.stage.websocket.ClientEndpoint
19:41:38,758 INFO [org.wildfly.extension.undertow] (MSC service thread 1-7) WFLYUT0021: Registered web context: /wildfly-thread-racing
19:41:38,770 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0013: Redeployed "wildfly-thread-racing.war"
19:41:38,770 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0016: Replaced deployment "wildfly-thread-racing.war" with deployment "wildfly-thread-racing.war"
19:41:38,771 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0002: Content removed from location /Users/emmartins/wildfly/git/wildfly/dist/target/wildfly-9.0.0.Alpha2-SNAPSHOT/standalone/data/content/98/04cfcd3addc74805031f222ee036ff47b62f5d/content
{code}
Web) https://github.com/emmartins/quickstart/tree/redeploy-exceptions2 , where the following exception occur about half of redeploys:
{code}
20:27:05,715 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0001: Content added at location /Users/emmartins/wildfly/git/wildfly/dist/target/wildfly-9.0.0.Alpha2-SNAPSHOT/standalone/data/content/c4/abc434ff307278c10061fb9dbbd3fcd0aff116/content
20:27:05,717 INFO [org.wildfly.extension.undertow] (MSC service thread 1-13) WFLYUT0022: Unregistered web context: /wildfly-thread-racing
20:27:05,734 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 77) WFLYJPA0011: Stopping Persistence Unit (phase 2 of 2) Service 'wildfly-thread-racing.war#RacePU'
20:27:05,735 INFO [org.jboss.weld.deployer] (MSC service thread 1-4) WFLYWELD0010: Stopping weld service for deployment wildfly-thread-racing.war
20:27:05,735 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 77) WFLYJPA0011: Stopping Persistence Unit (phase 1 of 2) Service 'wildfly-thread-racing.war#RacePU'
20:27:05,745 INFO [org.jboss.as.server.deployment] (MSC service thread 1-9) WFLYSRV0028: Stopped deployment wildfly-thread-racing.war (runtime-name: wildfly-thread-racing.war) in 28ms
20:27:05,746 INFO [org.jboss.as.server.deployment] (MSC service thread 1-14) WFLYSRV0027: Starting deployment of "wildfly-thread-racing.war" (runtime-name: "wildfly-thread-racing.war")
20:27:05,775 ERROR [org.jboss.msc.service.fail] (MSC service thread 1-8) MSC000001: Failed to start service jboss.deployment.unit."wildfly-thread-racing.war".PARSE: org.jboss.msc.service.StartException in service jboss.deployment.unit."wildfly-thread-racing.war".PARSE: WFLYSRV0153: Failed to process phase PARSE of deployment "wildfly-thread-racing.war"
at org.jboss.as.server.deployment.DeploymentUnitPhaseService.start(DeploymentUnitPhaseService.java:163)
at org.jboss.msc.service.ServiceControllerImpl$StartTask.startService(ServiceControllerImpl.java:1948)
at org.jboss.msc.service.ServiceControllerImpl$StartTask.run(ServiceControllerImpl.java:1881)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.NullPointerException
at org.wildfly.extension.undertow.deployment.JBossWebParsingDeploymentProcessor.deploy(JBossWebParsingDeploymentProcessor.java:61)
at org.jboss.as.server.deployment.DeploymentUnitPhaseService.start(DeploymentUnitPhaseService.java:156)
... 5 more
20:27:05,780 INFO [org.jboss.as.server.deployment] (MSC service thread 1-15) WFLYSRV0028: Stopped deployment wildfly-thread-racing.war (runtime-name: wildfly-thread-racing.war) in 33ms
20:27:05,782 INFO [org.jboss.as.server.deployment] (MSC service thread 1-11) WFLYSRV0027: Starting deployment of "wildfly-thread-racing.war" (runtime-name: "wildfly-thread-racing.war")
20:27:05,819 INFO [org.jboss.as.jpa] (MSC service thread 1-10) WFLYJPA0002: Read persistence.xml for RacePU
20:27:05,833 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 77) WFLYJPA0010: Starting Persistence Unit (phase 1 of 2) Service 'wildfly-thread-racing.war#RacePU'
20:27:05,833 INFO [org.hibernate.jpa.internal.util.LogHelper] (ServerService Thread Pool -- 77) HHH000204: Processing PersistenceUnitInfo [
name: RacePU
...]
20:27:05,838 INFO [org.jboss.weld.deployer] (MSC service thread 1-12) WFLYWELD0003: Processing weld deployment wildfly-thread-racing.war
20:27:05,841 INFO [org.jboss.as.ejb3.deployment.processors.EjbJndiBindingsDeploymentUnitProcessor] (MSC service thread 1-12) JNDI bindings for session bean named RaceResults in deployment unit deployment "wildfly-thread-racing.war" are as follows:
java:global/wildfly-thread-racing/RaceResults!org.jboss.as.quickstarts.threadracing.results.RaceResults
java:app/wildfly-thread-racing/RaceResults!org.jboss.as.quickstarts.threadracing.results.RaceResults
java:module/RaceResults!org.jboss.as.quickstarts.threadracing.results.RaceResults
java:global/wildfly-thread-racing/RaceResults
java:app/wildfly-thread-racing/RaceResults
java:module/RaceResults
20:27:05,872 INFO [org.jboss.as.messaging] (MSC service thread 1-12) WFLYMSG0002: Bound messaging object to jndi name java:global/threadRacing/stages/jms/requestQueue
20:27:05,878 INFO [org.jboss.weld.deployer] (MSC service thread 1-4) WFLYWELD0006: Starting Services for CDI deployment: wildfly-thread-racing.war
20:27:05,883 INFO [org.jboss.weld.deployer] (MSC service thread 1-12) WFLYWELD0009: Starting weld service for deployment wildfly-thread-racing.war
20:27:05,885 INFO [org.jboss.as.ejb3] (MSC service thread 1-13) WFLYEJB0042: Started message driven bean 'JMSRaceStageMessageListener' with 'hornetq-ra.rar' resource adapter
20:27:05,887 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 77) WFLYJPA0010: Starting Persistence Unit (phase 2 of 2) Service 'wildfly-thread-racing.war#RacePU'
20:27:05,893 INFO [org.hibernate.dialect.Dialect] (ServerService Thread Pool -- 77) HHH000400: Using dialect: org.hibernate.dialect.H2Dialect
20:27:05,893 WARN [org.hibernate.dialect.H2Dialect] (ServerService Thread Pool -- 77) HHH000431: Unable to determine H2 database version, certain features may not work
20:27:05,899 INFO [org.hibernate.hql.internal.ast.ASTQueryTranslatorFactory] (ServerService Thread Pool -- 77) HHH000397: Using ASTQueryTranslatorFactory
20:27:05,921 INFO [org.hibernate.dialect.Dialect] (ServerService Thread Pool -- 77) HHH000400: Using dialect: org.hibernate.dialect.H2Dialect
20:27:05,922 WARN [org.hibernate.dialect.H2Dialect] (ServerService Thread Pool -- 77) HHH000431: Unable to determine H2 database version, certain features may not work
20:27:06,057 INFO [io.undertow.websockets.jsr] (MSC service thread 1-15) UT026003: Adding annotated server endpoint class org.jboss.as.quickstarts.threadracing.WebSocketRace for path /race
20:27:06,085 INFO [org.jboss.resteasy.spi.ResteasyDeployment] (MSC service thread 1-15) Deploying javax.ws.rs.core.Application: class org.jboss.as.quickstarts.threadracing.stage.jaxrs.BoxApplication$Proxy$_$$_WeldClientProxy
20:27:06,086 INFO [org.jboss.resteasy.spi.ResteasyDeployment] (MSC service thread 1-15) Adding class resource org.jboss.as.quickstarts.threadracing.stage.jaxrs.BoxService from Application class org.jboss.as.quickstarts.threadracing.stage.jaxrs.BoxApplication$Proxy$_$$_WeldClientProxy
20:27:06,088 INFO [org.wildfly.extension.undertow] (MSC service thread 1-15) WFLYUT0021: Registered web context: /wildfly-thread-racing
20:27:06,102 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0013: Redeployed "wildfly-thread-racing.war"
20:27:06,102 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0016: Replaced deployment "wildfly-thread-racing.war" with deployment "wildfly-thread-racing.war"
20:27:06,103 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0002: Content removed from location /Users/emmartins/wildfly/git/wildfly/dist/target/wildfly-9.0.0.Alpha2-SNAPSHOT/standalone/data/content/fe/8d3392468fc3e5e8b15d722d003fe3e0f851af/content
{code}
was:
I'm noticing intermittent occurrences of exceptions when redeploying quickstarts, and unfortunately the chance seems quite high. The exceptions,a at least on my end, may be reproduced by using app "thread-racing" of the following branches of my quickstarts fork:
Web Services) https://github.com/emmartins/quickstart/tree/redeploy-exceptions , where the following exception occur at an alarming 8 out of 10 redeploys:
19:41:38,502 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0001: Content added at location /Users/emmartins/wildfly/git/wildfly/dist/target/wildfly-9.0.0.Alpha2-SNAPSHOT/standalone/data/content/b5/1306d722adbe53ba6b7445f1b2d72facd66201/content
19:41:38,504 INFO [org.wildfly.extension.undertow] (MSC service thread 1-3) WFLYUT0022: Unregistered web context: /wildfly-thread-racing
19:41:38,519 INFO [org.jboss.weld.deployer] (MSC service thread 1-4) WFLYWELD0010: Stopping weld service for deployment wildfly-thread-racing.war
19:41:38,527 INFO [org.jboss.as.server.deployment] (MSC service thread 1-12) WFLYSRV0028: Stopped deployment wildfly-thread-racing.war (runtime-name: wildfly-thread-racing.war) in 24ms
19:41:38,528 INFO [org.jboss.as.server.deployment] (MSC service thread 1-3) WFLYSRV0027: Starting deployment of "wildfly-thread-racing.war" (runtime-name: "wildfly-thread-racing.war")
19:41:38,556 ERROR [org.jboss.msc.service.fail] (MSC service thread 1-14) MSC000001: Failed to start service jboss.deployment.unit."wildfly-thread-racing.war".PARSE: org.jboss.msc.service.StartException in service jboss.deployment.unit."wildfly-thread-racing.war".PARSE: WFLYSRV0153: Failed to process phase PARSE of deployment "wildfly-thread-racing.war"
at org.jboss.as.server.deployment.DeploymentUnitPhaseService.start(DeploymentUnitPhaseService.java:163)
at org.jboss.msc.service.ServiceControllerImpl$StartTask.startService(ServiceControllerImpl.java:1948)
at org.jboss.msc.service.ServiceControllerImpl$StartTask.run(ServiceControllerImpl.java:1881)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.NullPointerException
at org.jboss.as.webservices.deployers.WebservicesDescriptorDeploymentProcessor.getWebServicesDescriptorURL(WebservicesDescriptorDeploymentProcessor.java:70)
at org.jboss.as.webservices.deployers.WebservicesDescriptorDeploymentProcessor.deploy(WebservicesDescriptorDeploymentProcessor.java:52)
at org.jboss.as.server.deployment.DeploymentUnitPhaseService.start(DeploymentUnitPhaseService.java:156)
... 5 more
19:41:38,559 INFO [org.jboss.as.server.deployment] (MSC service thread 1-6) WFLYSRV0028: Stopped deployment wildfly-thread-racing.war (runtime-name: wildfly-thread-racing.war) in 30ms
19:41:38,560 INFO [org.jboss.as.server.deployment] (MSC service thread 1-12) WFLYSRV0027: Starting deployment of "wildfly-thread-racing.war" (runtime-name: "wildfly-thread-racing.war")
19:41:38,593 WARN [org.jboss.weld.deployer] (MSC service thread 1-13) WFLYWELD0012: Warning while parsing vfs:/content/wildfly-thread-racing.war/WEB-INF/beans.xml:22 cvc-complex-type.4: Attribute 'bean-discovery-mode' must appear on element 'beans'.
19:41:38,609 INFO [org.jboss.weld.deployer] (MSC service thread 1-2) WFLYWELD0003: Processing weld deployment wildfly-thread-racing.war
19:41:38,633 INFO [org.jboss.as.messaging] (MSC service thread 1-2) WFLYMSG0002: Bound messaging object to jndi name java:global/threadRacing/stages/jms/requestQueue
19:41:38,637 INFO [org.jboss.weld.deployer] (MSC service thread 1-9) WFLYWELD0006: Starting Services for CDI deployment: wildfly-thread-racing.war
19:41:38,641 INFO [org.jboss.weld.deployer] (MSC service thread 1-5) WFLYWELD0009: Starting weld service for deployment wildfly-thread-racing.war
19:41:38,643 INFO [org.jboss.as.ejb3] (MSC service thread 1-10) WFLYEJB0042: Started message driven bean 'JMSRaceStageMessageListener' with 'hornetq-ra.rar' resource adapter
19:41:38,753 INFO [io.undertow.websockets.jsr] (MSC service thread 1-7) UT026003: Adding annotated server endpoint class org.jboss.as.quickstarts.threadracing.stage.websocket.ServerEndpoint for path /ws
19:41:38,754 INFO [io.undertow.websockets.jsr] (MSC service thread 1-7) UT026004: Adding annotated client endpoint class org.jboss.as.quickstarts.threadracing.stage.websocket.ClientEndpoint
19:41:38,758 INFO [org.wildfly.extension.undertow] (MSC service thread 1-7) WFLYUT0021: Registered web context: /wildfly-thread-racing
19:41:38,770 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0013: Redeployed "wildfly-thread-racing.war"
19:41:38,770 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0016: Replaced deployment "wildfly-thread-racing.war" with deployment "wildfly-thread-racing.war"
19:41:38,771 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0002: Content removed from location /Users/emmartins/wildfly/git/wildfly/dist/target/wildfly-9.0.0.Alpha2-SNAPSHOT/standalone/data/content/98/04cfcd3addc74805031f222ee036ff47b62f5d/content
Web) https://github.com/emmartins/quickstart/tree/redeploy-exceptions2 , where the following exception occur about half of redeploys:
20:27:05,715 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0001: Content added at location /Users/emmartins/wildfly/git/wildfly/dist/target/wildfly-9.0.0.Alpha2-SNAPSHOT/standalone/data/content/c4/abc434ff307278c10061fb9dbbd3fcd0aff116/content
20:27:05,717 INFO [org.wildfly.extension.undertow] (MSC service thread 1-13) WFLYUT0022: Unregistered web context: /wildfly-thread-racing
20:27:05,734 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 77) WFLYJPA0011: Stopping Persistence Unit (phase 2 of 2) Service 'wildfly-thread-racing.war#RacePU'
20:27:05,735 INFO [org.jboss.weld.deployer] (MSC service thread 1-4) WFLYWELD0010: Stopping weld service for deployment wildfly-thread-racing.war
20:27:05,735 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 77) WFLYJPA0011: Stopping Persistence Unit (phase 1 of 2) Service 'wildfly-thread-racing.war#RacePU'
20:27:05,745 INFO [org.jboss.as.server.deployment] (MSC service thread 1-9) WFLYSRV0028: Stopped deployment wildfly-thread-racing.war (runtime-name: wildfly-thread-racing.war) in 28ms
20:27:05,746 INFO [org.jboss.as.server.deployment] (MSC service thread 1-14) WFLYSRV0027: Starting deployment of "wildfly-thread-racing.war" (runtime-name: "wildfly-thread-racing.war")
20:27:05,775 ERROR [org.jboss.msc.service.fail] (MSC service thread 1-8) MSC000001: Failed to start service jboss.deployment.unit."wildfly-thread-racing.war".PARSE: org.jboss.msc.service.StartException in service jboss.deployment.unit."wildfly-thread-racing.war".PARSE: WFLYSRV0153: Failed to process phase PARSE of deployment "wildfly-thread-racing.war"
at org.jboss.as.server.deployment.DeploymentUnitPhaseService.start(DeploymentUnitPhaseService.java:163)
at org.jboss.msc.service.ServiceControllerImpl$StartTask.startService(ServiceControllerImpl.java:1948)
at org.jboss.msc.service.ServiceControllerImpl$StartTask.run(ServiceControllerImpl.java:1881)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.NullPointerException
at org.wildfly.extension.undertow.deployment.JBossWebParsingDeploymentProcessor.deploy(JBossWebParsingDeploymentProcessor.java:61)
at org.jboss.as.server.deployment.DeploymentUnitPhaseService.start(DeploymentUnitPhaseService.java:156)
... 5 more
20:27:05,780 INFO [org.jboss.as.server.deployment] (MSC service thread 1-15) WFLYSRV0028: Stopped deployment wildfly-thread-racing.war (runtime-name: wildfly-thread-racing.war) in 33ms
20:27:05,782 INFO [org.jboss.as.server.deployment] (MSC service thread 1-11) WFLYSRV0027: Starting deployment of "wildfly-thread-racing.war" (runtime-name: "wildfly-thread-racing.war")
20:27:05,819 INFO [org.jboss.as.jpa] (MSC service thread 1-10) WFLYJPA0002: Read persistence.xml for RacePU
20:27:05,833 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 77) WFLYJPA0010: Starting Persistence Unit (phase 1 of 2) Service 'wildfly-thread-racing.war#RacePU'
20:27:05,833 INFO [org.hibernate.jpa.internal.util.LogHelper] (ServerService Thread Pool -- 77) HHH000204: Processing PersistenceUnitInfo [
name: RacePU
...]
20:27:05,838 INFO [org.jboss.weld.deployer] (MSC service thread 1-12) WFLYWELD0003: Processing weld deployment wildfly-thread-racing.war
20:27:05,841 INFO [org.jboss.as.ejb3.deployment.processors.EjbJndiBindingsDeploymentUnitProcessor] (MSC service thread 1-12) JNDI bindings for session bean named RaceResults in deployment unit deployment "wildfly-thread-racing.war" are as follows:
java:global/wildfly-thread-racing/RaceResults!org.jboss.as.quickstarts.threadracing.results.RaceResults
java:app/wildfly-thread-racing/RaceResults!org.jboss.as.quickstarts.threadracing.results.RaceResults
java:module/RaceResults!org.jboss.as.quickstarts.threadracing.results.RaceResults
java:global/wildfly-thread-racing/RaceResults
java:app/wildfly-thread-racing/RaceResults
java:module/RaceResults
20:27:05,872 INFO [org.jboss.as.messaging] (MSC service thread 1-12) WFLYMSG0002: Bound messaging object to jndi name java:global/threadRacing/stages/jms/requestQueue
20:27:05,878 INFO [org.jboss.weld.deployer] (MSC service thread 1-4) WFLYWELD0006: Starting Services for CDI deployment: wildfly-thread-racing.war
20:27:05,883 INFO [org.jboss.weld.deployer] (MSC service thread 1-12) WFLYWELD0009: Starting weld service for deployment wildfly-thread-racing.war
20:27:05,885 INFO [org.jboss.as.ejb3] (MSC service thread 1-13) WFLYEJB0042: Started message driven bean 'JMSRaceStageMessageListener' with 'hornetq-ra.rar' resource adapter
20:27:05,887 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 77) WFLYJPA0010: Starting Persistence Unit (phase 2 of 2) Service 'wildfly-thread-racing.war#RacePU'
20:27:05,893 INFO [org.hibernate.dialect.Dialect] (ServerService Thread Pool -- 77) HHH000400: Using dialect: org.hibernate.dialect.H2Dialect
20:27:05,893 WARN [org.hibernate.dialect.H2Dialect] (ServerService Thread Pool -- 77) HHH000431: Unable to determine H2 database version, certain features may not work
20:27:05,899 INFO [org.hibernate.hql.internal.ast.ASTQueryTranslatorFactory] (ServerService Thread Pool -- 77) HHH000397: Using ASTQueryTranslatorFactory
20:27:05,921 INFO [org.hibernate.dialect.Dialect] (ServerService Thread Pool -- 77) HHH000400: Using dialect: org.hibernate.dialect.H2Dialect
20:27:05,922 WARN [org.hibernate.dialect.H2Dialect] (ServerService Thread Pool -- 77) HHH000431: Unable to determine H2 database version, certain features may not work
20:27:06,057 INFO [io.undertow.websockets.jsr] (MSC service thread 1-15) UT026003: Adding annotated server endpoint class org.jboss.as.quickstarts.threadracing.WebSocketRace for path /race
20:27:06,085 INFO [org.jboss.resteasy.spi.ResteasyDeployment] (MSC service thread 1-15) Deploying javax.ws.rs.core.Application: class org.jboss.as.quickstarts.threadracing.stage.jaxrs.BoxApplication$Proxy$_$$_WeldClientProxy
20:27:06,086 INFO [org.jboss.resteasy.spi.ResteasyDeployment] (MSC service thread 1-15) Adding class resource org.jboss.as.quickstarts.threadracing.stage.jaxrs.BoxService from Application class org.jboss.as.quickstarts.threadracing.stage.jaxrs.BoxApplication$Proxy$_$$_WeldClientProxy
20:27:06,088 INFO [org.wildfly.extension.undertow] (MSC service thread 1-15) WFLYUT0021: Registered web context: /wildfly-thread-racing
20:27:06,102 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0013: Redeployed "wildfly-thread-racing.war"
20:27:06,102 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0016: Replaced deployment "wildfly-thread-racing.war" with deployment "wildfly-thread-racing.war"
20:27:06,103 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0002: Content removed from location /Users/emmartins/wildfly/git/wildfly/dist/target/wildfly-9.0.0.Alpha2-SNAPSHOT/standalone/data/content/fe/8d3392468fc3e5e8b15d722d003fe3e0f851af/content
> App redeploy exceptions
> -----------------------
>
> Key: WFLY-4199
> URL: https://issues.jboss.org/browse/WFLY-4199
> Project: WildFly
> Issue Type: Bug
> Components: Web (Undertow), Web Services
> Reporter: Eduardo Martins
> Assignee: Stuart Douglas
>
> I'm noticing intermittent occurrences of exceptions when redeploying quickstarts, and unfortunately the chance seems quite high. The exceptions,a at least on my end, may be reproduced by using app "thread-racing" of the following branches of my quickstarts fork:
> Web Services) https://github.com/emmartins/quickstart/tree/redeploy-exceptions , where the following exception occur at an alarming 8 out of 10 redeploys:
> {code}
> 19:41:38,502 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0001: Content added at location /Users/emmartins/wildfly/git/wildfly/dist/target/wildfly-9.0.0.Alpha2-SNAPSHOT/standalone/data/content/b5/1306d722adbe53ba6b7445f1b2d72facd66201/content
> 19:41:38,504 INFO [org.wildfly.extension.undertow] (MSC service thread 1-3) WFLYUT0022: Unregistered web context: /wildfly-thread-racing
> 19:41:38,519 INFO [org.jboss.weld.deployer] (MSC service thread 1-4) WFLYWELD0010: Stopping weld service for deployment wildfly-thread-racing.war
> 19:41:38,527 INFO [org.jboss.as.server.deployment] (MSC service thread 1-12) WFLYSRV0028: Stopped deployment wildfly-thread-racing.war (runtime-name: wildfly-thread-racing.war) in 24ms
> 19:41:38,528 INFO [org.jboss.as.server.deployment] (MSC service thread 1-3) WFLYSRV0027: Starting deployment of "wildfly-thread-racing.war" (runtime-name: "wildfly-thread-racing.war")
> 19:41:38,556 ERROR [org.jboss.msc.service.fail] (MSC service thread 1-14) MSC000001: Failed to start service jboss.deployment.unit."wildfly-thread-racing.war".PARSE: org.jboss.msc.service.StartException in service jboss.deployment.unit."wildfly-thread-racing.war".PARSE: WFLYSRV0153: Failed to process phase PARSE of deployment "wildfly-thread-racing.war"
> at org.jboss.as.server.deployment.DeploymentUnitPhaseService.start(DeploymentUnitPhaseService.java:163)
> at org.jboss.msc.service.ServiceControllerImpl$StartTask.startService(ServiceControllerImpl.java:1948)
> at org.jboss.msc.service.ServiceControllerImpl$StartTask.run(ServiceControllerImpl.java:1881)
> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> at java.lang.Thread.run(Thread.java:745)
> Caused by: java.lang.NullPointerException
> at org.jboss.as.webservices.deployers.WebservicesDescriptorDeploymentProcessor.getWebServicesDescriptorURL(WebservicesDescriptorDeploymentProcessor.java:70)
> at org.jboss.as.webservices.deployers.WebservicesDescriptorDeploymentProcessor.deploy(WebservicesDescriptorDeploymentProcessor.java:52)
> at org.jboss.as.server.deployment.DeploymentUnitPhaseService.start(DeploymentUnitPhaseService.java:156)
> ... 5 more
> 19:41:38,559 INFO [org.jboss.as.server.deployment] (MSC service thread 1-6) WFLYSRV0028: Stopped deployment wildfly-thread-racing.war (runtime-name: wildfly-thread-racing.war) in 30ms
> 19:41:38,560 INFO [org.jboss.as.server.deployment] (MSC service thread 1-12) WFLYSRV0027: Starting deployment of "wildfly-thread-racing.war" (runtime-name: "wildfly-thread-racing.war")
> 19:41:38,593 WARN [org.jboss.weld.deployer] (MSC service thread 1-13) WFLYWELD0012: Warning while parsing vfs:/content/wildfly-thread-racing.war/WEB-INF/beans.xml:22 cvc-complex-type.4: Attribute 'bean-discovery-mode' must appear on element 'beans'.
> 19:41:38,609 INFO [org.jboss.weld.deployer] (MSC service thread 1-2) WFLYWELD0003: Processing weld deployment wildfly-thread-racing.war
> 19:41:38,633 INFO [org.jboss.as.messaging] (MSC service thread 1-2) WFLYMSG0002: Bound messaging object to jndi name java:global/threadRacing/stages/jms/requestQueue
> 19:41:38,637 INFO [org.jboss.weld.deployer] (MSC service thread 1-9) WFLYWELD0006: Starting Services for CDI deployment: wildfly-thread-racing.war
> 19:41:38,641 INFO [org.jboss.weld.deployer] (MSC service thread 1-5) WFLYWELD0009: Starting weld service for deployment wildfly-thread-racing.war
> 19:41:38,643 INFO [org.jboss.as.ejb3] (MSC service thread 1-10) WFLYEJB0042: Started message driven bean 'JMSRaceStageMessageListener' with 'hornetq-ra.rar' resource adapter
> 19:41:38,753 INFO [io.undertow.websockets.jsr] (MSC service thread 1-7) UT026003: Adding annotated server endpoint class org.jboss.as.quickstarts.threadracing.stage.websocket.ServerEndpoint for path /ws
> 19:41:38,754 INFO [io.undertow.websockets.jsr] (MSC service thread 1-7) UT026004: Adding annotated client endpoint class org.jboss.as.quickstarts.threadracing.stage.websocket.ClientEndpoint
> 19:41:38,758 INFO [org.wildfly.extension.undertow] (MSC service thread 1-7) WFLYUT0021: Registered web context: /wildfly-thread-racing
> 19:41:38,770 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0013: Redeployed "wildfly-thread-racing.war"
> 19:41:38,770 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0016: Replaced deployment "wildfly-thread-racing.war" with deployment "wildfly-thread-racing.war"
> 19:41:38,771 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0002: Content removed from location /Users/emmartins/wildfly/git/wildfly/dist/target/wildfly-9.0.0.Alpha2-SNAPSHOT/standalone/data/content/98/04cfcd3addc74805031f222ee036ff47b62f5d/content
> {code}
> Web) https://github.com/emmartins/quickstart/tree/redeploy-exceptions2 , where the following exception occur about half of redeploys:
> {code}
> 20:27:05,715 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0001: Content added at location /Users/emmartins/wildfly/git/wildfly/dist/target/wildfly-9.0.0.Alpha2-SNAPSHOT/standalone/data/content/c4/abc434ff307278c10061fb9dbbd3fcd0aff116/content
> 20:27:05,717 INFO [org.wildfly.extension.undertow] (MSC service thread 1-13) WFLYUT0022: Unregistered web context: /wildfly-thread-racing
> 20:27:05,734 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 77) WFLYJPA0011: Stopping Persistence Unit (phase 2 of 2) Service 'wildfly-thread-racing.war#RacePU'
> 20:27:05,735 INFO [org.jboss.weld.deployer] (MSC service thread 1-4) WFLYWELD0010: Stopping weld service for deployment wildfly-thread-racing.war
> 20:27:05,735 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 77) WFLYJPA0011: Stopping Persistence Unit (phase 1 of 2) Service 'wildfly-thread-racing.war#RacePU'
> 20:27:05,745 INFO [org.jboss.as.server.deployment] (MSC service thread 1-9) WFLYSRV0028: Stopped deployment wildfly-thread-racing.war (runtime-name: wildfly-thread-racing.war) in 28ms
> 20:27:05,746 INFO [org.jboss.as.server.deployment] (MSC service thread 1-14) WFLYSRV0027: Starting deployment of "wildfly-thread-racing.war" (runtime-name: "wildfly-thread-racing.war")
> 20:27:05,775 ERROR [org.jboss.msc.service.fail] (MSC service thread 1-8) MSC000001: Failed to start service jboss.deployment.unit."wildfly-thread-racing.war".PARSE: org.jboss.msc.service.StartException in service jboss.deployment.unit."wildfly-thread-racing.war".PARSE: WFLYSRV0153: Failed to process phase PARSE of deployment "wildfly-thread-racing.war"
> at org.jboss.as.server.deployment.DeploymentUnitPhaseService.start(DeploymentUnitPhaseService.java:163)
> at org.jboss.msc.service.ServiceControllerImpl$StartTask.startService(ServiceControllerImpl.java:1948)
> at org.jboss.msc.service.ServiceControllerImpl$StartTask.run(ServiceControllerImpl.java:1881)
> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> at java.lang.Thread.run(Thread.java:745)
> Caused by: java.lang.NullPointerException
> at org.wildfly.extension.undertow.deployment.JBossWebParsingDeploymentProcessor.deploy(JBossWebParsingDeploymentProcessor.java:61)
> at org.jboss.as.server.deployment.DeploymentUnitPhaseService.start(DeploymentUnitPhaseService.java:156)
> ... 5 more
> 20:27:05,780 INFO [org.jboss.as.server.deployment] (MSC service thread 1-15) WFLYSRV0028: Stopped deployment wildfly-thread-racing.war (runtime-name: wildfly-thread-racing.war) in 33ms
> 20:27:05,782 INFO [org.jboss.as.server.deployment] (MSC service thread 1-11) WFLYSRV0027: Starting deployment of "wildfly-thread-racing.war" (runtime-name: "wildfly-thread-racing.war")
> 20:27:05,819 INFO [org.jboss.as.jpa] (MSC service thread 1-10) WFLYJPA0002: Read persistence.xml for RacePU
> 20:27:05,833 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 77) WFLYJPA0010: Starting Persistence Unit (phase 1 of 2) Service 'wildfly-thread-racing.war#RacePU'
> 20:27:05,833 INFO [org.hibernate.jpa.internal.util.LogHelper] (ServerService Thread Pool -- 77) HHH000204: Processing PersistenceUnitInfo [
> name: RacePU
> ...]
> 20:27:05,838 INFO [org.jboss.weld.deployer] (MSC service thread 1-12) WFLYWELD0003: Processing weld deployment wildfly-thread-racing.war
> 20:27:05,841 INFO [org.jboss.as.ejb3.deployment.processors.EjbJndiBindingsDeploymentUnitProcessor] (MSC service thread 1-12) JNDI bindings for session bean named RaceResults in deployment unit deployment "wildfly-thread-racing.war" are as follows:
> java:global/wildfly-thread-racing/RaceResults!org.jboss.as.quickstarts.threadracing.results.RaceResults
> java:app/wildfly-thread-racing/RaceResults!org.jboss.as.quickstarts.threadracing.results.RaceResults
> java:module/RaceResults!org.jboss.as.quickstarts.threadracing.results.RaceResults
> java:global/wildfly-thread-racing/RaceResults
> java:app/wildfly-thread-racing/RaceResults
> java:module/RaceResults
> 20:27:05,872 INFO [org.jboss.as.messaging] (MSC service thread 1-12) WFLYMSG0002: Bound messaging object to jndi name java:global/threadRacing/stages/jms/requestQueue
> 20:27:05,878 INFO [org.jboss.weld.deployer] (MSC service thread 1-4) WFLYWELD0006: Starting Services for CDI deployment: wildfly-thread-racing.war
> 20:27:05,883 INFO [org.jboss.weld.deployer] (MSC service thread 1-12) WFLYWELD0009: Starting weld service for deployment wildfly-thread-racing.war
> 20:27:05,885 INFO [org.jboss.as.ejb3] (MSC service thread 1-13) WFLYEJB0042: Started message driven bean 'JMSRaceStageMessageListener' with 'hornetq-ra.rar' resource adapter
> 20:27:05,887 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 77) WFLYJPA0010: Starting Persistence Unit (phase 2 of 2) Service 'wildfly-thread-racing.war#RacePU'
> 20:27:05,893 INFO [org.hibernate.dialect.Dialect] (ServerService Thread Pool -- 77) HHH000400: Using dialect: org.hibernate.dialect.H2Dialect
> 20:27:05,893 WARN [org.hibernate.dialect.H2Dialect] (ServerService Thread Pool -- 77) HHH000431: Unable to determine H2 database version, certain features may not work
> 20:27:05,899 INFO [org.hibernate.hql.internal.ast.ASTQueryTranslatorFactory] (ServerService Thread Pool -- 77) HHH000397: Using ASTQueryTranslatorFactory
> 20:27:05,921 INFO [org.hibernate.dialect.Dialect] (ServerService Thread Pool -- 77) HHH000400: Using dialect: org.hibernate.dialect.H2Dialect
> 20:27:05,922 WARN [org.hibernate.dialect.H2Dialect] (ServerService Thread Pool -- 77) HHH000431: Unable to determine H2 database version, certain features may not work
> 20:27:06,057 INFO [io.undertow.websockets.jsr] (MSC service thread 1-15) UT026003: Adding annotated server endpoint class org.jboss.as.quickstarts.threadracing.WebSocketRace for path /race
> 20:27:06,085 INFO [org.jboss.resteasy.spi.ResteasyDeployment] (MSC service thread 1-15) Deploying javax.ws.rs.core.Application: class org.jboss.as.quickstarts.threadracing.stage.jaxrs.BoxApplication$Proxy$_$$_WeldClientProxy
> 20:27:06,086 INFO [org.jboss.resteasy.spi.ResteasyDeployment] (MSC service thread 1-15) Adding class resource org.jboss.as.quickstarts.threadracing.stage.jaxrs.BoxService from Application class org.jboss.as.quickstarts.threadracing.stage.jaxrs.BoxApplication$Proxy$_$$_WeldClientProxy
> 20:27:06,088 INFO [org.wildfly.extension.undertow] (MSC service thread 1-15) WFLYUT0021: Registered web context: /wildfly-thread-racing
> 20:27:06,102 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0013: Redeployed "wildfly-thread-racing.war"
> 20:27:06,102 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0016: Replaced deployment "wildfly-thread-racing.war" with deployment "wildfly-thread-racing.war"
> 20:27:06,103 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0002: Content removed from location /Users/emmartins/wildfly/git/wildfly/dist/target/wildfly-9.0.0.Alpha2-SNAPSHOT/standalone/data/content/fe/8d3392468fc3e5e8b15d722d003fe3e0f851af/content
> {code}
--
This message was sent by Atlassian JIRA
(v6.3.11#6341)
11 years, 6 months
[JBoss JIRA] (WFLY-4199) App redeploy exceptions
by Eduardo Martins (JIRA)
Eduardo Martins created WFLY-4199:
-------------------------------------
Summary: App redeploy exceptions
Key: WFLY-4199
URL: https://issues.jboss.org/browse/WFLY-4199
Project: WildFly
Issue Type: Bug
Components: Web (Undertow), Web Services
Reporter: Eduardo Martins
Assignee: Stuart Douglas
I'm noticing intermittent occurrences of exceptions when redeploying quickstarts, and unfortunately the chance seems quite high. The exceptions,a at least on my end, may be reproduced by using app "thread-racing" of the following branches of my quickstarts fork:
Web Services) https://github.com/emmartins/quickstart/tree/redeploy-exceptions , where the following exception occur at an alarming 8 out of 10 redeploys:
19:41:38,502 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0001: Content added at location /Users/emmartins/wildfly/git/wildfly/dist/target/wildfly-9.0.0.Alpha2-SNAPSHOT/standalone/data/content/b5/1306d722adbe53ba6b7445f1b2d72facd66201/content
19:41:38,504 INFO [org.wildfly.extension.undertow] (MSC service thread 1-3) WFLYUT0022: Unregistered web context: /wildfly-thread-racing
19:41:38,519 INFO [org.jboss.weld.deployer] (MSC service thread 1-4) WFLYWELD0010: Stopping weld service for deployment wildfly-thread-racing.war
19:41:38,527 INFO [org.jboss.as.server.deployment] (MSC service thread 1-12) WFLYSRV0028: Stopped deployment wildfly-thread-racing.war (runtime-name: wildfly-thread-racing.war) in 24ms
19:41:38,528 INFO [org.jboss.as.server.deployment] (MSC service thread 1-3) WFLYSRV0027: Starting deployment of "wildfly-thread-racing.war" (runtime-name: "wildfly-thread-racing.war")
19:41:38,556 ERROR [org.jboss.msc.service.fail] (MSC service thread 1-14) MSC000001: Failed to start service jboss.deployment.unit."wildfly-thread-racing.war".PARSE: org.jboss.msc.service.StartException in service jboss.deployment.unit."wildfly-thread-racing.war".PARSE: WFLYSRV0153: Failed to process phase PARSE of deployment "wildfly-thread-racing.war"
at org.jboss.as.server.deployment.DeploymentUnitPhaseService.start(DeploymentUnitPhaseService.java:163)
at org.jboss.msc.service.ServiceControllerImpl$StartTask.startService(ServiceControllerImpl.java:1948)
at org.jboss.msc.service.ServiceControllerImpl$StartTask.run(ServiceControllerImpl.java:1881)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.NullPointerException
at org.jboss.as.webservices.deployers.WebservicesDescriptorDeploymentProcessor.getWebServicesDescriptorURL(WebservicesDescriptorDeploymentProcessor.java:70)
at org.jboss.as.webservices.deployers.WebservicesDescriptorDeploymentProcessor.deploy(WebservicesDescriptorDeploymentProcessor.java:52)
at org.jboss.as.server.deployment.DeploymentUnitPhaseService.start(DeploymentUnitPhaseService.java:156)
... 5 more
19:41:38,559 INFO [org.jboss.as.server.deployment] (MSC service thread 1-6) WFLYSRV0028: Stopped deployment wildfly-thread-racing.war (runtime-name: wildfly-thread-racing.war) in 30ms
19:41:38,560 INFO [org.jboss.as.server.deployment] (MSC service thread 1-12) WFLYSRV0027: Starting deployment of "wildfly-thread-racing.war" (runtime-name: "wildfly-thread-racing.war")
19:41:38,593 WARN [org.jboss.weld.deployer] (MSC service thread 1-13) WFLYWELD0012: Warning while parsing vfs:/content/wildfly-thread-racing.war/WEB-INF/beans.xml:22 cvc-complex-type.4: Attribute 'bean-discovery-mode' must appear on element 'beans'.
19:41:38,609 INFO [org.jboss.weld.deployer] (MSC service thread 1-2) WFLYWELD0003: Processing weld deployment wildfly-thread-racing.war
19:41:38,633 INFO [org.jboss.as.messaging] (MSC service thread 1-2) WFLYMSG0002: Bound messaging object to jndi name java:global/threadRacing/stages/jms/requestQueue
19:41:38,637 INFO [org.jboss.weld.deployer] (MSC service thread 1-9) WFLYWELD0006: Starting Services for CDI deployment: wildfly-thread-racing.war
19:41:38,641 INFO [org.jboss.weld.deployer] (MSC service thread 1-5) WFLYWELD0009: Starting weld service for deployment wildfly-thread-racing.war
19:41:38,643 INFO [org.jboss.as.ejb3] (MSC service thread 1-10) WFLYEJB0042: Started message driven bean 'JMSRaceStageMessageListener' with 'hornetq-ra.rar' resource adapter
19:41:38,753 INFO [io.undertow.websockets.jsr] (MSC service thread 1-7) UT026003: Adding annotated server endpoint class org.jboss.as.quickstarts.threadracing.stage.websocket.ServerEndpoint for path /ws
19:41:38,754 INFO [io.undertow.websockets.jsr] (MSC service thread 1-7) UT026004: Adding annotated client endpoint class org.jboss.as.quickstarts.threadracing.stage.websocket.ClientEndpoint
19:41:38,758 INFO [org.wildfly.extension.undertow] (MSC service thread 1-7) WFLYUT0021: Registered web context: /wildfly-thread-racing
19:41:38,770 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0013: Redeployed "wildfly-thread-racing.war"
19:41:38,770 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0016: Replaced deployment "wildfly-thread-racing.war" with deployment "wildfly-thread-racing.war"
19:41:38,771 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0002: Content removed from location /Users/emmartins/wildfly/git/wildfly/dist/target/wildfly-9.0.0.Alpha2-SNAPSHOT/standalone/data/content/98/04cfcd3addc74805031f222ee036ff47b62f5d/content
Web) https://github.com/emmartins/quickstart/tree/redeploy-exceptions2 , where the following exception occur about half of redeploys:
20:27:05,715 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0001: Content added at location /Users/emmartins/wildfly/git/wildfly/dist/target/wildfly-9.0.0.Alpha2-SNAPSHOT/standalone/data/content/c4/abc434ff307278c10061fb9dbbd3fcd0aff116/content
20:27:05,717 INFO [org.wildfly.extension.undertow] (MSC service thread 1-13) WFLYUT0022: Unregistered web context: /wildfly-thread-racing
20:27:05,734 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 77) WFLYJPA0011: Stopping Persistence Unit (phase 2 of 2) Service 'wildfly-thread-racing.war#RacePU'
20:27:05,735 INFO [org.jboss.weld.deployer] (MSC service thread 1-4) WFLYWELD0010: Stopping weld service for deployment wildfly-thread-racing.war
20:27:05,735 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 77) WFLYJPA0011: Stopping Persistence Unit (phase 1 of 2) Service 'wildfly-thread-racing.war#RacePU'
20:27:05,745 INFO [org.jboss.as.server.deployment] (MSC service thread 1-9) WFLYSRV0028: Stopped deployment wildfly-thread-racing.war (runtime-name: wildfly-thread-racing.war) in 28ms
20:27:05,746 INFO [org.jboss.as.server.deployment] (MSC service thread 1-14) WFLYSRV0027: Starting deployment of "wildfly-thread-racing.war" (runtime-name: "wildfly-thread-racing.war")
20:27:05,775 ERROR [org.jboss.msc.service.fail] (MSC service thread 1-8) MSC000001: Failed to start service jboss.deployment.unit."wildfly-thread-racing.war".PARSE: org.jboss.msc.service.StartException in service jboss.deployment.unit."wildfly-thread-racing.war".PARSE: WFLYSRV0153: Failed to process phase PARSE of deployment "wildfly-thread-racing.war"
at org.jboss.as.server.deployment.DeploymentUnitPhaseService.start(DeploymentUnitPhaseService.java:163)
at org.jboss.msc.service.ServiceControllerImpl$StartTask.startService(ServiceControllerImpl.java:1948)
at org.jboss.msc.service.ServiceControllerImpl$StartTask.run(ServiceControllerImpl.java:1881)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.NullPointerException
at org.wildfly.extension.undertow.deployment.JBossWebParsingDeploymentProcessor.deploy(JBossWebParsingDeploymentProcessor.java:61)
at org.jboss.as.server.deployment.DeploymentUnitPhaseService.start(DeploymentUnitPhaseService.java:156)
... 5 more
20:27:05,780 INFO [org.jboss.as.server.deployment] (MSC service thread 1-15) WFLYSRV0028: Stopped deployment wildfly-thread-racing.war (runtime-name: wildfly-thread-racing.war) in 33ms
20:27:05,782 INFO [org.jboss.as.server.deployment] (MSC service thread 1-11) WFLYSRV0027: Starting deployment of "wildfly-thread-racing.war" (runtime-name: "wildfly-thread-racing.war")
20:27:05,819 INFO [org.jboss.as.jpa] (MSC service thread 1-10) WFLYJPA0002: Read persistence.xml for RacePU
20:27:05,833 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 77) WFLYJPA0010: Starting Persistence Unit (phase 1 of 2) Service 'wildfly-thread-racing.war#RacePU'
20:27:05,833 INFO [org.hibernate.jpa.internal.util.LogHelper] (ServerService Thread Pool -- 77) HHH000204: Processing PersistenceUnitInfo [
name: RacePU
...]
20:27:05,838 INFO [org.jboss.weld.deployer] (MSC service thread 1-12) WFLYWELD0003: Processing weld deployment wildfly-thread-racing.war
20:27:05,841 INFO [org.jboss.as.ejb3.deployment.processors.EjbJndiBindingsDeploymentUnitProcessor] (MSC service thread 1-12) JNDI bindings for session bean named RaceResults in deployment unit deployment "wildfly-thread-racing.war" are as follows:
java:global/wildfly-thread-racing/RaceResults!org.jboss.as.quickstarts.threadracing.results.RaceResults
java:app/wildfly-thread-racing/RaceResults!org.jboss.as.quickstarts.threadracing.results.RaceResults
java:module/RaceResults!org.jboss.as.quickstarts.threadracing.results.RaceResults
java:global/wildfly-thread-racing/RaceResults
java:app/wildfly-thread-racing/RaceResults
java:module/RaceResults
20:27:05,872 INFO [org.jboss.as.messaging] (MSC service thread 1-12) WFLYMSG0002: Bound messaging object to jndi name java:global/threadRacing/stages/jms/requestQueue
20:27:05,878 INFO [org.jboss.weld.deployer] (MSC service thread 1-4) WFLYWELD0006: Starting Services for CDI deployment: wildfly-thread-racing.war
20:27:05,883 INFO [org.jboss.weld.deployer] (MSC service thread 1-12) WFLYWELD0009: Starting weld service for deployment wildfly-thread-racing.war
20:27:05,885 INFO [org.jboss.as.ejb3] (MSC service thread 1-13) WFLYEJB0042: Started message driven bean 'JMSRaceStageMessageListener' with 'hornetq-ra.rar' resource adapter
20:27:05,887 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 77) WFLYJPA0010: Starting Persistence Unit (phase 2 of 2) Service 'wildfly-thread-racing.war#RacePU'
20:27:05,893 INFO [org.hibernate.dialect.Dialect] (ServerService Thread Pool -- 77) HHH000400: Using dialect: org.hibernate.dialect.H2Dialect
20:27:05,893 WARN [org.hibernate.dialect.H2Dialect] (ServerService Thread Pool -- 77) HHH000431: Unable to determine H2 database version, certain features may not work
20:27:05,899 INFO [org.hibernate.hql.internal.ast.ASTQueryTranslatorFactory] (ServerService Thread Pool -- 77) HHH000397: Using ASTQueryTranslatorFactory
20:27:05,921 INFO [org.hibernate.dialect.Dialect] (ServerService Thread Pool -- 77) HHH000400: Using dialect: org.hibernate.dialect.H2Dialect
20:27:05,922 WARN [org.hibernate.dialect.H2Dialect] (ServerService Thread Pool -- 77) HHH000431: Unable to determine H2 database version, certain features may not work
20:27:06,057 INFO [io.undertow.websockets.jsr] (MSC service thread 1-15) UT026003: Adding annotated server endpoint class org.jboss.as.quickstarts.threadracing.WebSocketRace for path /race
20:27:06,085 INFO [org.jboss.resteasy.spi.ResteasyDeployment] (MSC service thread 1-15) Deploying javax.ws.rs.core.Application: class org.jboss.as.quickstarts.threadracing.stage.jaxrs.BoxApplication$Proxy$_$$_WeldClientProxy
20:27:06,086 INFO [org.jboss.resteasy.spi.ResteasyDeployment] (MSC service thread 1-15) Adding class resource org.jboss.as.quickstarts.threadracing.stage.jaxrs.BoxService from Application class org.jboss.as.quickstarts.threadracing.stage.jaxrs.BoxApplication$Proxy$_$$_WeldClientProxy
20:27:06,088 INFO [org.wildfly.extension.undertow] (MSC service thread 1-15) WFLYUT0021: Registered web context: /wildfly-thread-racing
20:27:06,102 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0013: Redeployed "wildfly-thread-racing.war"
20:27:06,102 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0016: Replaced deployment "wildfly-thread-racing.war" with deployment "wildfly-thread-racing.war"
20:27:06,103 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0002: Content removed from location /Users/emmartins/wildfly/git/wildfly/dist/target/wildfly-9.0.0.Alpha2-SNAPSHOT/standalone/data/content/fe/8d3392468fc3e5e8b15d722d003fe3e0f851af/content
--
This message was sent by Atlassian JIRA
(v6.3.11#6341)
11 years, 6 months