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

runtime/Thread/TestAlwaysPreTouchStacks.java failed with Expected a higher ratio between stack committed and reserved

XMLWordPrintable

    • b03
    • x86_64, aarch64
    • linux

        The following test failed in the JDK23 CI:

        runtime/Thread/TestAlwaysPreTouchStacks.java

        Here's a snippet from the log file:

        #section:driver
        ----------messages:(8/324)----------
        command: driver TestAlwaysPreTouchStacks
        reason: User specified action: run driver TestAlwaysPreTouchStacks
        started: Fri Jan 26 19:06:32 UTC 2024
        Mode: agentvm
        Agent id: 20
        Additional exports to unnamed modules from @modules: java.base/jdk.internal.misc
        finished: Fri Jan 26 19:06:33 UTC 2024
        elapsed time (seconds): 1.616
        ----------configuration:(15/1958)----------

        <snip>

        ----------System.out:(5/1950)----------
        Command line: [/opt/mach5/mesos/work_dir/jib-master/install/jdk-23+8-500/linux-x64-debug.jdk/jdk-23/fastdebug/bin/java -cp /opt/mach5/mesos/work_dir/slaves/0db9c48f-6638-40d0-9a4b-bd9cc7533eb8-S9726/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/e55e166a-efc3-4d3a-a206-b61e49391ab7/runs/8b72de21-746f-4cc0-92b2-19a67e94af2d/testoutput/test-support/jtreg_open_test_hotspot_jtreg_tier1_runtime/classes/1/runtime/Thread/TestAlwaysPreTouchStacks.d:/opt/mach5/mesos/work_dir/jib-master/install/jdk-23+8-500/src.full/open/test/hotspot/jtreg/runtime/Thread:/opt/mach5/mesos/work_dir/slaves/0db9c48f-6638-40d0-9a4b-bd9cc7533eb8-S9726/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/e55e166a-efc3-4d3a-a206-b61e49391ab7/runs/8b72de21-746f-4cc0-92b2-19a67e94af2d/testoutput/test-support/jtreg_open_test_hotspot_jtreg_tier1_runtime/classes/1/test/lib:/opt/mach5/mesos/work_dir/jib-master/install/jtreg/7.3.1/1/bundles/jtreg-7.3.1+1.zip/jtreg/lib/jtreg.jar:/opt/mach5/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:/opt/mach5/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:/opt/mach5/mesos/work_dir/jib-master/install/jtreg/7.3.1/1/bundles/jtreg-7.3.1+1.zip/jtreg/lib/jcommander-1.82.jar:/opt/mach5/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:+UnlockDiagnosticVMOptions -Xmx100M -XX:+AlwaysPreTouchStacks -XX:NativeMemoryTracking=summary -XX:+PrintNMTStatistics TestAlwaysPreTouchStacks test ]
        [2024-01-26T19:06:33.437482360Z] Gathering output for process 22690
        [2024-01-26T19:06:33.594196345Z] Waiting for completion for process 22690
        [2024-01-26T19:06:33.594710910Z] Waiting for completion finished for process 22690
        >>>>> (stack: reserved=147918848, committed=2904064, peak=2904064): 147918848 - 2904064
        ----------System.err:(128/5337)----------
         stdout: [Alive: 2
        Alive: 1
        Alive: 0
        Alive: 3
        Alive: 5
        Alive: 4
        Alive: 6
        Alive: 7
        Alive: 8
        Alive: 9
        Alive: 10
        Alive: 11
        Alive: 12
        Alive: 13
        Alive: 14
        Alive: 15

        Native Memory Tracking:

        Total: reserved=1725098922, committed=190925738
               malloc: 25385898 #28837
               mmap: reserved=1699713024, committed=165539840

        - Java Heap (reserved=104857600, committed=104857600)
                                    (mmap: reserved=104857600, committed=104857600, at peak)
         
        - Class (reserved=1073842507, committed=231755)
                                    (classes #721)
                                    ( instance classes #608, array classes #113)
                                    (malloc=100683 #1625) (peak=100827 #1623)
                                    (mmap: reserved=1073741824, committed=131072, at peak)
                                    ( Metadata: )
                                    ( reserved=67108864, committed=327680)
                                    ( used=224352)
                                    ( waste=103328 =31.53%)
                                    ( Class space:)
                                    ( reserved=1073741824, committed=131072)
                                    ( used=15688)
                                    ( waste=115384 =88.03%)
         
        - Thread (reserved=148029184, committed=3014400)
                                    (threads #29)
                                    (stack: reserved=147918848, committed=2904064, peak=2904064)
                                    (malloc=72704 #203) (peak=81232 #207)
                                    (arena=37632 #64) (peak=179336 #44)
         
        - Code (reserved=254048944, committed=8145584)
                                    (malloc=416432 #12771) (peak=416512 #12775)
                                    (mmap: reserved=253632512, committed=7729152, at peak)
                                    (arena=0 #0) (peak=984 #1)
         
        - GC (reserved=57140362, committed=57140362)
                                    (malloc=21509258 #831) (at peak)
                                    (mmap: reserved=35631104, committed=35631104, at peak)
         
        - GCCardSet (reserved=23432, committed=23432)
                                    (malloc=23432 #303) (at peak)
         
        - Compiler (reserved=204104, committed=204104)
                                    (malloc=3800 #32) (peak=3904 #32)
                                    (arena=200304 #4) (peak=871952 #13)
         
        - Internal (reserved=502664, committed=502664)
                                    (malloc=465800 #10531) (peak=466369 #10543)
                                    (mmap: reserved=36864, committed=36864, at peak)
         
        - Symbol (reserved=1163808, committed=1163808)
                                    (malloc=795168 #167) (at peak)
                                    (arena=368640 #1) (at peak)
         
        - Native Memory Tracking (reserved=470832, committed=470832)
                                    (malloc=9440 #91) (peak=9952 #95)
                                    (tracking overhead=461392)
         
        - Shared class space (reserved=16777216, committed=13914112, readonly=0)
                                    (mmap: reserved=16777216, committed=13914112, peak=14180352)
         
        - Arena Chunk (reserved=699040, committed=699040)
                                    (malloc=699040 #96) (peak=1393880 #98)
         
        - Tracing (reserved=345, committed=345)
                                    (malloc=345 #9) (at peak)
         
        - Statistics (reserved=128, committed=128)
                                    (malloc=128 #2) (at peak)
         
        - Arguments (reserved=212, committed=212)
                                    (malloc=212 #5) (at peak)
         
        - Module (reserved=66568, committed=66568)
                                    (malloc=66568 #1232) (at peak)
         
        - Safepoint (reserved=8192, committed=8192)
                                    (mmap: reserved=8192, committed=8192, at peak)
         
        - Synchronization (reserved=124000, committed=124000)
                                    (malloc=124000 #910) (at peak)
         
        - Serviceability (reserved=17240, committed=17240)
                                    (malloc=17240 #10) (peak=17576 #14)
         
        - Metaspace (reserved=67121424, committed=340240)
                                    (malloc=12560 #9) (at peak)
                                    (mmap: reserved=67108864, committed=327680, at peak)
         
        - String Deduplication (reserved=704, committed=704)
                                    (malloc=704 #8) (at peak)
         
        - Object Monitors (reserved=416, committed=416)
                                    (malloc=416 #2) (at peak)
         
        - Unknown (reserved=0, committed=0)
                                    (mmap: reserved=0, committed=0, peak=20480)
         
        ];
         stderr: []
         exitValue = 0

        java.lang.RuntimeException: Expected a higher ratio between stack committed and reserved.
        at TestAlwaysPreTouchStacks.main(TestAlwaysPreTouchStacks.java:135)
        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: Failed. Execution failed: `main' threw exception: java.lang.RuntimeException: Expected a higher ratio between stack committed and reserved.

              qpzhang Patrick Zhang
              dcubed Daniel Daugherty
              Votes:
              0 Vote for this issue
              Watchers:
              6 Start watching this issue

                Created:
                Updated:
                Resolved: