[Issue 2516] New - Intermite polling hang problems

classic Classic list List threaded Threaded
5 messages Options
Reply | Threaded
Open this post in threaded view
|

[Issue 2516] New - Intermite polling hang problems

ajpurkiss
https://hudson.dev.java.net/issues/show_bug.cgi?id=2516
                 Issue #|2516
                 Summary|Intermite polling hang problems
               Component|hudson
                 Version|current
                Platform|All
              OS/Version|All
                     URL|
                  Status|NEW
       Status whiteboard|
                Keywords|
              Resolution|
              Issue type|DEFECT
                Priority|P1
            Subcomponent|subversion
             Assigned to|issues@hudson
             Reported by|ajpurkiss






------- Additional comments from [hidden email] Thu Oct 23 20:13:28 +0000 2008 -------
SVN polling hangs indefinitely once in a while and the only way to get round
this is to restart Hudson. I have included a thread dump after I noticed a job
was hung. Note that other jobs continue to poll svn fine only the one job is
affected. Hudson is 1.255, but I have experienced it once before in a previous
release.

Thread Dump
RequestHandlerThread[#6]

"RequestHandlerThread[#6]" Id=990 WAITING on winstone.RequestHandlerThread@45b046
        at java.lang.Object.wait(Native Method)
        -  waiting on winstone.RequestHandlerThread@45b046
        at java.lang.Object.wait(Object.java:485)
        at winstone.RequestHandlerThread.run(RequestHandlerThread.java:216)
        at java.lang.Thread.run(Thread.java:619)


pool-2-thread-126

"pool-2-thread-126" Id=331 WAITING on
java.util.concurrent.locks.ReentrantLock$NonfairSync@9eaa69 owned by
"pool-2-thread-121" Id=325
        at sun.misc.Unsafe.park(Native Method)
        -  waiting on java.util.concurrent.locks.ReentrantLock$NonfairSync@9eaa69
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:158)
        at
java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:747)
        at
java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireInterruptibly(AbstractQueuedSynchronizer.java:803)
        at
java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireInterruptibly(AbstractQueuedSynchronizer.java:1137)
        at
java.util.concurrent.locks.ReentrantLock.lockInterruptibly(ReentrantLock.java:312)
        at hudson.triggers.SCMTrigger$Runner.run(SCMTrigger.java:278)
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
        at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
        at java.util.concurrent.FutureTask.run(FutureTask.java:138)
        at
java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:885)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907)
        at java.lang.Thread.run(Thread.java:619)

        Number of locked synchronizers = 1
        - java.util.concurrent.locks.ReentrantLock$NonfairSync@137c5da


pool-2-thread-121

"pool-2-thread-121" Id=325 RUNNABLE
        at java.net.SocketInputStream.socketRead0(Native Method)
        at java.net.SocketInputStream.read(SocketInputStream.java:129)
        at com.sun.net.ssl.internal.ssl.InputRecord.readFully(InputRecord.java:293)
        at com.sun.net.ssl.internal.ssl.InputRecord.read(InputRecord.java:331)
        at com.sun.net.ssl.internal.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:789)
        -  locked java.lang.Object@14a6a42
        at
com.sun.net.ssl.internal.ssl.SSLSocketImpl.performInitialHandshake(SSLSocketImpl.java:1096)
        -  locked java.lang.Object@86210d
        at com.sun.net.ssl.internal.ssl.SSLSocketImpl.writeRecord(SSLSocketImpl.java:623)
        at com.sun.net.ssl.internal.ssl.AppOutputStream.write(AppOutputStream.java:59)
        -  locked com.sun.net.ssl.internal.ssl.AppOutputStream@5ed8cc
        at java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:65)
        at java.io.BufferedOutputStream.flush(BufferedOutputStream.java:123)
        -  locked java.io.BufferedOutputStream@24f4f0
        at
org.tmatesoft.svn.core.internal.io.dav.http.HTTPConnection.sendData(HTTPConnection.java:208)
        at
org.tmatesoft.svn.core.internal.io.dav.http.HTTPRequest.dispatch(HTTPRequest.java:158)
        at
org.tmatesoft.svn.core.internal.io.dav.http.HTTPConnection.request(HTTPConnection.java:321)
        at
org.tmatesoft.svn.core.internal.io.dav.http.HTTPConnection.request(HTTPConnection.java:255)
        at
org.tmatesoft.svn.core.internal.io.dav.http.HTTPConnection.request(HTTPConnection.java:243)
        at
org.tmatesoft.svn.core.internal.io.dav.DAVConnection.doPropfind(DAVConnection.java:122)
        at org.tmatesoft.svn.core.internal.io.dav.DAVUtil.getProperties(DAVUtil.java:61)
        at
org.tmatesoft.svn.core.internal.io.dav.DAVUtil.getResourceProperties(DAVUtil.java:66)
        at
org.tmatesoft.svn.core.internal.io.dav.DAVUtil.getStartingProperties(DAVUtil.java:90)
        at
org.tmatesoft.svn.core.internal.io.dav.DAVUtil.findStartingProperties(DAVUtil.java:112)
        at
org.tmatesoft.svn.core.internal.io.dav.DAVUtil.getBaselineProperties(DAVUtil.java:204)
        at org.tmatesoft.svn.core.internal.io.dav.DAVUtil.getBaselineInfo(DAVUtil.java:166)
        at
org.tmatesoft.svn.core.internal.io.dav.DAVRepository.checkPath(DAVRepository.java:210)
        at
hudson.scm.SubversionSCM$DescriptorImpl.checkRepositoryPath(SubversionSCM.java:1346)
        at hudson.scm.SubversionSCM.repositoryLocationsExist(SubversionSCM.java:1407)
        at hudson.scm.SubversionSCM.pollChanges(SubversionSCM.java:783)
        at hudson.model.AbstractProject.pollSCMChanges(AbstractProject.java:711)
        at hudson.triggers.SCMTrigger$Runner.runPolling(SCMTrigger.java:253)
        at hudson.triggers.SCMTrigger$Runner.run(SCMTrigger.java:285)
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
        at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
        at java.util.concurrent.FutureTask.run(FutureTask.java:138)
        at
java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:885)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907)
        at java.lang.Thread.run(Thread.java:619)

        Number of locked synchronizers = 2
        - java.util.concurrent.locks.ReentrantLock$NonfairSync@9eaa69
        - java.util.concurrent.locks.ReentrantLock$NonfairSync@f2eca1


RequestHandlerThread[#5]

"RequestHandlerThread[#5]" Id=164 WAITING on winstone.RequestHandlerThread@8d605d
        at java.lang.Object.wait(Native Method)
        -  waiting on winstone.RequestHandlerThread@8d605d
        at java.lang.Object.wait(Object.java:485)
        at winstone.RequestHandlerThread.run(RequestHandlerThread.java:216)
        at java.lang.Thread.run(Thread.java:619)


RequestHandlerThread[#0]

"RequestHandlerThread[#0]" Id=8 WAITING on winstone.RequestHandlerThread@1b1a81c
        at java.lang.Object.wait(Native Method)
        -  waiting on winstone.RequestHandlerThread@1b1a81c
        at java.lang.Object.wait(Object.java:485)
        at winstone.RequestHandlerThread.run(RequestHandlerThread.java:216)
        at java.lang.Thread.run(Thread.java:619)


RequestHandlerThread[#1]

"RequestHandlerThread[#1]" Id=9 WAITING on winstone.RequestHandlerThread@9403a8
        at java.lang.Object.wait(Native Method)
        -  waiting on winstone.RequestHandlerThread@9403a8
        at java.lang.Object.wait(Object.java:485)
        at winstone.RequestHandlerThread.run(RequestHandlerThread.java:216)
        at java.lang.Thread.run(Thread.java:619)


svn log copier

"svn log copier" Id=42 TIMED_WAITING on java.io.PipedInputStream@17c2382
        at java.lang.Object.wait(Native Method)
        -  waiting on java.io.PipedInputStream@17c2382
        at java.io.PipedInputStream.read(PipedInputStream.java:310)
        at java.io.PipedInputStream.read(PipedInputStream.java:361)
        at java.io.InputStream.read(InputStream.java:85)
        at hudson.util.StreamCopyThread.run(StreamCopyThread.java:27)


RequestHandlerThread[#2]

"RequestHandlerThread[#2]" Id=10 WAITING on winstone.RequestHandlerThread@ff4f71
        at java.lang.Object.wait(Native Method)
        -  waiting on winstone.RequestHandlerThread@ff4f71
        at java.lang.Object.wait(Object.java:485)
        at winstone.RequestHandlerThread.run(RequestHandlerThread.java:216)
        at java.lang.Thread.run(Thread.java:619)


Java2D Disposer

"Java2D Disposer" Id=39 WAITING on java.lang.ref.ReferenceQueue$Lock@1b8b15c
        at java.lang.Object.wait(Native Method)
        -  waiting on java.lang.ref.ReferenceQueue$Lock@1b8b15c
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:116)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:132)
        at sun.java2d.Disposer.run(Disposer.java:125)
        at java.lang.Thread.run(Thread.java:619)


RequestHandlerThread[#3]

"RequestHandlerThread[#3]" Id=11 RUNNABLE
        at sun.management.ThreadImpl.dumpThreads0(Native Method)
        at sun.management.ThreadImpl.getThreadInfo(ThreadImpl.java:359)
        at hudson.Functions.getThreadInfos(Functions.java:636)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
        at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
        at java.lang.reflect.Method.invoke(Method.java:597)
        at
org.apache.commons.jexl.util.introspection.UberspectImpl$VelMethodImpl.invoke(UberspectImpl.java:259)
        at org.apache.commons.jexl.parser.ASTMethod.execute(ASTMethod.java:104)
        at org.apache.commons.jexl.parser.ASTReference.execute(ASTReference.java:83)
        at org.apache.commons.jexl.parser.ASTReference.value(ASTReference.java:57)
        at
org.apache.commons.jexl.parser.ASTReferenceExpression.value(ASTReferenceExpression.java:51)
        at org.apache.commons.jexl.ExpressionImpl.evaluate(ExpressionImpl.java:80)
        at hudson.ExpressionFactory2$JexlExpression.evaluate(ExpressionFactory2.java:71)
        at
org.apache.commons.jelly.expression.ExpressionSupport.evaluateRecurse(ExpressionSupport.java:61)
        at
org.apache.commons.jelly.expression.ExpressionSupport.evaluateAsIterator(ExpressionSupport.java:94)
        at org.apache.commons.jelly.tags.core.ForEachTag.doTag(ForEachTag.java:89)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.tags.core.WhenTag.doTag(WhenTag.java:46)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.tags.core.ChooseTag.doTag(ChooseTag.java:38)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.tags.define.InvokeBodyTag.doTag(InvokeBodyTag.java:91)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.tags.core.IfTag.doTag(IfTag.java:42)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.tags.core.JellyTag.doTag(JellyTag.java:45)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.DynamicTag.doTag(DynamicTag.java:80)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.tags.define.InvokeBodyTag.doTag(InvokeBodyTag.java:91)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.impl.StaticTag.doTag(StaticTag.java:65)
        at org.apache.commons.jelly.impl.StaticTagScript.run(StaticTagScript.java:112)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.impl.StaticTag.doTag(StaticTag.java:65)
        at org.apache.commons.jelly.impl.StaticTagScript.run(StaticTagScript.java:112)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.impl.StaticTag.doTag(StaticTag.java:65)
        at org.apache.commons.jelly.impl.StaticTagScript.run(StaticTagScript.java:112)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.impl.StaticTag.doTag(StaticTag.java:65)
        at org.apache.commons.jelly.impl.StaticTagScript.run(StaticTagScript.java:112)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.impl.StaticTag.doTag(StaticTag.java:65)
        at org.apache.commons.jelly.impl.StaticTagScript.run(StaticTagScript.java:112)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.tags.core.JellyTag.doTag(JellyTag.java:45)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.DynamicTag.doTag(DynamicTag.java:80)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.tags.core.JellyTag.doTag(JellyTag.java:45)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at
org.kohsuke.stapler.jelly.DefaultScriptInvoker.invokeScript(DefaultScriptInvoker.java:29)
        at org.kohsuke.stapler.jelly.JellyFacet$1.dispatch(JellyFacet.java:47)
        at org.kohsuke.stapler.Stapler.invoke(Stapler.java:409)
        at org.kohsuke.stapler.Stapler.invoke(Stapler.java:352)
        at org.kohsuke.stapler.Stapler.service(Stapler.java:112)
        at javax.servlet.http.HttpServlet.service(HttpServlet.java:45)
        at winstone.ServletConfiguration.execute(ServletConfiguration.java:249)
        at winstone.RequestDispatcher.forward(RequestDispatcher.java:335)
        at winstone.RequestDispatcher.doFilter(RequestDispatcher.java:378)
        at hudson.util.PluginServletFilter$1.doFilter(PluginServletFilter.java:61)
        at hudson.util.PluginServletFilter.doFilter(PluginServletFilter.java:53)
        at winstone.FilterConfiguration.execute(FilterConfiguration.java:195)
        at winstone.RequestDispatcher.doFilter(RequestDispatcher.java:368)
        at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:52)
        at
hudson.security.UnwrapSecurityExceptionFilter.doFilter(UnwrapSecurityExceptionFilter.java:28)
        at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:55)
        at
org.acegisecurity.ui.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:166)
        at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:55)
        at
org.acegisecurity.providers.anonymous.AnonymousProcessingFilter.doFilter(AnonymousProcessingFilter.java:125)
        at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:55)
        at
org.acegisecurity.ui.rememberme.RememberMeProcessingFilter.doFilter(RememberMeProcessingFilter.java:142)
        at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:55)
        at
org.acegisecurity.ui.AbstractProcessingFilter.doFilter(AbstractProcessingFilter.java:271)
        at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:55)
        at
org.acegisecurity.ui.basicauth.BasicProcessingFilter.doFilter(BasicProcessingFilter.java:173)
        at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:55)
        at
org.acegisecurity.context.HttpSessionContextIntegrationFilter.doFilter(HttpSessionContextIntegrationFilter.java:249)
        at
hudson.security.HttpSessionContextIntegrationFilter2.doFilter(HttpSessionContextIntegrationFilter2.java:42)
        at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:55)
        at hudson.security.ChainedServletFilter.doFilter(ChainedServletFilter.java:44)
        at hudson.security.HudsonFilter.doFilter(HudsonFilter.java:85)
        at winstone.FilterConfiguration.execute(FilterConfiguration.java:195)
        at winstone.RequestDispatcher.doFilter(RequestDispatcher.java:368)
        at winstone.RequestDispatcher.forward(RequestDispatcher.java:333)
        at winstone.RequestHandlerThread.processRequest(RequestHandlerThread.java:244)
        at winstone.RequestHandlerThread.run(RequestHandlerThread.java:150)
        at java.lang.Thread.run(Thread.java:619)


RequestHandlerThread[#4]

"RequestHandlerThread[#4]" Id=12 WAITING on winstone.RequestHandlerThread@4cf007
        at java.lang.Object.wait(Native Method)
        -  waiting on winstone.RequestHandlerThread@4cf007
        at java.lang.Object.wait(Object.java:485)
        at winstone.RequestHandlerThread.run(RequestHandlerThread.java:216)
        at java.lang.Thread.run(Thread.java:619)


Executor #0 for windowssqadev

"Executor #0 for windowssqadev" Id=31 WAITING on hudson.util.OneShotEvent@d0738f
        at java.lang.Object.wait(Native Method)
        -  waiting on hudson.util.OneShotEvent@d0738f
        at java.lang.Object.wait(Object.java:485)
        at hudson.util.OneShotEvent.block(OneShotEvent.java:28)
        at hudson.model.Queue.pop(Queue.java:464)
        at hudson.model.Executor.run(Executor.java:72)


Executor #1 for master

"Executor #1 for master" Id=30 WAITING on hudson.util.OneShotEvent@1523996
        at java.lang.Object.wait(Native Method)
        -  waiting on hudson.util.OneShotEvent@1523996
        at java.lang.Object.wait(Object.java:485)
        at hudson.util.OneShotEvent.block(OneShotEvent.java:28)
        at hudson.model.Queue.pop(Queue.java:464)
        at hudson.model.Executor.run(Executor.java:72)


Executor #0 for master

"Executor #0 for master" Id=29 WAITING on hudson.util.OneShotEvent@142aa9b
        at java.lang.Object.wait(Native Method)
        -  waiting on hudson.util.OneShotEvent@142aa9b
        at java.lang.Object.wait(Object.java:485)
        at hudson.util.OneShotEvent.block(OneShotEvent.java:28)
        at hudson.model.Queue.pop(Queue.java:464)
        at hudson.model.Executor.run(Executor.java:72)


TCP slave agent listener port=0

"TCP slave agent listener port=0" Id=28 RUNNABLE (in native)
        at java.net.PlainSocketImpl.socketAccept(Native Method)
        at java.net.PlainSocketImpl.accept(PlainSocketImpl.java:384)
        -  locked java.net.SocksSocketImpl@13ee7be
        at java.net.ServerSocket.implAccept(ServerSocket.java:453)
        at java.net.ServerSocket.accept(ServerSocket.java:421)
        at hudson.TcpSlaveAgentListener.run(TcpSlaveAgentListener.java:82)


Thread-7

"Thread-7" Id=27 TIMED_WAITING on java.util.LinkedHashSet@e08a5b
        at java.lang.Object.wait(Native Method)
        -  waiting on java.util.LinkedHashSet@e08a5b
        at hudson.model.ViewJob$ReloadThread.getNext(ViewJob.java:136)
        at hudson.model.ViewJob$ReloadThread.run(ViewJob.java:152)


Thread-6

"Thread-6" Id=26 TIMED_WAITING
        at java.lang.Thread.sleep(Native Method)
        at org.jivesoftware.smack.PacketWriter$KeepAliveTask.run(PacketWriter.java:482)
        at java.lang.Thread.run(Thread.java:619)


Smack Listener Processor

"Smack Listener Processor" Id=25 WAITING on
org.jivesoftware.smack.PacketReader$2@19b9435
        at java.lang.Object.wait(Native Method)
        -  waiting on org.jivesoftware.smack.PacketReader$2@19b9435
        at java.lang.Object.wait(Object.java:485)
        at org.jivesoftware.smack.PacketReader.processListeners(PacketReader.java:267)
        at org.jivesoftware.smack.PacketReader.access$100(PacketReader.java:43)
        at org.jivesoftware.smack.PacketReader$2.run(PacketReader.java:72)


Smack Packet Reader

"Smack Packet Reader" Id=24 RUNNABLE (in native)
        at java.net.SocketInputStream.socketRead0(Native Method)
        at java.net.SocketInputStream.read(SocketInputStream.java:129)
        at com.sun.net.ssl.internal.ssl.InputRecord.readFully(InputRecord.java:293)
        at com.sun.net.ssl.internal.ssl.InputRecord.read(InputRecord.java:331)
        at com.sun.net.ssl.internal.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:789)
        -  locked java.lang.Object@11f2880
        at
com.sun.net.ssl.internal.ssl.SSLSocketImpl.readDataRecord(SSLSocketImpl.java:746)
        at com.sun.net.ssl.internal.ssl.AppInputStream.read(AppInputStream.java:75)
        -  locked com.sun.net.ssl.internal.ssl.AppInputStream@199b57c
        at sun.nio.cs.StreamDecoder.readBytes(StreamDecoder.java:264)
        at sun.nio.cs.StreamDecoder.implRead(StreamDecoder.java:306)
        at sun.nio.cs.StreamDecoder.read(StreamDecoder.java:158)
        -  locked java.io.InputStreamReader@13687fb
        at java.io.InputStreamReader.read(InputStreamReader.java:167)
        at java.io.BufferedReader.fill(BufferedReader.java:136)
        at java.io.BufferedReader.read1(BufferedReader.java:187)
        at java.io.BufferedReader.read(BufferedReader.java:261)
        -  locked java.io.InputStreamReader@13687fb
        at org.xmlpull.mxp1.MXParser.fillBuf(MXParser.java:2992)
        at org.xmlpull.mxp1.MXParser.more(MXParser.java:3046)
        at org.xmlpull.mxp1.MXParser.nextImpl(MXParser.java:1384)
        at org.xmlpull.mxp1.MXParser.next(MXParser.java:1093)
        at org.jivesoftware.smack.PacketReader.parsePackets(PacketReader.java:382)
        at org.jivesoftware.smack.PacketReader.access$000(PacketReader.java:43)
        at org.jivesoftware.smack.PacketReader$1.run(PacketReader.java:63)


Smack Packet Writer

"Smack Packet Writer" Id=23 TIMED_WAITING on java.util.LinkedList@119778a
        at java.lang.Object.wait(Native Method)
        -  waiting on java.util.LinkedList@119778a
        at org.jivesoftware.smack.PacketWriter.nextPacket(PacketWriter.java:235)
        at org.jivesoftware.smack.PacketWriter.writePackets(PacketWriter.java:256)
        at org.jivesoftware.smack.PacketWriter.access$000(PacketWriter.java:39)
        at org.jivesoftware.smack.PacketWriter$1.run(PacketWriter.java:79)


DestroyJavaVM

"DestroyJavaVM" Id=22 RUNNABLE


LauncherControlThread[ControlPort=-1]

"LauncherControlThread[ControlPort=-1]" Id=20 TIMED_WAITING
        at java.lang.Thread.sleep(Native Method)
        at winstone.Launcher.run(Launcher.java:279)
        at java.lang.Thread.run(Thread.java:619)


ConnectorThread:[ajp13-8010]

"ConnectorThread:[ajp13-8010]" Id=19 RUNNABLE (in native)
        at java.net.PlainSocketImpl.socketAccept(Native Method)
        at java.net.PlainSocketImpl.accept(PlainSocketImpl.java:384)
        -  locked java.net.SocksSocketImpl@f72877
        at java.net.ServerSocket.implAccept(ServerSocket.java:453)
        at java.net.ServerSocket.accept(ServerSocket.java:421)
        at winstone.ajp13.Ajp13Listener.run(Ajp13Listener.java:111)
        at java.lang.Thread.run(Thread.java:619)


ConnectorThread:[http-8081]

"ConnectorThread:[http-8081]" Id=18 RUNNABLE
        at java.net.PlainSocketImpl.socketAccept(Native Method)
        at java.net.PlainSocketImpl.accept(PlainSocketImpl.java:384)
        -  locked java.net.SocksSocketImpl@81a240
        at java.net.ServerSocket.implAccept(ServerSocket.java:453)
        at java.net.ServerSocket.accept(ServerSocket.java:421)
        at winstone.HttpListener.run(HttpListener.java:127)
        at java.lang.Thread.run(Thread.java:619)


WinstoneHostConfigurationMgmt:default

"WinstoneHostConfigurationMgmt:default" Id=17 TIMED_WAITING
        at java.lang.Thread.sleep(Native Method)
        at winstone.HostConfiguration.run(HostConfiguration.java:176)
        at java.lang.Thread.run(Thread.java:619)


Hudson cron thread

"Hudson cron thread" Id=16 TIMED_WAITING on java.util.TaskQueue@c34d5a
        at java.lang.Object.wait(Native Method)
        -  waiting on java.util.TaskQueue@c34d5a
        at java.util.TimerThread.mainLoop(Timer.java:509)
        at java.util.TimerThread.run(Timer.java:462)


WinstoneObjectPoolMgmt

"WinstoneObjectPoolMgmt" Id=13 TIMED_WAITING
        at java.lang.Thread.sleep(Native Method)
        at winstone.ObjectPool.run(ObjectPool.java:103)
        at java.lang.Thread.run(Thread.java:619)


Signal Dispatcher

"Signal Dispatcher" Id=4 RUNNABLE


Finalizer

"Finalizer" Id=3 WAITING on java.lang.ref.ReferenceQueue$Lock@b5b62
        at java.lang.Object.wait(Native Method)
        -  waiting on java.lang.ref.ReferenceQueue$Lock@b5b62
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:116)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:132)
        at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:159)


Reference Handler

"Reference Handler" Id=2 WAITING on java.lang.ref.Reference$Lock@19cb865
        at java.lang.Object.wait(Native Method)
        -  waiting on java.lang.ref.Reference$Lock@19cb865
        at java.lang.Object.wait(Object.java:485)
        at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:116)

---------------------------------------------------------------------
To unsubscribe, e-mail: [hidden email]
For additional commands, e-mail: [hidden email]

Reply | Threaded
Open this post in threaded view
|

[Issue 2516] Intermite polling hang problems

ajpurkiss
https://hudson.dev.java.net/issues/show_bug.cgi?id=2516






------- Additional comments from [hidden email] Wed Jan 21 17:46:10 +0000 2009 -------
Updating Hudson post svnkit update to 1.2.1 still hangs I have included a new
thread dump. It is probably worth updating to 1.2.2 anyway to get access to all
svn 1.5.5 features.

One job has hung while polling svn - looks to be executor 0 all other jobs
continue to poll svn. Like I have said before the only way to free it up is to
restart hudson. After that it will work for a bit and then hang (unsure what
causes the hang to occur)
 


Thread Dump
Update center installer thread
"Update center installer thread" Id=982 WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@7fecff
        at sun.misc.Unsafe.park(Native Method)
        -  waiting on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@7fecff
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:158)
        at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:1925)
        at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:358)
        at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:946)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:906)
        at java.lang.Thread.run(Thread.java:619)

RequestHandlerThread[#6]
"RequestHandlerThread[#6]" Id=385 WAITING on winstone.RequestHandlerThread@a063dc
        at java.lang.Object.wait(Native Method)
        -  waiting on winstone.RequestHandlerThread@a063dc
        at java.lang.Object.wait(Object.java:485)
        at winstone.RequestHandlerThread.run(RequestHandlerThread.java:216)
        at java.lang.Thread.run(Thread.java:619)

RequestHandlerThread[#5]
"RequestHandlerThread[#5]" Id=209 WAITING on winstone.RequestHandlerThread@1fc2eff
        at java.lang.Object.wait(Native Method)
        -  waiting on winstone.RequestHandlerThread@1fc2eff
        at java.lang.Object.wait(Object.java:485)
        at winstone.RequestHandlerThread.run(RequestHandlerThread.java:216)
        at java.lang.Thread.run(Thread.java:619)

RequestHandlerThread[#0]
"RequestHandlerThread[#0]" Id=8 RUNNABLE
        at sun.management.ThreadImpl.dumpThreads0(Native Method)
        at sun.management.ThreadImpl.getThreadInfo(ThreadImpl.java:359)
        at hudson.Functions.getThreadInfos(Functions.java:658)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
        at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
        at java.lang.reflect.Method.invoke(Method.java:597)
        at
org.apache.commons.jexl.util.introspection.UberspectImpl$VelMethodImpl.invoke(UberspectImpl.java:259)
        at org.apache.commons.jexl.parser.ASTMethod.execute(ASTMethod.java:104)
        at org.apache.commons.jexl.parser.ASTReference.execute(ASTReference.java:83)
        at org.apache.commons.jexl.parser.ASTReference.value(ASTReference.java:57)
        at
org.apache.commons.jexl.parser.ASTReferenceExpression.value(ASTReferenceExpression.java:51)
        at org.apache.commons.jexl.ExpressionImpl.evaluate(ExpressionImpl.java:80)
        at hudson.ExpressionFactory2$JexlExpression.evaluate(ExpressionFactory2.java:71)
        at
org.apache.commons.jelly.expression.ExpressionSupport.evaluateRecurse(ExpressionSupport.java:61)
        at
org.apache.commons.jelly.expression.ExpressionSupport.evaluateAsIterator(ExpressionSupport.java:94)
        at org.apache.commons.jelly.tags.core.ForEachTag.doTag(ForEachTag.java:89)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.tags.core.WhenTag.doTag(WhenTag.java:46)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.tags.core.ChooseTag.doTag(ChooseTag.java:38)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.tags.define.InvokeBodyTag.doTag(InvokeBodyTag.java:91)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.tags.core.IfTag.doTag(IfTag.java:42)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.tags.core.JellyTag.doTag(JellyTag.java:45)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.DynamicTag.doTag(DynamicTag.java:80)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.tags.define.InvokeBodyTag.doTag(InvokeBodyTag.java:91)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.impl.StaticTag.doTag(StaticTag.java:65)
        at org.apache.commons.jelly.impl.StaticTagScript.run(StaticTagScript.java:112)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.impl.StaticTag.doTag(StaticTag.java:65)
        at org.apache.commons.jelly.impl.StaticTagScript.run(StaticTagScript.java:112)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.impl.StaticTag.doTag(StaticTag.java:65)
        at org.apache.commons.jelly.impl.StaticTagScript.run(StaticTagScript.java:112)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.impl.StaticTag.doTag(StaticTag.java:65)
        at org.apache.commons.jelly.impl.StaticTagScript.run(StaticTagScript.java:112)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.impl.StaticTag.doTag(StaticTag.java:65)
        at org.apache.commons.jelly.impl.StaticTagScript.run(StaticTagScript.java:112)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.tags.core.JellyTag.doTag(JellyTag.java:45)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.DynamicTag.doTag(DynamicTag.java:80)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.tags.core.JellyTag.doTag(JellyTag.java:45)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at
org.kohsuke.stapler.jelly.DefaultScriptInvoker.invokeScript(DefaultScriptInvoker.java:29)
        at org.kohsuke.stapler.jelly.JellyFacet$1.dispatch(JellyFacet.java:46)
        at org.kohsuke.stapler.Stapler.invoke(Stapler.java:438)
        at org.kohsuke.stapler.Stapler.invoke(Stapler.java:356)
        at org.kohsuke.stapler.Stapler.service(Stapler.java:116)
        at javax.servlet.http.HttpServlet.service(HttpServlet.java:45)
        at winstone.ServletConfiguration.execute(ServletConfiguration.java:249)
        at winstone.RequestDispatcher.forward(RequestDispatcher.java:335)
        at winstone.RequestDispatcher.doFilter(RequestDispatcher.java:378)
        at hudson.util.PluginServletFilter$1.doFilter(PluginServletFilter.java:61)
        at hudson.util.PluginServletFilter.doFilter(PluginServletFilter.java:53)
        at winstone.FilterConfiguration.execute(FilterConfiguration.java:195)
        at winstone.RequestDispatcher.doFilter(RequestDispatcher.java:368)
        at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:52)
        at
hudson.security.UnwrapSecurityExceptionFilter.doFilter(UnwrapSecurityExceptionFilter.java:28)
        at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:55)
        at
org.acegisecurity.ui.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:166)
        at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:55)
        at
org.acegisecurity.providers.anonymous.AnonymousProcessingFilter.doFilter(AnonymousProcessingFilter.java:125)
        at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:55)
        at
org.acegisecurity.ui.rememberme.RememberMeProcessingFilter.doFilter(RememberMeProcessingFilter.java:142)
        at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:55)
        at
org.acegisecurity.ui.AbstractProcessingFilter.doFilter(AbstractProcessingFilter.java:271)
        at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:55)
        at
org.acegisecurity.ui.basicauth.BasicProcessingFilter.doFilter(BasicProcessingFilter.java:173)
        at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:55)
        at
org.acegisecurity.context.HttpSessionContextIntegrationFilter.doFilter(HttpSessionContextIntegrationFilter.java:249)
        at
hudson.security.HttpSessionContextIntegrationFilter2.doFilter(HttpSessionContextIntegrationFilter2.java:42)
        at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:55)
        at hudson.security.ChainedServletFilter.doFilter(ChainedServletFilter.java:44)
        at hudson.security.HudsonFilter.doFilter(HudsonFilter.java:85)
        at winstone.FilterConfiguration.execute(FilterConfiguration.java:195)
        at winstone.RequestDispatcher.doFilter(RequestDispatcher.java:368)
        at winstone.RequestDispatcher.forward(RequestDispatcher.java:333)
        at winstone.RequestHandlerThread.processRequest(RequestHandlerThread.java:244)
        at winstone.RequestHandlerThread.run(RequestHandlerThread.java:150)
        at java.lang.Thread.run(Thread.java:619)

RequestHandlerThread[#1]
"RequestHandlerThread[#1]" Id=9 WAITING on winstone.RequestHandlerThread@1719479
        at java.lang.Object.wait(Native Method)
        -  waiting on winstone.RequestHandlerThread@1719479
        at java.lang.Object.wait(Object.java:485)
        at winstone.RequestHandlerThread.run(RequestHandlerThread.java:216)
        at java.lang.Thread.run(Thread.java:619)

RequestHandlerThread[#2]
"RequestHandlerThread[#2]" Id=10 WAITING on winstone.RequestHandlerThread@1cacc11
        at java.lang.Object.wait(Native Method)
        -  waiting on winstone.RequestHandlerThread@1cacc11
        at java.lang.Object.wait(Object.java:485)
        at winstone.RequestHandlerThread.run(RequestHandlerThread.java:216)
        at java.lang.Thread.run(Thread.java:619)

pool-2-thread-34
"pool-2-thread-34" Id=104 WAITING on
java.util.concurrent.locks.ReentrantLock$NonfairSync@396218 owned by
"pool-2-thread-30" Id=98
        at sun.misc.Unsafe.park(Native Method)
        -  waiting on java.util.concurrent.locks.ReentrantLock$NonfairSync@396218
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:158)
        at
java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:747)
        at
java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireInterruptibly(AbstractQueuedSynchronizer.java:803)
        at
java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireInterruptibly(AbstractQueuedSynchronizer.java:1137)
        at
java.util.concurrent.locks.ReentrantLock.lockInterruptibly(ReentrantLock.java:312)
        at hudson.triggers.SCMTrigger$Runner.run(SCMTrigger.java:278)
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
        at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
        at java.util.concurrent.FutureTask.run(FutureTask.java:138)
        at
java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:885)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907)
        at java.lang.Thread.run(Thread.java:619)

        Number of locked synchronizers = 1
        - java.util.concurrent.locks.ReentrantLock$NonfairSync@11b8ec1

pool-2-thread-30
"pool-2-thread-30" Id=98 RUNNABLE
        at java.net.SocketInputStream.socketRead0(Native Method)
        at java.net.SocketInputStream.read(SocketInputStream.java:129)
        at com.sun.net.ssl.internal.ssl.InputRecord.readFully(InputRecord.java:293)
        at com.sun.net.ssl.internal.ssl.InputRecord.read(InputRecord.java:331)
        at com.sun.net.ssl.internal.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:789)
        -  locked java.lang.Object@1574c23
        at
com.sun.net.ssl.internal.ssl.SSLSocketImpl.performInitialHandshake(SSLSocketImpl.java:1096)
        -  locked java.lang.Object@47bdb5
        at com.sun.net.ssl.internal.ssl.SSLSocketImpl.writeRecord(SSLSocketImpl.java:623)
        at com.sun.net.ssl.internal.ssl.AppOutputStream.write(AppOutputStream.java:59)
        -  locked com.sun.net.ssl.internal.ssl.AppOutputStream@1b377a0
        at java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:65)
        at java.io.BufferedOutputStream.flush(BufferedOutputStream.java:123)
        -  locked java.io.BufferedOutputStream@2f5075
        at
org.tmatesoft.svn.core.internal.io.dav.http.HTTPConnection.sendData(HTTPConnection.java:210)
        at
org.tmatesoft.svn.core.internal.io.dav.http.HTTPRequest.dispatch(HTTPRequest.java:165)
        at
org.tmatesoft.svn.core.internal.io.dav.http.HTTPConnection.request(HTTPConnection.java:329)
        at
org.tmatesoft.svn.core.internal.io.dav.http.HTTPConnection.request(HTTPConnection.java:257)
        at
org.tmatesoft.svn.core.internal.io.dav.http.HTTPConnection.request(HTTPConnection.java:245)
        at
org.tmatesoft.svn.core.internal.io.dav.DAVConnection.doPropfind(DAVConnection.java:124)
        at org.tmatesoft.svn.core.internal.io.dav.DAVUtil.getProperties(DAVUtil.java:62)
        at
org.tmatesoft.svn.core.internal.io.dav.DAVUtil.getResourceProperties(DAVUtil.java:67)
        at
org.tmatesoft.svn.core.internal.io.dav.DAVUtil.getBaselineProperties(DAVUtil.java:230)
        at org.tmatesoft.svn.core.internal.io.dav.DAVUtil.getBaselineInfo(DAVUtil.java:167)
        at
org.tmatesoft.svn.core.internal.io.dav.DAVRepository.checkPath(DAVRepository.java:211)
        at
hudson.scm.SubversionSCM$DescriptorImpl.checkRepositoryPath(SubversionSCM.java:1356)
        at hudson.scm.SubversionSCM.repositoryLocationsExist(SubversionSCM.java:1418)
        at hudson.scm.SubversionSCM.pollChanges(SubversionSCM.java:783)
        at hudson.model.AbstractProject.pollSCMChanges(AbstractProject.java:713)
        at hudson.triggers.SCMTrigger$Runner.runPolling(SCMTrigger.java:253)
        at hudson.triggers.SCMTrigger$Runner.run(SCMTrigger.java:285)
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
        at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
        at java.util.concurrent.FutureTask.run(FutureTask.java:138)
        at
java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:885)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907)
        at java.lang.Thread.run(Thread.java:619)

        Number of locked synchronizers = 2
        - java.util.concurrent.locks.ReentrantLock$NonfairSync@396218
        - java.util.concurrent.locks.ReentrantLock$NonfairSync@4b61a1

RequestHandlerThread[#3]
"RequestHandlerThread[#3]" Id=11 RUNNABLE (in native)
        at java.net.SocketInputStream.socketRead0(Native Method)
        at java.net.SocketInputStream.read(SocketInputStream.java:129)
        at java.net.SocketInputStream.read(SocketInputStream.java:182)
        at winstone.WinstoneInputStream.read(WinstoneInputStream.java:51)
        at javax.servlet.ServletInputStream.readLine(ServletInputStream.java:27)
        at winstone.WinstoneInputStream.readLine(WinstoneInputStream.java:82)
        at winstone.HttpListener.parseURI(HttpListener.java:231)
        at winstone.RequestHandlerThread.run(RequestHandlerThread.java:87)
        at java.lang.Thread.run(Thread.java:619)

RequestHandlerThread[#4]
"RequestHandlerThread[#4]" Id=12 WAITING on winstone.RequestHandlerThread@f6ccad
        at java.lang.Object.wait(Native Method)
        -  waiting on winstone.RequestHandlerThread@f6ccad
        at java.lang.Object.wait(Object.java:485)
        at winstone.RequestHandlerThread.run(RequestHandlerThread.java:216)
        at java.lang.Thread.run(Thread.java:619)

Executor #0 for windowssqadev
"Executor #0 for windowssqadev" Id=33 WAITING on hudson.util.OneShotEvent@f77259
        at java.lang.Object.wait(Native Method)
        -  waiting on hudson.util.OneShotEvent@f77259
        at java.lang.Object.wait(Object.java:485)
        at hudson.util.OneShotEvent.block(OneShotEvent.java:28)
        at hudson.model.Queue.pop(Queue.java:466)
        at hudson.model.Executor.run(Executor.java:74)

Executor #2 for master
"Executor #2 for master" Id=32 WAITING on hudson.util.OneShotEvent@1745782
        at java.lang.Object.wait(Native Method)
        -  waiting on hudson.util.OneShotEvent@1745782
        at java.lang.Object.wait(Object.java:485)
        at hudson.util.OneShotEvent.block(OneShotEvent.java:28)
        at hudson.model.Queue.pop(Queue.java:466)
        at hudson.model.Executor.run(Executor.java:74)

Executor #1 for master
"Executor #1 for master" Id=31 WAITING on hudson.util.OneShotEvent@11d364c
        at java.lang.Object.wait(Native Method)
        -  waiting on hudson.util.OneShotEvent@11d364c
        at java.lang.Object.wait(Object.java:485)
        at hudson.util.OneShotEvent.block(OneShotEvent.java:28)
        at hudson.model.Queue.pop(Queue.java:466)
        at hudson.model.Executor.run(Executor.java:74)

Executor #0 for master
"Executor #0 for master" Id=30 WAITING on hudson.util.OneShotEvent@d7e235
        at java.lang.Object.wait(Native Method)
        -  waiting on hudson.util.OneShotEvent@d7e235
        at java.lang.Object.wait(Object.java:485)
        at hudson.util.OneShotEvent.block(OneShotEvent.java:28)
        at hudson.model.Queue.pop(Queue.java:466)
        at hudson.model.Executor.run(Executor.java:74)

TCP slave agent listener port=0
"TCP slave agent listener port=0" Id=29 RUNNABLE (in native)
        at java.net.PlainSocketImpl.socketAccept(Native Method)
        at java.net.PlainSocketImpl.accept(PlainSocketImpl.java:384)
        -  locked java.net.SocksSocketImpl@1441772
        at java.net.ServerSocket.implAccept(ServerSocket.java:453)
        at java.net.ServerSocket.accept(ServerSocket.java:421)
        at hudson.TcpSlaveAgentListener.run(TcpSlaveAgentListener.java:82)

Thread-7
"Thread-7" Id=28 TIMED_WAITING on java.util.LinkedHashSet@15f4325
        at java.lang.Object.wait(Native Method)
        -  waiting on java.util.LinkedHashSet@15f4325
        at hudson.model.ViewJob$ReloadThread.getNext(ViewJob.java:136)
        at hudson.model.ViewJob$ReloadThread.run(ViewJob.java:152)

DestroyJavaVM
"DestroyJavaVM" Id=23 RUNNABLE

LauncherControlThread[ControlPort=-1]
"LauncherControlThread[ControlPort=-1]" Id=21 TIMED_WAITING
        at java.lang.Thread.sleep(Native Method)
        at winstone.Launcher.run(Launcher.java:279)
        at java.lang.Thread.run(Thread.java:619)

ConnectorThread:[ajp13-8010]
"ConnectorThread:[ajp13-8010]" Id=20 RUNNABLE (in native)
        at java.net.PlainSocketImpl.socketAccept(Native Method)
        at java.net.PlainSocketImpl.accept(PlainSocketImpl.java:384)
        -  locked java.net.SocksSocketImpl@179b3c7
        at java.net.ServerSocket.implAccept(ServerSocket.java:453)
        at java.net.ServerSocket.accept(ServerSocket.java:421)
        at winstone.ajp13.Ajp13Listener.run(Ajp13Listener.java:111)
        at java.lang.Thread.run(Thread.java:619)

ConnectorThread:[http-8081]
"ConnectorThread:[http-8081]" Id=19 RUNNABLE (in native)
        at java.net.PlainSocketImpl.socketAccept(Native Method)
        at java.net.PlainSocketImpl.accept(PlainSocketImpl.java:384)
        -  locked java.net.SocksSocketImpl@28f290
        at java.net.ServerSocket.implAccept(ServerSocket.java:453)
        at java.net.ServerSocket.accept(ServerSocket.java:421)
        at winstone.HttpListener.run(HttpListener.java:127)
        at java.lang.Thread.run(Thread.java:619)

WinstoneHostConfigurationMgmt:default
"WinstoneHostConfigurationMgmt:default" Id=18 TIMED_WAITING
        at java.lang.Thread.sleep(Native Method)
        at winstone.HostConfiguration.run(HostConfiguration.java:176)
        at java.lang.Thread.run(Thread.java:619)

Hudson cron thread
"Hudson cron thread" Id=17 TIMED_WAITING on java.util.TaskQueue@4ce4a3
        at java.lang.Object.wait(Native Method)
        -  waiting on java.util.TaskQueue@4ce4a3
        at java.util.TimerThread.mainLoop(Timer.java:509)
        at java.util.TimerThread.run(Timer.java:462)

Java2D Disposer
"Java2D Disposer" Id=15 WAITING on java.lang.ref.ReferenceQueue$Lock@36b284
        at java.lang.Object.wait(Native Method)
        -  waiting on java.lang.ref.ReferenceQueue$Lock@36b284
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:116)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:132)
        at sun.java2d.Disposer.run(Disposer.java:125)
        at java.lang.Thread.run(Thread.java:619)

WinstoneObjectPoolMgmt
"WinstoneObjectPoolMgmt" Id=13 TIMED_WAITING
        at java.lang.Thread.sleep(Native Method)
        at winstone.ObjectPool.run(ObjectPool.java:103)
        at java.lang.Thread.run(Thread.java:619)

Signal Dispatcher
"Signal Dispatcher" Id=4 RUNNABLE

Finalizer
"Finalizer" Id=3 WAITING on java.lang.ref.ReferenceQueue$Lock@1022d8f
        at java.lang.Object.wait(Native Method)
        -  waiting on java.lang.ref.ReferenceQueue$Lock@1022d8f
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:116)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:132)
        at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:159)

Reference Handler
"Reference Handler" Id=2 WAITING on java.lang.ref.Reference$Lock@1fd3804
        at java.lang.Object.wait(Native Method)
        -  waiting on java.lang.ref.Reference$Lock@1fd3804
        at java.lang.Object.wait(Object.java:485)
        at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:116)

 
 



---------------------------------------------------------------------
To unsubscribe, e-mail: [hidden email]
For additional commands, e-mail: [hidden email]

Reply | Threaded
Open this post in threaded view
|

[Issue 2516] Intermite polling hang problems

andrewgoktepe
In reply to this post by ajpurkiss
https://hudson.dev.java.net/issues/show_bug.cgi?id=2516






------- Additional comments from [hidden email] Thu Jan 22 07:24:27 +0000 2009 -------
I am seeing the same problem on 1.276 and 1.277.  After upgrading from 1.270 to
1.277 the issue has appeared in our environment for the first time.

In the thread dump it looks like several threads are blocked at
hudson.scm.SubversionSCM.pollChanges.

The symptom of the problem is that jobs which are configured to poll regularly
(some every 3 minutes, some every 5 minutes) will poll once or twice, and then
never again.  But there are other jobs which continue to poll, so as the author
of this bug report said, it is not all jobs which are stuck.


Thread Dump
RequestHandlerThread[#6]

"RequestHandlerThread[#6]" Id=281 WAITING on winstone.RequestHandlerThread@125df8a
        at java.lang.Object.wait(Native Method)
        -  waiting on winstone.RequestHandlerThread@125df8a
        at java.lang.Object.wait(Object.java:485)
        at winstone.RequestHandlerThread.run(RequestHandlerThread.java:216)
        at java.lang.Thread.run(Thread.java:619)


pool-2-thread-12

"pool-2-thread-12" Id=249 WAITING on
java.util.concurrent.locks.ReentrantLock$NonfairSync@18b9d48 owned by
"pool-2-thread-8" Id=243
        at sun.misc.Unsafe.park(Native Method)
        -  waiting on java.util.concurrent.locks.ReentrantLock$NonfairSync@18b9d48
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:158)
        at
java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:747)
        at
java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireInterruptibly(AbstractQueuedSynchronizer.java:803)
        at
java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireInterruptibly(AbstractQueuedSynchronizer.java:1137)
        at
java.util.concurrent.locks.ReentrantLock.lockInterruptibly(ReentrantLock.java:312)
        at hudson.triggers.SCMTrigger$Runner.run(SCMTrigger.java:397)
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
        at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
        at java.util.concurrent.FutureTask.run(FutureTask.java:138)
        at
java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:885)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907)
        at java.lang.Thread.run(Thread.java:619)

        Number of locked synchronizers = 1
        - java.util.concurrent.locks.ReentrantLock$NonfairSync@176f013


pool-2-thread-11

"pool-2-thread-11" Id=248 WAITING on
java.util.concurrent.locks.ReentrantLock$NonfairSync@4cd904 owned by
"pool-2-thread-9" Id=244
        at sun.misc.Unsafe.park(Native Method)
        -  waiting on java.util.concurrent.locks.ReentrantLock$NonfairSync@4cd904
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:158)
        at
java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:747)
        at
java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireInterruptibly(AbstractQueuedSynchronizer.java:803)
        at
java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireInterruptibly(AbstractQueuedSynchronizer.java:1137)
        at
java.util.concurrent.locks.ReentrantLock.lockInterruptibly(ReentrantLock.java:312)
        at hudson.triggers.SCMTrigger$Runner.run(SCMTrigger.java:397)
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
        at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
        at java.util.concurrent.FutureTask.run(FutureTask.java:138)
        at
java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:885)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907)
        at java.lang.Thread.run(Thread.java:619)

        Number of locked synchronizers = 1
        - java.util.concurrent.locks.ReentrantLock$NonfairSync@102e9f1


pool-2-thread-10

"pool-2-thread-10" Id=246 TIMED_WAITING
        at java.lang.Thread.sleep(Native Method)
        at hudson.scm.SubversionSCM.pollChanges(SubversionSCM.java:834)
        at hudson.model.AbstractProject.pollSCMChanges(AbstractProject.java:728)
        at hudson.triggers.SCMTrigger$Runner.runPolling(SCMTrigger.java:372)
        at hudson.triggers.SCMTrigger$Runner.run(SCMTrigger.java:405)
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
        at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
        at java.util.concurrent.FutureTask.run(FutureTask.java:138)
        at
java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:885)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907)
        at java.lang.Thread.run(Thread.java:619)

        Number of locked synchronizers = 2
        - java.util.concurrent.locks.ReentrantLock$NonfairSync@13bb696
        - java.util.concurrent.locks.ReentrantLock$NonfairSync@1506dfb


pool-2-thread-9

"pool-2-thread-9" Id=244 TIMED_WAITING
        at java.lang.Thread.sleep(Native Method)
        at hudson.scm.SubversionSCM.pollChanges(SubversionSCM.java:834)
        at hudson.model.AbstractProject.pollSCMChanges(AbstractProject.java:728)
        at hudson.triggers.SCMTrigger$Runner.runPolling(SCMTrigger.java:372)
        at hudson.triggers.SCMTrigger$Runner.run(SCMTrigger.java:405)
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
        at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
        at java.util.concurrent.FutureTask.run(FutureTask.java:138)
        at
java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:885)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907)
        at java.lang.Thread.run(Thread.java:619)

        Number of locked synchronizers = 2
        - java.util.concurrent.locks.ReentrantLock$NonfairSync@4cd904
        - java.util.concurrent.locks.ReentrantLock$NonfairSync@1648bd9


pool-2-thread-8

"pool-2-thread-8" Id=243 TIMED_WAITING
        at java.lang.Thread.sleep(Native Method)
        at hudson.scm.SubversionSCM.pollChanges(SubversionSCM.java:834)
        at hudson.model.AbstractProject.pollSCMChanges(AbstractProject.java:728)
        at hudson.triggers.SCMTrigger$Runner.runPolling(SCMTrigger.java:372)
        at hudson.triggers.SCMTrigger$Runner.run(SCMTrigger.java:405)
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
        at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
        at java.util.concurrent.FutureTask.run(FutureTask.java:138)
        at
java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:885)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907)
        at java.lang.Thread.run(Thread.java:619)

        Number of locked synchronizers = 2
        - java.util.concurrent.locks.ReentrantLock$NonfairSync@18b9d48
        - java.util.concurrent.locks.ReentrantLock$NonfairSync@198fc5


pool-2-thread-7

"pool-2-thread-7" Id=241 TIMED_WAITING
        at java.lang.Thread.sleep(Native Method)
        at hudson.scm.SubversionSCM.pollChanges(SubversionSCM.java:834)
        at hudson.model.AbstractProject.pollSCMChanges(AbstractProject.java:728)
        at hudson.triggers.SCMTrigger$Runner.runPolling(SCMTrigger.java:372)
        at hudson.triggers.SCMTrigger$Runner.run(SCMTrigger.java:405)
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
        at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
        at java.util.concurrent.FutureTask.run(FutureTask.java:138)
        at
java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:885)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907)
        at java.lang.Thread.run(Thread.java:619)

        Number of locked synchronizers = 2
        - java.util.concurrent.locks.ReentrantLock$NonfairSync@2ddcec
        - java.util.concurrent.locks.ReentrantLock$NonfairSync@103341a


pool-2-thread-6

"pool-2-thread-6" Id=240 WAITING on
java.util.concurrent.locks.ReentrantLock$NonfairSync@1b2648 owned by
"pool-2-thread-4" Id=238
        at sun.misc.Unsafe.park(Native Method)
        -  waiting on java.util.concurrent.locks.ReentrantLock$NonfairSync@1b2648
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:158)
        at
java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:747)
        at
java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireInterruptibly(AbstractQueuedSynchronizer.java:803)
        at
java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireInterruptibly(AbstractQueuedSynchronizer.java:1137)
        at
java.util.concurrent.locks.ReentrantLock.lockInterruptibly(ReentrantLock.java:312)
        at hudson.triggers.SCMTrigger$Runner.run(SCMTrigger.java:397)
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
        at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
        at java.util.concurrent.FutureTask.run(FutureTask.java:138)
        at
java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:885)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907)
        at java.lang.Thread.run(Thread.java:619)

        Number of locked synchronizers = 1
        - java.util.concurrent.locks.ReentrantLock$NonfairSync@151b84e


pool-2-thread-5

"pool-2-thread-5" Id=239 WAITING on
java.util.concurrent.locks.ReentrantLock$NonfairSync@1b2648 owned by
"pool-2-thread-4" Id=238
        at sun.misc.Unsafe.park(Native Method)
        -  waiting on java.util.concurrent.locks.ReentrantLock$NonfairSync@1b2648
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:158)
        at
java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:747)
        at
java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireInterruptibly(AbstractQueuedSynchronizer.java:803)
        at
java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireInterruptibly(AbstractQueuedSynchronizer.java:1137)
        at
java.util.concurrent.locks.ReentrantLock.lockInterruptibly(ReentrantLock.java:312)
        at hudson.triggers.SCMTrigger$Runner.run(SCMTrigger.java:397)
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
        at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
        at java.util.concurrent.FutureTask.run(FutureTask.java:138)
        at
java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:885)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907)
        at java.lang.Thread.run(Thread.java:619)

        Number of locked synchronizers = 1
        - java.util.concurrent.locks.ReentrantLock$NonfairSync@6e537c


pool-2-thread-4

"pool-2-thread-4" Id=238 TIMED_WAITING
        at java.lang.Thread.sleep(Native Method)
        at hudson.scm.SubversionSCM.pollChanges(SubversionSCM.java:834)
        at hudson.model.AbstractProject.pollSCMChanges(AbstractProject.java:728)
        at hudson.triggers.SCMTrigger$Runner.runPolling(SCMTrigger.java:372)
        at hudson.triggers.SCMTrigger$Runner.run(SCMTrigger.java:405)
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
        at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
        at java.util.concurrent.FutureTask.run(FutureTask.java:138)
        at
java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:885)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907)
        at java.lang.Thread.run(Thread.java:619)

        Number of locked synchronizers = 2
        - java.util.concurrent.locks.ReentrantLock$NonfairSync@1b2648
        - java.util.concurrent.locks.ReentrantLock$NonfairSync@12b2c95


pool-2-thread-3

"pool-2-thread-3" Id=237 TIMED_WAITING
        at java.lang.Thread.sleep(Native Method)
        at hudson.scm.SubversionSCM.pollChanges(SubversionSCM.java:834)
        at hudson.model.AbstractProject.pollSCMChanges(AbstractProject.java:728)
        at hudson.triggers.SCMTrigger$Runner.runPolling(SCMTrigger.java:372)
        at hudson.triggers.SCMTrigger$Runner.run(SCMTrigger.java:405)
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
        at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
        at java.util.concurrent.FutureTask.run(FutureTask.java:138)
        at
java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:885)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907)
        at java.lang.Thread.run(Thread.java:619)

        Number of locked synchronizers = 2
        - java.util.concurrent.locks.ReentrantLock$NonfairSync@17bff50
        - java.util.concurrent.locks.ReentrantLock$NonfairSync@1b706fb


pool-2-thread-2

"pool-2-thread-2" Id=236 WAITING on
java.util.concurrent.locks.ReentrantLock$NonfairSync@13bb696 owned by
"pool-2-thread-10" Id=246
        at sun.misc.Unsafe.park(Native Method)
        -  waiting on java.util.concurrent.locks.ReentrantLock$NonfairSync@13bb696
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:158)
        at
java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:747)
        at
java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireInterruptibly(AbstractQueuedSynchronizer.java:803)
        at
java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireInterruptibly(AbstractQueuedSynchronizer.java:1137)
        at
java.util.concurrent.locks.ReentrantLock.lockInterruptibly(ReentrantLock.java:312)
        at hudson.triggers.SCMTrigger$Runner.run(SCMTrigger.java:397)
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
        at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
        at java.util.concurrent.FutureTask.run(FutureTask.java:138)
        at
java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:885)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907)
        at java.lang.Thread.run(Thread.java:619)

        Number of locked synchronizers = 1
        - java.util.concurrent.locks.ReentrantLock$NonfairSync@12b5b0e


pool-2-thread-1

"pool-2-thread-1" Id=235 WAITING on
java.util.concurrent.locks.ReentrantLock$NonfairSync@18b9d48 owned by
"pool-2-thread-8" Id=243
        at sun.misc.Unsafe.park(Native Method)
        -  waiting on java.util.concurrent.locks.ReentrantLock$NonfairSync@18b9d48
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:158)
        at
java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:747)
        at
java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireInterruptibly(AbstractQueuedSynchronizer.java:803)
        at
java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireInterruptibly(AbstractQueuedSynchronizer.java:1137)
        at
java.util.concurrent.locks.ReentrantLock.lockInterruptibly(ReentrantLock.java:312)
        at hudson.triggers.SCMTrigger$Runner.run(SCMTrigger.java:397)
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
        at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
        at java.util.concurrent.FutureTask.run(FutureTask.java:138)
        at
java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:885)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907)
        at java.lang.Thread.run(Thread.java:619)

        Number of locked synchronizers = 1
        - java.util.concurrent.locks.ReentrantLock$NonfairSync@167179c


RequestHandlerThread[#5]

"RequestHandlerThread[#5]" Id=233 WAITING on winstone.RequestHandlerThread@13f13e5
        at java.lang.Object.wait(Native Method)
        -  waiting on winstone.RequestHandlerThread@13f13e5
        at java.lang.Object.wait(Object.java:485)
        at winstone.RequestHandlerThread.run(RequestHandlerThread.java:216)
        at java.lang.Thread.run(Thread.java:619)


RequestHandlerThread[#0]

"RequestHandlerThread[#0]" Id=8 WAITING on winstone.RequestHandlerThread@335c8c
        at java.lang.Object.wait(Native Method)
        -  waiting on winstone.RequestHandlerThread@335c8c
        at java.lang.Object.wait(Object.java:485)
        at winstone.RequestHandlerThread.run(RequestHandlerThread.java:216)
        at java.lang.Thread.run(Thread.java:619)


RequestHandlerThread[#1]

"RequestHandlerThread[#1]" Id=9 RUNNABLE
        at sun.management.ThreadImpl.dumpThreads0(Native Method)
        at sun.management.ThreadImpl.getThreadInfo(ThreadImpl.java:359)
        at hudson.Functions.getThreadInfos(Functions.java:658)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
        at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
        at java.lang.reflect.Method.invoke(Method.java:597)
        at
org.apache.commons.jexl.util.introspection.UberspectImpl$VelMethodImpl.invoke(UberspectImpl.java:258)
        at org.apache.commons.jexl.parser.ASTMethod.execute(ASTMethod.java:104)
        at org.apache.commons.jexl.parser.ASTReference.execute(ASTReference.java:83)
        at org.apache.commons.jexl.parser.ASTReference.value(ASTReference.java:57)
        at
org.apache.commons.jexl.parser.ASTReferenceExpression.value(ASTReferenceExpression.java:51)
        at org.apache.commons.jexl.ExpressionImpl.evaluate(ExpressionImpl.java:80)
        at hudson.ExpressionFactory2$JexlExpression.evaluate(ExpressionFactory2.java:71)
        at
org.apache.commons.jelly.expression.ExpressionSupport.evaluateRecurse(ExpressionSupport.java:61)
        at
org.apache.commons.jelly.expression.ExpressionSupport.evaluateAsIterator(ExpressionSupport.java:94)
        at org.apache.commons.jelly.tags.core.ForEachTag.doTag(ForEachTag.java:89)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.tags.core.WhenTag.doTag(WhenTag.java:46)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.tags.core.ChooseTag.doTag(ChooseTag.java:38)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.tags.define.InvokeBodyTag.doTag(InvokeBodyTag.java:91)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.tags.core.IfTag.doTag(IfTag.java:42)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.tags.core.JellyTag.doTag(JellyTag.java:45)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.DynamicTag.doTag(DynamicTag.java:80)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.tags.define.InvokeBodyTag.doTag(InvokeBodyTag.java:91)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.impl.StaticTag.doTag(StaticTag.java:65)
        at org.apache.commons.jelly.impl.StaticTagScript.run(StaticTagScript.java:112)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.impl.StaticTag.doTag(StaticTag.java:65)
        at org.apache.commons.jelly.impl.StaticTagScript.run(StaticTagScript.java:112)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.impl.StaticTag.doTag(StaticTag.java:65)
        at org.apache.commons.jelly.impl.StaticTagScript.run(StaticTagScript.java:112)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.impl.StaticTag.doTag(StaticTag.java:65)
        at org.apache.commons.jelly.impl.StaticTagScript.run(StaticTagScript.java:112)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.impl.StaticTag.doTag(StaticTag.java:65)
        at org.apache.commons.jelly.impl.StaticTagScript.run(StaticTagScript.java:112)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.tags.core.JellyTag.doTag(JellyTag.java:45)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.DynamicTag.doTag(DynamicTag.java:80)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95)
        at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:186)
        at org.apache.commons.jelly.tags.core.JellyTag.doTag(JellyTag.java:45)
        at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:262)
        at
org.kohsuke.stapler.jelly.DefaultScriptInvoker.invokeScript(DefaultScriptInvoker.java:29)
        at org.kohsuke.stapler.jelly.JellyFacet$1.dispatch(JellyFacet.java:46)
        at org.kohsuke.stapler.Stapler.invoke(Stapler.java:438)
        at org.kohsuke.stapler.Stapler.invoke(Stapler.java:356)
        at org.kohsuke.stapler.Stapler.service(Stapler.java:116)
        at javax.servlet.http.HttpServlet.service(HttpServlet.java:45)
        at winstone.ServletConfiguration.execute(ServletConfiguration.java:249)
        at winstone.RequestDispatcher.forward(RequestDispatcher.java:335)
        at winstone.RequestDispatcher.doFilter(RequestDispatcher.java:378)
        at hudson.util.PluginServletFilter$1.doFilter(PluginServletFilter.java:68)
        at hudson.util.PluginServletFilter.doFilter(PluginServletFilter.java:60)
        at winstone.FilterConfiguration.execute(FilterConfiguration.java:195)
        at winstone.RequestDispatcher.doFilter(RequestDispatcher.java:368)
        at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:52)
        at
hudson.security.UnwrapSecurityExceptionFilter.doFilter(UnwrapSecurityExceptionFilter.java:28)
        at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:55)
        at
org.acegisecurity.ui.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:166)
        at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:55)
        at
org.acegisecurity.providers.anonymous.AnonymousProcessingFilter.doFilter(AnonymousProcessingFilter.java:125)
        at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:55)
        at
org.acegisecurity.ui.rememberme.RememberMeProcessingFilter.doFilter(RememberMeProcessingFilter.java:142)
        at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:55)
        at
org.acegisecurity.ui.AbstractProcessingFilter.doFilter(AbstractProcessingFilter.java:271)
        at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:55)
        at
org.acegisecurity.ui.basicauth.BasicProcessingFilter.doFilter(BasicProcessingFilter.java:173)
        at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:55)
        at
org.acegisecurity.context.HttpSessionContextIntegrationFilter.doFilter(HttpSessionContextIntegrationFilter.java:249)
        at
hudson.security.HttpSessionContextIntegrationFilter2.doFilter(HttpSessionContextIntegrationFilter2.java:42)
        at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:55)
        at hudson.security.ChainedServletFilter.doFilter(ChainedServletFilter.java:44)
        at hudson.security.HudsonFilter.doFilter(HudsonFilter.java:110)
        at winstone.FilterConfiguration.execute(FilterConfiguration.java:195)
        at winstone.RequestDispatcher.doFilter(RequestDispatcher.java:368)
        at winstone.RequestDispatcher.forward(RequestDispatcher.java:333)
        at winstone.RequestHandlerThread.processRequest(RequestHandlerThread.java:244)
        at winstone.RequestHandlerThread.run(RequestHandlerThread.java:150)
        at java.lang.Thread.run(Thread.java:619)


RequestHandlerThread[#2]

"RequestHandlerThread[#2]" Id=10 WAITING on winstone.RequestHandlerThread@11370
        at java.lang.Object.wait(Native Method)
        -  waiting on winstone.RequestHandlerThread@11370
        at java.lang.Object.wait(Object.java:485)
        at winstone.RequestHandlerThread.run(RequestHandlerThread.java:216)
        at java.lang.Thread.run(Thread.java:619)


---------------------------------------------------------------------
To unsubscribe, e-mail: [hidden email]
For additional commands, e-mail: [hidden email]

Reply | Threaded
Open this post in threaded view
|

[Issue 2516] Intermite polling hang problems

andrewgoktepe
In reply to this post by ajpurkiss
https://hudson.dev.java.net/issues/show_bug.cgi?id=2516






------- Additional comments from [hidden email] Sat Jan 24 01:31:21 +0000 2009 -------
I submitted a separate defect against svn polling in Hudson:
https://hudson.dev.java.net/issues/show_bug.cgi?id=2913

I think the root cause of my svn problems could still be this issue (2516), but
it was exacerbated in my environment by 2913.

---------------------------------------------------------------------
To unsubscribe, e-mail: [hidden email]
For additional commands, e-mail: [hidden email]

Reply | Threaded
Open this post in threaded view
|

[Issue 2516] Intermite polling hang problems

Kohsuke Kawaguchi
Administrator
In reply to this post by ajpurkiss
https://hudson.dev.java.net/issues/show_bug.cgi?id=2516



User kohsuke changed the following:

                What    |Old value                 |New value
================================================================================
                  Status|NEW                       |RESOLVED
--------------------------------------------------------------------------------
                Priority|P1                        |P3
--------------------------------------------------------------------------------
              Resolution|                          |FIXED
--------------------------------------------------------------------------------




------- Additional comments from [hidden email] Thu Jul  9 21:11:55 +0000 2009 -------
rev.15443 adds time out to Subversion, which should prevent infinite blockage.
I'm not sure exactly which release of Hudson this was integrated, but as of
1.315, I consider this bug closed.

---------------------------------------------------------------------
To unsubscribe, e-mail: [hidden email]
For additional commands, e-mail: [hidden email]