Result of trunk-mjit-wait@phosphorus-docker at 2021-06-08 13:54:31 +0900

• NG (8c87efaa8a) [LOG]

• Linux phosphorus-docker 4.9.0-15-amd64 #1 SMP Debian 4.9.258-1 (2021-03-08) x86_64 x86_64 x86_64 GNU/Linux
  

• rev: 8c87efaa8a
  test-all : 
  test-spec: 
  exit statuses:
    "make update-unicode  -j6" exit with 0.
    "make update-download -j6" exit with 0.
    "make update-rubyspec -j6" exit with 0.
    "make update-src      -j6" exit with 0.
    "make after-update    -j6" exit with 0.
    "make miniruby -j6" exit with 0.
    "make ruby -j6" exit with 0.
    "make all -j6" exit with 0.
    "make install -j6" exit with 0.
  Logfile: /home/ko1/ruby/logs/brlog.trunk-mjit-wait.20210607-235402
  #<BuildRuby:0x0000560c7054b460
   @BUILD_DIR="/tmp/ruby/v3/build",
   @INSTALL_DIR="/tmp/ruby/v3/install",
   @REPOSITORY="https://github.com/ruby/ruby.git",
   @REPOSITORY_TYPE=:git,
   @SRC_DIR="/tmp/ruby/v3/src",
   @TARGET_BUILD_DIR="/tmp/ruby/v3/build/trunk-mjit-wait",
   @TARGET_INSTALL_DIR="/tmp/ruby/v3/install/trunk-mjit-wait",
   @TARGET_NAME="trunk-mjit-wait",
   @TARGET_SRC_DIR="/tmp/ruby/v3/src/trunk-mjit-wait",
   @build_opts="-j6",
   @configure_opts=["cppflags=-DMJIT_FORCE_ENABLE"],
   @gist=false,
   @git_branch=nil,
   @git_worktree=nil,
   @incremental=true,
   @logfile="/home/ko1/ruby/logs/brlog.trunk-mjit-wait.20210607-235402",
   @make="make",
   @quiet=false,
   @ruby_env=
    [["RUBY_DEBUG", "ci"], ["RUBY_TEST_SUBPROCESS_TIMEOUT_SCALE", "30"]],
   @steps=
    ["checkout",
     "autoconf",
     "configure",
     "build_up",
     "build_miniruby",
     "build_ruby",
     "build_all",
     "build_install",
     "test_btest",
     "test_basic",
     "test_all",
     "test_rubyspec"],
   @svn_revision=nil,
   @test_opts=
    "RUN_OPTS=\"--disable-gems --jit-debug=-ggdb3 --jit-wait --jit-warnings --jit-min-calls=5\"",
   @timeout=18000>
                             user     system      total        real
  checkout               0.000000   0.000000   0.000000 (  0.000018)
  autoconf               0.000000   0.000000   0.000000 (  0.000053)
  configure              0.000000   0.000000   0.000000 (  0.000036)
  build_up             From https://github.com/ruby/ruby
     a49a08a..8c87efa  master     -> origin/master
    0.000000   0.012000   6.968000 (  5.143193)
  build_miniruby         0.000000   0.000000   1.760000 (  1.800686)
  build_ruby             0.004000   0.000000   3.736000 (  2.992125)
  build_all              0.016000   0.000000  23.520000 (  5.998685)
  build_install          0.028000   0.000000  23.524000 ( 10.142052)
  test_btest           test_attr.rb             ..
  test_autoload.rb         ........
  test_block.rb            ..........................................................
  test_class.rb            ................................................
  test_env.rb              ..
  test_eval.rb             .....................................
  test_exception.rb        ..................................
  test_fiber.rb            .....
  test_finalizer.rb        .
  test_flip.rb             .
  test_flow.rb             ..............................................................
  test_fork.rb             ....
  test_gc.rb               ..
  test_insns.rb            ...............................................................................................................................................................................................................................................................................................................................................................................................
  test_io.rb               .........
  test_jump.rb             .............................
  test_literal.rb          ............................................................................................................................................................
  test_literal_suffix.rb   ................................................
  test_load.rb             ..
  test_marshal.rb          .
  test_massign.rb          ..................................
  test_method.rb           ...............................................................................................................................................................................................................................
  test_objectspace.rb      ......
  test_proc.rb             .....................................
  test_ractor.rb           .................$$$ #<Timeout::Error: execution expired>
  ### enter analyzing mode for stuck processes
  
  $$$ ps jx
   PPID   PID  PGID   SID TTY      TPGID STAT   UID   TIME COMMAND
     10    11    11    11 ?           -1 Ss    1001   0:00 sh build-loop.sh trunk-mjit-wait --incremental --process-num=6
     11  2906    11    11 ?           -1 Sl    1001   0:00 ruby ./br.rb build_report trunk-mjit-wait --incremental --process-num=6
   2906  2908    11    11 ?           -1 S     1001   0:00 sh -c ruby /home/ko1/ruby/build-ruby/build-ruby.rb --target_name=trunk-mjit-wait --logfile=/home/ko1/ruby/logs/brlog.trunk-mjit-wait.20210607-235402 --root_dir=/tmp/ruby --timeout=18000 --configure_opts=cppflags="-DMJIT_FORCE_ENABLE" --add-env=RUBY_TEST_SUBPROCESS_TIMEOUT_SCALE=30 --test_opts='RUN_OPTS="--disable-gems --jit-debug=-ggdb3 --jit-wait --jit-warnings --jit-min-calls=5"' --incremental --process-num=6
   2908  2909    11    11 ?           -1 Sl    1001   0:00 ruby /home/ko1/ruby/build-ruby/build-ruby.rb --target_name=trunk-mjit-wait --logfile=/home/ko1/ruby/logs/brlog.trunk-mjit-wait.20210607-235402 --root_dir=/tmp/ruby --timeout=18000 --configure_opts=cppflags=-DMJIT_FORCE_ENABLE --add-env=RUBY_TEST_SUBPROCESS_TIMEOUT_SCALE=30 --test_opts=RUN_OPTS="--disable-gems --jit-debug=-ggdb3 --jit-wait --jit-warnings --jit-min-calls=5" --incremental --process-num=6
   2909  3701    11    11 ?           -1 S     1001   0:00 sh -c make yes-btest RUN_OPTS="--disable-gems --jit-debug=-ggdb3 --jit-wait --jit-warnings --jit-min-calls=5"
   3701  3702    11    11 ?           -1 S     1001   0:00 make yes-btest RUN_OPTS=--disable-gems --jit-debug=-ggdb3 --jit-wait --jit-warnings --jit-min-calls=5
   3702  3708    11    11 ?           -1 Sl    1001   0:01 /usr/bin/ruby --disable=gems /tmp/ruby/v3/src/trunk-mjit-wait/bootstraptest/runner.rb --ruby=./miniruby -I/tmp/ruby/v3/src/trunk-mjit-wait/lib -I. -I.ext/common   --disable-gems --jit-debug=-ggdb3 --jit-wait --jit-warnings --jit-min-calls=5
   3708  9157    11    11 ?           -1 Sl    1001 287:05 /tmp/ruby/v3/build/trunk-mjit-wait/miniruby -I/tmp/ruby/v3/src/trunk-mjit-wait/lib -I/tmp/ruby/v3/build/trunk-mjit-wait -I/tmp/ruby/v3/build/trunk-mjit-wait/.ext/common --disable-gems --jit-debug=-ggdb3 --jit-wait --jit-warnings --jit-min-calls=5 -W0 bootstraptest.tmp.rb
   2909  9164    11    11 ?           -1 R     1001   0:00 ps jx
  {10=>[11], 11=>[2906], 2906=>[2908], 2908=>[2909], 2909=>[3701, 9164], 3701=>[3702], 3702=>[3708], 3708=>[9157]}
  "timeout 60 gdb -p 9157 -x /home/ko1/ruby/build-ruby/gdbscript -batch -quiet"
  [New LWP 9158]
  [New LWP 9161]
  [New LWP 9162]
  [Thread debugging using libthread_db enabled]
  Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
  183	../sysdeps/nptl/futex-internal.h: No such file or directory.
  futex_wait_cancelable (private=<optimized out>, expected=0, futex_word=0x5586fe34590c) at ../sysdeps/nptl/futex-internal.h:183
  >>> Threads  Id   Target Id                                          Frame 
  * 1    Thread 0x7fd47b01ab80 (LWP 9157) "miniruby"        futex_wait_cancelable (private=<optimized out>, expected=0, futex_word=0x5586fe34590c) at ../sysdeps/nptl/futex-internal.h:183
    2    Thread 0x7fd477a0f700 (LWP 9158) "ruby-mjitworker" 0x00005586fc55deea in get_from_list (list=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/ccan/list/list.h:761
    3    Thread 0x7fd477207700 (LWP 9161) "miniruby"        __lll_lock_wait (futex=futex@entry=0x5586fc816b20 <mjit_engine_mutex>, private=0) at lowlevellock.c:52
    4    Thread 0x7fd477006700 (LWP 9162) "miniruby"        __lll_lock_wait (futex=futex@entry=0x5586fc816b20 <mjit_engine_mutex>, private=0) at lowlevellock.c:52
  >>> Machine level backtrace
  
  Thread 4 (Thread 0x7fd477006700 (LWP 9162)):
  #0  __lll_lock_wait (futex=futex@entry=0x5586fc816b20 <mjit_engine_mutex>, private=0) at lowlevellock.c:52
  #1  0x00007fd47b43b0a3 in __GI___pthread_mutex_lock (mutex=mutex@entry=0x5586fc816b20 <mjit_engine_mutex>) at ../nptl/pthread_mutex_lock.c:80
  #2  0x00005586fc68320d in rb_native_mutex_lock (lock=lock@entry=0x5586fc816b20 <mjit_engine_mutex>) at /tmp/ruby/v3/src/trunk-mjit-wait/thread_pthread.c:439
  #3  0x00005586fc55c07a in CRITICAL_SECTION_START (level=3, msg=0x5586fc70e058 "in rb_mjit_wait_call for a client wakeup") at /tmp/ruby/v3/src/trunk-mjit-wait/mjit_worker.c:446
  #4  mjit_wait (body=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/mjit.c:319
  #5  0x00005586fc55ecc5 in rb_mjit_wait_call (ec=0x5586fe415190, body=0x5586fe42a0b0) at /tmp/ruby/v3/src/trunk-mjit-wait/mjit.c:334
  #6  0x00005586fc6cf28e in mjit_exec_slowpath (body=0x5586fe42a0b0, iseq=<optimized out>, ec=0x5586fe415190) at /tmp/ruby/v3/src/trunk-mjit-wait/mjit.h:120
  #7  mjit_exec (ec=0x5586fe415190) at /tmp/ruby/v3/src/trunk-mjit-wait/mjit.h:159
  #8  rb_vm_exec (ec=<optimized out>, mjit_enable_p=true) at /tmp/ruby/v3/src/trunk-mjit-wait/vm.c:2159
  #9  0x00005586fc6d210f in invoke_block (captured=<optimized out>, opt_pc=<optimized out>, type=<optimized out>, cref=0x0, self=140550508428920, iseq=0x7fd47af13fc8, ec=0x5586fe415190) at /tmp/ruby/v3/src/trunk-mjit-wait/vm.c:1260
  #10 invoke_iseq_block_from_c (me=0x0, is_lambda=<optimized out>, cref=0x0, passed_block_handler=0, kw_splat=0, argv=0x7fd476f05858, argc=1, self=140550508428920, captured=<optimized out>, ec=0x5586fe415190) at /tmp/ruby/v3/src/trunk-mjit-wait/vm.c:1332
  #11 invoke_block_from_c_bh (argc=<optimized out>, kw_splat=<optimized out>, passed_block_handler=<optimized out>, cref=<optimized out>, is_lambda=<optimized out>, force_blockarg=<optimized out>, argv=<optimized out>, block_handler=<optimized out>, ec=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/vm.c:1350
  #12 vm_yield (argc=1, kw_splat=0, argv=0x7fd476f05858, ec=0x5586fe415190) at /tmp/ruby/v3/src/trunk-mjit-wait/vm.c:1395
  #13 rb_yield_0 (argv=0x7fd476f05858, argc=1) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_eval.c:1344
  #14 rb_yield_1 (val=<optimized out>, val@entry=5) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_eval.c:1350
  #15 0x00005586fc58e3bc in int_dotimes (num=20001) at /tmp/ruby/v3/src/trunk-mjit-wait/include/ruby/internal/arithmetic/long.h:95
  #16 0x00005586fc6c387b in vm_call_cfunc_with_frame (ec=0x5586fe415190, reg_cfp=0x7fd477005c90, calling=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_insnhelper.c:2943
  #17 0x00005586fc6cddd3 in vm_sendish (ec=0x5586fe415190, reg_cfp=0x7fd477005c90, cd=0x5586fe4294d0, block_handler=<optimized out>, method_explorer=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_callinfo.h:336
  #18 0x00005586fc6d86bb in vm_exec_core (ec=0x5586fe415190, initial=128) at ../../src/trunk-mjit-wait/insns.def:754
  #19 0x00005586fc6cea2e in rb_vm_exec (ec=<optimized out>, mjit_enable_p=true) at /tmp/ruby/v3/src/trunk-mjit-wait/vm.c:2160
  #20 0x00005586fc686027 in thread_do_start_proc (th=0x5586fe40a410) at /tmp/ruby/v3/src/trunk-mjit-wait/thread.c:718
  #21 0x00005586fc688d87 in thread_do_start (th=0x5586fe40a410) at /tmp/ruby/v3/src/trunk-mjit-wait/thread.c:759
  #22 thread_start_func_2 (th=<optimized out>, stack_start=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/thread.c:824
  #23 0x00005586fc6896fb in thread_start_func_1 (th_ptr=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/thread_pthread.c:1051
  #24 0x00007fd47b438609 in start_thread (arg=<optimized out>) at pthread_create.c:477
  #25 0x00007fd47b13e293 in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:95
  
  Thread 3 (Thread 0x7fd477207700 (LWP 9161)):
  #0  __lll_lock_wait (futex=futex@entry=0x5586fc816b20 <mjit_engine_mutex>, private=0) at lowlevellock.c:52
  #1  0x00007fd47b43b0a3 in __GI___pthread_mutex_lock (mutex=mutex@entry=0x5586fc816b20 <mjit_engine_mutex>) at ../nptl/pthread_mutex_lock.c:80
  #2  0x00005586fc68320d in rb_native_mutex_lock (lock=lock@entry=0x5586fc816b20 <mjit_engine_mutex>) at /tmp/ruby/v3/src/trunk-mjit-wait/thread_pthread.c:439
  #3  0x00005586fc55c07a in CRITICAL_SECTION_START (level=3, msg=0x5586fc70e058 "in rb_mjit_wait_call for a client wakeup") at /tmp/ruby/v3/src/trunk-mjit-wait/mjit_worker.c:446
  #4  mjit_wait (body=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/mjit.c:319
  #5  0x00005586fc55ecc5 in rb_mjit_wait_call (ec=0x5586fe420590, body=0x5586fe42a0b0) at /tmp/ruby/v3/src/trunk-mjit-wait/mjit.c:334
  #6  0x00005586fc6cf28e in mjit_exec_slowpath (body=0x5586fe42a0b0, iseq=<optimized out>, ec=0x5586fe420590) at /tmp/ruby/v3/src/trunk-mjit-wait/mjit.h:120
  #7  mjit_exec (ec=0x5586fe420590) at /tmp/ruby/v3/src/trunk-mjit-wait/mjit.h:159
  #8  rb_vm_exec (ec=<optimized out>, mjit_enable_p=true) at /tmp/ruby/v3/src/trunk-mjit-wait/vm.c:2159
  #9  0x00005586fc6d210f in invoke_block (captured=<optimized out>, opt_pc=<optimized out>, type=<optimized out>, cref=0x0, self=140550572423480, iseq=0x7fd47af13fc8, ec=0x5586fe420590) at /tmp/ruby/v3/src/trunk-mjit-wait/vm.c:1260
  #10 invoke_iseq_block_from_c (me=0x0, is_lambda=<optimized out>, cref=0x0, passed_block_handler=0, kw_splat=0, argv=0x7fd477106778, argc=1, self=140550572423480, captured=<optimized out>, ec=0x5586fe420590) at /tmp/ruby/v3/src/trunk-mjit-wait/vm.c:1332
  #11 invoke_block_from_c_bh (argc=<optimized out>, kw_splat=<optimized out>, passed_block_handler=<optimized out>, cref=<optimized out>, is_lambda=<optimized out>, force_blockarg=<optimized out>, argv=<optimized out>, block_handler=<optimized out>, ec=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/vm.c:1350
  #12 vm_yield (argc=1, kw_splat=0, argv=0x7fd477106778, ec=0x5586fe420590) at /tmp/ruby/v3/src/trunk-mjit-wait/vm.c:1395
  #13 rb_yield_0 (argv=0x7fd477106778, argc=1) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_eval.c:1344
  #14 rb_yield_1 (val=<optimized out>, val@entry=5) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_eval.c:1350
  #15 0x00005586fc58e3bc in int_dotimes (num=20001) at /tmp/ruby/v3/src/trunk-mjit-wait/include/ruby/internal/arithmetic/long.h:95
  #16 0x00005586fc6c387b in vm_call_cfunc_with_frame (ec=0x5586fe420590, reg_cfp=0x7fd477206c90, calling=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_insnhelper.c:2943
  #17 0x00005586fc6cfd39 in vm_call_method_each_type (ec=0x5586fe420590, cfp=0x7fd477206c90, calling=0x7fd4771069a0) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_insnhelper.c:3433
  #18 0x00005586fc6d0414 in vm_call_method (ec=0x5586fe420590, cfp=0x7fd477206c90, calling=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_insnhelper.c:3551
  #19 0x00005586fc6cddd3 in vm_sendish (ec=0x5586fe420590, reg_cfp=0x7fd477206c90, cd=0x5586fe4294d0, block_handler=<optimized out>, method_explorer=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_callinfo.h:336
  #20 0x00005586fc6d86bb in vm_exec_core (ec=0x5586fe420590, initial=128) at ../../src/trunk-mjit-wait/insns.def:754
  #21 0x00005586fc6cea2e in rb_vm_exec (ec=<optimized out>, mjit_enable_p=true) at /tmp/ruby/v3/src/trunk-mjit-wait/vm.c:2160
  #22 0x00005586fc686027 in thread_do_start_proc (th=0x5586fe420390) at /tmp/ruby/v3/src/trunk-mjit-wait/thread.c:718
  #23 0x00005586fc688d87 in thread_do_start (th=0x5586fe420390) at /tmp/ruby/v3/src/trunk-mjit-wait/thread.c:759
  #24 thread_start_func_2 (th=<optimized out>, stack_start=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/thread.c:824
  #25 0x00005586fc6896fb in thread_start_func_1 (th_ptr=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/thread_pthread.c:1051
  #26 0x00007fd47b438609 in start_thread (arg=<optimized out>) at pthread_create.c:477
  #27 0x00007fd47b13e293 in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:95
  
  Thread 2 (Thread 0x7fd477a0f700 (LWP 9158)):
  #0  0x00005586fc55deea in get_from_list (list=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/ccan/list/list.h:761
  #1  mjit_worker () at /tmp/ruby/v3/src/trunk-mjit-wait/mjit_worker.c:1477
  #2  0x00005586fc67e58e in mjit_worker (arg=0x5586fc55d850 <mjit_worker>) at /tmp/ruby/v3/src/trunk-mjit-wait/thread_pthread.c:2018
  #3  0x00007fd47b438609 in start_thread (arg=<optimized out>) at pthread_create.c:477
  #4  0x00007fd47b13e293 in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:95
  
  Thread 1 (Thread 0x7fd47b01ab80 (LWP 9157)):
  #0  futex_wait_cancelable (private=<optimized out>, expected=0, futex_word=0x5586fe34590c) at ../sysdeps/nptl/futex-internal.h:183
  #1  __pthread_cond_wait_common (abstime=0x0, clockid=0, mutex=0x5586fe3458b8, cond=0x5586fe3458e0) at pthread_cond_wait.c:508
  #2  __pthread_cond_wait (cond=cond@entry=0x5586fe3458e0, mutex=mutex@entry=0x5586fe3458b8) at pthread_cond_wait.c:638
  #3  0x00005586fc683c1d in rb_native_cond_wait (cond=cond@entry=0x5586fe3458e0, mutex=mutex@entry=0x5586fe3458b8) at /tmp/ruby/v3/src/trunk-mjit-wait/thread_pthread.c:545
  #4  0x00005586fc5ec4ec in ractor_cond_wait (r=0x5586fe345890) at /tmp/ruby/v3/src/trunk-mjit-wait/ractor.c:527
  #5  ractor_sleep_wo_gvl (ptr=ptr@entry=0x5586fe345890) at /tmp/ruby/v3/src/trunk-mjit-wait/ractor.c:527
  #6  0x00005586fc68b1ce in rb_nogvl (func=func@entry=0x5586fc5ec4a0 <ractor_sleep_wo_gvl>, data1=data1@entry=0x5586fe345890, ubf=<optimized out>, ubf@entry=0x5586fc5ec3c0 <ractor_sleep_interrupt>, data2=<optimized out>, data2@entry=0x5586fe345890, flags=flags@entry=3) at /tmp/ruby/v3/src/trunk-mjit-wait/thread.c:1673
  #7  0x00005586fc5f0d87 in ractor_sleep (ec=0x5586fe345680, cr=0x5586fe345890) at /tmp/ruby/v3/src/trunk-mjit-wait/ractor.c:590
  #8  ractor_select (ec=<optimized out>, rs=<optimized out>, rs_len=<optimized out>, yielded_value=<optimized out>, move=<optimized out>, ret_r=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/ractor.c:1235
  #9  0x00005586fc5f0ee1 in ractor_take (r=<optimized out>, ec=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/ractor.c:1335
  #10 builtin_inline_class_694 (ec=<optimized out>, self=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/ractor.rb:695
  #11 0x00005586fc6dbaef in invoke_bf (reg_cfp=<optimized out>, bf=<optimized out>, bf=<optimized out>, argv=<optimized out>, ec=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_insnhelper.c:5593
  #12 vm_invoke_builtin_delegate (start_index=<optimized out>, bf=<optimized out>, cfp=<optimized out>, ec=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_insnhelper.c:5593
  #13 vm_invoke_builtin_delegate (start_index=<optimized out>, bf=<optimized out>, cfp=<optimized out>, ec=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_insnhelper.c:5581
  #14 vm_exec_core (ec=0x5586fe345680, initial=128) at ../../src/trunk-mjit-wait/insns.def:1477
  #15 0x00005586fc6cea2e in rb_vm_exec (ec=<optimized out>, mjit_enable_p=true) at /tmp/ruby/v3/src/trunk-mjit-wait/vm.c:2160
  #16 0x00005586fc6d39e2 in vm_call0_body (ec=0x5586fe345680, calling=0x7ffd13b72ea0, argv=0x7ffd13b72f80) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_eval.c:178
  #17 0x00005586fc6d67b0 in vm_call0_cc (kw_splat=<optimized out>, cc=<optimized out>, argv=0x7ffd13b72f80, argc=0, id=6033, recv=140550572423480, ec=0x5586fe345680) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_eval.c:72
  #18 rb_call0 (ec=0x5586fe345680, recv=140550572423480, mid=6033, argc=0, argv=0x7ffd13b72f80, call_scope=<optimized out>, self=140550572424240) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_eval.c:520
  #19 0x00005586fc6d723f in rb_call (scope=CALL_PUBLIC_KW, argv=0x8, argc=0, mid=<optimized out>, recv=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_eval.c:845
  #20 rb_funcall_with_block_kw (recv=<optimized out>, mid=<optimized out>, argc=argc@entry=0, argv=argv@entry=0x7ffd13b72f80, passed_procval=passed_procval@entry=8, kw_splat=kw_splat@entry=0) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_eval.c:1192
  #21 0x00005586fc6718b0 in rb_sym_proc_call (mid=<optimized out>, argc=argc@entry=1, argv=argv@entry=0x7ffd13b72f78, kw_splat=kw_splat@entry=0, passed_proc=passed_proc@entry=8) at /tmp/ruby/v3/src/trunk-mjit-wait/string.c:11154
  #22 0x00005586fc6d28fc in vm_yield_with_symbol (block_handler=0, kw_splat=0, argv=0x7ffd13b72f78, argc=1, symbol=<optimized out>, ec=0x5586fe345680) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_insnhelper.c:3758
  #23 invoke_block_from_c_bh (argc=<optimized out>, kw_splat=<optimized out>, passed_block_handler=<optimized out>, cref=<optimized out>, is_lambda=<optimized out>, force_blockarg=<optimized out>, argv=<optimized out>, block_handler=<optimized out>, ec=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/vm.c:1359
  #24 vm_yield (argc=1, kw_splat=0, argv=0x7ffd13b72f78, ec=0x5586fe345680) at /tmp/ruby/v3/src/trunk-mjit-wait/vm.c:1395
  #25 rb_yield_0 (argv=0x7ffd13b72f78, argc=1) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_eval.c:1344
  #26 rb_yield (val=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_eval.c:1360
  #27 0x00005586fc44b4d6 in rb_ary_collect (ary=140550572424240) at /tmp/ruby/v3/src/trunk-mjit-wait/include/ruby/internal/core/rarray.h:172
  #28 0x00005586fc6c387b in vm_call_cfunc_with_frame (ec=0x5586fe345680, reg_cfp=0x7fd47b018fa0, calling=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_insnhelper.c:2943
  #29 0x00005586fc6cfd39 in vm_call_method_each_type (ec=0x5586fe345680, cfp=0x7fd47b018fa0, calling=0x7ffd13b731c0) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_insnhelper.c:3433
  #30 0x00005586fc6d0414 in vm_call_method (ec=0x5586fe345680, cfp=0x7fd47b018fa0, calling=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_insnhelper.c:3551
  #31 0x00005586fc6cddd3 in vm_sendish (ec=0x5586fe345680, reg_cfp=0x7fd47b018fa0, cd=0x5586fe42a6d0, block_handler=<optimized out>, method_explorer=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_callinfo.h:336
  #32 0x00005586fc6d86bb in vm_exec_core (ec=0x5586fe345680, initial=128) at ../../src/trunk-mjit-wait/insns.def:754
  #33 0x00005586fc6cea2e in rb_vm_exec (ec=<optimized out>, mjit_enable_p=true) at /tmp/ruby/v3/src/trunk-mjit-wait/vm.c:2160
  #34 0x00005586fc4e47ed in rb_ec_exec_node (ec=ec@entry=0x5586fe345680, n=n@entry=0x7fd47af0c200) at /tmp/ruby/v3/src/trunk-mjit-wait/eval.c:317
  #35 0x00005586fc4e980f in ruby_run_node (n=0x7fd47af0c200) at /tmp/ruby/v3/src/trunk-mjit-wait/eval.c:375
  #36 0x00005586fc440d23 in main (argc=<optimized out>, argv=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/main.c:47
  >>> Dump Ruby level backtrace
  $1 = 0
  ">>> Finish
  "[Inferior 1 (process 9157) detached]
  [nil, 9157]
  "timeout 60 gdb -p 3708 -x /home/ko1/ruby/build-ruby/gdbscript -batch -quiet"
  Fstderr output is not empty
     th: 0x5586fe344e10, native_id: 0x7fd47b01ab80
     -- Control frame information -----------------------------------------------
     c:0004 p:0003 s:0016 e:000015 METHOD <internal:ractor>:694 [FINISH]
       me:
         called_id: take, type: iseq
         owner class: 0x00007fd47aeddf90 [3LM   ] T_CLASS Ractor
       self: 0x00007fd47af13938 [0LM  U] ractor (Ractor)r:2
     c:0003 p:---- s:0012 e:000011 CFUNC  :map
       me:
         called_id: map, type: cfunc
         owner class: 0x00007fd47aec9c48 [3LM   ] T_CLASS Array
       self: 0x00007fd47af13c30 [3LM   ] T_ARRAY (Array)[E ] len: 3 (embed)
     c:0002 p:0017 s:0008 E:0026b8 EVAL   bootstraptest.tmp.rb:8 [FINISH]
       self: 0x00007fd47aeb84e8 [3LM   ] T_OBJECT (embed) len:3
       lvars:
         n: T_FIXNUM 3
     c:0001 p:0000 s:0003 E:0004c0 (none) [FINISH]
       self: 0x00007fd47aeb84e8 [3LM   ] T_OBJECT (embed) len:3
  [New LWP 3710]
  [Thread debugging using libthread_db enabled]
  Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
  26	../sysdeps/unix/sysv/linux/read.c: No such file or directory.
  __GI___libc_read (nbytes=8192, buf=0x55b767a01350, fd=6) at ../sysdeps/unix/sysv/linux/read.c:26
  >>> Threads  Id   Target Id                                        Frame 
  * 1    Thread 0x7ff63db16740 (LWP 3708) "ruby"          __GI___libc_read (nbytes=8192, buf=0x55b767a01350, fd=6) at ../sysdeps/unix/sysv/linux/read.c:26
    2    Thread 0x7ff63a5bc700 (LWP 3710) "runner.rb:476" __GI___libc_read (nbytes=8192, buf=0x7ff634005040, fd=5) at ../sysdeps/unix/sysv/linux/read.c:26
  >>> Machine level backtrace
  
  Thread 2 (Thread 0x7ff63a5bc700 (LWP 3710)):
  #0  __GI___libc_read (nbytes=8192, buf=0x7ff634005040, fd=5) at ../sysdeps/unix/sysv/linux/read.c:26
  #1  __GI___libc_read (fd=5, buf=0x7ff634005040, nbytes=8192) at ../sysdeps/unix/sysv/linux/read.c:24
  #2  0x00007ff63e021799 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #3  0x00007ff63e12e3ff in rb_thread_io_blocking_region () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #4  0x00007ff63e0283ea in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #5  0x00007ff63dffb797 in rb_ensure () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #6  0x00007ff63e0231ac in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #7  0x00007ff63e027b66 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #8  0x00007ff63e02abbb in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #9  0x00007ff63e15d026 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #10 0x00007ff63e150406 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #11 0x00007ff63e1610ba in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #12 0x00007ff63e167870 in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #13 0x00007ff63e16b336 in rb_vm_invoke_proc () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #14 0x00007ff63e12cac3 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #15 0x00007ff63e12ec10 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #16 0x00007ff63e12f04d in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #17 0x00007ff63dd43609 in start_thread (arg=<optimized out>) at pthread_create.c:477
  #18 0x00007ff63de7f293 in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:95
  
  Thread 1 (Thread 0x7ff63db16740 (LWP 3708)):
  #0  __GI___libc_read (nbytes=8192, buf=0x55b767a01350, fd=6) at ../sysdeps/unix/sysv/linux/read.c:26
  #1  __GI___libc_read (fd=6, buf=0x55b767a01350, nbytes=8192) at ../sysdeps/unix/sysv/linux/read.c:24
  #2  0x00007ff63e021799 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #3  0x00007ff63e12e3ff in rb_thread_io_blocking_region () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #4  0x00007ff63e0283ea in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #5  0x00007ff63dffb797 in rb_ensure () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #6  0x00007ff63e0231ac in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #7  0x00007ff63e027b66 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #8  0x00007ff63e033f77 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #9  0x00007ff63e15d026 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #10 0x00007ff63e150406 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #11 0x00007ff63e1610ba in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #12 0x00007ff63e167870 in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #13 0x00007ff63e041663 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #14 0x00007ff63e04180b in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #15 0x00007ff63e15d026 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #16 0x00007ff63e150406 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #17 0x00007ff63e1610ba in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #18 0x00007ff63e167870 in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #19 0x00007ff63e1749f1 in rb_yield () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #20 0x00007ff63df7c45c in rb_ary_each () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #21 0x00007ff63e15d026 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #22 0x00007ff63e169dab in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #23 0x00007ff63e150406 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #24 0x00007ff63e161131 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #25 0x00007ff63e167870 in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #26 0x00007ff63e1749f1 in rb_yield () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #27 0x00007ff63dffb797 in rb_ensure () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #28 0x00007ff63dfdbebf in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #29 0x00007ff63e15d026 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #30 0x00007ff63e169dab in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #31 0x00007ff63e150406 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #32 0x00007ff63e161131 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #33 0x00007ff63e167870 in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #34 0x00007ff63dff8491 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #35 0x00007ff63dffd2ee in ruby_run_node () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
  #36 0x000055b765c5c17f in ?? ()
  #37 0x00007ff63dd840b3 in __libc_start_main (main=0x55b765c5c120, argc=4, argv=0x7ffcee0cbf98, init=<optimized out>, fini=<optimized out>, rtld_fini=<optimized out>, stack_end=0x7ffcee0cbf88) at ../csu/libc-start.c:308
  #38 0x000055b765c5c1ce in _start ()
  >>> Dump Ruby level backtrace
  /home/ko1/ruby/build-ruby/gdbscript:12: Error in sourced command file:
  No symbol "rb_vmdebug_stack_dump_all_threads" in current context.
  [Inferior 1 (process 3708) detached]
  .[nil, 3708]
  "timeout 60 gdb -p 3702 -x /home/ko1/ruby/build-ruby/gdbscript -batch -quiet"
  make: *** [uncommon.mk:763: yes-btest] Killed
  ptrace: No such process.
  >>> ThreadsNo threads.
  >>> Machine level backtrace
  >>> Dump Ruby level backtrace
  /home/ko1/ruby/build-ruby/gdbscript:12: Error in sourced command file:
  No symbol table is loaded.  Use the "file" command.
  [nil, 3702]
  #<Errno::ESRCH: No such process>
  "timeout 60 gdb -p 3701 -x /home/ko1/ruby/build-ruby/gdbscript -batch -quiet"
  Could not attach to process.  If your uid matches the uid of the target
  process, check the setting of /proc/sys/kernel/yama/ptrace_scope, or try
  again as the root user.  For more details, see /etc/sysctl.d/10-ptrace.conf
  warning: process 3701 is a zombie - the process has already terminated
  ptrace: Operation not permitted.
  >>> ThreadsNo threads.
  >>> Machine level backtrace
  >>> Dump Ruby level backtrace
  /home/ko1/ruby/build-ruby/gdbscript:12: Error in sourced command file:
  No symbol table is loaded.  Use the "file" command.
  [nil, 3701]
  "timeout 60 gdb -p 9164 -x /home/ko1/ruby/build-ruby/gdbscript -batch -quiet"
  ptrace: No such process.
  >>> ThreadsNo threads.
  >>> Machine level backtrace
  >>> Dump Ruby level backtrace
  /home/ko1/ruby/build-ruby/gdbscript:12: Error in sourced command file:
  No symbol table is loaded.  Use the "file" command.
  [nil, 9164]
  #<Errno::ESRCH: No such process>
    0.008000   0.000000 17999.036000 (18002.082914)
  /home/ko1/ruby/build-ruby/build-ruby.rb:174:in `each_line': execution expired (Timeout::Error)
  	from /home/ko1/ruby/build-ruby/build-ruby.rb:174:in `block (2 levels) in cmd'
  	from /usr/lib/ruby/2.7.0/timeout.rb:110:in `timeout'
  	from /home/ko1/ruby/build-ruby/build-ruby.rb:173:in `block in cmd'
  	from /home/ko1/ruby/build-ruby/build-ruby.rb:170:in `popen'
  	from /home/ko1/ruby/build-ruby/build-ruby.rb:170:in `cmd'
  	from /home/ko1/ruby/build-ruby/build-ruby.rb:308:in `block in test_btest'
  	from /home/ko1/ruby/build-ruby/build-ruby.rb:243:in `block in builddir'
  	from /home/ko1/ruby/build-ruby/build-ruby.rb:242:in `chdir'
  	from /home/ko1/ruby/build-ruby/build-ruby.rb:242:in `builddir'
  	from /home/ko1/ruby/build-ruby/build-ruby.rb:307:in `test_btest'
  	from /home/ko1/ruby/build-ruby/build-ruby.rb:382:in `block (4 levels) in run'
  	from /usr/lib/ruby/2.7.0/benchmark.rb:293:in `measure'
  	from /usr/lib/ruby/2.7.0/benchmark.rb:375:in `item'
  	from /home/ko1/ruby/build-ruby/build-ruby.rb:380:in `block (3 levels) in run'
  	from /home/ko1/ruby/build-ruby/build-ruby.rb:379:in `each'
  	from /home/ko1/ruby/build-ruby/build-ruby.rb:379:in `block (2 levels) in run'
  	from /usr/lib/ruby/2.7.0/benchmark.rb:173:in `benchmark'
  	from /usr/lib/ruby/2.7.0/benchmark.rb:205:in `bm'
  	from /home/ko1/ruby/build-ruby/build-ruby.rb:378:in `block in run'
  	from /usr/lib/ruby/2.7.0/benchmark.rb:293:in `measure'
  	from /home/ko1/ruby/build-ruby/build-ruby.rb:377:in `run'
  	from /home/ko1/ruby/build-ruby/build-ruby.rb:551:in `<main>'
  total: 18028.16 sec