Skip to content

Instantly share code, notes, and snippets.

@gaol
Created March 9, 2017 03:10
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save gaol/b38189b8493df5b5c6b779c510ba64f7 to your computer and use it in GitHub Desktop.
Save gaol/b38189b8493df5b5c6b779c510ba64f7 to your computer and use it in GitHub Desktop.
long-running-servlet-without-shutdownNow
11:06:22,998 DEBUG [io.undertow.request] (default I/O-3) Matched prefix path /long-running-servlet for path /long-running-servlet/HeavyProcessing
11:06:23,007 DEBUG [io.undertow.request.security] (default task-1) Attempting to authenticate HttpServerExchange{ GET /long-running-servlet/HeavyProcessing request {Accept=[*/*], User-Agent=[curl/7.51.0], Host=[127.0.0.1:8080]} response {X-Powered-By=[Undertow/1], Server=[WildFly/10]}}, authentication required: false
11:06:23,008 DEBUG [io.undertow.request.security] (default task-1) Authentication outcome was NOT_ATTEMPTED with method io.undertow.security.impl.CachedAuthenticatedSessionMechanism@3e39fda2 for HttpServerExchange{ GET /long-running-servlet/HeavyProcessing request {Accept=[*/*], User-Agent=[curl/7.51.0], Host=[127.0.0.1:8080]} response {X-Powered-By=[Undertow/1], Server=[WildFly/10]}}
11:06:23,008 DEBUG [io.undertow.request.security] (default task-1) Authentication result was ATTEMPTED for HttpServerExchange{ GET /long-running-servlet/HeavyProcessing request {Accept=[*/*], User-Agent=[curl/7.51.0], Host=[127.0.0.1:8080]} response {X-Powered-By=[Undertow/1], Server=[WildFly/10]}}
11:06:23,013 INFO [org.jboss.qa.management.web.servlets.HeavyProcessingServlet] (default task-1) Started request processing
11:06:26,734 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0211: Suspending server with 1000 ms timeout.
11:06:26,735 INFO [org.jboss.as.ejb3] (management-handler-thread - 1) WFLYEJB0493: EJB subsystem suspension complete
11:06:27,738 INFO [org.jboss.as.server] (Management Triggered Shutdown) WFLYSRV0241: Shutting down in response to management operation 'shutdown'
11:06:27,746 DEBUG [org.jboss.as.security] (MSC service thread 1-2) Stopping security domain service jboss-ejb-policy
11:06:27,749 DEBUG [org.jboss.as.security] (MSC service thread 1-3) Stopping security domain service jboss-web-policy
11:06:27,749 DEBUG [org.jboss.as.connector.subsystems.resourceadapters] (MSC service thread 1-5) Stopping ResourceAdaptersSubsystem Service
11:06:27,760 DEBUG [org.wildfly.extension.undertow] (MSC service thread 1-2) Stopping console redirect for default-host
11:06:27,767 DEBUG [org.jboss.as.connector.deployment.registry] (MSC service thread 1-2) Stopping service service jboss.raregistry
11:06:27,771 DEBUG [org.jboss.tm.usertx.UserTransactionRegistry] (MSC service thread 1-2) org.jboss.tm.usertx.UserTransactionRegistry@5a4e7413 removeListener org.jboss.as.jpa.container.JPAUserTransactionListener@3bdc9e1a
11:06:27,766 DEBUG [org.jboss.as.security] (MSC service thread 1-1) Stopping security domain service jaspitest
11:06:27,772 DEBUG [org.jboss.as.connector] (MSC service thread 1-1) Stopped CommonDeployment %s
11:06:27,771 DEBUG [org.wildfly.extension.batch] (MSC service thread 1-6) Removing batch environment; ModuleClassLoader for Module "deployment.long-running-servlet.war" from Service Module Loader
11:06:27,769 DEBUG [org.jboss.as.mail.extension] (MSC service thread 1-3) WFLYMAIL0003: Removed mail session [java:jboss/mail/Default]
11:06:27,774 DEBUG [org.infinispan.manager.DefaultCacheManager] (MSC service thread 1-3) Stopping cache manager ISPN on null
11:06:27,777 DEBUG [org.infinispan.manager.DefaultCacheManager] (MSC service thread 1-8) Stopping cache manager ISPN on null
11:06:27,777 DEBUG [org.infinispan.manager.DefaultCacheManager] (MSC service thread 1-7) Stopping cache manager ISPN on null
11:06:27,778 DEBUG [org.infinispan.manager.DefaultCacheManager] (MSC service thread 1-6) Stopping cache manager ISPN on null
11:06:27,780 INFO [org.wildfly.extension.undertow] (ServerService Thread Pool -- 68) WFLYUT0022: Unregistered web context: '/long-running-servlet' from server 'default-server'
11:06:27,781 DEBUG [org.jboss.as.domain.management] (MSC service thread 1-1) Stopping 'ManagementRealm' Security Realm Service
11:06:27,816 DEBUG [org.jboss.as.clustering.infinispan] (MSC service thread 1-8) ejb cache container stopped
11:06:27,822 DEBUG [org.jboss.as.clustering.infinispan] (MSC service thread 1-7) server cache container stopped
11:06:27,822 DEBUG [org.jboss.as.clustering.infinispan] (MSC service thread 1-6) web cache container stopped
11:06:27,822 DEBUG [org.jboss.as.clustering.infinispan] (MSC service thread 1-3) hibernate cache container stopped
11:06:27,830 DEBUG [org.jboss.as.security] (MSC service thread 1-5) Stopping security domain service other
11:06:27,830 DEBUG [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (MSC service thread 1-8) stop: CachedConnectionManagerImpl@2c1dd7e7[debug=false error=false ignoreConnections=false transactionIntegration=org.jboss.as.connector.services.jca.NonTxCachedConnectionManagerService$NoopTransactionIntegration@17bbdac1 currentObjects=null objectToConnectionManagerMap={} connectionStackTraces={}]
11:06:27,830 INFO [org.wildfly.extension.undertow] (MSC service thread 1-6) WFLYUT0019: Host default-host stopping
11:06:27,831 DEBUG [org.jboss.as.connector] (MSC service thread 1-8) Stopped CcmService service jboss.non-tx-cached-connection-manager
11:06:27,839 DEBUG [org.jboss.as.ejb3.deployment] (MSC service thread 1-7) unRegistering EJB client context for classloader ModuleClassLoader for Module "deployment.long-running-servlet.war" from Service Module Loader
11:06:27,841 INFO [org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-1) WFLYJCA0010: Unbound data source [java:jboss/datasources/ExampleDS]
11:06:27,841 DEBUG [org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-1) Removed JDBC Data-source [java:jboss/datasources/ExampleDS]
11:06:27,845 DEBUG [org.jboss.jca.core.connectionmanager.TxConnectionManager] (ServerService Thread Pool -- 70) java:jboss/datasources/ExampleDS: shutdown
11:06:27,846 DEBUG [org.jboss.jca.core.connectionmanager.pool.strategy.OnePool] (ServerService Thread Pool -- 70) ExampleDS: shutdown
11:06:27,846 INFO [org.jboss.as.connector.deployers.jdbc] (MSC service thread 1-5) WFLYJCA0019: Stopped Driver service with driver-name = h2
11:06:27,846 DEBUG [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (MSC service thread 1-5) stop: CachedConnectionManagerImpl@1b654f4b[debug=false error=false ignoreConnections=false transactionIntegration=org.jboss.jca.core.tx.jbossts.TransactionIntegrationImpl@392fe8b9 currentObjects=null objectToConnectionManagerMap={} connectionStackTraces={}]
11:06:27,846 DEBUG [org.jboss.tm.usertx.UserTransactionRegistry] (MSC service thread 1-5) org.jboss.tm.usertx.UserTransactionRegistry@5a4e7413 removeListener org.jboss.jca.core.tx.jbossts.UserTransactionListenerImpl@3ef554fd
11:06:27,846 DEBUG [org.jboss.as.connector] (MSC service thread 1-5) Stopped CcmService service jboss.cached-connection-manager
11:06:27,846 DEBUG [org.jboss.as.connector] (MSC service thread 1-5) stopped ManagementRepositoryService service jboss.management_repository
11:06:27,847 DEBUG [org.jboss.as.connector.deployment.registry] (MSC service thread 1-5) Stopping service service jboss.jdbc-driver.registry
11:06:27,847 DEBUG [org.jboss.as.connector] (MSC service thread 1-5) Stopping JCA WorkManager:
11:06:27,847 DEBUG [org.jboss.as.connector] (MSC service thread 1-5) Stopped JCA WorkManager:
11:06:27,887 INFO [org.wildfly.extension.undertow] (MSC service thread 1-5) WFLYUT0008: Undertow HTTP listener default suspending
11:06:27,888 INFO [org.wildfly.extension.undertow] (MSC service thread 1-5) WFLYUT0007: Undertow HTTP listener default stopped, was bound to 127.0.0.1:8080
11:06:27,888 INFO [org.wildfly.extension.undertow] (MSC service thread 1-5) WFLYUT0008: Undertow HTTPS listener https suspending
11:06:27,888 INFO [org.wildfly.extension.undertow] (MSC service thread 1-5) WFLYUT0007: Undertow HTTPS listener https stopped, was bound to 127.0.0.1:8443
11:06:27,888 DEBUG [org.jboss.as.domain.management] (MSC service thread 1-5) Stopping 'ApplicationRealm' Security Realm Service
11:06:27,889 INFO [org.wildfly.extension.undertow] (MSC service thread 1-5) WFLYUT0004: Undertow 1.4.11.Final stopping
11:06:27,892 INFO [org.jboss.as.server.deployment] (MSC service thread 1-5) WFLYSRV0028: Stopped deployment long-running-servlet.war (runtime-name: long-running-servlet.war) in 144ms
11:06:27,907 DEBUG [io.undertow] (default I/O-3) Failed to schedule task io.undertow.util.DateUtils$2@1dd3bdf3 as worker is shutting down: java.util.concurrent.RejectedExecutionException: XNIO007007: Thread is terminating
at org.xnio.nio.WorkerThread.executeAfter(WorkerThread.java:623)
at io.undertow.util.WorkerUtils.executeAfter(WorkerUtils.java:46)
at io.undertow.util.DateUtils.getCurrentDateTime(DateUtils.java:251)
at io.undertow.util.DateUtils.addDateHeaderIfRequired(DateUtils.java:235)
at io.undertow.server.protocol.http.HttpTransferEncoding.createSinkConduit(HttpTransferEncoding.java:203)
at io.undertow.server.protocol.http.HttpServerConnection.getSinkConduit(HttpServerConnection.java:209)
at io.undertow.server.HttpServerExchange.getResponseChannel(HttpServerExchange.java:1285)
at io.undertow.servlet.spec.ServletOutputStreamImpl.close(ServletOutputStreamImpl.java:606)
at io.undertow.servlet.spec.HttpServletResponseImpl.closeStreamAndWriter(HttpServletResponseImpl.java:479)
at io.undertow.servlet.core.ServletBlockingHttpExchange.close(ServletBlockingHttpExchange.java:92)
at io.undertow.server.HttpServerExchange.endExchange(HttpServerExchange.java:1585)
at io.undertow.server.AbstractServerConnection$CloseSetter.handleEvent(AbstractServerConnection.java:316)
at io.undertow.server.AbstractServerConnection$CloseSetter.handleEvent(AbstractServerConnection.java:296)
at org.xnio.ChannelListeners.invokeChannelListener(ChannelListeners.java:92)
at org.xnio.StreamConnection.invokeCloseListener(StreamConnection.java:80)
at org.xnio.Connection.writeClosed(Connection.java:117)
at org.xnio.nio.AbstractNioStreamConnection.writeClosed(AbstractNioStreamConnection.java:47)
at org.xnio.nio.NioSocketConduit.terminateWrites(NioSocketConduit.java:182)
at org.xnio.nio.NioSocketConduit.truncateWrites(NioSocketConduit.java:198)
at org.xnio.conduits.ConduitStreamSinkChannel.close(ConduitStreamSinkChannel.java:186)
at org.xnio.IoUtils.safeClose(IoUtils.java:152)
at org.xnio.conduits.WriteReadyHandler$ChannelListenerHandler.forceTermination(WriteReadyHandler.java:57)
at org.xnio.nio.NioSocketConduit.forceTermination(NioSocketConduit.java:108)
at org.xnio.nio.WorkerThread.run(WorkerThread.java:496)
11:06:27,909 DEBUG [io.undertow] (default I/O-3) Failed to schedule task io.undertow.server.protocol.ParseTimeoutUpdater@165ee7f6 as worker is shutting down: java.util.concurrent.RejectedExecutionException: XNIO007007: Thread is terminating
at org.xnio.nio.WorkerThread.executeAfter(WorkerThread.java:623)
at io.undertow.util.WorkerUtils.executeAfter(WorkerUtils.java:46)
at io.undertow.server.protocol.ParseTimeoutUpdater.handleSchedule(ParseTimeoutUpdater.java:107)
at io.undertow.server.protocol.ParseTimeoutUpdater.connectionIdle(ParseTimeoutUpdater.java:85)
at io.undertow.server.protocol.http.HttpReadListener.newRequest(HttpReadListener.java:116)
at io.undertow.server.protocol.http.HttpReadListener.exchangeComplete(HttpReadListener.java:299)
at io.undertow.server.protocol.http.HttpServerConnection.exchangeComplete(HttpServerConnection.java:232)
at io.undertow.server.HttpServerExchange.invokeExchangeCompleteListeners(HttpServerExchange.java:1247)
at io.undertow.server.HttpServerExchange.terminateResponse(HttpServerExchange.java:1524)
at io.undertow.server.Connectors.terminateResponse(Connectors.java:104)
at io.undertow.server.protocol.http.ServerFixedLengthStreamSinkConduit.channelFinished(ServerFixedLengthStreamSinkConduit.java:56)
at io.undertow.conduits.AbstractFixedLengthStreamSinkConduit.truncateWrites(AbstractFixedLengthStreamSinkConduit.java:274)
at org.xnio.conduits.ConduitStreamSinkChannel.close(ConduitStreamSinkChannel.java:186)
at io.undertow.channels.DetachableStreamSinkChannel.close(DetachableStreamSinkChannel.java:111)
at org.xnio.IoUtils.safeClose(IoUtils.java:152)
at io.undertow.servlet.spec.ServletOutputStreamImpl.close(ServletOutputStreamImpl.java:615)
at io.undertow.servlet.spec.HttpServletResponseImpl.closeStreamAndWriter(HttpServletResponseImpl.java:479)
at io.undertow.servlet.core.ServletBlockingHttpExchange.close(ServletBlockingHttpExchange.java:92)
at io.undertow.server.HttpServerExchange.endExchange(HttpServerExchange.java:1585)
at io.undertow.server.AbstractServerConnection$CloseSetter.handleEvent(AbstractServerConnection.java:316)
at io.undertow.server.AbstractServerConnection$CloseSetter.handleEvent(AbstractServerConnection.java:296)
at org.xnio.ChannelListeners.invokeChannelListener(ChannelListeners.java:92)
at org.xnio.StreamConnection.invokeCloseListener(StreamConnection.java:80)
at org.xnio.Connection.writeClosed(Connection.java:117)
at org.xnio.nio.AbstractNioStreamConnection.writeClosed(AbstractNioStreamConnection.java:47)
at org.xnio.nio.NioSocketConduit.terminateWrites(NioSocketConduit.java:182)
at org.xnio.nio.NioSocketConduit.truncateWrites(NioSocketConduit.java:198)
at org.xnio.conduits.ConduitStreamSinkChannel.close(ConduitStreamSinkChannel.java:186)
at org.xnio.IoUtils.safeClose(IoUtils.java:152)
at org.xnio.conduits.WriteReadyHandler$ChannelListenerHandler.forceTermination(WriteReadyHandler.java:57)
at org.xnio.nio.NioSocketConduit.forceTermination(NioSocketConduit.java:108)
at org.xnio.nio.WorkerThread.run(WorkerThread.java:496)
11:06:27,911 DEBUG [io.undertow.request.io] (default I/O-3) UT005013: An IOException occurred: java.nio.channels.ClosedChannelException
at io.undertow.server.protocol.http.HttpResponseConduit.processWrite(HttpResponseConduit.java:122)
at io.undertow.server.protocol.http.HttpResponseConduit.flush(HttpResponseConduit.java:739)
at io.undertow.conduits.AbstractFixedLengthStreamSinkConduit.flush(AbstractFixedLengthStreamSinkConduit.java:229)
at org.xnio.conduits.ConduitStreamSinkChannel.flush(ConduitStreamSinkChannel.java:162)
at io.undertow.channels.DetachableStreamSinkChannel.flush(DetachableStreamSinkChannel.java:119)
at org.xnio.channels.Channels.flushBlocking(Channels.java:63)
at io.undertow.servlet.spec.ServletOutputStreamImpl.close(ServletOutputStreamImpl.java:612)
at io.undertow.servlet.spec.HttpServletResponseImpl.closeStreamAndWriter(HttpServletResponseImpl.java:479)
at io.undertow.servlet.core.ServletBlockingHttpExchange.close(ServletBlockingHttpExchange.java:92)
at io.undertow.server.HttpServerExchange.endExchange(HttpServerExchange.java:1585)
at io.undertow.server.AbstractServerConnection$CloseSetter.handleEvent(AbstractServerConnection.java:316)
at io.undertow.server.AbstractServerConnection$CloseSetter.handleEvent(AbstractServerConnection.java:296)
at org.xnio.ChannelListeners.invokeChannelListener(ChannelListeners.java:92)
at org.xnio.StreamConnection.invokeCloseListener(StreamConnection.java:80)
at org.xnio.Connection.writeClosed(Connection.java:117)
at org.xnio.nio.AbstractNioStreamConnection.writeClosed(AbstractNioStreamConnection.java:47)
at org.xnio.nio.NioSocketConduit.terminateWrites(NioSocketConduit.java:182)
at org.xnio.nio.NioSocketConduit.truncateWrites(NioSocketConduit.java:198)
at org.xnio.conduits.ConduitStreamSinkChannel.close(ConduitStreamSinkChannel.java:186)
at org.xnio.IoUtils.safeClose(IoUtils.java:152)
at org.xnio.conduits.WriteReadyHandler$ChannelListenerHandler.forceTermination(WriteReadyHandler.java:57)
at org.xnio.nio.NioSocketConduit.forceTermination(NioSocketConduit.java:108)
at org.xnio.nio.WorkerThread.run(WorkerThread.java:496)
.... // HERE Waitting for long-running-servlet to finish!
11:06:48,015 INFO [org.jboss.qa.management.web.servlets.HeavyProcessingServlet] (default task-1) Finished request processing
11:06:48,018 DEBUG [org.jboss.as.repository] (MSC service thread 1-3) ContentRepository stopped
11:06:48,019 DEBUG [org.jboss.as.server] (ServerService Thread Pool -- 70) DeploymentMountProvider stopped
11:06:48,020 INFO [org.jboss.as] (MSC service thread 1-7) WFLYSRV0050: WildFly Full 11.0.0.Alpha1-SNAPSHOT (WildFly Core 3.0.0.Beta8-SNAPSHOT) stopped in 20275ms
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment