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

compiler/compilercontrol/jcmd/AddExcludeTest.java failed with compilable: true, but should: false on required level: 1: expected true to equal false

    XMLWordPrintable

Details

    • aarch64
    • os_x

    Description

      The following test failed in the JDK23 CI:

      compiler/compilercontrol/jcmd/AddExcludeTest.java

      Here's a snippet from the log file:

      #section:driver
      ----------messages:(11/451)----------
      command: driver compiler.compilercontrol.jcmd.AddExcludeTest
      reason: User specified action: run driver compiler.compilercontrol.jcmd.AddExcludeTest
      started: Thu Jan 11 15:23:05 GMT 2024
      Mode: agentvm
      Agent id: 9
      Additional exports to unnamed modules from @modules: java.base/jdk.internal.misc
      Timeout signalled after 480 seconds
      Timeout information:
      --- Timeout information end.
      finished: Thu Jan 11 15:35:19 GMT 2024
      elapsed time (seconds): 733.442
      ----------configuration:(17/2569)----------

      <snip>

      ----------System.out:(22/5369)----------
      For random generator using seed: -1844730141841391074
      To re-run test with same seed value please add "-Djdk.test.lib.random.seed=-1844730141841391074" to command line.
      (CompileCommand EXCLUDE Type: JCMD Compiler: null MethodDescriptor: *Klass*.*hod* IsValid: true JCMDType: ADD)
      Command line: [/System/Volumes/Data/mesos/work_dir/jib-master/install/jdk-23+5-303/macosx-aarch64-debug.jdk/jdk-23/fastdebug/bin/java -cp /System/Volumes/Data/mesos/work_dir/slaves/73e57426-9086-438c-bf1c-51bfaf1790ad-S14746/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/833044d7-ebb8-4bc3-b988-c29c2c6b2c84/runs/233fff7f-35dd-44ab-aff8-d11855797123/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_not_fast_compiler/classes/2/compiler/compilercontrol/jcmd/AddExcludeTest.d:/System/Volumes/Data/mesos/work_dir/jib-master/install/jdk-23+5-303/src.full/open/test/hotspot/jtreg/compiler/compilercontrol/jcmd:/System/Volumes/Data/mesos/work_dir/slaves/73e57426-9086-438c-bf1c-51bfaf1790ad-S14746/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/833044d7-ebb8-4bc3-b988-c29c2c6b2c84/runs/233fff7f-35dd-44ab-aff8-d11855797123/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_not_fast_compiler/classes/2/test/lib:/System/Volumes/Data/mesos/work_dir/slaves/73e57426-9086-438c-bf1c-51bfaf1790ad-S14746/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/833044d7-ebb8-4bc3-b988-c29c2c6b2c84/runs/233fff7f-35dd-44ab-aff8-d11855797123/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_not_fast_compiler/classes/2:/System/Volumes/Data/mesos/work_dir/jib-master/install/jtreg/7.3.1/1/bundles/jtreg-7.3.1+1.zip/jtreg/lib/jtreg.jar:/System/Volumes/Data/mesos/work_dir/jib-master/install/jtreg/7.3.1/1/bundles/jtreg-7.3.1+1.zip/jtreg/lib/junit-platform-console-standalone-1.9.2.jar:/System/Volumes/Data/mesos/work_dir/jib-master/install/jtreg/7.3.1/1/bundles/jtreg-7.3.1+1.zip/jtreg/lib/testng-7.3.0.jar:/System/Volumes/Data/mesos/work_dir/jib-master/install/jtreg/7.3.1/1/bundles/jtreg-7.3.1+1.zip/jtreg/lib/jcommander-1.82.jar:/System/Volumes/Data/mesos/work_dir/jib-master/install/jtreg/7.3.1/1/bundles/jtreg-7.3.1+1.zip/jtreg/lib/guice-5.1.0.jar -XX:MaxRAMPercentage=6.25 -Dtest.boot.jdk=/System/Volumes/Data/mesos/work_dir/jib-master/install/jdk/21/35/bundles/macos-aarch64/jdk-21_macos-aarch64_bin.tar.gz/jdk-21.jdk/Contents/Home -Djava.io.tmpdir=/System/Volumes/Data/mesos/work_dir/slaves/73e57426-9086-438c-bf1c-51bfaf1790ad-S14746/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/833044d7-ebb8-4bc3-b988-c29c2c6b2c84/runs/233fff7f-35dd-44ab-aff8-d11855797123/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_not_fast_compiler/tmp -ea -esa -XX:CompileThreshold=100 -XX:+UnlockExperimentalVMOptions -server -XX:+TieredCompilation -Dtest.boot.jdk=/System/Volumes/Data/mesos/work_dir/jib-master/install/jdk/21/35/bundles/macos-aarch64/jdk-21_macos-aarch64_bin.tar.gz/jdk-21.jdk/Contents/Home -Djava.io.tmpdir=/System/Volumes/Data/mesos/work_dir/slaves/73e57426-9086-438c-bf1c-51bfaf1790ad-S14746/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/833044d7-ebb8-4bc3-b988-c29c2c6b2c84/runs/233fff7f-35dd-44ab-aff8-d11855797123/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_not_fast_compiler/tmp -Djava.library.path=/System/Volumes/Data/mesos/work_dir/jib-master/install/jdk-23+5-303/macosx-aarch64-debug.test/hotspot/jtreg/native --patch-module=java.base=/System/Volumes/Data/mesos/work_dir/slaves/73e57426-9086-438c-bf1c-51bfaf1790ad-S14746/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/833044d7-ebb8-4bc3-b988-c29c2c6b2c84/runs/233fff7f-35dd-44ab-aff8-d11855797123/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_not_fast_compiler/patches/java.base -Djava.security.policy=file:/System/Volumes/Data/mesos/work_dir/slaves/73e57426-9086-438c-bf1c-51bfaf1790ad-S14746/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/833044d7-ebb8-4bc3-b988-c29c2c6b2c84/runs/233fff7f-35dd-44ab-aff8-d11855797123/./testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_not_fast_compiler/jtreg.policy -Xmixed -Xbootclasspath/a:. -XX:+UnlockDiagnosticVMOptions -XX:+WhiteBoxAPI -Xbatch -XX:CompileCommandFile=command_file compiler.compilercontrol.share.actions.BaseAction 62465 states ]
      [2024-01-11T15:23:06.066834Z] Gathering output for process 63859
      [2024-01-11T15:23:06.069196Z] Waiting for completion for process 63859
      Running DCMD 'Compiler.directives_add jcmd_directives.json' through 'PidJcmdExecutor'
      Executing command '[/System/Volumes/Data/mesos/work_dir/jib-master/install/jdk-23+5-303/macosx-aarch64-debug.jdk/jdk-23/fastdebug/bin/jcmd, 63859, Compiler.directives_add jcmd_directives.json]'
      [2024-01-11T15:23:06.748861Z] Gathering output for process 63863
      [2024-01-11T15:23:06.749160Z] Waiting for completion for process 63863
      [2024-01-11T15:32:10.491341Z] Waiting for completion finished for process 63863
      Output and diagnostic info for process 63863 was saved into 'pid-63863-output.log'
      Command returned with exit code 134
      ---------------- stdout ----------------
      63859:

      ---------------- stderr ----------------

      ----------------------------------------

      [2024-01-11T15:32:10.854504Z] Waiting for completion finished for process 63859
      Output and diagnostic info for process 63859 was saved into 'pid-63859-output.log'
      ----------System.err:(38/2337)----------
       stdout: [INFO: Client connection port = 62465
      Checking expected compilation state: {
        method: public void compiler.compilercontrol.share.pool.sub.Klass.method(int,java.lang.String[],java.lang.Integer,byte[],double[][])
        compile [Optional[false], Optional[false]]
        force_inline [Optional[false], Optional[false]]
        dont_inline [Optional[true], Optional[true]]
        log Optional.empty
        print_assembly Optional.empty
        print_inline Optional.empty
      }
      ];
       stderr: [Exception in thread "main" java.lang.RuntimeException: FAILED: method public void compiler.compilercontrol.share.pool.sub.Klass.method(int,java.lang.String[],java.lang.Integer,byte[],double[][]) compilable: true, but should: false on required level: 1: expected true to equal false
      at jdk.test.lib.Asserts.fail(Asserts.java:634)
      at jdk.test.lib.Asserts.assertEquals(Asserts.java:205)
      at jdk.test.lib.Asserts.assertEQ(Asserts.java:178)
      at compiler.compilercontrol.share.actions.CompileAction.checkCompilation(CompileAction.java:90)
      at compiler.compilercontrol.share.actions.CompileAction.checkCompiled(CompileAction.java:70)
      at compiler.compilercontrol.share.actions.BaseAction.lambda$check$2(BaseAction.java:141)
      at java.base/java.util.ArrayList.forEach(ArrayList.java:1597)
      at compiler.compilercontrol.share.actions.BaseAction.check(BaseAction.java:139)
      at compiler.compilercontrol.share.actions.BaseAction.communicate(BaseAction.java:100)
      at compiler.compilercontrol.share.actions.BaseAction.main(BaseAction.java:59)
      ]
       exitValue = 1

      java.lang.RuntimeException: Expected to get exit value of [0], exit value is: [1]
      at jdk.test.lib.process.OutputAnalyzer.shouldHaveExitValue(OutputAnalyzer.java:521)
      at compiler.compilercontrol.share.scenario.Scenario.execute(Scenario.java:118)
      at compiler.compilercontrol.share.SingleCommand.test(SingleCommand.java:54)
      at compiler.compilercontrol.jcmd.AddExcludeTest.main(AddExcludeTest.java:46)
      at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103)
      at java.base/java.lang.reflect.Method.invoke(Method.java:580)
      at com.sun.javatest.regtest.agent.MainActionHelper$AgentVMRunnable.run(MainActionHelper.java:333)
      at java.base/java.lang.Thread.run(Thread.java:1575)

      JavaTest Message: Test threw exception: java.lang.RuntimeException
      JavaTest Message: shutting down test

      result: Error. Agent error: java.lang.Exception: Agent 9 timed out with a timeout of 480 seconds; check console log for any additional details

      Here's the first failure that caught my eye:

      ----------System.err:(38/2337)----------
       stdout: [INFO: Client connection port = 62465
      Checking expected compilation state: {
        method: public void compiler.compilercontrol.share.pool.sub.Klass.method(int,java.lang.String[],java.lang.Integer,byte[],double[][])
        compile [Optional[false], Optional[false]]
        force_inline [Optional[false], Optional[false]]
        dont_inline [Optional[true], Optional[true]]
        log Optional.empty
        print_assembly Optional.empty
        print_inline Optional.empty
      }
      ];
       stderr: [Exception in thread "main" java.lang.RuntimeException: FAILED: method public void compiler.compilercontrol.share.pool.sub.Klass.method(int,java.lang.String[],java.lang.Integer,byte[],double[][]) compilable: true, but should: false on required level: 1: expected true to equal false
      at jdk.test.lib.Asserts.fail(Asserts.java:634)
      at jdk.test.lib.Asserts.assertEquals(Asserts.java:205)
      at jdk.test.lib.Asserts.assertEQ(Asserts.java:178)
      at compiler.compilercontrol.share.actions.CompileAction.checkCompilation(CompileAction.java:90)
      at compiler.compilercontrol.share.actions.CompileAction.checkCompiled(CompileAction.java:70)
      at compiler.compilercontrol.share.actions.BaseAction.lambda$check$2(BaseAction.java:141)
      at java.base/java.util.ArrayList.forEach(ArrayList.java:1597)
      at compiler.compilercontrol.share.actions.BaseAction.check(BaseAction.java:139)
      at compiler.compilercontrol.share.actions.BaseAction.communicate(BaseAction.java:100)
      at compiler.compilercontrol.share.actions.BaseAction.main(BaseAction.java:59)
      ]
       exitValue = 1

      Attachments

        Activity

          People

            Unassigned Unassigned
            dcubed Daniel Daugherty
            Votes:
            0 Vote for this issue
            Watchers:
            3 Start watching this issue

            Dates

              Created:
              Updated:
              Resolved: