I am looking. This looks very weird and seems to be something with the test framework, but I don't know what this is yet.
Dawid On Mon, Jun 23, 2014 at 10:11 AM, Dawid Weiss <dawid.we...@cs.put.poznan.pl> wrote: > > Wait, let me see what's going on. > D. > > > On Mon, Jun 23, 2014 at 9:03 AM, Uwe Schindler <u...@thetaphi.de> wrote: > >> Same happened again: >> https://builds.apache.org/job/Lucene-Solr-Tests-trunk-Java7/4733/console >> >> >> >> Should I kill -3? >> >> >> >> ----- >> >> Uwe Schindler >> >> H.-H.-Meier-Allee 63, D-28213 Bremen >> >> http://www.thetaphi.de >> >> eMail: u...@thetaphi.de >> >> >> >> *From:* dawid.we...@gmail.com [mailto:dawid.we...@gmail.com] *On Behalf >> Of *Dawid Weiss >> *Sent:* Sunday, June 22, 2014 10:03 PM >> *To:* dev@lucene.apache.org >> *Subject:* Re: SSLMigration test hangs on FreeBSD blackhole >> >> >> >> >> >> This looks very weird because there's no actual "test" thread running. >> And the runner's thread is hung on readBytes (?)... This is very suspicious. >> >> >> >> Dawid >> >> >> >> On Sun, Jun 22, 2014 at 4:46 PM, Uwe Schindler <u...@thetaphi.de> wrote: >> >> I requested a stack dump: >> https://builds.apache.org/job/Lucene-Solr-NightlyTests-4.x/565/console >> >> [junit4] JVM J0: stdout was not empty, see: >> /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/temp/junit4-J0-20140621_125257_468.sysout >> [junit4] >>> JVM J0: stdout (verbatim) ---- >> [junit4] 2014-06-22 14:44:03 >> [junit4] Full thread dump OpenJDK 64-Bit Server VM (24.60-b09 mixed >> mode): >> [junit4] >> [junit4] "RMI TCP Accept-0" daemon prio=5 tid=0x00000008033e6800 >> nid=0x846b95c00 runnable [0x00007ffff6e70000] >> [junit4] java.lang.Thread.State: RUNNABLE >> [junit4] at java.net.PlainSocketImpl.socketAccept(Native Method) >> [junit4] at >> java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:398) >> [junit4] at java.net.ServerSocket.implAccept(ServerSocket.java:530) >> [junit4] at java.net.ServerSocket.accept(ServerSocket.java:498) >> [junit4] at >> sun.rmi.transport.tcp.TCPTransport$AcceptLoop.executeAcceptLoop(TCPTransport.java:388) >> [junit4] at >> sun.rmi.transport.tcp.TCPTransport$AcceptLoop.run(TCPTransport.java:360) >> [junit4] at java.lang.Thread.run(Thread.java:745) >> [junit4] >> [junit4] "RMI RenewClean-[127.0.0.1:40915]" daemon prio=5 >> tid=0x00000008517df000 nid=0x83c049800 in Object.wait() [0x00007ffff2426000] >> [junit4] java.lang.Thread.State: TIMED_WAITING (on object monitor) >> [junit4] at java.lang.Object.wait(Native Method) >> [junit4] at >> java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:135) >> [junit4] - locked <0x000000080de40760> (a >> java.lang.ref.ReferenceQueue$Lock) >> [junit4] at >> sun.rmi.transport.DGCClient$EndpointEntry$RenewCleanThread.run(DGCClient.java:535) >> [junit4] at java.lang.Thread.run(Thread.java:745) >> [junit4] >> [junit4] "RMI Scheduler(0)" daemon prio=5 tid=0x00000008033e2800 >> nid=0x84abf0c00 waiting on condition [0x00007fffec5c8000] >> [junit4] java.lang.Thread.State: TIMED_WAITING (parking) >> [junit4] at sun.misc.Unsafe.park(Native Method) >> [junit4] - parking to wait for <0x000000080de3e008> (a >> java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) >> [junit4] at >> java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226) >> [junit4] at >> java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2082) >> [junit4] at >> java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1090) >> [junit4] at >> java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:807) >> [junit4] at >> java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068) >> [junit4] at >> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) >> [junit4] at >> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) >> [junit4] at java.lang.Thread.run(Thread.java:745) >> [junit4] >> [junit4] "GC Daemon" daemon prio=5 tid=0x00000008033e4000 >> nid=0x837d98400 in Object.wait() [0x00007ffff090b000] >> [junit4] java.lang.Thread.State: TIMED_WAITING (on object monitor) >> [junit4] at java.lang.Object.wait(Native Method) >> [junit4] at sun.misc.GC$Daemon.run(GC.java:117) >> [junit4] - locked <0x000000080de434a8> (a sun.misc.GC$LatencyLock) >> [junit4] >> [junit4] "RMI Reaper" prio=5 tid=0x00000008033e3800 nid=0x83c050400 in >> Object.wait() [0x00007ffff3638000] >> [junit4] java.lang.Thread.State: WAITING (on object monitor) >> [junit4] at java.lang.Object.wait(Native Method) >> [junit4] at >> java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:135) >> [junit4] - locked <0x000000080de36d38> (a >> java.lang.ref.ReferenceQueue$Lock) >> [junit4] at >> java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:151) >> [junit4] at >> sun.rmi.transport.ObjectTable$Reaper.run(ObjectTable.java:351) >> [junit4] at java.lang.Thread.run(Thread.java:745) >> [junit4] >> [junit4] "RMI TCP Accept-0" daemon prio=5 tid=0x00000008033e2000 >> nid=0x850ca1800 runnable [0x00007ffff5557000] >> [junit4] java.lang.Thread.State: RUNNABLE >> [junit4] at java.net.PlainSocketImpl.socketAccept(Native Method) >> [junit4] at >> java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:398) >> [junit4] at java.net.ServerSocket.implAccept(ServerSocket.java:530) >> [junit4] at java.net.ServerSocket.accept(ServerSocket.java:498) >> [junit4] at >> sun.rmi.transport.tcp.TCPTransport$AcceptLoop.executeAcceptLoop(TCPTransport.java:388) >> [junit4] at >> sun.rmi.transport.tcp.TCPTransport$AcceptLoop.run(TCPTransport.java:360) >> [junit4] at java.lang.Thread.run(Thread.java:745) >> [junit4] >> [junit4] "RMI TCP Accept-0" daemon prio=5 tid=0x00000008033e1000 >> nid=0x8454da800 runnable [0x00007fffddde1000] >> [junit4] java.lang.Thread.State: RUNNABLE >> [junit4] at java.net.PlainSocketImpl.socketAccept(Native Method) >> [junit4] at >> java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:398) >> [junit4] at java.net.ServerSocket.implAccept(ServerSocket.java:530) >> [junit4] at java.net.ServerSocket.accept(ServerSocket.java:498) >> [junit4] at >> sun.rmi.transport.tcp.TCPTransport$AcceptLoop.executeAcceptLoop(TCPTransport.java:388) >> [junit4] at >> sun.rmi.transport.tcp.TCPTransport$AcceptLoop.run(TCPTransport.java:360) >> [junit4] at java.lang.Thread.run(Thread.java:745) >> [junit4] >> [junit4] "Service Thread" daemon prio=5 tid=0x0000000801256800 >> nid=0x801183800 runnable [0x0000000000000000] >> [junit4] java.lang.Thread.State: RUNNABLE >> [junit4] >> [junit4] "C2 CompilerThread1" daemon prio=5 tid=0x0000000801255800 >> nid=0x801182c00 waiting on condition [0x0000000000000000] >> [junit4] java.lang.Thread.State: RUNNABLE >> [junit4] >> [junit4] "C2 CompilerThread0" daemon prio=5 tid=0x0000000801255000 >> nid=0x801049c00 waiting on condition [0x0000000000000000] >> [junit4] java.lang.Thread.State: RUNNABLE >> [junit4] >> [junit4] "Signal Dispatcher" daemon prio=5 tid=0x0000000801254000 >> nid=0x801049000 waiting on condition [0x0000000000000000] >> [junit4] java.lang.Thread.State: RUNNABLE >> [junit4] >> [junit4] "Finalizer" daemon prio=5 tid=0x0000000801253800 >> nid=0x801047c00 in Object.wait() [0x00007ffffebed000] >> [junit4] java.lang.Thread.State: WAITING (on object monitor) >> [junit4] at java.lang.Object.wait(Native Method) >> [junit4] at >> java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:135) >> [junit4] - locked <0x000000080be6bee0> (a >> java.lang.ref.ReferenceQueue$Lock) >> [junit4] at >> java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:151) >> [junit4] at >> java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:209) >> [junit4] >> [junit4] "Reference Handler" daemon prio=5 tid=0x0000000801252800 >> nid=0x801047000 in Object.wait() [0x00007ffffecee000] >> [junit4] java.lang.Thread.State: WAITING (on object monitor) >> [junit4] at java.lang.Object.wait(Native Method) >> [junit4] at java.lang.Object.wait(Object.java:503) >> [junit4] at >> java.lang.ref.Reference$ReferenceHandler.run(Reference.java:133) >> [junit4] - locked <0x000000080be84ac8> (a >> java.lang.ref.Reference$Lock) >> [junit4] >> [junit4] "main" prio=5 tid=0x0000000801252000 nid=0x801007c00 runnable >> [0x00007fffffbfd000] >> [junit4] java.lang.Thread.State: RUNNABLE >> [junit4] at java.io.FileInputStream.readBytes(Native Method) >> [junit4] at java.io.FileInputStream.read(FileInputStream.java:272) >> [junit4] at >> java.io.BufferedInputStream.read1(BufferedInputStream.java:273) >> [junit4] at >> java.io.BufferedInputStream.read(BufferedInputStream.java:334) >> [junit4] - locked <0x000000080be8cd38> (a >> java.io.BufferedInputStream) >> [junit4] at >> sun.nio.cs.StreamDecoder.readBytes(StreamDecoder.java:283) >> [junit4] at >> sun.nio.cs.StreamDecoder.implRead(StreamDecoder.java:325) >> [junit4] at sun.nio.cs.StreamDecoder.read(StreamDecoder.java:177) >> [junit4] - locked <0x000000080bef6c00> (a >> java.io.InputStreamReader) >> [junit4] at >> java.io.InputStreamReader.read(InputStreamReader.java:184) >> [junit4] at java.io.BufferedReader.fill(BufferedReader.java:154) >> [junit4] at >> java.io.BufferedReader.readLine(BufferedReader.java:317) >> [junit4] - locked <0x000000080bef6c00> (a >> java.io.InputStreamReader) >> [junit4] at >> java.io.BufferedReader.readLine(BufferedReader.java:382) >> [junit4] at >> com.carrotsearch.ant.tasks.junit4.slave.StdInLineIterator.computeNext(StdInLineIterator.java:31) >> [junit4] at >> com.carrotsearch.ant.tasks.junit4.slave.StdInLineIterator.computeNext(StdInLineIterator.java:13) >> [junit4] at >> com.carrotsearch.ant.tasks.junit4.dependencies.com.google.common.collect.AbstractIterator.tryToComputeNext(AbstractIterator.java:143) >> [junit4] at >> com.carrotsearch.ant.tasks.junit4.dependencies.com.google.common.collect.AbstractIterator.hasNext(AbstractIterator.java:138) >> [junit4] at >> com.carrotsearch.ant.tasks.junit4.dependencies.com.google.common.collect.Iterators$5.hasNext(Iterators.java:542) >> [junit4] at >> com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:169) >> [junit4] at >> com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:276) >> [junit4] at >> com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:12) >> [junit4] >> [junit4] "VM Thread" prio=5 tid=0x00000008013d1800 nid=0x801046400 >> runnable >> [junit4] >> [junit4] "GC task thread#0 (ParallelGC)" prio=5 tid=0x00000008013c8800 >> nid=0x80103c000 runnable >> [junit4] >> [junit4] "GC task thread#1 (ParallelGC)" prio=5 tid=0x00000008013c9800 >> nid=0x80103cc00 runnable >> [junit4] >> [junit4] "GC task thread#2 (ParallelGC)" prio=5 tid=0x00000008013ca000 >> nid=0x80103d800 runnable >> [junit4] >> [junit4] "GC task thread#3 (ParallelGC)" prio=5 tid=0x00000008013ca800 >> nid=0x80103e400 runnable >> [junit4] >> [junit4] "GC task thread#4 (ParallelGC)" prio=5 tid=0x00000008013cb000 >> nid=0x80103f000 runnable >> [junit4] >> [junit4] "GC task thread#5 (ParallelGC)" prio=5 tid=0x00000008013cc000 >> nid=0x80103fc00 runnable >> [junit4] >> [junit4] "GC task thread#6 (ParallelGC)" prio=5 tid=0x00000008013cc800 >> nid=0x801040800 runnable >> [junit4] >> [junit4] "GC task thread#7 (ParallelGC)" prio=5 tid=0x00000008013cd000 >> nid=0x801041400 runnable >> [junit4] >> [junit4] "GC task thread#8 (ParallelGC)" prio=5 tid=0x00000008013cd800 >> nid=0x801042000 runnable >> [junit4] >> [junit4] "GC task thread#9 (ParallelGC)" prio=5 tid=0x00000008013ce800 >> nid=0x801042c00 runnable >> [junit4] >> [junit4] "GC task thread#10 (ParallelGC)" prio=5 >> tid=0x00000008013cf000 nid=0x801043800 runnable >> [junit4] >> [junit4] "GC task thread#11 (ParallelGC)" prio=5 >> tid=0x00000008013cf800 nid=0x801044400 runnable >> [junit4] >> [junit4] "GC task thread#12 (ParallelGC)" prio=5 >> tid=0x00000008013d0000 nid=0x801045000 runnable >> [junit4] >> [junit4] "VM Periodic Task Thread" prio=5 tid=0x00000008013d2000 >> nid=0x801184800 waiting on condition >> [junit4] >> [junit4] JNI global references: 367 >> [junit4] >> [junit4] Heap >> [junit4] PSYoungGen total 166400K, used 3708K >> [0x0000000820e00000, 0x000000082b300000, 0x000000082b900000) >> [junit4] eden space 163840K, 2% used >> [0x0000000820e00000,0x000000082119f1d8,0x000000082ae00000) >> [junit4] from space 2560K, 0% used >> [0x000000082b080000,0x000000082b080000,0x000000082b300000) >> [junit4] to space 2560K, 0% used >> [0x000000082ae00000,0x000000082ae00000,0x000000082b080000) >> [junit4] ParOldGen total 302592K, used 130308K >> [0x000000080b900000, 0x000000081e080000, 0x0000000820e00000) >> [junit4] object space 302592K, 43% used >> [0x000000080b900000,0x0000000813841278,0x000000081e080000) >> [junit4] PSPermGen total 55808K, used 55612K >> [0x0000000806700000, 0x0000000809d80000, 0x000000080b900000) >> [junit4] object space 55808K, 99% used >> [0x0000000806700000,0x0000000809d4f160,0x0000000809d80000) >> [junit4] <<< JVM J0: EOF ---- >> [junit4] JVM J1: 1.21 .. 6848.88 = 6847.67s >> [junit4] Execution time total: 1 day 1 hour 51 minutes 34 seconds >> >> >> ----- >> Uwe Schindler >> H.-H.-Meier-Allee 63, D-28213 Bremen >> http://www.thetaphi.de >> eMail: u...@thetaphi.de >> >> > -----Original Message----- >> > From: Uwe Schindler [mailto:u...@thetaphi.de] >> > Sent: Sunday, June 22, 2014 11:51 AM >> > To: dev@lucene.apache.org >> > Subject: SSLMigration test hangs on FreeBSD blackhole >> > >> > Hi, >> > >> > in every run the SSLMigrationTest hung on ASF Jenkins, where we have the >> > FreeBSD blackhole. It is not even cancelled by the Test Runner, it hangs >> > forever: https://builds.apache.org/job/Lucene-Solr-NightlyTests- >> > 4.x/565/console >> > We did not see this error before, because the ASF Jenkins was offline >> for >> > about a month. >> > It looks like there is a timeout missing. For those who don't know: On >> > FreeBSD the blackhole causes even for connection to localhost: if the >> port is >> > not bound it timeouts when connecting (instead of connection error). If >> no >> > timeout is set, it takes forever. >> > >> > Uwe >> > >> > ----- >> > Uwe Schindler >> > H.-H.-Meier-Allee 63, D-28213 Bremen >> > http://www.thetaphi.de >> > eMail: u...@thetaphi.de >> > >> > >> > >> > >> > --------------------------------------------------------------------- >> > To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For >> additional >> > commands, e-mail: dev-h...@lucene.apache.org >> >> >> --------------------------------------------------------------------- >> To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org >> For additional commands, e-mail: dev-h...@lucene.apache.org >> >> >> > >