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

3 JLI tests intermittently time out

    Details

    • Type: Bug
    • Status: Resolved
    • Priority: P4
    • Resolution: Cannot Reproduce
    • Affects Version/s: 10
    • Fix Version/s: 11
    • Component/s: core-svc
    • Labels:
      None

      Description

      The following three JLI tests intermittently timed out on
      Solaris-X64 'release' bits run:

          java/lang/instrument/PremainClass/ZeroArgPremainAgentTest.java
          java/lang/instrument/PremainClass/NoPremainAgentTest.java
          java/lang/instrument/VerifyLocalVariableTableOnRetransformTest.sh


      ZeroArgPremainAgentTest.java appears to have timed out
      while running another command:

      "MainThread" #24 prio=5 os_prio=64 tid=0x0000000000c18000 nid=0x50 in Object.wait() [0xffff80ff945fd000]
         java.lang.Thread.State: WAITING (on object monitor)
              at java.lang.Object.wait(java.base@10-internal/Native Method)
              - waiting on <0x0000000400ba9b68> (a java.lang.ProcessImpl)
              at java.lang.Object.wait(java.base@10-internal/Object.java:328)
              at java.lang.ProcessImpl.waitFor(java.base@10-internal/ProcessImpl.java:494)
              - waiting to re-lock in wait() <0x0000000400ba9b68> (a java.lang.ProcessImpl)
              at jdk.testlibrary.ProcessTools.executeProcess(ProcessTools.java:381)
              at jdk.testlibrary.ProcessTools.executeProcess(ProcessTools.java:355)
              at ZeroArgPremainAgentTest.main(ZeroArgPremainAgentTest.java:51)
              at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@10-internal/Native Method)
              at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@10-internal/NativeMethodAccessorImpl.java:62)
              at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@10-internal/DelegatingMethodAccessorImpl.java:43)
              at java.lang.reflect.Method.invoke(java.base@10-internal/Method.java:564)
              at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:115)
              at java.lang.Thread.run(java.base@10-internal/Thread.java:844)

      Here's the command that was running:

      ----------System.out:(3/686)----------
      Command line: [/work/shared/bug_hunt/8167108/SMR_prototype_10/build/solaris-x86_64-normal-server-release/images/jdk/bin/java -javaagent:ZeroArgPremainAgent.jar -classpath /work/shared/bug_hunt/8167108/SMR_prototype_10/JTwork_release/test_jdk_0/classes/51/java/lang/instrument/PremainClass/ZeroArgPremainAgentTest.d DummyMain ]
      testjvm.cmd:/work/shared/bug_hunt/8167108/SMR_prototype_10/build/solaris-x86_64-normal-server-release/images/jdk/bin/java -javaagent:ZeroArgPremainAgent.jar -classpath /work/shared/bug_hunt/8167108/SMR_prototype_10/JTwork_release/test_jdk_0/classes/51/java/lang/instrument/PremainClass/ZeroArgPremainAgentTest.d DummyMain
      Timeout signalled after 360 seconds


      NoPremainAgentTest.java also appears to have timed out
      while running another command:

      "MainThread" #24 prio=5 os_prio=64 tid=0x0000000000ca0800 nid=0x50 in Object.wait() [0xffff80ff945fd000]
         java.lang.Thread.State: WAITING (on object monitor)
              at java.lang.Object.wait(java.base@10-internal/Native Method)
              - waiting on <0x0000000400baa0d0> (a java.lang.ProcessImpl)
              at java.lang.Object.wait(java.base@10-internal/Object.java:328)
              at java.lang.ProcessImpl.waitFor(java.base@10-internal/ProcessImpl.java:494)
              - waiting to re-lock in wait() <0x0000000400baa0d0> (a java.lang.ProcessImpl)
              at jdk.testlibrary.ProcessTools.executeProcess(ProcessTools.java:381)
              at jdk.testlibrary.ProcessTools.executeProcess(ProcessTools.java:355)
              at NoPremainAgentTest.main(NoPremainAgentTest.java:51)
              at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@10-internal/Native Method)
              at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@10-internal/NativeMethodAccessorImpl.java:62)
              at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@10-internal/DelegatingMethodAccessorImpl.java:43)
              at java.lang.reflect.Method.invoke(java.base@10-internal/Method.java:564)
              at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:115)
              at java.lang.Thread.run(java.base@10-internal/Thread.java:844)

      Here's the command that was running:

      ----------System.out:(3/666)----------
      Command line: [/work/shared/bug_hunt/8167108/SMR_prototype_10/build/solaris-x86_64-normal-server-release/images/jdk/bin/java -javaagent:NoPremainAgent.jar -classpath /work/shared/bug_hunt/8167108/SMR_prototype_10/JTwork_release/test_jdk_0/classes/52/java/lang/instrument/PremainClass/NoPremainAgentTest.d DummyMain ]
      testjvm.cmd:/work/shared/bug_hunt/8167108/SMR_prototype_10/build/solaris-x86_64-normal-server-release/images/jdk/bin/java -javaagent:NoPremainAgent.jar -classpath /work/shared/bug_hunt/8167108/SMR_prototype_10/JTwork_release/test_jdk_0/classes/52/java/lang/instrument/PremainClass/NoPremainAgentTest.d DummyMain
      Timeout signalled after 360 seconds


      VerifyLocalVariableTableOnRetransformTest.sh also timed out,
      but we have less information there since it is a shell test:

      #section:shell
      ----------messages:(3/179)----------
      command: shell VerifyLocalVariableTableOnRetransformTest.sh
      reason: User specified action: run shell VerifyLocalVariableTableOnRetransformTest.sh
      elapsed time (seconds): 361.325


      What caught my eye about these three failures is that they
      all failed at about the same time:

      $ ls -l JTwork_release/test_jdk_0/java/lang/instrument/PremainClass/{ZeroArgPremainAgentTest.jtr,NoPremainAgentTest.jtr} JTwork_release/test_jdk_0/java/lang/instrument/VerifyLocalVariableTableOnRetransformTest.jtr
      -rw-r--r-- 1 dcubed green 32961 Dec 15 08:33 JTwork_release/test_jdk_0/java/lang/instrument/PremainClass/NoPremainAgentTest.jtr
      -rw-r--r-- 1 dcubed green 33175 Dec 15 08:33 JTwork_release/test_jdk_0/java/lang/instrument/PremainClass/ZeroArgPremainAgentTest.jtr
      -rw-r--r-- 1 dcubed green 13314 Dec 15 08:34 JTwork_release/test_jdk_0/java/lang/instrument/VerifyLocalVariableTableOnRetransformTest.jtr

      There wasn't anything special running on my Solaris X64
      server at 0833 other than the test run. I find myself
      wondering if these three tests ran into some resource
      conflict when they ran close enough in parallel.

        Attachments

          Activity

            People

            • Assignee:
              cjplummer Chris Plummer
              Reporter:
              dcubed Daniel Daugherty
            • Votes:
              0 Vote for this issue
              Watchers:
              2 Start watching this issue

              Dates

              • Created:
                Updated:
                Resolved: