You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@maven.apache.org by "Peter Firmstone (Jira)" <ji...@apache.org> on 2021/06/03 02:29:00 UTC

[jira] [Created] (SUREFIRE-1916) thread blocked freezing progress

Peter Firmstone created SUREFIRE-1916:
-----------------------------------------

             Summary: thread blocked freezing progress
                 Key: SUREFIRE-1916
                 URL: https://issues.apache.org/jira/browse/SUREFIRE-1916
             Project: Maven Surefire
          Issue Type: Bug
          Components: Maven Surefire Plugin
    Affects Versions: 2.22.2
         Environment: java -version
openjdk version "1.8.0_292"
OpenJDK Runtime Environment (Zulu 8.54.0.21-CA-win64) (build 1.8.0_292-b10)
OpenJDK 64-Bit Server VM (Zulu 8.54.0.21-CA-win64) (build 25.292-b10, mixed mode)
            Reporter: Peter Firmstone


Thread live lock during reporting.  I'll update to a later release, this is very uncommon it's never happened before, just thought I'd report it here.

 


2021-06-03 12:16:36
Full thread dump OpenJDK 64-Bit Server VM (25.292-b10 mixed mode):

"ThreadedStreamConsumer" #40 daemon prio=5 os_prio=0 tid=0x000000003cd46800 nid=0x56b8 runnable [0x000000004118e000]
 java.lang.Thread.State: RUNNABLE
 at java.io.FileOutputStream.writeBytes(Native Method)
 at java.io.FileOutputStream.write(FileOutputStream.java:326)
 at java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:82)
 at java.io.BufferedOutputStream.flush(BufferedOutputStream.java:140)
 - locked <0x00000003f2a966e0> (a java.io.BufferedOutputStream)
 at java.io.PrintStream.write(PrintStream.java:482)
 - locked <0x00000003f2a966c0> (a java.io.PrintStream)
 at sun.nio.cs.StreamEncoder.writeBytes(StreamEncoder.java:221)
 at sun.nio.cs.StreamEncoder.implFlushBuffer(StreamEncoder.java:291)
 at sun.nio.cs.StreamEncoder.flushBuffer(StreamEncoder.java:104)
 - locked <0x00000003f2a96808> (a java.io.OutputStreamWriter)
 at java.io.OutputStreamWriter.flushBuffer(OutputStreamWriter.java:185)
 at java.io.PrintStream.write(PrintStream.java:527)
 - locked <0x00000003f2a966c0> (a java.io.PrintStream)
 at java.io.PrintStream.print(PrintStream.java:583)
 at org.fusesource.jansi.FilterPrintStream.write(FilterPrintStream.java:99)
 at org.fusesource.jansi.FilterPrintStream.write(FilterPrintStream.java:107)
 at org.fusesource.jansi.FilterPrintStream.print(FilterPrintStream.java:156)
 at org.fusesource.jansi.FilterPrintStream.println(FilterPrintStream.java:231)
 - locked <0x00000003f2a70188> (a org.fusesource.jansi.WindowsAnsiPrintStream)
 at org.slf4j.impl.SimpleLogger.write(SimpleLogger.java:318)
 at org.slf4j.impl.SimpleLogger.log(SimpleLogger.java:295)
 at org.slf4j.impl.SimpleLogger.info(SimpleLogger.java:480)
 at org.apache.maven.cli.logging.Slf4jLogger.info(Slf4jLogger.java:59)
 at org.apache.maven.plugin.surefire.log.PluginConsoleLogger.info(PluginConsoleLogger.java:77)
 at org.apache.maven.plugin.surefire.report.ConsoleReporter.println(ConsoleReporter.java:96)
 at org.apache.maven.plugin.surefire.report.ConsoleReporter.testSetCompleted(ConsoleReporter.java:74)
 at org.apache.maven.plugin.surefire.report.TestSetRunListener.testSetCompleted(TestSetRunListener.java:183)
 at org.apache.maven.plugin.surefire.booterclient.output.ForkClient.processLine(ForkClient.java:227)
 at org.apache.maven.plugin.surefire.booterclient.output.ForkClient.consumeLine(ForkClient.java:177)
 at org.apache.maven.plugin.surefire.booterclient.output.ThreadedStreamConsumer$Pumper.run(ThreadedStreamConsumer.java:88)
 at java.lang.Thread.run(Thread.java:748)

Locked ownable synchronizers:
 - None

"ping-timer-10s" #39 daemon prio=5 os_prio=0 tid=0x000000003cd49800 nid=0x5c54 waiting on condition [0x0000000040e8f000]
 java.lang.Thread.State: WAITING (parking)
 at sun.misc.Unsafe.park(Native Method)
 - parking to wait for <0x000000067ff54578> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
 at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
 at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2044)
 at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1081)
 at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
 at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
 at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
 at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
 at java.lang.Thread.run(Thread.java:748)

Locked ownable synchronizers:
 - None

"timeout-check-timer" #37 daemon prio=5 os_prio=0 tid=0x000000003cd48800 nid=0x67a4 runnable [0x0000000040a6f000]
 java.lang.Thread.State: TIMED_WAITING (parking)
 at sun.misc.Unsafe.park(Native Method)
 - parking to wait for <0x000000067ff585d0> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
 at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
 at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2083)
 at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
 at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
 at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
 at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
 at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
 at java.lang.Thread.run(Thread.java:748)

Locked ownable synchronizers:
 - None

"resolver-5" #18 daemon prio=5 os_prio=0 tid=0x000000003a5f9800 nid=0x4894 waiting on condition [0x000000004024f000]
 java.lang.Thread.State: WAITING (parking)
 at sun.misc.Unsafe.park(Native Method)
 - parking to wait for <0x00000003f2d89448> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
 at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
 at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2044)
 at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
 at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
 at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
 at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
 at java.lang.Thread.run(Thread.java:748)

Locked ownable synchronizers:
 - None

"resolver-4" #17 daemon prio=5 os_prio=0 tid=0x000000003a518000 nid=0x59b0 waiting on condition [0x000000004014e000]
 java.lang.Thread.State: WAITING (parking)
 at sun.misc.Unsafe.park(Native Method)
 - parking to wait for <0x00000003f2d89448> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
 at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
 at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2044)
 at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
 at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
 at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
 at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
 at java.lang.Thread.run(Thread.java:748)

Locked ownable synchronizers:
 - None

"resolver-3" #16 daemon prio=5 os_prio=0 tid=0x0000000038426800 nid=0x2944 waiting on condition [0x0000000040d8f000]
 java.lang.Thread.State: WAITING (parking)
 at sun.misc.Unsafe.park(Native Method)
 - parking to wait for <0x00000003f2d89448> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
 at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
 at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2044)
 at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
 at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
 at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
 at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
 at java.lang.Thread.run(Thread.java:748)

Locked ownable synchronizers:
 - None

"resolver-2" #15 daemon prio=5 os_prio=0 tid=0x000000003b423000 nid=0x66b4 waiting on condition [0x0000000040c8e000]
 java.lang.Thread.State: WAITING (parking)
 at sun.misc.Unsafe.park(Native Method)
 - parking to wait for <0x00000003f2d89448> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
 at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
 at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2044)
 at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
 at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
 at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
 at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
 at java.lang.Thread.run(Thread.java:748)

Locked ownable synchronizers:
 - None

"resolver-1" #14 daemon prio=5 os_prio=0 tid=0x000000003ce4d800 nid=0x2c08 waiting on condition [0x0000000040b8f000]
 java.lang.Thread.State: WAITING (parking)
 at sun.misc.Unsafe.park(Native Method)
 - parking to wait for <0x00000003f2d89448> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
 at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
 at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2044)
 at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
 at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
 at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
 at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
 at java.lang.Thread.run(Thread.java:748)

Locked ownable synchronizers:
 - None

"Service Thread" #10 daemon prio=9 os_prio=0 tid=0x000000003838a000 nid=0x5ef8 runnable [0x0000000000000000]
 java.lang.Thread.State: RUNNABLE

Locked ownable synchronizers:
 - None

"C1 CompilerThread3" #9 daemon prio=9 os_prio=2 tid=0x0000000038304000 nid=0x1484 waiting on condition [0x0000000000000000]
 java.lang.Thread.State: RUNNABLE

Locked ownable synchronizers:
 - None

"C2 CompilerThread2" #8 daemon prio=9 os_prio=2 tid=0x00000000382fd000 nid=0x43b8 waiting on condition [0x0000000000000000]
 java.lang.Thread.State: RUNNABLE

Locked ownable synchronizers:
 - None

"C2 CompilerThread1" #7 daemon prio=9 os_prio=2 tid=0x00000000382f8800 nid=0x5030 waiting on condition [0x0000000000000000]
 java.lang.Thread.State: RUNNABLE

Locked ownable synchronizers:
 - None

"C2 CompilerThread0" #6 daemon prio=9 os_prio=2 tid=0x00000000382f5000 nid=0x5c74 waiting on condition [0x0000000000000000]
 java.lang.Thread.State: RUNNABLE

Locked ownable synchronizers:
 - None

"Attach Listener" #5 daemon prio=5 os_prio=2 tid=0x00000000382ef000 nid=0x424c waiting on condition [0x0000000000000000]
 java.lang.Thread.State: RUNNABLE

Locked ownable synchronizers:
 - None

"Signal Dispatcher" #4 daemon prio=9 os_prio=2 tid=0x00000000364ee800 nid=0x46bc runnable [0x0000000000000000]
 java.lang.Thread.State: RUNNABLE

Locked ownable synchronizers:
 - None

"Finalizer" #3 daemon prio=8 os_prio=1 tid=0x00000000382e0800 nid=0x22ec in Object.wait() [0x00000000388bf000]
 java.lang.Thread.State: WAITING (on object monitor)
 at java.lang.Object.wait(Native Method)
 - waiting on <0x00000003f2a13aa0> (a java.lang.ref.ReferenceQueue$Lock)
 at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:144)
 - locked <0x00000003f2a13aa0> (a java.lang.ref.ReferenceQueue$Lock)
 at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:165)
 at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:216)

Locked ownable synchronizers:
 - None

"Reference Handler" #2 daemon prio=10 os_prio=2 tid=0x00000000364db800 nid=0x55ec in Object.wait() [0x00000000387bf000]
 java.lang.Thread.State: WAITING (on object monitor)
 at java.lang.Object.wait(Native Method)
 - waiting on <0x00000003f2a22ec0> (a java.lang.ref.Reference$Lock)
 at java.lang.Object.wait(Object.java:502)
 at java.lang.ref.Reference.tryHandlePending(Reference.java:191)
 - locked <0x00000003f2a22ec0> (a java.lang.ref.Reference$Lock)
 at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:153)

Locked ownable synchronizers:
 - None

"main" #1 prio=5 os_prio=0 tid=0x0000000002432800 nid=0x6484 waiting for monitor entry [0x00000000023bd000]
 java.lang.Thread.State: BLOCKED (on object monitor)
 at org.fusesource.jansi.FilterPrintStream.println(FilterPrintStream.java:231)
 - waiting to lock <0x00000003f2a70188> (a org.fusesource.jansi.WindowsAnsiPrintStream)
 at org.slf4j.impl.SimpleLogger.write(SimpleLogger.java:318)
 at org.slf4j.impl.SimpleLogger.log(SimpleLogger.java:295)
 at org.slf4j.impl.SimpleLogger.info(SimpleLogger.java:480)
 at org.apache.maven.cli.logging.Slf4jLogger.info(Slf4jLogger.java:59)
 at org.apache.maven.plugin.surefire.log.PluginConsoleLogger.info(PluginConsoleLogger.java:77)
 at org.apache.maven.plugin.surefire.report.DefaultReporterFactory.log(DefaultReporterFactory.java:464)
 at org.apache.maven.plugin.surefire.report.DefaultReporterFactory.runCompleted(DefaultReporterFactory.java:188)
 at org.apache.maven.plugin.surefire.report.DefaultReporterFactory.close(DefaultReporterFactory.java:168)
 at org.apache.maven.plugin.surefire.booterclient.ForkStarter.run(ForkStarter.java:251)
 at org.apache.maven.plugin.surefire.AbstractSurefireMojo.executeProvider(AbstractSurefireMojo.java:1183)
 at org.apache.maven.plugin.surefire.AbstractSurefireMojo.executeAfterPreconditionsChecked(AbstractSurefireMojo.java:1011)
 at org.apache.maven.plugin.surefire.AbstractSurefireMojo.execute(AbstractSurefireMojo.java:857)
 at org.apache.maven.plugin.DefaultBuildPluginManager.executeMojo(DefaultBuildPluginManager.java:137)
 at org.apache.maven.lifecycle.internal.MojoExecutor.execute(MojoExecutor.java:210)
 at org.apache.maven.lifecycle.internal.MojoExecutor.execute(MojoExecutor.java:156)
 at org.apache.maven.lifecycle.internal.MojoExecutor.execute(MojoExecutor.java:148)
 at org.apache.maven.lifecycle.internal.LifecycleModuleBuilder.buildProject(LifecycleModuleBuilder.java:117)
 at org.apache.maven.lifecycle.internal.LifecycleModuleBuilder.buildProject(LifecycleModuleBuilder.java:81)
 at org.apache.maven.lifecycle.internal.builder.singlethreaded.SingleThreadedBuilder.build(SingleThreadedBuilder.java:56)
 at org.apache.maven.lifecycle.internal.LifecycleStarter.execute(LifecycleStarter.java:128)
 at org.apache.maven.DefaultMaven.doExecute(DefaultMaven.java:305)
 at org.apache.maven.DefaultMaven.doExecute(DefaultMaven.java:192)
 at org.apache.maven.DefaultMaven.execute(DefaultMaven.java:105)
 at org.apache.maven.cli.MavenCli.execute(MavenCli.java:957)
 at org.apache.maven.cli.MavenCli.doMain(MavenCli.java:289)
 at org.apache.maven.cli.MavenCli.main(MavenCli.java:193)
 at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
 at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
 at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
 at java.lang.reflect.Method.invoke(Method.java:498)
 at org.codehaus.plexus.classworlds.launcher.Launcher.launchEnhanced(Launcher.java:282)
 at org.codehaus.plexus.classworlds.launcher.Launcher.launch(Launcher.java:225)
 at org.codehaus.plexus.classworlds.launcher.Launcher.mainWithExitCode(Launcher.java:406)
 at org.codehaus.plexus.classworlds.launcher.Launcher.main(Launcher.java:347)

Locked ownable synchronizers:
 - None

"VM Thread" os_prio=2 tid=0x00000000364d8800 nid=0x1460 runnable

"ParGC Thread#0" os_prio=0 tid=0x0000000002448000 nid=0x2294 runnable

"ParGC Thread#1" os_prio=0 tid=0x0000000002449800 nid=0x4c24 runnable

"ParGC Thread#2" os_prio=0 tid=0x000000000244b000 nid=0x441c runnable

"ParGC Thread#3" os_prio=0 tid=0x000000000244c800 nid=0x22b4 runnable

"ParGC Thread#4" os_prio=0 tid=0x0000000002450000 nid=0x65c0 runnable

"ParGC Thread#5" os_prio=0 tid=0x0000000002451000 nid=0x5de4 runnable

"ParGC Thread#6" os_prio=0 tid=0x0000000002454800 nid=0x4ccc runnable

"ParGC Thread#7" os_prio=0 tid=0x0000000002455800 nid=0x32f4 runnable

"VM Periodic Task Thread" os_prio=2 tid=0x000000003838c800 nid=0x44dc waiting on condition

JNI global references: 505

 



--
This message was sent by Atlassian Jira
(v8.3.4#803005)