java多线程应用程序：获取线程阻塞时间

Question

我在工作线程终止之前调用 threadInfo.getBlockedCount() 和 getBlockedTime() 。 我得到的阻塞计数为 1，但阻塞时间为 0。 这是否意味着线程被阻塞，但阻塞时间小于一毫秒？

如果上述情况成立，是否有其他方法可以获取线程被阻塞的准确时间？

Answer 1

但是，如果在启动线程之前调用 ThreadMXBean#setThreadContentionMonitoringEnabled(true)，则线程的阻塞时间（被阻塞）似乎只会返回非零结果。否则，它总是返回零（如果禁用争用监视，则返回 -1）。下面的代码演示了这一点：

import java.lang.management.ManagementFactory;
import java.lang.management.ThreadInfo;
import java.lang.management.ThreadMXBean;

public class BlockedTimeMain {
    public static void main(String[] _) throws InterruptedException  {
        ThreadMXBean mbean = ManagementFactory.getThreadMXBean();
        final Object lock = new Object();

        Thread t = new Thread("Foo") {
            @Override public void run() {
                // This will block forever
                synchronized(lock) {
                    // Will never get here
                    System.out.println("Got the lock from " + Thread.currentThread());
                }
            }
        };
        synchronized(lock) {
            t.start();
            mbean.setThreadContentionMonitoringEnabled(true);
            for (int i=0; i < 5; i++) {
                ThreadInfo[] tis = mbean.getThreadInfo(new long[]{t.getId()}, true, true);
                ThreadInfo ti = tis[0];

                if (ti.getThreadId() != t.getId())
                    throw new AssertionError("Unexpected " + t.getId() + " vs " + tis[0].getThreadId());

                System.out.println(t + " " + ti.getThreadState() 
                        + ": blockedTime=" + ti.getBlockedTime() + "/" + ti.getBlockedCount() 
                        + ", waitTime" + ti.getWaitedTime() + "/" + ti.getWaitedCount());
                Thread.sleep(1000);
            }
        }
        System.exit(0);
    }
}

示例输出：

Thread[Foo,5,main] BLOCKED: blockedTime=0/1, waitTime0/0
Thread[Foo,5,main] BLOCKED: blockedTime=0/1, waitTime0/0
Thread[Foo,5,main] BLOCKED: blockedTime=0/1, waitTime0/0
Thread[Foo,5,main] BLOCKED: blockedTime=0/1, waitTime0/0

Answer 2

可以测试一下，例如：

import java.lang.management.ManagementFactory;
import java.lang.management.ThreadInfo;
import java.lang.management.ThreadMXBean;

public class BlockedTimeMain {
    public static void main(String[] _) throws InterruptedException  {
        ThreadMXBean mbean = ManagementFactory.getThreadMXBean();
        mbean.setThreadContentionMonitoringEnabled(true);
        final Object lock = new Object();

        Thread t = new Thread("Foo") {
            @Override public void run() {
                // This will block forever
                synchronized(lock) {
                    // Will never get here
                    System.out.println("Got the lock from " + Thread.currentThread());
                }
            }
        };
        synchronized(lock) {
            t.start();
            for (;;) {
                ThreadInfo[] tis = mbean.getThreadInfo(new long[]{t.getId()}, true, true);
                ThreadInfo ti = tis[0];

                if (ti.getThreadId() != t.getId())
                    throw new AssertionError("Unexpected " + t.getId() + " vs " + tis[0].getThreadId());

                System.out.println(t + " " + ti.getThreadState() 
                        + ": blockedTime=" + ti.getBlockedTime() + "/" + ti.getBlockedCount() 
                        + ", waitTime" + ti.getWaitedTime() + "/" + ti.getWaitedCount());
                Thread.sleep(1000);
            }
        }
    }
}

示例输出：

Thread[Foo,5,main] BLOCKED: blockedTime=2/1, waitTime0/0
Thread[Foo,5,main] BLOCKED: blockedTime=1007/1, waitTime0/0
Thread[Foo,5,main] BLOCKED: blockedTime=2012/1, waitTime0/0
Thread[Foo,5,main] BLOCKED: blockedTime=3016/1, waitTime0/0
Thread[Foo,5,main] BLOCKED: blockedTime=4021/1, waitTime0/0
Thread[Foo,5,main] BLOCKED: blockedTime=5025/1, waitTime0/0
Thread[Foo,5,main] BLOCKED: blockedTime=6028/1, waitTime0/0
Thread[Foo,5,main] BLOCKED: blockedTime=7032/1, waitTime0/0
Thread[Foo,5,main] BLOCKED: blockedTime=8035/1, waitTime0/0

Answer 3

是的，这确实意味着它被阻止了 0 毫秒。即不涉及阻塞。线程没有等待监视器锁进入同步块/方法。

您看到这一点是因为您必须编写一个具有一两个线程的简单程序，并且没有延迟。
您将需要在线程上引入非常重的负载才能真正看到正值。

Answer 4

显然，这就是它的意思，而且显然没有办法让时间更精确。 （javadocs 说，阻塞时间可能是测量的，并且（大概）以更高的精度累积，但是 ThreadInfo API 没有公开此信息，并且似乎没有任何其他更合理的方式）

我说“显然”，因为 javadoc 实际上将时间值描述为“近似累计经过时间”。这使得这可能是一个非常粗略的近似值，可能与 System.getCurrentTimeMillis() 返回的时钟值具有相同的粒度。此外，它没有说明用高精度计时器测量的累积时间在转换为毫秒值时是否会四舍五入或截断；即零是否表示“小于 1 毫秒”或“小于 0.5 毫秒”。