Result of trunk-mjit-wait@phosphorus-docker at 2021-01-08 23:48:55 +0900

• NG (98bd7e87a0) [LOG]

• Linux phosphorus-docker 4.9.0-14-amd64 #1 SMP Debian 4.9.246-2 (2020-12-17) x86_64 x86_64 x86_64 GNU/Linux
  

• rev: 98bd7e87a0
  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.
    "make yes-btest RUN_OPTS=\"--disable-gems --jit-debug=-ggdb3 --jit-wait --jit-warnings --jit-min-calls=5\"" exit with 0.
    "make yes-test-basic RUN_OPTS=\"--disable-gems --jit-debug=-ggdb3 --jit-wait --jit-warnings --jit-min-calls=5\"" exit with 0.
  Logfile: /home/ko1/ruby/logs/brlog.trunk-mjit-wait.20210108-093219
  #<BuildRuby:0x0000555d4e44b460
   @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.20210108-093219",
   @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.004000   0.004000 (  0.000020)
  autoconf               0.000000   0.000000   0.000000 (  0.000042)
  configure              0.000000   0.000000   0.000000 (  0.000036)
  build_up             From https://github.com/ruby/ruby
     d4b7e96..98bd7e8  master     -> origin/master
    0.008000   0.004000  12.824000 ( 12.410655)
  build_miniruby         0.000000   0.000000   0.164000 (  0.179746)
  build_ruby             0.000000   0.004000   3.444000 (  3.209340)
  build_all              0.012000   0.004000  54.288000 ( 13.464997)
  build_install          0.012000   0.012000  48.476000 ( 14.862867)
  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           ..................................................................................
  test_string.rb           .
  test_struct.rb           .
  test_syntax.rb           ............................................................................................................................................................
  test_thread.rb           .................................................
  Fiber count: 10000 (skipping)
  PASS all 1481 tests
    0.000000   0.000000 960.352000 (945.195968)
  test_basic             0.004000   0.008000   5.796000 (  4.559312)
  test_all             MJIT warning: Skipped to compile unsupported instruction: defineclass
  MJIT warning: Skipped to compile unsupported instruction: defineclass
  Skipping Gem::PackageTask tests.  rake not found.
  MJIT warning: Skipped to compile unsupported instruction: defineclass
  MJIT warning: Skipped to compile unsupported instruction: defineclass
  MJIT warning: failure in loading code from '/tmp/_ruby_mjit_p14181u1336.so': /tmp/_ruby_mjit_p14181u1336.so: undefined symbol: rb_float_abs
  MJIT warning: failure in loading code from '/tmp/_ruby_mjit_p14181u1534.so': /tmp/_ruby_mjit_p14181u1534.so: undefined symbol: flo_iszero
  MJIT warning: timed out to wait for JIT finish
  MJIT warning: timed out to wait for JIT finish
  MJIT warning: timed out to wait for JIT finish
  MJIT warning: timed out to wait for JIT finish
  MJIT warning: timed out to wait for JIT finish
  MJIT warning: timed out to wait for JIT finish
  MJIT warning: timed out to wait for JIT finish
  MJIT warning: timed out to wait for JIT finish
  MJIT warning: timed out to wait for JIT finish
  $$$ #<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  5293    11    11 ?           -1 Sl    1001   0:00 ruby ./br.rb build_report trunk-mjit-wait --incremental --process-num=6
   5293  5295    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.20210108-093219 --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
   5295  5296    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.20210108-093219 --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
   5296 14173    11    11 ?           -1 S     1001   0:00 sh -c make yes-test-all RUN_OPTS="--disable-gems --jit-debug=-ggdb3 --jit-wait --jit-warnings --jit-min-calls=5"
  14173 14174    11    11 ?           -1 S     1001   0:00 make yes-test-all RUN_OPTS=--disable-gems --jit-debug=-ggdb3 --jit-wait --jit-warnings --jit-min-calls=5
  14174 14181    11    11 ?           -1 Sl    1001   2:58 /tmp/ruby/v3/src/trunk-mjit-wait/test/runner.rb
   5296 30170    11    11 ?           -1 R     1001   0:00 ps jx
  {10=>[11], 11=>[5293], 5293=>[5295], 5295=>[5296], 5296=>[14173, 30170], 14173=>[14174], 14174=>[14181]}
  "timeout 60 gdb -p 14181 -x /home/ko1/ruby/build-ruby/gdbscript -batch -quiet"
  [New LWP 29427]
  [New LWP 30129]
  
  warning: Could not load shared library symbols for 1251 libraries, e.g. /tmp/_ruby_mjit_p14181u2.so.
  Use the "info sharedlibrary" command to see the complete listing.
  Do you need "set solib-search-path" or "set sysroot"?
  [Thread debugging using libthread_db enabled]
  Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
  44	../sysdeps/unix/sysv/linux/ppoll.c: No such file or directory.
  0x00007f08a100cbf6 in __ppoll (fds=fds@entry=0x7ffc08447d50, nfds=nfds@entry=2, timeout=<optimized out>, sigmask=sigmask@entry=0x0) at ../sysdeps/unix/sysv/linux/ppoll.c:44
  >>> Threads  Id   Target Id                                           Frame 
  * 1    Thread 0x7f08a0ef5b80 (LWP 14181) "ruby"            0x00007f08a100cbf6 in __ppoll (fds=fds@entry=0x7ffc08447d50, nfds=nfds@entry=2, timeout=<optimized out>, sigmask=sigmask@entry=0x0) at ../sysdeps/unix/sysv/linux/ppoll.c:44
    2    Thread 0x7f0895bd6700 (LWP 29427) "ruby-mjitworker" futex_wait_cancelable (private=<optimized out>, expected=0, futex_word=0x55d772d3b84c <mjit_worker_wakeup+44>) at ../sysdeps/nptl/futex-internal.h:183
    3    Thread 0x7f0896d9a700 (LWP 30129) "test_smtp.rb:2*" 0x00007f08a100f12b in __GI___select (nfds=nfds@entry=8, readfds=readfds@entry=0x7f088400f4d0, writefds=writefds@entry=0x0, exceptfds=exceptfds@entry=0x0, timeout=0x0) at ../sysdeps/unix/sysv/linux/select.c:41
  >>> Machine level backtrace
  
  Thread 3 (Thread 0x7f0896d9a700 (LWP 30129)):
  #0  0x00007f08a100f12b in __GI___select (nfds=nfds@entry=8, readfds=readfds@entry=0x7f088400f4d0, writefds=writefds@entry=0x0, exceptfds=exceptfds@entry=0x0, timeout=0x0) at ../sysdeps/unix/sysv/linux/select.c:41
  #1  0x000055d772b19442 in rb_fd_select (timeout=<optimized out>, exceptfds=<optimized out>, writefds=<optimized out>, readfds=<optimized out>, n=8) at /tmp/ruby/v3/src/trunk-mjit-wait/thread.c:4055
  #2  native_fd_select (th=<optimized out>, timeout=<optimized out>, exceptfds=<optimized out>, writefds=<optimized out>, readfds=<optimized out>, n=8) at /tmp/ruby/v3/src/trunk-mjit-wait/thread_pthread.c:1186
  #3  do_select (p=p@entry=139674866257952) at /tmp/ruby/v3/src/trunk-mjit-wait/thread.c:4226
  #4  0x000055d772983a14 in rb_ensure (b_proc=b_proc@entry=0x55d772b19230 <do_select>, data1=data1@entry=139674866257952, e_proc=e_proc@entry=0x55d772b0dc50 <select_set_free>, data2=data2@entry=139674866257952) at /tmp/ruby/v3/src/trunk-mjit-wait/eval.c:1158
  #5  0x000055d772b1bd8e in rb_thread_fd_select (max=max@entry=8, read=read@entry=0x7f0896c992e0, write=write@entry=0x0, except=except@entry=0x0, timeout=timeout@entry=0x0) at /tmp/ruby/v3/src/trunk-mjit-wait/thread.c:4352
  #6  0x000055d7729c2745 in select_internal (fds=<optimized out>, tp=0x0, except=<optimized out>, write=<optimized out>, read=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/io.c:9338
  #7  select_call (arg=arg@entry=139674866258624) at /tmp/ruby/v3/src/trunk-mjit-wait/io.c:9408
  #8  0x000055d772983a14 in rb_ensure (b_proc=b_proc@entry=0x55d7729c2410 <select_call>, data1=data1@entry=139674866258624, e_proc=e_proc@entry=0x55d7729be900 <select_end>, data2=data2@entry=139674866258624) at /tmp/ruby/v3/src/trunk-mjit-wait/eval.c:1158
  #9  0x000055d7729be841 in rb_f_select (argc=<optimized out>, argv=<optimized out>, obj=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/io.c:9756
  #10 0x00007f0894dfeded in ?? ()
  #11 0x0000000000000000 in ?? ()
  
  Thread 2 (Thread 0x7f0895bd6700 (LWP 29427)):
  #0  futex_wait_cancelable (private=<optimized out>, expected=0, futex_word=0x55d772d3b84c <mjit_worker_wakeup+44>) at ../sysdeps/nptl/futex-internal.h:183
  #1  __pthread_cond_wait_common (abstime=0x0, clockid=0, mutex=0x55d772d3b8e0 <mjit_engine_mutex>, cond=0x55d772d3b820 <mjit_worker_wakeup>) at pthread_cond_wait.c:508
  #2  __pthread_cond_wait (cond=cond@entry=0x55d772d3b820 <mjit_worker_wakeup>, mutex=mutex@entry=0x55d772d3b8e0 <mjit_engine_mutex>) at pthread_cond_wait.c:638
  #3  0x000055d772b12ddd in rb_native_cond_wait (cond=cond@entry=0x55d772d3b820 <mjit_worker_wakeup>, mutex=mutex@entry=0x55d772d3b8e0 <mjit_engine_mutex>) at /tmp/ruby/v3/src/trunk-mjit-wait/thread_pthread.c:503
  #4  0x000055d7729f4221 in mjit_worker () at /tmp/ruby/v3/src/trunk-mjit-wait/mjit_worker.c:1371
  #5  0x000055d772b0d7fe in mjit_worker (arg=0x55d7729f4110 <mjit_worker>) at /tmp/ruby/v3/src/trunk-mjit-wait/thread_pthread.c:1941
  #6  0x00007f08a1313609 in start_thread (arg=<optimized out>) at pthread_create.c:477
  #7  0x00007f08a1019293 in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:95
  
  Thread 1 (Thread 0x7f08a0ef5b80 (LWP 14181)):
  #0  0x00007f08a100cbf6 in __ppoll (fds=fds@entry=0x7ffc08447d50, nfds=nfds@entry=2, timeout=<optimized out>, sigmask=sigmask@entry=0x0) at ../sysdeps/unix/sysv/linux/ppoll.c:44
  #1  0x000055d772b16562 in native_ppoll_sleep (th=th@entry=0x55d773c62e20, rel=rel@entry=0x0) at /tmp/ruby/v3/src/trunk-mjit-wait/hrtime.h:148
  #2  0x000055d772b188fa in native_sleep (th=th@entry=0x55d773c62e20, rel=0x0) at /tmp/ruby/v3/src/trunk-mjit-wait/thread_pthread.c:2166
  #3  0x000055d772b18ce5 in thread_join_sleep (arg=arg@entry=140720447192864) at /tmp/ruby/v3/src/trunk-mjit-wait/thread.c:1189
  #4  0x000055d772983a14 in rb_ensure (b_proc=b_proc@entry=0x55d772b18ad0 <thread_join_sleep>, data1=data1@entry=140720447192864, e_proc=e_proc@entry=0x55d772b0d420 <remove_from_join_list>, data2=data2@entry=140720447192864) at /tmp/ruby/v3/src/trunk-mjit-wait/eval.c:1158
  #5  0x000055d772b11bfd in thread_join (timeout=8, target_th=0x55d77beea470) at /tmp/ruby/v3/src/trunk-mjit-wait/thread.c:1239
  #6  thread_join_m (argc=<optimized out>, argv=<optimized out>, self=94383979230480) at /tmp/ruby/v3/src/trunk-mjit-wait/thread.c:1332
  #7  0x000055d772b5287b in vm_call_cfunc_with_frame (ec=0x55d773c63680, reg_cfp=0x7f08a0ef38d8, calling=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_insnhelper.c:2896
  #8  0x000055d772b68b30 in vm_sendish (method_explorer=<optimized out>, block_handler=<optimized out>, cd=<optimized out>, reg_cfp=<optimized out>, ec=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_callinfo.h:336
  #9  vm_exec_core (ec=0x55d773c63680, initial=2) at ../../src/trunk-mjit-wait/insns.def:789
  #10 0x000055d772b5d16e in rb_vm_exec (ec=<optimized out>, mjit_enable_p=true) at /tmp/ruby/v3/src/trunk-mjit-wait/vm.c:2162
  #11 0x000055d772b60d4e in invoke_block (captured=<optimized out>, opt_pc=<optimized out>, type=<optimized out>, cref=0x0, self=94383979232400, iseq=0x55d7749008e8, ec=0x55d773c63680) at /tmp/ruby/v3/src/trunk-mjit-wait/vm.c:1262
  #12 invoke_iseq_block_from_c (me=0x0, is_lambda=<optimized out>, cref=0x0, passed_block_handler=0, kw_splat=0, argv=0x7ffc08448270, argc=1, self=94383979232400, captured=<optimized out>, ec=0x55d773c63680) at /tmp/ruby/v3/src/trunk-mjit-wait/vm.c:1334
  #13 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:1352
  #14 vm_yield (argc=1, kw_splat=0, argv=0x7ffc08448270, ec=0x55d773c63680) at /tmp/ruby/v3/src/trunk-mjit-wait/vm.c:1397
  #15 rb_yield_0 (argv=0x7ffc08448270, argc=1) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_eval.c:1171
  #16 rb_yield_1 (val=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_eval.c:1177
  #17 rb_yield (val=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_eval.c:1187
  #18 0x000055d772b889fc in rb_ary_each (ary=94383979231640) at /tmp/ruby/v3/src/trunk-mjit-wait/include/ruby/internal/core/rarray.h:172
  #19 0x000055d772b5287b in vm_call_cfunc_with_frame (ec=0x55d773c63680, reg_cfp=0x7f08a0ef3948, calling=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_insnhelper.c:2896
  #20 0x000055d772b5e479 in vm_call_method_each_type (ec=0x55d773c63680, cfp=0x7f08a0ef3948, calling=0x7ffc08448560) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_insnhelper.c:3386
  #21 0x000055d772b5eb54 in vm_call_method (ec=0x55d773c63680, cfp=0x7f08a0ef3948, calling=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_insnhelper.c:3504
  #22 0x000055d772b5e8d7 in vm_call_refined (calling=0x7ffc08448560, cfp=0x7f08a0ef3948, ec=0x55d773c63680) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_insnhelper.c:3365
  #23 vm_call_method_each_type (ec=0x55d773c63680, cfp=0x7f08a0ef3948, calling=0x7ffc08448560) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_insnhelper.c:3443
  #24 0x000055d772b5eb54 in vm_call_method (ec=0x55d773c63680, cfp=0x7f08a0ef3948, calling=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_insnhelper.c:3504
  #25 0x00007f0894b3e4e9 in ?? ()
  #26 0x00000bb100000001 in ?? ()
  #27 0x00007ffc08448490 in ?? ()
  #28 0x00007f08a0ef3961 in ?? ()
  #29 0x000055d77b8df998 in ?? ()
  #30 0x0000000000000000 in ?? ()
  >>> Dump Ruby level backtrace
  th: 0x55d773c62e20, native_id: 0x7f08a0ef5b80
  -- Control frame information -----------------------------------------------
  c:0034 p:---- s:0183 e:000182 CFUNC  :join
    me:
      called_id: join, type: cfunc
      owner class: 0x000055d773cd5730 [3LM R ] T_CLASS Thread
    self: 0x000055d77b8df510 [0    U] VM/thread (Thread)VM/thread
  c:0033 p:0005 s:0179 e:000178 BLOCK  /tmp/ruby/v3/src/trunk-mjit-wait/test/net/smtp/test_smtp.rb:47 [FINISH]
    me:
      called_id: teardown, type: iseq
      owner class: 0x000055d7748d2538 [3LM R ] T_CLASS Net::TestSMTP
    self: 0x000055d77b8dfc90 [0     ] T_OBJECT (Net::TestSMTP)len:8 ptr:0x00007f08a0bd4c10
    lvars:
      th: 0x000055d77b8df510 [0    U] VM/thread (Thread)VM/thread
  c:0032 p:---- s:0175 e:000174 CFUNC  :each
    me:
      called_id: each, type: cfunc
      owner class: 0x000055d773cfdcf8 [3LM R ] T_CLASS Array
    self: 0x000055d77b8df998 [0     ] T_ARRAY (Array)[E ] len: 1 (embed)
  c:0031 p:0006 s:0171 e:000170 METHOD /tmp/ruby/v3/src/trunk-mjit-wait/test/net/smtp/test_smtp.rb:47
    me:
      called_id: teardown, type: iseq
      owner class: 0x000055d7748d2538 [3LM R ] T_CLASS Net::TestSMTP
    self: 0x000055d77b8dfc90 [0     ] T_OBJECT (Net::TestSMTP)len:8 ptr:0x00007f08a0bd4c10
  c:0030 p:0006 s:0167 e:000166 BLOCK  /tmp/ruby/v3/src/trunk-mjit-wait/tool/lib/minitest/unit.rb:1335 [FINISH]
    me:
      called_id: run, type: iseq
      owner class: 0x000055d773e3f620 [3LM R ] T_CLASS MiniTest::Unit::TestCase
    self: 0x000055d77b8dfc90 [0     ] T_OBJECT (Net::TestSMTP)len:8 ptr:0x00007f08a0bd4c10
    lvars:
      hook: 0x000055d773e67710 [3LM   ] T_STRING (String)teardown
  c:0029 p:---- s:0163 e:000162 CFUNC  :each
    me:
      called_id: each, type: cfunc
      owner class: 0x000055d773cfdcf8 [3LM R ] T_CLASS Array
    self: 0x000055d77b8dd1e8 [0     ] T_ARRAY (Array)[E ] len: 3 (embed)
  c:0028 p:0122 s:0159 e:000158 METHOD /tmp/ruby/v3/src/trunk-mjit-wait/tool/lib/minitest/unit.rb:1333 [FINISH]
    me:
      called_id: run, type: iseq
      owner class: 0x000055d773e3f620 [3LM R ] T_CLASS MiniTest::Unit::TestCase
    self: 0x000055d77b8dfc90 [0     ] T_OBJECT (Net::TestSMTP)len:8 ptr:0x00007f08a0bd4c10
    lvars:
      runner: 0x000055d773fcdac8 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x000055d77b582a30
      start_time: 0x000055d77b8dfc40 [0    U] time (Time)time
      result: 0x000055d77b8dd210 [0     ] T_STRING (String)E
      time: T_FLOAT
      e: 0x000055d77b8dea20 [0     ] T_OBJECT (Net::OpenTimeout)len:5 ptr:0x00007f08a0bd4e38
  c:0027 p:0013 s:0150 e:000149 METHOD /tmp/ruby/v3/src/trunk-mjit-wait/tool/lib/test/unit/testcase.rb:18
    me:
      called_id: run, type: iseq
      owner class: 0x000055d773fbc908 [3LM   ] T_CLASS Test::Unit::TestCase
    self: 0x000055d77b8dfc90 [0     ] T_OBJECT (Net::TestSMTP)len:8 ptr:0x00007f08a0bd4c10
    lvars:
      runner: 0x000055d773fcdac8 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x000055d77b582a30
  c:0026 p:0077 s:0145 e:000144 BLOCK  /tmp/ruby/v3/src/trunk-mjit-wait/tool/lib/minitest/unit.rb:969 [FINISH]
    me:
      called_id: _run_suite, type: iseq
      owner class: 0x000055d773e48dd8 [3LM   ] T_CLASS MiniTest::Unit
    self: 0x000055d773fcdac8 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x000055d77b582a30
    lvars:
      method: 0x000055d77b90ebf8 [0     ] T_STRING (String) [shared] test_start_instance_with_position_argument
      inst: 0x000055d77b8dfc90 [0     ] T_OBJECT (Net::TestSMTP)len:8 ptr:0x00007f08a0bd4c10
      start_time: T_NIL
      result: T_NIL
  c:0025 p:---- s:0138 e:000137 CFUNC  :map
    me:
      called_id: map, type: cfunc
      owner class: 0x000055d773cfdcf8 [3LM R ] T_CLASS Array
    self: 0x000055d77b90eae0 [0     ] T_ARRAY (Array)[  T] len: 20, capa:20 ptr:0x00007f08a0bd1aa0
  c:0024 p:0006 s:0134 e:000133 BLOCK  /tmp/ruby/v3/src/trunk-mjit-wait/tool/lib/minitest/unit.rb:962 [FINISH]
    me:
      called_id: _run_suite, type: iseq
      owner class: 0x000055d773e48dd8 [3LM   ] T_CLASS MiniTest::Unit
    self: 0x000055d773fcdac8 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x000055d77b582a30
    lvars:
      assertions: T_NIL
  c:0023 p:0163 s:0130 E:000c60 METHOD /tmp/ruby/v3/src/trunk-mjit-wait/tool/lib/minitest/unit.rb:989 [FINISH]
    me:
      called_id: _run_suite, type: iseq
      owner class: 0x000055d773e48dd8 [3LM   ] T_CLASS MiniTest::Unit
    self: 0x000055d773fcdac8 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x000055d77b582a30
    lvars:
      suite: 0x000055d7748d2538 [3LM R ] T_CLASS Net::TestSMTP
      type: T_SYMBOL test
      header: 0x000055d77b90f058 [0     ] T_STRING (String)test_suite_header
      filter: 0x000055d77406a120 [3LM   ] T_REGEXP 
      all_test_methods: 0x000055d77b90eb30 [0     ] T_ARRAY (Array)[   ] len: 20, capa:20 ptr:0x000055d77bee3bf0
      filtered_test_methods: 0x000055d77b90eae0 [0     ] T_ARRAY (Array)[  T] len: 20, capa:20 ptr:0x00007f08a0bd1aa0
      leakchecker: 0x000055d77b90e860 [0     ] T_OBJECT (LeakChecker)len:7 ptr:0x00007f08a0bd1dd0
      continuation: 0x000055d77b90d190 [0     ] proc (Proc) block in _run_suite@/tmp/ruby/v3/src/trunk-mjit-wait/tool/lib/minitest/unit.rb:961
  c:0022 p:0042 s:0118 e:000117 METHOD /tmp/ruby/v3/src/trunk-mjit-wait/tool/lib/test/unit.rb:1136
    me:
      called_id: _run_suite, type: iseq
      owner class: 0x000055d773fc6700 [3LM   ] T_MODULE (Module)Test::Unit::ExcludesOption
      defined_class: 0x000055d773fc5da0 [3LM   ] T_ICLASS src:Test::Unit::ExcludesOption
    self: 0x000055d773fcdac8 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x000055d77b582a30
    lvars:
      suite: 0x000055d7748d2538 [3LM R ] T_CLASS Net::TestSMTP
      type: T_SYMBOL test
      ex: T_NIL
  c:0021 p:0010 s:0111 e:000109 BLOCK  /tmp/ruby/v3/src/trunk-mjit-wait/tool/lib/test/unit.rb:627 [FINISH]
    me:
      called_id: _run_suites, type: iseq
      owner class: 0x000055d773fbc3b8 [3LM   ] T_MODULE (Module)Test::Unit::Parallel
      defined_class: 0x000055d773fc5fd0 [3LM   ] T_ICLASS src:Test::Unit::Parallel
    self: 0x000055d773fcdac8 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x000055d77b582a30
    lvars:
      suite: 0x000055d7748d2538 [3LM R ] T_CLASS Net::TestSMTP
      e: T_NIL
  c:0020 p:---- s:0105 e:000104 CFUNC  :each
    me:
      called_id: each, type: cfunc
      owner class: 0x000055d773cfdcf8 [3LM R ] T_CLASS Array
    self: 0x000055d77b5dfd88 [3LM   ] T_ARRAY (Array)[   ] len: 957, capa:957 ptr:0x000055d77b1c8010
  c:0019 p:0054 s:0101 e:000100 METHOD /tmp/ruby/v3/src/trunk-mjit-wait/tool/lib/test/unit.rb:625
    me:
      called_id: _run_suites, type: iseq
      owner class: 0x000055d773fbc3b8 [3LM   ] T_MODULE (Module)Test::Unit::Parallel
      defined_class: 0x000055d773fc5fd0 [3LM   ] T_ICLASS src:Test::Unit::Parallel
    self: 0x000055d773fcdac8 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x000055d77b582a30
    lvars:
      suites: 0x000055d77b5dfd88 [3LM   ] T_ARRAY (Array)[   ] len: 957, capa:957 ptr:0x000055d77b1c8010
      type: T_SYMBOL test
      result: 0x000055d77b8cdd60 [3LM R ] T_ARRAY (Array)[   ] len: 91, capa:128 ptr:0x000055d77c510180
  c:0018 p:0008 s:0094 e:000093 METHOD /tmp/ruby/v3/src/trunk-mjit-wait/tool/lib/test/unit.rb:662
    me:
      called_id: _run_suites, type: iseq
      owner class: 0x000055d773fc7358 [3LM   ] T_MODULE (Module)Test::Unit::Skipping
      defined_class: 0x000055d773fc5f30 [3LM R ] T_ICLASS src:Test::Unit::Skipping
    self: 0x000055d773fcdac8 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x000055d77b582a30
    lvars:
      suites: 0x000055d77b5dfd88 [3LM   ] T_ARRAY (Array)[   ] len: 957, capa:957 ptr:0x000055d77b1c8010
      type: T_SYMBOL test
      result: T_NIL
  c:0017 p:0140 s:0087 e:000086 METHOD /tmp/ruby/v3/src/trunk-mjit-wait/tool/lib/minitest/unit.rb:904
    me:
      called_id: _run_anything, type: iseq
      owner class: 0x000055d773e48dd8 [3LM   ] T_CLASS MiniTest::Unit
    self: 0x000055d773fcdac8 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x000055d77b582a30
    lvars:
      type: T_SYMBOL test
      suites: 0x000055d77b5dfd88 [3LM   ] T_ARRAY (Array)[   ] len: 957, capa:957 ptr:0x000055d77b1c8010
      test_count: T_FIXNUM 0
      assertion_count: T_FIXNUM 0
      sync: T_TRUE
      old_sync: T_FALSE
      start: 0x000055d77b5b6258 [0    U] time (Time)time
      results: T_NIL
      t: T_NIL
  c:0016 p:0016 s:0074 e:000073 METHOD /tmp/ruby/v3/src/trunk-mjit-wait/tool/lib/test/unit.rb:1073
    me:
      called_id: _run_anything, type: iseq
      owner class: 0x000055d773fc67c8 [3LM   ] T_MODULE (Module)Test::Unit::RepeatOption
      defined_class: 0x000055d773fc5e90 [3LM   ] T_ICLASS src:Test::Unit::RepeatOption
    self: 0x000055d773fcdac8 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x000055d77b582a30
    lvars:
      type: T_SYMBOL test
  c:0015 p:0005 s:0069 e:000068 METHOD /tmp/ruby/v3/src/trunk-mjit-wait/tool/lib/minitest/unit.rb:1137
    me:
      called_id: run_tests, type: iseq
      owner class: 0x000055d773e48dd8 [3LM   ] T_CLASS MiniTest::Unit
    self: 0x000055d773fcdac8 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x000055d77b582a30
  c:0014 p:0006 s:0065 e:000064 BLOCK  /tmp/ruby/v3/src/trunk-mjit-wait/tool/lib/minitest/unit.rb:1124 [FINISH]
    me:
      called_id: _run, type: iseq
      owner class: 0x000055d773e48dd8 [3LM   ] T_CLASS MiniTest::Unit
    self: 0x000055d773fcdac8 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x000055d77b582a30
    lvars:
      plugin: 0x000055d773e834b0 [3LM   ] T_STRING (String)run_tests
  c:0013 p:---- s:0061 e:000060 CFUNC  :each
    me:
      called_id: each, type: cfunc
      owner class: 0x000055d773cfdcf8 [3LM R ] T_CLASS Array
    self: 0x000055d77b5e4270 [3LM   ] T_ARRAY (Array)[E ] len: 1 (embed)
  c:0012 p:0047 s:0057 e:000056 METHOD /tmp/ruby/v3/src/trunk-mjit-wait/tool/lib/minitest/unit.rb:1123
    me:
      called_id: _run, type: iseq
      owner class: 0x000055d773e48dd8 [3LM   ] T_CLASS MiniTest::Unit
    self: 0x000055d773fcdac8 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x000055d77b582a30
    lvars:
      args: 0x000055d773fbfef0 [3LM   ] T_HASH (Hash)[A ] 8
  c:0011 p:0013 s:0052 e:000051 METHOD /tmp/ruby/v3/src/trunk-mjit-wait/tool/lib/minitest/unit.rb:1111
    me:
      called_id: run, type: iseq
      owner class: 0x000055d773e48dd8 [3LM   ] T_CLASS MiniTest::Unit
    self: 0x000055d773fcdac8 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x000055d77b582a30
    lvars:
      args: 0x000055d773ced100 [3LM   ] T_ARRAY shared -> 0x000055d77406a8c8 [3LM   ] T_ARRAY (Array)[   ] len: 831, capa:2 ptr:0x000055d7740aa280
  c:0010 p:0008 s:0047 e:000046 METHOD /tmp/ruby/v3/src/trunk-mjit-wait/tool/lib/test/unit.rb:847
    me:
      called_id: run, type: iseq
      owner class: 0x000055d773fc7150 [3LM   ] T_MODULE (Module)Test::Unit::StatusLine
      defined_class: 0x000055d773fc6020 [3LM R ] T_ICLASS src:Test::Unit::StatusLine
    self: 0x000055d773fcdac8 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x000055d77b582a30
    lvars:
      args: 0x000055d77b5e4d60 [3LM   ] T_ARRAY (Array)[E ] len: 1 (embed)
      result: T_NIL
  c:0009 p:0008 s:0041 e:000040 METHOD /tmp/ruby/v3/src/trunk-mjit-wait/tool/lib/test/unit.rb:695
    me:
      called_id: run, type: iseq
      owner class: 0x000055d773fc7268 [3LM   ] T_MODULE (Module)Test::Unit::Statistics
      defined_class: 0x000055d773fc5f80 [3LM R ] T_ICLASS src:Test::Unit::Statistics
    self: 0x000055d773fcdac8 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x000055d77b582a30
    lvars:
      args: 0x000055d77b5e4ea0 [3LM   ] T_ARRAY (Array)[E ] len: 1 (embed)
      result: T_NIL
  c:0008 p:0015 s:0035 e:000034 METHOD /tmp/ruby/v3/src/trunk-mjit-wait/tool/lib/test/unit.rb:34
    me:
      called_id: run, type: iseq
      owner class: 0x000055d773fbc688 [3LM   ] T_MODULE Test::Unit::RunCount
      defined_class: 0x000055d773fc5d00 [3LM   ] T_ICLASS src:Test::Unit::RunCount
    self: 0x000055d773fcdac8 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x000055d77b582a30
    lvars:
      (null): 0x000055d77b5e4fb8 [3LM   ] T_ARRAY (Array)[E ] len: 1 (embed)
  c:0007 p:0006 s:0030 e:000029 METHOD /tmp/ruby/v3/src/trunk-mjit-wait/tool/lib/test/unit.rb:1175
    me:
      called_id: run, type: iseq
      owner class: 0x000055d773fc6160 [3LM   ] T_CLASS Test::Unit::Runner
    self: 0x000055d773fcdac8 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x000055d77b582a30
    lvars:
      argv: 0x000055d773ced100 [3LM   ] T_ARRAY shared -> 0x000055d77406a8c8 [3LM   ] T_ARRAY (Array)[   ] len: 831, capa:2 ptr:0x000055d7740aa280
  c:0006 p:0032 s:0025 e:000024 METHOD /tmp/ruby/v3/src/trunk-mjit-wait/tool/lib/test/unit.rb:1245
    me:
      called_id: run, type: iseq
      owner class: 0x000055d773fc5b98 [3LM   ] T_CLASS Test::Unit::AutoRunner
    self: 0x000055d773fcdd98 [3LM   ] T_OBJECT (Test::Unit::AutoRunner)len:5 ptr:0x000055d77402a0b0
  c:0005 p:0009 s:0021 e:000020 METHOD /tmp/ruby/v3/src/trunk-mjit-wait/tool/lib/test/unit.rb:1249
    me:
      called_id: run, type: iseq
      owner class: 0x000055d773fc5b70 [3LM   ] T_CLASS (annon)
    self: 0x000055d773fc5b98 [3LM   ] T_CLASS Test::Unit::AutoRunner
    lvars:
      args: 0x000055d773fcdf78 [3LM   ] T_ARRAY (Array)[E ] len: 2 (embed)
  c:0004 p:0172 s:0016 e:000014 TOP    /tmp/ruby/v3/src/trunk-mjit-wait/tool/test/runner.rb:23 [FINISH]
    self: 0x000055d773d1c4c8 [3LM   ] T_OBJECT (embed) len:3
    lvars:
      dir: 0x000055d773fcdff0 [3LM   ] T_STRING (String)/tmp/ruby/v3/src/trunk-mjit-wait/test
  c:0003 p:---- s:0011 e:000010 CFUNC  :require_relative
    me:
      called_id: require_relative, type: cfunc
      owner class: 0x000055d773d1e638 [3LM   ] T_MODULE Kernel
      defined_class: 0x000055d773d1e5e8 [3LM R ] T_ICLASS src:Kernel
    self: 0x000055d773d1c4c8 [3LM   ] T_OBJECT (embed) len:3
  c:0002 p:0092 s:0006 e:000005 EVAL   /tmp/ruby/v3/src/trunk-mjit-wait/test/runner.rb:11 [FINISH]
    self: 0x000055d773d1c4c8 [3LM   ] T_OBJECT (embed) len:3
  c:0001 p:0000 s:0003 E:000d90 (none) [FINISH]
    self: 0x000055d773d1c4c8 [3LM   ] T_OBJECT (embed) len:3
  
  th: 0x55d77beea470, native_id: 0x7f0896d9a700
  -- Control frame information -----------------------------------------------
  c:0007 p:---- s:0032 e:000031 CFUNC  :select
    me:
      called_id: select, type: cfunc
      owner class: 0x000055d773cef900 [3LM   ] T_CLASS (annon)
    self: 0x000055d773cef928 [3LM   ] T_CLASS IO
  c:0006 p:0014 s:0027 e:000026 BLOCK  /tmp/ruby/v3/build/trunk-mjit-wait/.ext/common/socket.rb:806 [FINISH]
    me:
      called_id: accept_loop, type: iseq
      owner class: 0x000055d77417cf18 [3LM R ] T_CLASS (annon)
    self: 0x000055d77417cf40 [3LM R ] T_CLASS Socket
    lvars:
      readable: T_NIL
      _: T_NIL
  c:0005 p:---- s:0022 e:000021 CFUNC  :loop
    me:
      called_id: loop, type: cfunc
      owner class: 0x000055d773d1e638 [3LM   ] T_MODULE Kernel
      defined_class: 0x000055d773d1e5e8 [3LM R ] T_ICLASS src:Kernel
    self: 0x000055d77417cf40 [3LM R ] T_CLASS Socket
  c:0004 p:0031 s:0018 e:000017 METHOD /tmp/ruby/v3/build/trunk-mjit-wait/.ext/common/socket.rb:805
    me:
      called_id: accept_loop, type: iseq
      owner class: 0x000055d77417cf18 [3LM R ] T_CLASS (annon)
    self: 0x000055d77417cf40 [3LM R ] T_CLASS Socket
    lvars:
      sockets: 0x000055d77b8dee80 [0     ] T_ARRAY (Array)[E ] len: 1 (embed)
  c:0003 p:0014 s:0013 e:000012 METHOD /tmp/ruby/v3/src/trunk-mjit-wait/test/net/smtp/test_smtp.rb:276
    me:
      called_id: accept, type: iseq
      owner class: 0x000055d7748d2538 [3LM R ] T_CLASS Net::TestSMTP
    self: 0x000055d77b8dfc90 [0     ] T_OBJECT (Net::TestSMTP)len:8 ptr:0x00007f08a0bd4c10
    lvars:
      servers: 0x000055d77b8df740 [0     ] T_ARRAY (Array)[E ] len: 1 (embed)
  c:0002 p:0022 s:0008 e:000007 BLOCK  /tmp/ruby/v3/src/trunk-mjit-wait/test/net/smtp/test_smtp.rb:283 [FINISH]
    me:
      called_id: fake_server_start, type: iseq
      owner class: 0x000055d7748d2538 [3LM R ] T_CLASS Net::TestSMTP
    self: 0x000055d77b8dfc90 [0     ] T_OBJECT (Net::TestSMTP)len:8 ptr:0x00007f08a0bd4c10
    lvars:
      sock: T_NIL
      credential: T_NIL
  c:0001 p:---- s:0003 e:000002 (none) [FINISH]
    self: T_NIL
  
  $1 = 0
  ">>> Finish
  "[Inferior 1 (process 14181) detached]
  [nil, 14181]
  "timeout 60 gdb -p 14174 -x /home/ko1/ruby/build-ruby/gdbscript -batch -quiet"
  make: *** [uncommon.mk:802: yes-test-all] 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, 14174]
  #<Errno::ESRCH: No such process>
  "timeout 60 gdb -p 14173 -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 14173 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, 14173]
  "timeout 60 gdb -p 30170 -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, 30170]
  #<Errno::ESRCH: No such process>
    0.000000   0.008000 3663.928000 (18002.083618)
  /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:320:in `block in test_all'
  	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:319:in `test_all'
  	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: 18995.97 sec