Result of trunk-mjit-wait@phosphorus-docker at 2020-12-29 14:36:02 +0900

• NG (06b44f819e) [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: 06b44f819e
  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.20201229-001820
  #<BuildRuby:0x00005597778a7460
   @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.20201229-001820",
   @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.000024)
  autoconf               0.000000   0.000000   0.000000 (  0.000056)
  configure              0.000000   0.000000   0.000000 (  0.000049)
  build_up               0.012000   0.004000  10.760000 (  7.237670)
  build_miniruby         0.000000   0.000000   0.168000 (  0.182725)
  build_ruby             0.004000   0.000000   0.168000 (  0.194261)
  build_all              0.004000   0.008000  47.700000 ( 15.070609)
  build_install          0.020000   0.008000  49.852000 ( 16.247988)
  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 1480 tests
    0.000000   0.000000 1025.996000 (1015.094841)
  test_basic             0.004000   0.008000   6.132000 (  4.780680)
  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: 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
  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  3197    11    11 ?           -1 S     1001   0:00 ruby ./br.rb build_report trunk-mjit-wait --incremental --process-num=6
   3197  3198    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.20201229-001820 --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
   3198  3199    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.20201229-001820 --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
   3199 11957    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"
  11957 11958    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
  11958 11965    11    11 ?           -1 Sl    1001   3:02 /tmp/ruby/v3/src/trunk-mjit-wait/test/runner.rb
   3199 28057    11    11 ?           -1 R     1001   0:00 ps jx
  {10=>[11], 11=>[3197], 3197=>[3198], 3198=>[3199], 3199=>[11957, 28057], 11957=>[11958], 11958=>[11965]}
  "timeout 60 gdb -p 11965 -x /home/ko1/ruby/build-ruby/gdbscript -batch -quiet"
  [New LWP 27332]
  [New LWP 28004]
  
  warning: Could not load shared library symbols for 1253 libraries, e.g. /tmp/_ruby_mjit_p11965u2.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.
  0x00007fc54c495bf6 in __ppoll (fds=fds@entry=0x7ffe3cccc030, 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 0x7fc54c37eb80 (LWP 11965) "ruby"            0x00007fc54c495bf6 in __ppoll (fds=fds@entry=0x7ffe3cccc030, nfds=nfds@entry=2, timeout=<optimized out>, sigmask=sigmask@entry=0x0) at ../sysdeps/unix/sysv/linux/ppoll.c:44
    2    Thread 0x7fc541244700 (LWP 27332) "ruby-mjitworker" futex_wait_cancelable (private=<optimized out>, expected=0, futex_word=0x559ecd20b828 <mjit_worker_wakeup+40>) at ../sysdeps/nptl/futex-internal.h:183
    3    Thread 0x7fc541c8c700 (LWP 28004) "test_smtp.rb:2*" 0x00007fc54c49812b in __GI___select (nfds=nfds@entry=8, readfds=readfds@entry=0x7fc53406a230, writefds=writefds@entry=0x0, exceptfds=exceptfds@entry=0x0, timeout=0x0) at ../sysdeps/unix/sysv/linux/select.c:41
  >>> Machine level backtrace
  
  Thread 3 (Thread 0x7fc541c8c700 (LWP 28004)):
  #0  0x00007fc54c49812b in __GI___select (nfds=nfds@entry=8, readfds=readfds@entry=0x7fc53406a230, writefds=writefds@entry=0x0, exceptfds=exceptfds@entry=0x0, timeout=0x0) at ../sysdeps/unix/sysv/linux/select.c:41
  #1  0x0000559eccfeb0c2 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=140485187907616) at /tmp/ruby/v3/src/trunk-mjit-wait/thread.c:4226
  #4  0x0000559ecce55a24 in rb_ensure (b_proc=b_proc@entry=0x559eccfeaeb0 <do_select>, data1=data1@entry=140485187907616, e_proc=e_proc@entry=0x559eccfdf8d0 <select_set_free>, data2=data2@entry=140485187907616) at /tmp/ruby/v3/src/trunk-mjit-wait/eval.c:1158
  #5  0x0000559eccfeda0e in rb_thread_fd_select (max=max@entry=8, read=read@entry=0x7fc541b8b2e0, write=write@entry=0x0, except=except@entry=0x0, timeout=timeout@entry=0x0) at /tmp/ruby/v3/src/trunk-mjit-wait/thread.c:4352
  #6  0x0000559ecce941d5 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=140485187908288) at /tmp/ruby/v3/src/trunk-mjit-wait/io.c:9408
  #8  0x0000559ecce55a24 in rb_ensure (b_proc=b_proc@entry=0x559ecce93ea0 <select_call>, data1=data1@entry=140485187908288, e_proc=e_proc@entry=0x559ecce90390 <select_end>, data2=data2@entry=140485187908288) at /tmp/ruby/v3/src/trunk-mjit-wait/eval.c:1158
  #9  0x0000559ecce902d1 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 0x00007fc540212dfd in ?? ()
  #11 0x0000000000000000 in ?? ()
  
  Thread 2 (Thread 0x7fc541244700 (LWP 27332)):
  #0  futex_wait_cancelable (private=<optimized out>, expected=0, futex_word=0x559ecd20b828 <mjit_worker_wakeup+40>) at ../sysdeps/nptl/futex-internal.h:183
  #1  __pthread_cond_wait_common (abstime=0x0, clockid=0, mutex=0x559ecd20b8c0 <mjit_engine_mutex>, cond=0x559ecd20b800 <mjit_worker_wakeup>) at pthread_cond_wait.c:508
  #2  __pthread_cond_wait (cond=cond@entry=0x559ecd20b800 <mjit_worker_wakeup>, mutex=mutex@entry=0x559ecd20b8c0 <mjit_engine_mutex>) at pthread_cond_wait.c:638
  #3  0x0000559eccfe4a5d in rb_native_cond_wait (cond=cond@entry=0x559ecd20b800 <mjit_worker_wakeup>, mutex=mutex@entry=0x559ecd20b8c0 <mjit_engine_mutex>) at /tmp/ruby/v3/src/trunk-mjit-wait/thread_pthread.c:503
  #4  0x0000559eccec5c51 in mjit_worker () at /tmp/ruby/v3/src/trunk-mjit-wait/mjit_worker.c:1384
  #5  0x0000559eccfdf47e in mjit_worker (arg=0x559eccec5b40 <mjit_worker>) at /tmp/ruby/v3/src/trunk-mjit-wait/thread_pthread.c:1941
  #6  0x00007fc54c79c609 in start_thread (arg=<optimized out>) at pthread_create.c:477
  #7  0x00007fc54c4a2293 in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:95
  
  Thread 1 (Thread 0x7fc54c37eb80 (LWP 11965)):
  #0  0x00007fc54c495bf6 in __ppoll (fds=fds@entry=0x7ffe3cccc030, nfds=nfds@entry=2, timeout=<optimized out>, sigmask=sigmask@entry=0x0) at ../sysdeps/unix/sysv/linux/ppoll.c:44
  #1  0x0000559eccfe81e2 in native_ppoll_sleep (th=th@entry=0x559ecd92be20, rel=rel@entry=0x0) at /tmp/ruby/v3/src/trunk-mjit-wait/hrtime.h:148
  #2  0x0000559eccfea57a in native_sleep (th=th@entry=0x559ecd92be20, rel=0x0) at /tmp/ruby/v3/src/trunk-mjit-wait/thread_pthread.c:2166
  #3  0x0000559eccfea965 in thread_join_sleep (arg=arg@entry=140729918472704) at /tmp/ruby/v3/src/trunk-mjit-wait/thread.c:1189
  #4  0x0000559ecce55a24 in rb_ensure (b_proc=b_proc@entry=0x559eccfea750 <thread_join_sleep>, data1=data1@entry=140729918472704, e_proc=e_proc@entry=0x559eccfdf0a0 <remove_from_join_list>, data2=data2@entry=140729918472704) at /tmp/ruby/v3/src/trunk-mjit-wait/eval.c:1158
  #5  0x0000559eccfe387d in thread_join (timeout=8, target_th=0x559ed62b7400) at /tmp/ruby/v3/src/trunk-mjit-wait/thread.c:1239
  #6  thread_join_m (argc=<optimized out>, argv=<optimized out>, self=94140674428280) at /tmp/ruby/v3/src/trunk-mjit-wait/thread.c:1332
  #7  0x0000559ecd0244db in vm_call_cfunc_with_frame (ec=0x559ecd92c680, reg_cfp=0x7fc54c37c8d8, calling=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_insnhelper.c:2899
  #8  0x0000559ecd03a770 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=0x559ecd92c680, initial=2) at ../../src/trunk-mjit-wait/insns.def:789
  #10 0x0000559ecd02ed7e in rb_vm_exec (ec=<optimized out>, mjit_enable_p=true) at /tmp/ruby/v3/src/trunk-mjit-wait/vm.c:2163
  #11 0x0000559ecd03298e in invoke_block (captured=<optimized out>, opt_pc=<optimized out>, type=<optimized out>, cref=0x0, self=94140674429360, iseq=0x559ecf3d1990, ec=0x559ecd92c680) at /tmp/ruby/v3/src/trunk-mjit-wait/vm.c:1263
  #12 invoke_iseq_block_from_c (me=0x0, is_lambda=<optimized out>, cref=0x0, passed_block_handler=0, kw_splat=0, argv=0x7ffe3cccc550, argc=1, self=94140674429360, captured=<optimized out>, ec=0x559ecd92c680) at /tmp/ruby/v3/src/trunk-mjit-wait/vm.c:1335
  #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:1353
  #14 vm_yield (argc=1, kw_splat=0, argv=0x7ffe3cccc550, ec=0x559ecd92c680) at /tmp/ruby/v3/src/trunk-mjit-wait/vm.c:1398
  #15 rb_yield_0 (argv=0x7ffe3cccc550, 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 0x0000559ecd05a5ac in rb_ary_each (ary=94140674428960) at /tmp/ruby/v3/src/trunk-mjit-wait/include/ruby/internal/core/rarray.h:172
  #19 0x0000559ecd0244db in vm_call_cfunc_with_frame (ec=0x559ecd92c680, reg_cfp=0x7fc54c37c948, calling=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_insnhelper.c:2899
  #20 0x0000559ecd0300b9 in vm_call_method_each_type (ec=0x559ecd92c680, cfp=0x7fc54c37c948, calling=0x7ffe3cccc840) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_insnhelper.c:3389
  #21 0x0000559ecd030794 in vm_call_method (ec=0x559ecd92c680, cfp=0x7fc54c37c948, calling=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_insnhelper.c:3507
  #22 0x0000559ecd030517 in vm_call_refined (calling=0x7ffe3cccc840, cfp=0x7fc54c37c948, ec=0x559ecd92c680) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_insnhelper.c:3368
  #23 vm_call_method_each_type (ec=0x559ecd92c680, cfp=0x7fc54c37c948, calling=0x7ffe3cccc840) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_insnhelper.c:3446
  #24 0x0000559ecd030794 in vm_call_method (ec=0x559ecd92c680, cfp=0x7fc54c37c948, calling=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit-wait/vm_insnhelper.c:3507
  #25 0x00007fc523fd9887 in ?? ()
  #26 0x00000bb100000001 in ?? ()
  #27 0x00007ffe3cccc770 in ?? ()
  #28 0x00007fc54c37c961 in ?? ()
  #29 0x0000559ed5755020 in ?? ()
  #30 0x0000000000000000 in ?? ()
  >>> Dump Ruby level backtrace
  th: 0x559ecd92be20, native_id: 0x7fc54c37eb80
  -- Control frame information -----------------------------------------------
  c:0034 p:---- s:0183 e:000182 CFUNC  :join
    me:
      called_id: join, type: cfunc
      owner class: 0x0000559ecd9a1638 [3LM R ] T_CLASS Thread
    self: 0x0000559ed5754d78 [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:36 [FINISH]
    me:
      called_id: teardown, type: iseq
      owner class: 0x0000559ecf3d8ab0 [3LM R ] T_CLASS Net::TestSMTP
    self: 0x0000559ed57551b0 [0     ] T_OBJECT (Net::TestSMTP)len:8 ptr:0x00007fc54c056ea8
    lvars:
      th: 0x0000559ed5754d78 [0    U] VM/thread (Thread)VM/thread
  c:0032 p:---- s:0175 e:000174 CFUNC  :each
    me:
      called_id: each, type: cfunc
      owner class: 0x0000559ecd9c9c78 [3LM R ] T_CLASS Array
    self: 0x0000559ed5755020 [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:36
    me:
      called_id: teardown, type: iseq
      owner class: 0x0000559ecf3d8ab0 [3LM R ] T_CLASS Net::TestSMTP
    self: 0x0000559ed57551b0 [0     ] T_OBJECT (Net::TestSMTP)len:8 ptr:0x00007fc54c056ea8
  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: 0x0000559ecda9d960 [3LM R ] T_CLASS MiniTest::Unit::TestCase
    self: 0x0000559ed57551b0 [0     ] T_OBJECT (Net::TestSMTP)len:8 ptr:0x00007fc54c056ea8
    lvars:
      hook: 0x0000559ecda9e978 [3LM   ] T_STRING (String)teardown
  c:0029 p:---- s:0163 e:000162 CFUNC  :each
    me:
      called_id: each, type: cfunc
      owner class: 0x0000559ecd9c9c78 [3LM R ] T_CLASS Array
    self: 0x0000559ed574f7d8 [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: 0x0000559ecda9d960 [3LM R ] T_CLASS MiniTest::Unit::TestCase
    self: 0x0000559ed57551b0 [0     ] T_OBJECT (Net::TestSMTP)len:8 ptr:0x00007fc54c056ea8
    lvars:
      runner: 0x0000559ecdca0348 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x0000559ed5033860
      start_time: 0x0000559ed5755188 [0    U] time (Time)time
      result: 0x0000559ed574f800 [0     ] T_STRING (String)E
      time: T_FLOAT
      e: 0x0000559ed57548c8 [0     ] T_OBJECT (Net::OpenTimeout)len:5 ptr:0x00007fc54c0570d0
  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: 0x0000559ecdc82aa0 [3LM   ] T_CLASS Test::Unit::TestCase
    self: 0x0000559ed57551b0 [0     ] T_OBJECT (Net::TestSMTP)len:8 ptr:0x00007fc54c056ea8
    lvars:
      runner: 0x0000559ecdca0348 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x0000559ed5033860
  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: 0x0000559ecda9fd78 [3LM   ] T_CLASS MiniTest::Unit
    self: 0x0000559ecdca0348 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x0000559ed5033860
    lvars:
      method: 0x0000559ed5777ad0 [0     ] T_STRING (String) [shared] test_start_instance_with_position_argument
      inst: 0x0000559ed57551b0 [0     ] T_OBJECT (Net::TestSMTP)len:8 ptr:0x00007fc54c056ea8
      start_time: T_NIL
      result: T_NIL
  c:0025 p:---- s:0138 e:000137 CFUNC  :map
    me:
      called_id: map, type: cfunc
      owner class: 0x0000559ecd9c9c78 [3LM R ] T_CLASS Array
    self: 0x0000559ed5777940 [0     ] T_ARRAY (Array)[  T] len: 20, capa:20 ptr:0x00007fc54c053d38
  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: 0x0000559ecda9fd78 [3LM   ] T_CLASS MiniTest::Unit
    self: 0x0000559ecdca0348 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x0000559ed5033860
    lvars:
      assertions: T_NIL
  c:0023 p:0163 s:0130 E:001fa0 METHOD /tmp/ruby/v3/src/trunk-mjit-wait/tool/lib/minitest/unit.rb:989 [FINISH]
    me:
      called_id: _run_suite, type: iseq
      owner class: 0x0000559ecda9fd78 [3LM   ] T_CLASS MiniTest::Unit
    self: 0x0000559ecdca0348 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x0000559ed5033860
    lvars:
      suite: 0x0000559ecf3d8ab0 [3LM R ] T_CLASS Net::TestSMTP
      type: T_SYMBOL test
      header: 0x0000559ed5777e90 [0     ] T_STRING (String)test_suite_header
      filter: 0x0000559ecdd7f840 [3LM   ] T_REGEXP 
      all_test_methods: 0x0000559ed5777990 [0     ] T_ARRAY (Array)[   ] len: 20, capa:20 ptr:0x0000559ed5b99bc0
      filtered_test_methods: 0x0000559ed5777940 [0     ] T_ARRAY (Array)[  T] len: 20, capa:20 ptr:0x00007fc54c053d38
      leakchecker: 0x0000559ed57776e8 [0     ] T_OBJECT (LeakChecker)len:7 ptr:0x00007fc54c054068
      continuation: 0x0000559ed5776220 [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: 0x0000559ecdc80930 [3LM   ] T_MODULE (Module)Test::Unit::ExcludesOption
      defined_class: 0x0000559ecdc801b0 [3LM   ] T_ICLASS src:Test::Unit::ExcludesOption
    self: 0x0000559ecdca0348 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x0000559ed5033860
    lvars:
      suite: 0x0000559ecf3d8ab0 [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: 0x0000559ecdc82578 [3LM   ] T_MODULE (Module)Test::Unit::Parallel
      defined_class: 0x0000559ecdc802c8 [3LM   ] T_ICLASS src:Test::Unit::Parallel
    self: 0x0000559ecdca0348 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x0000559ed5033860
    lvars:
      suite: 0x0000559ecf3d8ab0 [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: 0x0000559ecd9c9c78 [3LM R ] T_CLASS Array
    self: 0x0000559ed61562e0 [3LM   ] T_ARRAY (Array)[   ] len: 957, capa:957 ptr:0x0000559ed6174070
  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: 0x0000559ecdc82578 [3LM   ] T_MODULE (Module)Test::Unit::Parallel
      defined_class: 0x0000559ecdc802c8 [3LM   ] T_ICLASS src:Test::Unit::Parallel
    self: 0x0000559ecdca0348 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x0000559ed5033860
    lvars:
      suites: 0x0000559ed61562e0 [3LM   ] T_ARRAY (Array)[   ] len: 957, capa:957 ptr:0x0000559ed6174070
      type: T_SYMBOL test
      result: 0x0000559ed6429210 [3LM R ] T_ARRAY (Array)[   ] len: 91, capa:128 ptr:0x0000559ed638e780
  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: 0x0000559ecdc81560 [3LM   ] T_MODULE (Module)Test::Unit::Skipping
      defined_class: 0x0000559ecdc80278 [3LM R ] T_ICLASS src:Test::Unit::Skipping
    self: 0x0000559ecdca0348 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x0000559ed5033860
    lvars:
      suites: 0x0000559ed61562e0 [3LM   ] T_ARRAY (Array)[   ] len: 957, capa:957 ptr:0x0000559ed6174070
      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: 0x0000559ecda9fd78 [3LM   ] T_CLASS MiniTest::Unit
    self: 0x0000559ecdca0348 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x0000559ed5033860
    lvars:
      type: T_SYMBOL test
      suites: 0x0000559ed61562e0 [3LM   ] T_ARRAY (Array)[   ] len: 957, capa:957 ptr:0x0000559ed6174070
      test_count: T_FIXNUM 0
      assertion_count: T_FIXNUM 0
      sync: T_TRUE
      old_sync: T_FALSE
      start: 0x0000559ed6180ae0 [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: 0x0000559ecdc809f8 [3LM   ] T_MODULE (Module)Test::Unit::RepeatOption
      defined_class: 0x0000559ecdc80228 [3LM   ] T_ICLASS src:Test::Unit::RepeatOption
    self: 0x0000559ecdca0348 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x0000559ed5033860
    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: 0x0000559ecda9fd78 [3LM   ] T_CLASS MiniTest::Unit
    self: 0x0000559ecdca0348 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x0000559ed5033860
  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: 0x0000559ecda9fd78 [3LM   ] T_CLASS MiniTest::Unit
    self: 0x0000559ecdca0348 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x0000559ed5033860
    lvars:
      plugin: 0x0000559ecdb15e60 [3LM   ] T_STRING (String)run_tests
  c:0013 p:---- s:0061 e:000060 CFUNC  :each
    me:
      called_id: each, type: cfunc
      owner class: 0x0000559ecd9c9c78 [3LM R ] T_CLASS Array
    self: 0x0000559ed61564c0 [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: 0x0000559ecda9fd78 [3LM   ] T_CLASS MiniTest::Unit
    self: 0x0000559ecdca0348 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x0000559ed5033860
    lvars:
      args: 0x0000559ecdc8ab10 [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: 0x0000559ecda9fd78 [3LM   ] T_CLASS MiniTest::Unit
    self: 0x0000559ecdca0348 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x0000559ed5033860
    lvars:
      args: 0x0000559ecd9b9080 [3LM   ] T_ARRAY shared -> 0x0000559ecdd7ff48 [3LM   ] T_ARRAY (Array)[   ] len: 831, capa:2 ptr:0x0000559ecdd35620
  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: 0x0000559ecdc81358 [3LM   ] T_MODULE (Module)Test::Unit::StatusLine
      defined_class: 0x0000559ecdc802f0 [3LM R ] T_ICLASS src:Test::Unit::StatusLine
    self: 0x0000559ecdca0348 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x0000559ed5033860
    lvars:
      args: 0x0000559ed6156970 [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: 0x0000559ecdc81470 [3LM   ] T_MODULE (Module)Test::Unit::Statistics
      defined_class: 0x0000559ecdc802a0 [3LM R ] T_ICLASS src:Test::Unit::Statistics
    self: 0x0000559ecdca0348 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x0000559ed5033860
    lvars:
      args: 0x0000559ed61569e8 [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: 0x0000559ecdc82848 [3LM   ] T_MODULE Test::Unit::RunCount
      defined_class: 0x0000559ecdc80160 [3LM   ] T_ICLASS src:Test::Unit::RunCount
    self: 0x0000559ecdca0348 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x0000559ed5033860
    lvars:
      (null): 0x0000559ed6156a60 [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: 0x0000559ecdc803e0 [3LM   ] T_CLASS Test::Unit::Runner
    self: 0x0000559ecdca0348 [3LM   ] T_OBJECT (Test::Unit::AutoRunner::Runner)len:22 ptr:0x0000559ed5033860
    lvars:
      argv: 0x0000559ecd9b9080 [3LM   ] T_ARRAY shared -> 0x0000559ecdd7ff48 [3LM   ] T_ARRAY (Array)[   ] len: 831, capa:2 ptr:0x0000559ecdd35620
  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: 0x0000559ecdc8bfd8 [3LM   ] T_CLASS Test::Unit::AutoRunner
    self: 0x0000559ecdca03c0 [3LM   ] T_OBJECT (Test::Unit::AutoRunner)len:5 ptr:0x0000559ecdce9010
  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: 0x0000559ecdc8bfb0 [3LM   ] T_CLASS (annon)
    self: 0x0000559ecdc8bfd8 [3LM   ] T_CLASS Test::Unit::AutoRunner
    lvars:
      args: 0x0000559ecdca0410 [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: 0x0000559ecd9e84c0 [3LM   ] T_OBJECT (embed) len:3
    lvars:
      dir: 0x0000559ecdca0460 [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: 0x0000559ecd9ea630 [3LM   ] T_MODULE Kernel
      defined_class: 0x0000559ecd9ea5e0 [3LM R ] T_ICLASS src:Kernel
    self: 0x0000559ecd9e84c0 [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: 0x0000559ecd9e84c0 [3LM   ] T_OBJECT (embed) len:3
  c:0001 p:0000 s:0003 E:000e80 (none) [FINISH]
    self: 0x0000559ecd9e84c0 [3LM   ] T_OBJECT (embed) len:3
  
  th: 0x559ed62b7400, native_id: 0x7fc541c8c700
  -- Control frame information -----------------------------------------------
  c:0007 p:---- s:0032 e:000031 CFUNC  :select
    me:
      called_id: select, type: cfunc
      owner class: 0x0000559ecd9bb880 [3LM   ] T_CLASS (annon)
    self: 0x0000559ecd9bb8a8 [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: 0x0000559ecde441e0 [3LM R ] T_CLASS (annon)
    self: 0x0000559ecde44208 [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: 0x0000559ecd9ea630 [3LM   ] T_MODULE Kernel
      defined_class: 0x0000559ecd9ea5e0 [3LM R ] T_ICLASS src:Kernel
    self: 0x0000559ecde44208 [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: 0x0000559ecde441e0 [3LM R ] T_CLASS (annon)
    self: 0x0000559ecde44208 [3LM R ] T_CLASS Socket
    lvars:
      sockets: 0x0000559ed5754bc0 [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:265
    me:
      called_id: accept, type: iseq
      owner class: 0x0000559ecf3d8ab0 [3LM R ] T_CLASS Net::TestSMTP
    self: 0x0000559ed57551b0 [0     ] T_OBJECT (Net::TestSMTP)len:8 ptr:0x00007fc54c056ea8
    lvars:
      servers: 0x0000559ed5754eb8 [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:272 [FINISH]
    me:
      called_id: fake_server_start, type: iseq
      owner class: 0x0000559ecf3d8ab0 [3LM R ] T_CLASS Net::TestSMTP
    self: 0x0000559ed57551b0 [0     ] T_OBJECT (Net::TestSMTP)len:8 ptr:0x00007fc54c056ea8
    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 11965) detached]
  [nil, 11965]
  "timeout 60 gdb -p 11958 -x /home/ko1/ruby/build-ruby/gdbscript -batch -quiet"
  make: *** [uncommon.mk:800: 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, 11958]
  #<Errno::ESRCH: No such process>
  "timeout 60 gdb -p 11957 -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 11957 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, 11957]
  "timeout 60 gdb -p 28057 -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, 28057]
  #<Errno::ESRCH: No such process>
    0.000000   0.004000 3714.264000 (18001.903622)
  /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: 19060.71 sec