【问题标题】:Java blocking issue: Why would JVM block threads in many different classes/methods?Java 阻塞问题:为什么 JVM 会阻塞许多不同类/方法中的线程?
【发布时间】:2010-10-25 15:52:05
【问题描述】:

更新:这看起来像是内存问题。一个 3.8 Gb 的 Hprof 文件表明发生这种“阻塞”时 JVM 正在转储其堆。我们的运营团队看到该站点没有响应,进行了堆栈跟踪,然后关闭了该实例。我相信他们在堆转储完成之前关闭了该站点。日志中没有错误/异常/问题证据 - 可能是因为 JVM 在生成错误消息之前就被杀死了。

原始问题 我们最近遇到了一个应用程序出现的情况——对最终用户来说——挂起。我们在应用程序重新启动之前获得了堆栈跟踪,我发现了一些令人惊讶的结果:在 527 个线程中,463 个线程状态为 BLOCKED。

过去 过去阻塞的线程通常有这个问题: 1)一些明显的瓶颈:例如一些数据库记录锁或文件系统锁问题导致其他线程等待。 2) 所有被阻塞的线程都会阻塞在同一个类/方法上(例如 jdbc 或文件系统类)

异常数据 在这种情况下,除了应用程序类(包括 jdbc 和 lucene 调用)之外,我看到各种类/方法被阻止,包括 jvm 内部类、jboss 类、log4j 等

问题 什么会导致 JVM 阻塞 log4j.Hierarchy.getLogger、java.lang.reflect.Constructor.newInstance?显然某些资源“稀缺”,但哪种资源?

谢谢

堆栈跟踪摘录

http-0.0.0.0-80-417" daemon prio=6 tid=0x000000000f6f1800 nid=0x1a00 waiting for monitor entry [0x000000002dd5d000]
   java.lang.Thread.State: BLOCKED (on object monitor)
                at sun.reflect.GeneratedConstructorAccessor68.newInstance(Unknown Source)
                at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:27)
                at java.lang.reflect.Constructor.newInstance(Constructor.java:513)
                at java.lang.Class.newInstance0(Class.java:355)
                at java.lang.Class.newInstance(Class.java:308)
                at org.jboss.ejb.Container.createBeanClassInstance(Container.java:630)

http-0.0.0.0-80-451" daemon prio=6 tid=0x000000000f184800 nid=0x14d4 waiting for monitor entry [0x000000003843d000]
   java.lang.Thread.State: BLOCKED (on object monitor)
                at java.lang.Class.getDeclaredMethods0(Native Method)
                at java.lang.Class.privateGetDeclaredMethods(Class.java:2427)
                at java.lang.Class.getMethod0(Class.java:2670)

"http-0.0.0.0-80-449" daemon prio=6 tid=0x000000000f17d000 nid=0x2240 waiting for monitor entry [0x000000002fa5f000]
   java.lang.Thread.State: BLOCKED (on object monitor)
                at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.register(Http11Protocol.java:638)
                - waiting to lock <0x00000007067515e8> (a org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler)
                at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.createProcessor(Http11Protocol.java:630)


"http-0.0.0.0-80-439" daemon prio=6 tid=0x000000000f701800 nid=0x1ed8 waiting for monitor entry [0x000000002f35b000]
   java.lang.Thread.State: BLOCKED (on object monitor)
                at org.apache.log4j.Hierarchy.getLogger(Hierarchy.java:261)
                at org.apache.log4j.Hierarchy.getLogger(Hierarchy.java:242)
                at org.apache.log4j.LogManager.getLogger(LogManager.java:198)

【问题讨论】:

  • GC 日志看起来如何?

标签: java garbage-collection locking blocking concurrent-programming


【解决方案1】:

这些大致按照我尝试它们的顺序列出,具体取决于收集的证据:

  • 您是否查看过GC 行为?你有记忆压力吗?这可能会导致newInstance() 和上面的其他一些被阻止。使用-XX:+PrintGCDetails -XX:+PrintGCTimeStamps -verbose:gc 运行您的虚拟机并记录输出。您是否在故障/锁定时间附近看到过多的 GC 时间?
    • 条件是否可重复?如果是这样,请尝试在 JVM (-Xmx) 中使用不同的堆大小,并查看行为是否发生重大变化。如果是这样,请查找内存泄漏或为您的应用正确调整堆大小。
    • 如果前一个很难,并且您没有得到OutOfMemoryError,您可以调整 GC 可调参数...参见JDK6.0 XX optionsJDK6.0 GC Tuning Whitepaper。具体看-XX:+UseGCOverheadLimit-XX:+GCTimeLimit 以及相关选项。 (注意这些没有很好的记录,但可能有用...)
  • 可能存在僵局?只有堆栈跟踪摘录,无法在这里确定。在线程被阻塞的监视器状态中查找周期(与它们持有的状态相比)。我相信jconsole可以为你做到这一点......(yep, under the threads tab, "detect deadlocks"
  • 尝试执行多个重复的堆栈跟踪,并查看哪些内容发生了变化,哪些内容保持不变...
  • 进行取证... 对于每个显示“BLOCKED”的堆栈条目,查找特定的代码行并确定那里是否有监视器。如果有一个实际的监视器采集,应该很容易识别限制资源。但是,如果没有透明可用的监视器,您的某些线程可能会显示为阻塞,这将更加棘手......

【讨论】:

  • 看起来我们有一个 OutOfMemoryException 并且 jvm 已经开始转储它的内存(即 HeapDumpOnOutOfMemoryError),但是这些操作在 jvm 完成之前就杀死了它。日志没有异常或 OutOfMemory 错误....
  • @user331465:是的,好吧,在 OOM 条件实际触发 OOM 错误之前可能需要一些时间。在 UseGCOverheadLimit、GCTimeLimit、GCHeapFreeLimit 上查看 JVM 的 XX 选项。可能这是您的问题的一部分——分配内存的线程被阻塞不是因为锁本身,而是因为它们正在等待分配内存。
  • @user331465:建议您修改您的问题以包含有关 GC/内存问题的信息,因为它主要关注问题。
  • 多少GC时间过长?在我的应用程序中,jstat 将 FGCT 和 CGT 显示为 ~90000。是 90 秒吗?
猜你喜欢
  • 2021-10-19
  • 1970-01-01
  • 2012-06-13
  • 1970-01-01
  • 1970-01-01
  • 2021-08-29
  • 2022-01-17
  • 1970-01-01
相关资源
最近更新 更多