Skip to content

Instantly share code, notes, and snippets.

@gaol
Created March 8, 2017 10:34
Show Gist options
  • Save gaol/feebbd48d37f347060c32a31c4523519 to your computer and use it in GitHub Desktop.
Save gaol/feebbd48d37f347060c32a31c4523519 to your computer and use it in GitHub Desktop.
shutdown by interrupt long running servlet
18:30:25,628 DEBUG [io.undertow.request] (default I/O-1) Matched prefix path /long-running-servlet for path /long-running-servlet/HeavyProcessing
18:30:25,651 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
18:30:25,653 DEBUG [io.undertow.request.security] (default task-1) Authentication outcome was NOT_ATTEMPTED with method io.undertow.security.impl.CachedAuthenticatedSessionMechanism@76806308 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]}}
18:30:25,653 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]}}
18:30:25,656 INFO [org.jboss.qa.management.web.servlets.HeavyProcessingServlet] (default task-1) Started request processing
18:30:28,750 INFO [org.jboss.as.server] (management-handler-thread - 1) WFLYSRV0211: Suspending server with 1000 ms timeout.
18:30:28,751 INFO [org.jboss.as.ejb3] (management-handler-thread - 1) WFLYEJB0493: EJB subsystem suspension complete
18:30:29,753 INFO [org.jboss.as.server] (Management Triggered Shutdown) WFLYSRV0241: Shutting down in response to management operation 'shutdown'
18:30:29,760 DEBUG [org.jboss.as.security] (MSC service thread 1-5) Stopping security domain service jboss-ejb-policy
18:30:29,766 DEBUG [org.jboss.as.security] (MSC service thread 1-3) Stopping security domain service jboss-web-policy
18:30:29,766 DEBUG [org.jboss.as.connector.subsystems.resourceadapters] (MSC service thread 1-2) Stopping ResourceAdaptersSubsystem Service
18:30:29,777 DEBUG [org.wildfly.extension.undertow] (MSC service thread 1-1) Stopping console redirect for default-host
18:30:29,779 DEBUG [org.jboss.as.security] (MSC service thread 1-6) Stopping security domain service jaspitest
18:30:29,779 DEBUG [org.jboss.as.mail.extension] (MSC service thread 1-6) WFLYMAIL0003: Removed mail session [java:jboss/mail/Default]
18:30:29,780 DEBUG [org.jboss.as.connector.deployment.registry] (MSC service thread 1-6) Stopping service service jboss.raregistry
18:30:29,795 DEBUG [org.infinispan.manager.DefaultCacheManager] (MSC service thread 1-6) Stopping cache manager ISPN on null
18:30:29,798 DEBUG [org.infinispan.manager.DefaultCacheManager] (MSC service thread 1-2) Stopping cache manager ISPN on null
18:30:29,785 DEBUG [org.jboss.tm.usertx.UserTransactionRegistry] (MSC service thread 1-8) org.jboss.tm.usertx.UserTransactionRegistry@4010c753 removeListener org.jboss.as.jpa.container.JPAUserTransactionListener@aec4f4d
18:30:29,799 DEBUG [org.infinispan.manager.DefaultCacheManager] (MSC service thread 1-8) Stopping cache manager ISPN on null
18:30:29,793 DEBUG [org.jboss.as.connector] (MSC service thread 1-3) Stopped CommonDeployment %s
18:30:29,816 DEBUG [org.jboss.as.clustering.infinispan] (MSC service thread 1-2) server cache container stopped
18:30:29,814 DEBUG [org.infinispan.manager.DefaultCacheManager] (MSC service thread 1-4) Stopping cache manager ISPN on null
18:30:29,811 INFO [org.wildfly.extension.undertow] (ServerService Thread Pool -- 68) WFLYUT0022: Unregistered web context: '/long-running-servlet' from server 'default-server'
18:30:29,810 DEBUG [org.jboss.as.clustering.infinispan] (MSC service thread 1-8) web cache container stopped
18:30:29,820 DEBUG [org.wildfly.extension.batch] (MSC service thread 1-3) Removing batch environment; ModuleClassLoader for Module "deployment.long-running-servlet.war" from Service Module Loader
18:30:29,820 DEBUG [org.jboss.as.clustering.infinispan] (MSC service thread 1-4) ejb cache container stopped
18:30:29,822 DEBUG [org.jboss.as.clustering.infinispan] (MSC service thread 1-6) hibernate cache container stopped
18:30:29,831 DEBUG [org.jboss.as.domain.management] (MSC service thread 1-2) Stopping 'ManagementRealm' Security Realm Service
18:30:29,833 INFO [org.wildfly.extension.undertow] (MSC service thread 1-4) WFLYUT0019: Host default-host stopping
18:30:29,833 DEBUG [org.jboss.as.security] (MSC service thread 1-4) Stopping security domain service other
18:30:29,833 DEBUG [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (MSC service thread 1-4) stop: CachedConnectionManagerImpl@a00f62d[debug=false error=false ignoreConnections=false transactionIntegration=org.jboss.as.connector.services.jca.NonTxCachedConnectionManagerService$NoopTransactionIntegration@136ec05e currentObjects=null objectToConnectionManagerMap={} connectionStackTraces={}]
18:30:29,834 DEBUG [org.jboss.as.connector] (MSC service thread 1-4) Stopped CcmService service jboss.non-tx-cached-connection-manager
18:30:29,834 DEBUG [org.jboss.as.ejb3.deployment] (MSC service thread 1-3) unRegistering EJB client context for classloader ModuleClassLoader for Module "deployment.long-running-servlet.war" from Service Module Loader
18:30:29,835 INFO [org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-1) WFLYJCA0010: Unbound data source [java:jboss/datasources/ExampleDS]
18:30:29,835 DEBUG [org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-3) Removed JDBC Data-source [java:jboss/datasources/ExampleDS]
18:30:29,845 DEBUG [org.jboss.jca.core.connectionmanager.TxConnectionManager] (ServerService Thread Pool -- 69) java:jboss/datasources/ExampleDS: shutdown
18:30:29,854 DEBUG [org.jboss.jca.core.connectionmanager.pool.strategy.OnePool] (ServerService Thread Pool -- 69) ExampleDS: shutdown
18:30:29,861 DEBUG [org.jboss.jca.core.api.connectionmanager.ccm.CachedConnectionManager] (MSC service thread 1-3) stop: CachedConnectionManagerImpl@43698e13[debug=false error=false ignoreConnections=false transactionIntegration=org.jboss.jca.core.tx.jbossts.TransactionIntegrationImpl@39f176d currentObjects=null objectToConnectionManagerMap={} connectionStackTraces={}]
18:30:29,865 DEBUG [org.jboss.tm.usertx.UserTransactionRegistry] (MSC service thread 1-3) org.jboss.tm.usertx.UserTransactionRegistry@4010c753 removeListener org.jboss.jca.core.tx.jbossts.UserTransactionListenerImpl@43d26ae
18:30:29,866 DEBUG [org.jboss.as.connector] (MSC service thread 1-3) Stopped CcmService service jboss.cached-connection-manager
18:30:29,866 INFO [org.jboss.as.connector.deployers.jdbc] (MSC service thread 1-2) WFLYJCA0019: Stopped Driver service with driver-name = h2
18:30:29,865 DEBUG [org.jboss.as.connector] (MSC service thread 1-7) Stopping JCA WorkManager:
18:30:29,867 DEBUG [org.jboss.as.connector.deployment.registry] (MSC service thread 1-2) Stopping service service jboss.jdbc-driver.registry
18:30:29,867 DEBUG [org.jboss.as.connector] (MSC service thread 1-7) Stopped JCA WorkManager:
18:30:29,865 DEBUG [org.jboss.as.connector] (MSC service thread 1-5) stopped ManagementRepositoryService service jboss.management_repository
18:30:29,879 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 115ms
18:30:29,883 INFO [org.wildfly.extension.undertow] (MSC service thread 1-2) WFLYUT0008: Undertow HTTP listener default suspending
18:30:29,884 INFO [org.wildfly.extension.undertow] (MSC service thread 1-2) WFLYUT0007: Undertow HTTP listener default stopped, was bound to 127.0.0.1:8080
18:30:29,885 INFO [org.wildfly.extension.undertow] (MSC service thread 1-8) WFLYUT0008: Undertow HTTPS listener https suspending
18:30:29,885 INFO [org.wildfly.extension.undertow] (MSC service thread 1-8) WFLYUT0007: Undertow HTTPS listener https stopped, was bound to 127.0.0.1:8443
18:30:29,886 DEBUG [org.jboss.as.domain.management] (MSC service thread 1-2) Stopping 'ApplicationRealm' Security Realm Service
18:30:29,887 INFO [org.wildfly.extension.undertow] (MSC service thread 1-1) WFLYUT0004: Undertow 1.4.11.Final stopping
18:30:29,897 DEBUG [io.undertow] (default I/O-1) Failed to schedule task io.undertow.util.DateUtils$2@18d0224d 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)
18:30:29,899 DEBUG [io.undertow] (default I/O-1) Failed to schedule task io.undertow.server.protocol.ParseTimeoutUpdater@3b527eb1 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)
18:30:29,899 DEBUG [io.undertow.request.io] (default I/O-1) 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)
18:30:29,990 ERROR [io.undertow.request] (default task-1) UT005023: Exception handling request to /long-running-servlet/HeavyProcessing: javax.servlet.ServletException: java.lang.InterruptedException: sleep interrupted
at org.jboss.qa.management.web.servlets.HeavyProcessingServlet.doGet(HeavyProcessingServlet.java:36)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:687)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
at io.undertow.servlet.handlers.ServletHandler.handleRequest(ServletHandler.java:85)
at io.undertow.servlet.handlers.security.ServletSecurityRoleHandler.handleRequest(ServletSecurityRoleHandler.java:62)
at io.undertow.servlet.handlers.ServletDispatchingHandler.handleRequest(ServletDispatchingHandler.java:36)
at org.wildfly.extension.undertow.security.SecurityContextAssociationHandler.handleRequest(SecurityContextAssociationHandler.java:78)
at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43)
at io.undertow.servlet.handlers.security.SSLInformationAssociationHandler.handleRequest(SSLInformationAssociationHandler.java:131)
at io.undertow.servlet.handlers.security.ServletAuthenticationCallHandler.handleRequest(ServletAuthenticationCallHandler.java:57)
at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43)
at io.undertow.security.handlers.AbstractConfidentialityHandler.handleRequest(AbstractConfidentialityHandler.java:46)
at io.undertow.servlet.handlers.security.ServletConfidentialityConstraintHandler.handleRequest(ServletConfidentialityConstraintHandler.java:64)
at io.undertow.security.handlers.AuthenticationMechanismsHandler.handleRequest(AuthenticationMechanismsHandler.java:60)
at io.undertow.servlet.handlers.security.CachedAuthenticatedSessionHandler.handleRequest(CachedAuthenticatedSessionHandler.java:77)
at io.undertow.security.handlers.NotificationReceiverHandler.handleRequest(NotificationReceiverHandler.java:50)
at io.undertow.security.handlers.AbstractSecurityContextAssociationHandler.handleRequest(AbstractSecurityContextAssociationHandler.java:43)
at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43)
at org.wildfly.extension.undertow.security.jacc.JACCContextIdHandler.handleRequest(JACCContextIdHandler.java:61)
at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43)
at org.wildfly.extension.undertow.deployment.GlobalRequestControllerHandler.handleRequest(GlobalRequestControllerHandler.java:46)
at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43)
at io.undertow.servlet.handlers.ServletInitialHandler.handleFirstRequest(ServletInitialHandler.java:292)
at io.undertow.servlet.handlers.ServletInitialHandler.access$100(ServletInitialHandler.java:81)
at io.undertow.servlet.handlers.ServletInitialHandler$2.call(ServletInitialHandler.java:138)
at io.undertow.servlet.handlers.ServletInitialHandler$2.call(ServletInitialHandler.java:135)
at io.undertow.servlet.core.ServletRequestContextThreadSetupAction$1.call(ServletRequestContextThreadSetupAction.java:48)
at io.undertow.servlet.core.ContextClassLoaderSetupAction$1.call(ContextClassLoaderSetupAction.java:43)
at org.wildfly.extension.undertow.security.SecurityContextThreadSetupAction.lambda$create$0(SecurityContextThreadSetupAction.java:105)
at org.wildfly.extension.undertow.deployment.UndertowDeploymentInfoService$UndertowThreadSetupAction.lambda$create$0(UndertowDeploymentInfoService.java:1706)
at org.wildfly.extension.undertow.deployment.UndertowDeploymentInfoService$UndertowThreadSetupAction.lambda$create$0(UndertowDeploymentInfoService.java:1706)
at org.wildfly.extension.undertow.deployment.UndertowDeploymentInfoService$UndertowThreadSetupAction.lambda$create$0(UndertowDeploymentInfoService.java:1706)
at org.wildfly.extension.undertow.deployment.UndertowDeploymentInfoService$UndertowThreadSetupAction.lambda$create$0(UndertowDeploymentInfoService.java:1706)
at io.undertow.servlet.handlers.ServletInitialHandler.dispatchRequest(ServletInitialHandler.java:272)
at io.undertow.servlet.handlers.ServletInitialHandler.access$000(ServletInitialHandler.java:81)
at io.undertow.servlet.handlers.ServletInitialHandler$1.handleRequest(ServletInitialHandler.java:104)
at io.undertow.server.Connectors.executeRootHandler(Connectors.java:211)
at io.undertow.server.HttpServerExchange$1.run(HttpServerExchange.java:809)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.InterruptedException: sleep interrupted
at java.lang.Thread.sleep(Native Method)
at org.jboss.qa.management.web.servlets.HeavyProcessingServlet.doGet(HeavyProcessingServlet.java:34)
... 40 more
18:30:29,992 DEBUG [org.jboss.as.server] (ServerService Thread Pool -- 69) DeploymentMountProvider stopped
18:30:29,992 DEBUG [org.jboss.as.repository] (MSC service thread 1-2) ContentRepository stopped
18:30:29,996 INFO [org.jboss.as] (MSC service thread 1-2) WFLYSRV0050: WildFly Full 11.0.0.Alpha1-SNAPSHOT (WildFly Core 3.0.0.Beta8-SNAPSHOT) stopped in 233ms
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment