Uploaded image for project: 'JDK'
  1. JDK
  2. JDK-8130653

sun/tools/jmap/BasicJMapTest.java timed out intermittently

XMLWordPrintable

    • Icon: Bug Bug
    • Resolution: Duplicate
    • Icon: P5 P5
    • 9
    • 9
    • core-svc
    • b75
    • sparc
    • solaris

        This issue was reported and resolved in JDK-8081292 by increasing timeout. But it happens again on Solaris sparc 11.


        See the test output:
        command: main BasicJMapTest
        reason: User specified action: run main/timeout=240 BasicJMapTest
        Timeout signalled after 960 seconds
        Timeout information:
        Running jstack on process 9608
        2015-07-06 11:11:55
        Full thread dump Java HotSpot(TM) 64-Bit Server VM (1.9.0-ea-langtools-nightly-h2957-20150705-b72 mixed mode):

        "Attach Listener" #147 daemon prio=9 os_prio=64 tid=0x0000000100f23000 nid=0x9c waiting on condition [0x0000000000000000]
           java.lang.Thread.State: RUNNABLE

        "SameVMThread" #144 prio=5 os_prio=64 tid=0x0000000101164000 nid=0x99 runnable [0xffffffff601fd000]
           java.lang.Thread.State: RUNNABLE
        at java.io.RandomAccessFile.read0(Native Method)
        at java.io.RandomAccessFile.read(RandomAccessFile.java:348)
        at java.io.RandomAccessFile.readInt(RandomAccessFile.java:809)
        at jdk.test.lib.hprof.parser.FileReadBuffer.getInt(FileReadBuffer.java:77)
        - locked <0x00000007a1600210> (a jdk.test.lib.hprof.parser.FileReadBuffer)
        at jdk.test.lib.hprof.model.JavaObject.readValue(JavaObject.java:227)
        at jdk.test.lib.hprof.model.JavaLazyReadObject.getValue(JavaLazyReadObject.java:72)
        at jdk.test.lib.hprof.model.JavaObject.getFields(JavaObject.java:117)
        at jdk.test.lib.hprof.model.JavaObject.visitReferencedObjects(JavaObject.java:142)
        at jdk.test.lib.hprof.model.Snapshot.calculateReferencesToObjects(Snapshot.java:325)
        at jdk.test.lib.hprof.model.Snapshot.resolve(Snapshot.java:293)
        at jdk.test.lib.hprof.HprofParser.parse(HprofParser.java:87)
        at jdk.test.lib.hprof.HprofParser.parse(HprofParser.java:54)
        at BasicJMapTest.verifyDumpFile(BasicJMapTest.java:98)
        at BasicJMapTest.dump(BasicJMapTest.java:91)
        at BasicJMapTest.testDumpLive(BasicJMapTest.java:75)
        at BasicJMapTest.main(BasicJMapTest.java:57)
        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:502)
        at com.sun.javatest.regtest.agent.MainActionHelper$SameVMRunnable.run(MainActionHelper.java:218)
        at java.lang.Thread.run(Thread.java:745)

        "RMI Scheduler(0)" #42 daemon prio=5 os_prio=64 tid=0x0000000100b63800 nid=0x33 waiting on condition [0xffffffff60ffe000]
           java.lang.Thread.State: WAITING (parking)
        at sun.misc.Unsafe.park(Native Method)
        - parking to wait for <0x00000007a01a7e38> (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:2039)
        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:1067)
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
        at java.lang.Thread.run(Thread.java:745)

        "pool-1-thread-1" #10 daemon prio=5 os_prio=64 tid=0x0000000100580000 nid=0x14 waiting on condition [0xffffffff61afe000]
           java.lang.Thread.State: TIMED_WAITING (parking)
        at sun.misc.Unsafe.park(Native Method)
        - parking to wait for <0x00000007a00faf90> (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:2078)
        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:1067)
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
        at java.lang.Thread.run(Thread.java:745)

        "Service Thread" #9 daemon prio=9 os_prio=64 tid=0x00000001003a6800 nid=0x12 runnable [0x0000000000000000]
           java.lang.Thread.State: RUNNABLE

        "Sweeper thread" #8 daemon prio=9 os_prio=64 tid=0x0000000100346800 nid=0x11 runnable [0x0000000000000000]
           java.lang.Thread.State: RUNNABLE

        "C1 CompilerThread1" #7 daemon prio=9 os_prio=64 tid=0x0000000100344800 nid=0x10 waiting on condition [0x0000000000000000]
           java.lang.Thread.State: RUNNABLE

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

        "Signal Dispatcher" #5 daemon prio=9 os_prio=64 tid=0x000000010033e800 nid=0xe runnable [0x0000000000000000]
           java.lang.Thread.State: RUNNABLE

        "Surrogate Locker Thread (Concurrent GC)" #4 daemon prio=9 os_prio=64 tid=0x000000010033d800 nid=0xd waiting on condition [0x0000000000000000]
           java.lang.Thread.State: RUNNABLE

        "Finalizer" #3 daemon prio=8 os_prio=64 tid=0x000000010030e800 nid=0xc in Object.wait() [0xffffffff648fe000]
           java.lang.Thread.State: WAITING (on object monitor)
        at java.lang.Object.wait(Native Method)
        - waiting on <0x00000007a00fbae8> (a java.lang.ref.ReferenceQueue$Lock)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:143)
        - locked <0x00000007a00fbae8> (a java.lang.ref.ReferenceQueue$Lock)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:164)
        at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:213)

        "Reference Handler" #2 daemon prio=10 os_prio=64 tid=0x0000000100304800 nid=0xb in Object.wait() [0xffffffff77eff000]
           java.lang.Thread.State: WAITING (on object monitor)
        at java.lang.Object.wait(Native Method)
        - waiting on <0x00000007a00fbca0> (a java.lang.ref.Reference$Lock)
        at java.lang.Object.wait(Object.java:508)
        at java.lang.ref.Reference.tryHandlePending(Reference.java:192)
        - locked <0x00000007a00fbca0> (a java.lang.ref.Reference$Lock)
        at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:154)

        "main" #1 prio=5 os_prio=64 tid=0x0000000100112000 nid=0x2 in Object.wait() [0xffffffff7d3fe000]
           java.lang.Thread.State: WAITING (on object monitor)
        at java.lang.Object.wait(Native Method)
        - waiting on <0x00000007a12b22b8> (a java.lang.Thread)
        at java.lang.Thread.join(Thread.java:1249)
        - locked <0x00000007a12b22b8> (a java.lang.Thread)
        at java.lang.Thread.join(Thread.java:1323)
        at com.sun.javatest.regtest.agent.MainActionHelper.runClass(MainActionHelper.java:127)
        at com.sun.javatest.regtest.agent.AgentServer.doMain(AgentServer.java:230)
        at com.sun.javatest.regtest.agent.AgentServer.run(AgentServer.java:180)
        at com.sun.javatest.regtest.agent.AgentServer.main(AgentServer.java:57)

        "VM Thread" os_prio=64 tid=0x00000001002f2800 nid=0xa runnable

        "GC Thread#0" os_prio=64 tid=0x000000010018c800 nid=0x3 runnable

        "GC Thread#1" os_prio=64 tid=0x0000000100181800 nid=0x4 runnable

        "G1 Main Marker" os_prio=64 tid=0x0000000100168000 nid=0x8 runnable

        "G1 Marker#0" os_prio=64 tid=0x0000000100169000 nid=0x9 runnable

        "G1 Refine#0" os_prio=64 tid=0x0000000100177800 nid=0x7 runnable

        "G1 Refine#1" os_prio=64 tid=0x0000000100176000 nid=0x6 runnable

        "G1 Refine#2" os_prio=64 tid=0x0000000100183800 nid=0x5 runnable

        "VM Periodic Task Thread" os_prio=64 tid=0x00000001003a8800 nid=0x13 waiting on condition

        JNI global references: 360

        --- Timeout information end.
        elapsed time (seconds): 962.538

              Unassigned Unassigned
              xiaofeya Xiaofeng Yang
              Votes:
              0 Vote for this issue
              Watchers:
              8 Start watching this issue

                Created:
                Updated:
                Resolved: