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

RunThese30M failed "assert(t->jfr_thread_local()->shelved_buffer() == __null) failed: invariant"

XMLWordPrintable

    • jfr
    • b14
    • x86_64
    • os_x

      The following test failed in the JDK14 CI:

      applications/runthese/RunThese30M.java

      Here's a snippet from the log file:

      Checking for JDK Version : 9.0
      Creating spec class.
      Verifying the constraints on the serial fields
      serial2004 passed.

      [error occurred during error reporting ((null)), id 0xe0000000, Internal Error (/scratch/mesos/slaves/7cfa21b9-afde-4338-a459-d3e0a13ec793-S738/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/1047c430-6082-419a-8a0f-bc81651990f5/runs/23a96164-96bf-40f4-8d06-750830762f95/workspace/open/src/hotspot/share/jfr/recorder/storage/jfrStorage.cpp:467)]

      #
      # A fatal error has been detected by the Java Runtime Environment:
      #
      # Internal Error (/scratch/mesos/slaves/7cfa21b9-afde-4338-a459-d3e0a13ec793-S738/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/1047c430-6082-419a-8a0f-bc81651990f5/runs/23a96164-96bf-40f4-8d06-750830762f95/workspace/open/src/hotspot/share/jfr/recorder/storage/jfrStorage.cpp:467), pid=51996, tid=44659
      # assert(t->jfr_thread_local()->shelved_buffer() == __null) failed: invariant
      #
      # JRE version: Java(TM) SE Runtime Environment (14.0+34) (fastdebug build 14-ea+34-1444)
      # Java VM: Java HotSpot(TM) 64-Bit Server VM (fastdebug 14-ea+34-1444, compiled mode, g1 gc, bsd-amd64)
      # Core dump will be written. Default location: core.51996
      #
      Unsupported internal testing APIs have been used.

      # An error report file with more information is saved as:
      # /scratch/mesos/slaves/7cfa21b9-afde-4338-a459-d3e0a13ec793-S786/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/1ed5f3dc-6bf5-449a-8755-23127cb739f4/runs/f6904624-f98f-4708-966e-4ee5fc286d98/testoutput/test-support/jtreg_closed_test_hotspot_jtreg_applications_runthese_RunThese30M_java/scratch/0/hs_err_pid51996.log
      #
      # If you would like to submit a bug report, please visit:
      # https://bugreport.java.com/bugreport/crash.jsp
      #
      ----------System.err:(1034/91950)----------


      Here's the crashing thread's stack:

      --------------- T H R E A D ---------------

      Current thread (0x00007fccf9142000): JavaThread "/scratch/mesos/jib-master/install/com/oracle/jpg/bigapps/jck/9.0/jck-9.0-20170922.165600-1.tar.gz/JCK-runtime-9/classes javasoft.sqe.tests.api.java.lang.invoke.MethodHandle.HighArityTests " daemon [_thread_in_vm, id=44659, stack(0x0000700003a15000,0x0000700003b15000)]

      Stack: [0x0000700003a15000,0x0000700003b15000], sp=0x0000700003b0fe50, free space=1003k
      Native frames: (J=compiled Java code, A=aot compiled Java code, j=interpreted, Vv=VM code, C=native code)
      V [libjvm.dylib+0xb78a7b] VMError::report_and_die(int, char const*, char const*, __va_list_tag*, Thread*, unsigned char*, void*, void*, char const*, int, unsigned long)+0x6e5
      V [libjvm.dylib+0xb79197] VMError::report_and_die(Thread*, void*, char const*, int, char const*, char const*, __va_list_tag*)+0x47
      V [libjvm.dylib+0x3675ac] report_vm_error(char const*, int, char const*, char const*, ...)+0x145
      V [libjvm.dylib+0x5bbf81] JfrStorage::flush_regular(JfrBuffer*, unsigned char const*, unsigned long, unsigned long, bool, Thread*)+0x7f
      V [libjvm.dylib+0x5bbc26] JfrStorage::flush(JfrBuffer*, unsigned long, unsigned long, bool, Thread*)+0x174
      V [libjvm.dylib+0x593957] JfrFlush::JfrFlush(JfrBuffer*, unsigned long, unsigned long, Thread*)+0x29
      V [libjvm.dylib+0xb4848e] Adapter<JfrFlush>::flush(unsigned long, unsigned long)+0x5e
      V [libjvm.dylib+0xb483b6] StorageHost<Adapter<JfrFlush>, StackObj>::accommodate(unsigned long, unsigned long)+0x16
      V [libjvm.dylib+0xb48530] WriterHost<EncoderHost<BigEndianEncoderImpl, BigEndianEncoderImpl>, EncoderHost<Varint128EncoderImpl, BigEndianEncoderImpl>, MemoryWriterHost<Adapter<JfrFlush>, StackObj, ExclusiveAccessAssert> >::ensure_size(unsigned long)+0x40
      V [libjvm.dylib+0xb4860d] void WriterHost<EncoderHost<BigEndianEncoderImpl, BigEndianEncoderImpl>, EncoderHost<Varint128EncoderImpl, BigEndianEncoderImpl>, MemoryWriterHost<Adapter<JfrFlush>, StackObj, ExclusiveAccessAssert> >::write<unsigned long long>(unsigned long long const*, unsigned long)+0x2d
      V [libjvm.dylib+0xb79827] JfrEvent<EventShutdown>::write_event()+0x157
      V [libjvm.dylib+0x652ff2] JfrEvent<EventShutdown>::commit()+0x7a
      V [libjvm.dylib+0xb787f9] VMError::report_and_die(int, char const*, char const*, __va_list_tag*, Thread*, unsigned char*, void*, void*, char const*, int, unsigned long)+0x463
      V [libjvm.dylib+0xb79197] VMError::report_and_die(Thread*, void*, char const*, int, char const*, char const*, __va_list_tag*)+0x47
      V [libjvm.dylib+0x3675ac] report_vm_error(char const*, int, char const*, char const*, ...)+0x145
      V [libjvm.dylib+0x5bbf81] JfrStorage::flush_regular(JfrBuffer*, unsigned char const*, unsigned long, unsigned long, bool, Thread*)+0x7f
      V [libjvm.dylib+0x5bbc26] JfrStorage::flush(JfrBuffer*, unsigned long, unsigned long, bool, Thread*)+0x174
      V [libjvm.dylib+0x593957] JfrFlush::JfrFlush(JfrBuffer*, unsigned long, unsigned long, Thread*)+0x29
      V [libjvm.dylib+0xb4848e] Adapter<JfrFlush>::flush(unsigned long, unsigned long)+0x5e
      V [libjvm.dylib+0xb483b6] StorageHost<Adapter<JfrFlush>, StackObj>::accommodate(unsigned long, unsigned long)+0x16
      V [libjvm.dylib+0xb48530] WriterHost<EncoderHost<BigEndianEncoderImpl, BigEndianEncoderImpl>, EncoderHost<Varint128EncoderImpl, BigEndianEncoderImpl>, MemoryWriterHost<Adapter<JfrFlush>, StackObj, ExclusiveAccessAssert> >::ensure_size(unsigned long)+0x40
      V [libjvm.dylib+0xb4860d] void WriterHost<EncoderHost<BigEndianEncoderImpl, BigEndianEncoderImpl>, EncoderHost<Varint128EncoderImpl, BigEndianEncoderImpl>, MemoryWriterHost<Adapter<JfrFlush>, StackObj, ExclusiveAccessAssert> >::write<unsigned long long>(unsigned long long const*, unsigned long)+0x2d
      V [libjvm.dylib+0x384ff9] JfrEvent<EventDeoptimization>::write_event()+0x157
      V [libjvm.dylib+0x384728] JfrEvent<EventDeoptimization>::commit()+0x7a
      V [libjvm.dylib+0x38169e] Deoptimization::uncommon_trap_inner(JavaThread*, int)+0x71c
      V [libjvm.dylib+0x3829f6] Deoptimization::uncommon_trap(JavaThread*, int, int)+0x42

      Java frames: (J=compiled Java code, j=interpreted, Vv=VM code)
      v ~UncommonTrapBlob
      J 144676 c2 jdk.jfr.internal.EventWriter.putUncheckedLong(J)V jdk.jfr@14-ea (278 bytes) @ 0x000000010b8edcec [0x000000010b8edaa0+0x000000000000024c]
      J 145313 c2 jdk.jfr.internal.EventWriter.putStringValue(Ljava/lang/String;)V jdk.jfr@14-ea (56 bytes) @ 0x000000010be84c88 [0x000000010be84b60+0x0000000000000128]
      J 145304 c2 jdk.jfr.internal.EventWriter.putString(Ljava/lang/String;Ljdk/jfr/internal/StringPool;)V jdk.jfr@14-ea (84 bytes) @ 0x000000010b7001f8 [0x000000010b6ffb00+0x00000000000006f8]
      J 145288 c2 jdk.jfr.internal.handlers.EventHandler2380_1580288127805-51996.write(JJLjava/lang/String;Ljava/lang/Class;)V jdk.jfr@14-ea (72 bytes) @ 0x000000010ba68a9c [0x000000010ba685a0+0x00000000000004fc]
      J 145279 c2 jdk.jfr.events.ErrorThrownEvent.commit()V jdk.jfr@14-ea (81 bytes) @ 0x000000010bc1f58c [0x000000010bc1f4c0+0x00000000000000cc]
      J 145270 c2 jdk.jfr.internal.instrument.ThrowableTracer.traceError(Ljava/lang/Error;Ljava/lang/String;)V jdk.jfr@14-ea (66 bytes) @ 0x000000010b9c2b54 [0x000000010b9c2a80+0x00000000000000d4]
      J 145261 c2 java.lang.NoSuchMethodError.<init>(Ljava/lang/String;)V java.base@14-ea (6 bytes) @ 0x000000010c64e78c [0x000000010c64e740+0x000000000000004c]
      v ~StubRoutines::call_stub
      J 761 java.lang.invoke.MethodHandleNatives.resolve(Ljava/lang/invoke/MemberName;Ljava/lang/Class;Z)Ljava/lang/invoke/MemberName; java.base@14-ea (0 bytes) @ 0x000000010b8453ea [0x000000010b845360+0x000000000000008a]
      J 144674 c2 java.lang.invoke.MemberName$Factory.resolve(BLjava/lang/invoke/MemberName;Ljava/lang/Class;Z)Ljava/lang/invoke/MemberName; java.base@14-ea (157 bytes) @ 0x000000010be8373c [0x000000010be836a0+0x000000000000009c]
      J 144841 c2 java.lang.invoke.InvokerBytecodeGenerator.resolveFrom(Ljava/lang/String;Ljava/lang/invoke/MethodType;Ljava/lang/Class;)Ljava/lang/invoke/MemberName; java.base@14-ea (106 bytes) @ 0x000000010cf7cd64 [0x000000010cf7cc60+0x0000000000000104]
      J 144834 c2 java.lang.invoke.InvokerBytecodeGenerator.lookupPregenerated(Ljava/lang/invoke/LambdaForm;Ljava/lang/invoke/MethodType;)Ljava/lang/invoke/MemberName; java.base@14-ea (299 bytes) @ 0x000000010cbe34f8 [0x000000010cbe2e60+0x0000000000000698]
      J 145644 c2 java.lang.invoke.DelegatingMethodHandle.makeReinvokerForm(Ljava/lang/invoke/MethodHandle;ILjava/lang/Object;ZLjava/lang/invoke/LambdaForm$NamedFunction;Ljava/lang/invoke/LambdaForm$NamedFunction;)Ljava/lang/invoke/LambdaForm; java.base@14-ea (344 bytes) @ 0x000000010cdca5c0 [0x000000010cdc9700+0x0000000000000ec0]
      J 144804 c2 java.lang.invoke.DirectMethodHandle.rebind()Ljava/lang/invoke/BoundMethodHandle; java.base@14-ea (5 bytes) @ 0x000000010bc29adc [0x000000010bc29a60+0x000000000000007c]
      J 145736 c2 javasoft.sqe.tests.api.java.lang.invoke.MethodHandle.HighArityTests.tooLargeAsSpreader3(Ljava/lang/invoke/MethodHandle;Ljava/lang/Class;)V (10 bytes) @ 0x000000010d1f14e4 [0x000000010d1f1440+0x00000000000000a4]
      v ~StubRoutines::call_stub
      J 2423 jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Ljava/lang/reflect/Method;Ljava/lang/Object;[Ljava/lang/Object;)Ljava/lang/Object; java.base@14-ea (0 bytes) @ 0x000000010bb8967b [0x000000010bb895e0+0x000000000000009b]
      J 145278 c2 jdk.internal.reflect.NativeMethodAccessorImpl.invoke(Ljava/lang/Object;[Ljava/lang/Object;)Ljava/lang/Object; java.base@14-ea (104 bytes) @ 0x000000010bd15180 [0x000000010bd14e20+0x0000000000000360]
      J 145269 c2 jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(Ljava/lang/Object;[Ljava/lang/Object;)Ljava/lang/Object; java.base@14-ea (10 bytes) @ 0x000000010d0fefdc [0x000000010d0fefa0+0x000000000000003c]
      J 145721 c2 com.oracle.tck.lib.autd2.processors.tc.TGFTestCaseMethodSetting$$Lambda$3620.call()Ljava/lang/Object; (12 bytes) @ 0x000000010b8d72ec [0x000000010b8d7180+0x000000000000016c]
      J 145710 c2 com.oracle.tck.lib.autd2.processors.tc.DefaultThreadRunning.process(Lcom/oracle/tck/lib/autd2/TestCaseContext$TestCaseLifePhase;Lcom/oracle/tck/lib/autd2/TestCaseContext;)V (48 bytes) @ 0x000000010ba043e4 [0x000000010ba043a0+0x0000000000000044]
      J 146036 c2 com.oracle.tck.lib.autd2.processors.tc.DefaultThreadRunning.process(Lcom/oracle/tck/lib/autd2/LifePhase;Lcom/oracle/tck/lib/autd2/Context;)V (13 bytes) @ 0x000000010cb0975c [0x000000010cb09700+0x000000000000005c]
      J 146022 c2 com.oracle.tck.lib.autd2.AUTD2Utils.iterateThroughProcessorsUntilAllAreDone(Lcom/oracle/tck/lib/autd2/Context;Ljava/util/TreeMap;Lcom/oracle/tck/lib/autd2/LifePhase;Ljava/util/List;)V (207 bytes) @ 0x000000010ccacfb0 [0x000000010ccacd80+0x0000000000000230]
      j com.oracle.tck.lib.autd2.AUTD2Utils.iterateLifePhases(Lcom/oracle/tck/lib/autd2/Context;[Lcom/oracle/tck/lib/autd2/LifePhase;)V+72
      J 135647 c2 com.oracle.tck.lib.autd2.AUTD2Utils.iterateTestCaseLifePhase(Lcom/oracle/tck/lib/autd2/TestCaseContext;)Lcom/oracle/tck/lib/autd2/TestResult; (37 bytes) @ 0x000000010c121868 [0x000000010c121760+0x0000000000000108]
      J 129789 c2 com.oracle.tck.lib.autd2.processors.tg.RunningTestCases.runTestCaseAsNeeded(Lcom/oracle/tck/lib/autd2/TestCaseContext;)Lcom/oracle/tck/lib/autd2/TestResult; (5 bytes) @ 0x000000010ba3874c [0x000000010ba38720+0x000000000000002c]
      j com.oracle.tck.lib.autd2.processors.tg.RunningTestCases.lambda$process$0(Lcom/oracle/tck/lib/autd2/TestGroupContext;Lcom/oracle/tck/lib/autd2/TestCaseContext;)V+24
      j com.oracle.tck.lib.autd2.processors.tg.RunningTestCases$$Lambda$3575.accept(Ljava/lang/Object;)V+12
      J 126275 c2 java.lang.Iterable.forEach(Ljava/util/function/Consumer;)V java.base@14-ea (39 bytes) @ 0x000000010c0b5470 [0x000000010c0b53e0+0x0000000000000090]
      j com.oracle.tck.lib.autd2.processors.tg.RunningTestCases.process(Lcom/oracle/tck/lib/autd2/TestGroupContext$TestGroupLifePhase;Lcom/oracle/tck/lib/autd2/TestGroupContext;)V+13
      j com.oracle.tck.lib.autd2.processors.tg.RunningTestCases.process(Lcom/oracle/tck/lib/autd2/LifePhase;Lcom/oracle/tck/lib/autd2/Context;)V+9
      j com.oracle.tck.lib.autd2.AUTD2Utils.iterateThroughProcessorsUntilAllAreDone(Lcom/oracle/tck/lib/autd2/Context;Ljava/util/TreeMap;Lcom/oracle/tck/lib/autd2/LifePhase;Ljava/util/List;)V+120
      j com.oracle.tck.lib.autd2.AUTD2Utils.iterateLifePhases(Lcom/oracle/tck/lib/autd2/Context;[Lcom/oracle/tck/lib/autd2/LifePhase;)V+72
      j com.oracle.tck.lib.autd2.TestRunner.performRun(Lcom/oracle/tck/lib/autd2/TestGroupContext;Ljava/util/Map;)V+213
      j com.oracle.tck.lib.autd2.TestRunner.run(Ljava/lang/Object;Ljava/io/PrintWriter;Ljava/io/PrintWriter;Ljava/util/Map;[Ljava/lang/String;)Lcom/oracle/tck/lib/autd2/TestResult;+80
      j com.oracle.tck.lib.autd2.AUTD2.run(Ljava/lang/Object;Ljava/io/PrintWriter;Ljava/io/PrintWriter;[Ljava/lang/String;)Ljavasoft/sqe/javatest/Status;+70
      j com.oracle.tck.lib.autd2.AUTD2.run(Ljava/lang/Object;[Ljava/lang/String;)Ljavasoft/sqe/javatest/Status;+28
      j javasoft.sqe.tests.api.java.lang.invoke.MethodHandle.HighArityTests.main([Ljava/lang/String;)V+8
      v ~StubRoutines::call_stub
      J 2423 jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Ljava/lang/reflect/Method;Ljava/lang/Object;[Ljava/lang/Object;)Ljava/lang/Object; java.base@14-ea (0 bytes) @ 0x000000010bb8967b [0x000000010bb895e0+0x000000000000009b]
      J 126570 c2 jdk.internal.reflect.NativeMethodAccessorImpl.invoke(Ljava/lang/Object;[Ljava/lang/Object;)Ljava/lang/Object; java.base@14-ea (104 bytes) @ 0x000000010ba8eb2c [0x000000010ba8e960+0x00000000000001cc]
      J 126567 c2 jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(Ljava/lang/Object;[Ljava/lang/Object;)Ljava/lang/Object; java.base@14-ea (10 bytes) @ 0x000000010b96e1dc [0x000000010b96e1a0+0x000000000000003c]
      J 126789 c2 applications.kitchensink.process.stress.modules.JckStressModule$TestRunner$1.run()V (127 bytes) @ 0x000000010bda919c [0x000000010bda9120+0x000000000000007c]
      v ~StubRoutines::call_stub

      Starting this bug out as a P3 since this failure mode is
      new (to me anyway) and it happened in the JDK14 CI.

            mgronlun Markus Grönlund
            dcubed Daniel Daugherty
            Votes:
            0 Vote for this issue
            Watchers:
            3 Start watching this issue

              Created:
              Updated:
              Resolved: