top / trunk-gc-asserts@phosphorus-docker

Result of trunk-gc-asserts@phosphorus-docker at 2022-02-01 20:58:36 +0900

NG (ddb9d60f7d)[LOG]
test-all:
test-spec:

commands:

 "make update-unicode  DEFS=\"-DRGENGC_CHECK_MODE=2\"" exit with 0.
"make update-download DEFS=\"-DRGENGC_CHECK_MODE=2\"" exit with 0.
"make update-rubyspec DEFS=\"-DRGENGC_CHECK_MODE=2\"" exit with 0.
"make update-src      DEFS=\"-DRGENGC_CHECK_MODE=2\"" exit with 0.
"make after-update    DEFS=\"-DRGENGC_CHECK_MODE=2\"" exit with 512.
make[1]: *** No rule to make target 'id.h', needed by 'ripper.y'.  Stop.
make: *** [uncommon.mk:1198: /tmp/ruby/v3/src/trunk-gc-asserts/ext/ripper/ripper.c] Error 2
"make miniruby DEFS=\"-DRGENGC_CHECK_MODE=2\"" exit with 0.
"make ruby DEFS=\"-DRGENGC_CHECK_MODE=2\"" exit with 0.
"make all DEFS=\"-DRGENGC_CHECK_MODE=2\"" exit with 0.
"make install DEFS=\"-DRGENGC_CHECK_MODE=2\"" exit with 0.
"make yes-btest TESTOPTS=-q TESTS='-j6'" exit with 0.
"make yes-test-basic TESTS='-j6'" exit with 0.
make yes-test-all TESTOPTS='--stderr-on-failure' TESTS='-j6'
$$$ #<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-gc-asserts --incremental --process-num=6
25610  6375    11    11 ?           -1 R     1001   0:00 ps jx
   11 25606    11    11 ?           -1 Sl    1001   0:00 ruby ./br.rb build_report trunk-gc-asserts --incremental --process-num=6
25606 25609    11    11 ?           -1 S     1001   0:00 sh -c ruby /home/ko1/ruby/build-ruby/build-ruby.rb --target_name=trunk-gc-asserts --logfile=/home/ko1/ruby/logs/brlog.trunk-gc-asserts.20220201-084701 --root_dir=/tmp/ruby --timeout=10800 --build_opts='DEFS="-DRGENGC_CHECK_MODE=2"'                              --add-env=RUBY_TEST_SUBPROCESS_TIMEOUT_SCALE=30 --incremental --process-num=6
25609 25610    11    11 ?           -1 Sl    1001   0:00 ruby /home/ko1/ruby/build-ruby/build-ruby.rb --target_name=trunk-gc-asserts --logfile=/home/ko1/ruby/logs/brlog.trunk-gc-asserts.20220201-084701 --root_dir=/tmp/ruby --timeout=10800 --build_opts=DEFS="-DRGENGC_CHECK_MODE=2" --add-env=RUBY_TEST_SUBPROCESS_TIMEOUT_SCALE=30 --incremental --process-num=6
25610 28687    11    11 ?           -1 S     1001   0:00 sh -c make yes-test-all TESTOPTS='--stderr-on-failure' TESTS='-j6'
28687 28688    11    11 ?           -1 S     1001   0:00 make yes-test-all TESTOPTS=--stderr-on-failure TESTS=-j6
28688 28696    11    11 ?           -1 S     1001   0:58 /tmp/ruby/v3/build/trunk-gc-asserts/ruby --disable-gems /tmp/ruby/v3/src/trunk-gc-asserts/test/runner.rb --ruby=./miniruby -I/tmp/ruby/v3/src/trunk-gc-asserts/lib -I. -I.ext/common  /tmp/ruby/v3/src/trunk-gc-asserts/tool/runruby.rb --extout=.ext  -- --disable-gems --excludes-dir=/tmp/ruby/v3/src/trunk-gc-asserts/test/excludes --name=!/memory_leak/ --stderr-on-failure -j6
28696 28698    11    11 ?           -1 Rl    1001 152:41 /tmp/ruby/v3/src/trunk-gc-asserts/tool/lib/test/unit/parallel.rb: TestComprehensiveCaseMapping#test_UTF-16BE_upcase_turkic
{10=>[11], 25610=>[6375, 28687], 11=>[25606], 25606=>[25609], 25609=>[25610], 28687=>[28688], 28688=>[28696], 28696=>[28698]}
$ timeout 60 gdb -p 6375 -x /home/ko1/ruby/build-ruby/gdbscript -batch -quiet 2> /dev/null
>>> ThreadsNo threads.
>>> Machine level backtrace
>>> Dump Ruby level backtrace
#<Errno::ESRCH: No such process>
$ timeout 60 gdb -p 28698 -x /home/ko1/ruby/build-ruby/gdbscript -batch -quiet 2> /dev/null
[New LWP 6374]
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
0x00007f6c72858857 in cc_table_memsize_i (ccs_ptr=93864803165696, data_ptr=0x7ffcb545cf90) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:4526
4526	    *total_size += sizeof(ccs->entries[0]) * ccs->capa;
>>> Threads  Id   Target Id                                         Frame 
* 1    Thread 0x7f6c72310f40 (LWP 28698) "ruby"          0x00007f6c72858857 in cc_table_memsize_i (ccs_ptr=93864803165696, data_ptr=0x7ffcb545cf90) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:4526
  2    Thread 0x7f6c6f71f700 (LWP 6374) "parallel.rb:46" 0x00007f6c72427aff in __GI___poll (fds=fds@entry=0x7f6c6f61e5f0, nfds=nfds@entry=1, timeout=timeout@entry=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
>>> Machine level backtrace
Thread 2 (Thread 0x7f6c6f71f700 (LWP 6374)):
#0  0x00007f6c72427aff in __GI___poll (fds=fds@entry=0x7f6c6f61e5f0, nfds=nfds@entry=1, timeout=timeout@entry=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
#1  0x00007f6c7288a76a in poll (__timeout=-1, __nfds=1, __fds=0x7f6c6f61e5f0) at /usr/include/x86_64-linux-gnu/bits/poll2.h:46
#2  nogvl_wait_for (th=<optimized out>, events=1, fptr=0x555e99f64a00) at /tmp/ruby/v3/src/trunk-gc-asserts/io.c:11695
#3  nogvl_wait_for (events=1, fptr=0x555e99f64a00, th=<optimized out>) at /tmp/ruby/v3/src/trunk-gc-asserts/io.c:11678
#4  internal_read_func (ptr=ptr@entry=0x7f6c6f61e860) at /tmp/ruby/v3/src/trunk-gc-asserts/io.c:1092
#5  0x00007f6c729e311d in rb_thread_io_blocking_region (func=0x7f6c7288a6d0 <internal_read_func>, data1=0x7f6c6f61e860, fd=<optimized out>) at /tmp/ruby/v3/src/trunk-gc-asserts/thread.c:1808
#6  0x00007f6c7284a32e in rb_ensure (b_proc=b_proc@entry=0x7f6c7288b4d0 <read_internal_call>, data1=data1@entry=140103701882976, e_proc=e_proc@entry=0x7f6c729aef00 <rb_str_unlocktmp>, data2=<optimized out>) at /tmp/ruby/v3/src/trunk-gc-asserts/eval.c:993
#7  0x00007f6c729c61e1 in rb_str_locktmp_ensure (str=<optimized out>, func=func@entry=0x7f6c7288b4d0 <read_internal_call>, arg=arg@entry=140103701882976) at /tmp/ruby/v3/src/trunk-gc-asserts/string.c:3021
#8  0x00007f6c7289fa6f in read_internal_locktmp (iis=0x7f6c6f61e860, str=<optimized out>) at /tmp/ruby/v3/src/trunk-gc-asserts/io.c:3214
#9  io_getpartial (argc=<optimized out>, argv=<optimized out>, io=<optimized out>, no_exception=no_exception@entry=8, nonblock=nonblock@entry=0) at /tmp/ruby/v3/src/trunk-gc-asserts/io.c:3214
#10 0x00007f6c7289ff05 in io_readpartial (argc=<optimized out>, argv=<optimized out>, io=<optimized out>) at /tmp/ruby/v3/src/trunk-gc-asserts/io.c:3332
#11 0x00007f6c72a1a76b in vm_call_cfunc_with_frame (ec=0x555e99e94bb0, reg_cfp=0x7f6c6f71ebd0, calling=<optimized out>) at /tmp/ruby/v3/src/trunk-gc-asserts/vm_insnhelper.c:3037
#12 0x00007f6c72a289c2 in vm_sendish (block_handler=<optimized out>, method_explorer=<optimized out>, cd=<optimized out>, reg_cfp=<optimized out>, ec=<optimized out>) at /tmp/ruby/v3/src/trunk-gc-asserts/vm_callinfo.h:349
#13 vm_exec_core (ec=0x555e99e94bb0, initial=1) at ../../src/trunk-gc-asserts/insns.def:778
#14 0x00007f6c72a2e593 in rb_vm_exec (ec=0x555e99e94bb0, mjit_enable_p=true) at /tmp/ruby/v3/src/trunk-gc-asserts/vm.c:2211
#15 0x00007f6c72a366d3 in rb_vm_invoke_proc (ec=<optimized out>, proc=proc@entry=0x555e99b080f0, argc=argc@entry=0, argv=argv@entry=0x7f6c6f61ebf0, kw_splat=<optimized out>, passed_block_handler=passed_block_handler@entry=0) at /tmp/ruby/v3/src/trunk-gc-asserts/vm.c:1521
#16 0x00007f6c729e3785 in thread_do_start_proc (th=0x555e998ff670) at /tmp/ruby/v3/src/trunk-gc-asserts/thread.c:716
#17 0x00007f6c729e3dac in thread_do_start (th=0x555e998ff670) at /tmp/ruby/v3/src/trunk-gc-asserts/thread.c:735
#18 thread_start_func_2 (th=<optimized out>, stack_start=<optimized out>) at /tmp/ruby/v3/src/trunk-gc-asserts/thread.c:809
#19 0x00007f6c729e4811 in thread_start_func_1 (th_ptr=<optimized out>) at /tmp/ruby/v3/src/trunk-gc-asserts/thread_pthread.c:1054
#20 0x00007f6c7272e609 in start_thread (arg=<optimized out>) at pthread_create.c:477
#21 0x00007f6c72434293 in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:95
Thread 1 (Thread 0x7f6c72310f40 (LWP 28698)):
#0  0x00007f6c72858857 in cc_table_memsize_i (ccs_ptr=93864803165696, data_ptr=0x7ffcb545cf90) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:4526
#1  0x00007f6c729d8c75 in rb_id_table_foreach_values (tbl=tbl@entry=0x555e99692e80, func=func@entry=0x7f6c72858850 <cc_table_memsize_i>, data=data@entry=0x7ffcb545cf90) at /tmp/ruby/v3/src/trunk-gc-asserts/id_table.c:296
#2  0x00007f6c728651b2 in cc_table_memsize (cc_table=0x555e99692e80) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:4534
#3  obj_memsize_of (use_all_types=0, obj=140103713510560) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:4594
#4  obj_memsize_of (use_all_types=0, obj=140103713510560) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:4539
#5  check_rvalue_consistency_force (obj=140103713510560, terminate=1) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:1434
#6  0x00007f6c7286b086 in check_rvalue_consistency (obj=140103713510560) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:4296
#7  is_markable_object (objspace=0x555e984fa0b0, obj=140103713510560) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:4296
#8  gc_mark (obj=140103713510560, objspace=0x555e984fa0b0) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:6823
#9  gc_mark_children (objspace=0x555e984fa0b0, obj=140103703562240) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:6978
#10 0x00007f6c7286b9c6 in rb_objspace_reachable_objects_from (obj=140103703562240, func=0x7f6c72869170 <check_children_i>, data=<optimized out>) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:11180
#11 0x00007f6c7286bb41 in verify_internal_consistency_i (data=0x7ffcb545d0b0, stride=40, page_end=0x7f6c6f7bbff0, page_start=<optimized out>) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:7617
#12 gc_verify_internal_consistency_ (objspace=0x555e984fa0b0) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:7791
#13 0x00007f6c7286cfca in gc_verify_internal_consistency (objspace=0x555e984fa0b0) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:7868
#14 gc_sweep_finish (objspace=0x555e984fa0b0) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:5686
#15 gc_sweep_step (objspace=0x555e984fa0b0, size_pool=0x555e984fa0d8, heap=0x555e984fa100) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:5772
#16 0x00007f6c7286dbee in gc_sweep_rest (objspace=<optimized out>) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:5790
#17 gc_sweep_continue (objspace=0x555e984fa0b0, sweep_size_pool=<optimized out>, heap=0x555e984fa1b8) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:5815
#18 0x00007f6c7287407e in heap_prepare (heap=<optimized out>, size_pool=<optimized out>, objspace=0x555e984fa0b0) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:2205
#19 heap_next_freepage (heap=<optimized out>, size_pool=<optimized out>, objspace=<optimized out>) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:2406
#20 ractor_cache_slots (size_pool_idx=<optimized out>, cr=<optimized out>, objspace=<optimized out>) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:2442
#21 newobj_slowpath (size_pool_idx=1, wb_protected=1, cr=<optimized out>, objspace=0x555e984fa0b0, flags=5, klass=0) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:2502
#22 newobj_slowpath_wb_protected (klass=0, flags=5, objspace=0x555e984fa0b0, cr=<optimized out>, size_pool_idx=1) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:2522
#23 0x00007f6c72874706 in newobj_of0 (alloc_size=58, cr=<optimized out>, wb_protected=1, flags=5, klass=0) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:2562
#24 newobj_of (alloc_size=58, wb_protected=1, v3=0, v2=0, v1=0, flags=5, klass=0) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:2573
#25 rb_wb_protected_newobj_of (klass=klass@entry=0, flags=flags@entry=5, size=size@entry=58) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:2595
#26 0x00007f6c729af9da in str_alloc (size=58, klass=0) at /tmp/ruby/v3/src/trunk-gc-asserts/string.c:887
#27 str_alloc_embed (capa=34, klass=0) at /tmp/ruby/v3/src/trunk-gc-asserts/string.c:857
#28 str_new0 (klass=klass@entry=0, ptr=ptr@entry=0x0, len=33, termlen=termlen@entry=1) at /tmp/ruby/v3/src/trunk-gc-asserts/string.c:887
#29 0x00007f6c729b8965 in str_new (len=<optimized out>, ptr=0x0, klass=0) at /tmp/ruby/v3/src/trunk-gc-asserts/string.c:913
#30 rb_str_tmp_new (len=<optimized out>) at /tmp/ruby/v3/src/trunk-gc-asserts/string.c:1528
#31 0x00007ffcb545d700 in ?? ()
#32 0x0000000372a2f799 in ?? ()
#33 0x0000555e985028c0 in ?? ()
#34 0x00007f6c6eaf0000 in ?? () from /tmp/ruby/v3/build/trunk-gc-asserts/.ext/x86_64-linux/enc/utf_16be.so
#35 0x0000000000000021 in ?? ()
#36 0x00007f6c6ea714c0 in ?? ()
#37 0x00007f6c7220f3a0 in ?? ()
#38 0x00007ffcb545d710 in ?? ()
#39 0x00007f6c7220f398 in ?? ()
#40 0x00007f6c727b03b3 in ary_memcpy (argv=0x8, argc=1, beg=0, ary=93864770676576) at /tmp/ruby/v3/src/trunk-gc-asserts/array.c:781
#41 rb_ary_tmp_new_from_values (klass=<optimized out>, n=1, elts=0x8) at /tmp/ruby/v3/src/trunk-gc-asserts/array.c:781
#42 0x00007f6c72a22f0c in args_rest_array (args=<synthetic pointer>, args=<synthetic pointer>) at /tmp/ruby/v3/src/trunk-gc-asserts/vm_args.c:180
#43 args_setup_rest_parameter (locals=0x7f6c7220f3a0, args=<synthetic pointer>) at /tmp/ruby/v3/src/trunk-gc-asserts/vm_args.c:276
#44 setup_parameters_complex (ec=<optimized out>, iseq=<optimized out>, calling=<optimized out>, ci=<optimized out>, locals=<optimized out>, arg_setup_type=<optimized out>) at /tmp/ruby/v3/src/trunk-gc-asserts/vm_args.c:658
Backtrace stopped: Cannot access memory at address 0xb
>>> Dump Ruby level backtrace
th: 0x555e984f9f30, native_id: 0x7f6c72310f40
-- Control frame information -----------------------------------------------
c:0017 p:---- s:0110 e:000109 CFUNC  :encode
  me:
    called_id: encode, type: cfunc
    owner class: 0x00007f6c70142da8 [3LM    ] T_CLASS String
  self: 0x00007f6c6ea714a8 [3LM    ] T_STRING (String) [embed] len: 3, capa: 15 "???"
c:0016 p:0007 s:0105 e:000104 BLOCK  /tmp/ruby/v3/src/trunk-gc-asserts/test/ruby/enc/test_case_comprehensive.rb:154 [FINISH]
  me:
    called_id: test_UTF-16BE_upcase_turkic, type: bmethod
    owner class: 0x00007f6c6eb207a0 [3LM    ] T_CLASS TestComprehensiveCaseMapping
  self: 0x00007f6c6d231a78 [3LM    ] T_OBJECT (TestComprehensiveCaseMapping)len:8 ptr:0x0000555e9abc0b40
  lvars:
    code: 0x00007f6c6ea714a8 [3LM    ] T_STRING (String) [embed] len: 3, capa: 15 "???"
    source: T_NIL
    target: T_NIL
    result: T_NIL
c:0015 p:---- s:0098 e:000097 CFUNC  :each
  me:
    called_id: each, type: cfunc
    owner class: 0x00007f6c701354a0 [3LM    ] T_CLASS Array
  self: 0x00007f6c6cdca480 [3LM    ] T_ARRAY (Array)[   ] len: 33791, capa:37834 ptr:0x0000555e98dd5ec0
c:0014 p:0006 s:0094 E:001170 BLOCK  /tmp/ruby/v3/src/trunk-gc-asserts/test/ruby/enc/test_case_comprehensive.rb:153 [FINISH]
  me:
    called_id: test_UTF-16BE_upcase_turkic, type: bmethod
    owner class: 0x00007f6c6eb207a0 [3LM    ] T_CLASS TestComprehensiveCaseMapping
  self: 0x00007f6c6d231a78 [3LM    ] T_OBJECT (TestComprehensiveCaseMapping)len:8 ptr:0x0000555e9abc0b40
c:0013 p:0041 s:0091 e:000090 METHOD /tmp/ruby/v3/src/trunk-gc-asserts/tool/lib/test/unit/testcase.rb:200
  me:
    called_id: run_test, type: iseq
    owner class: 0x00007f6c6f88e090 [3LM    ] T_CLASS Test::Unit::TestCase
  self: 0x00007f6c6d231a78 [3LM    ] T_OBJECT (TestComprehensiveCaseMapping)len:8 ptr:0x0000555e9abc0b40
  lvars:
    name: T_SYMBOL test_UTF-16BE_upcase_turkic
    progname: 0x00007f6c6f776db0 [3LM    ] T_STRING (String) [embed] len: 64, capa: 135 "/tmp/ruby/v3/src/trunk-gc-asserts/tool/lib/test/unit/parallel.rb"
c:0012 p:0059 s:0085 e:000084 METHOD /tmp/ruby/v3/src/trunk-gc-asserts/tool/lib/test/unit/testcase.rb:168
  me:
    called_id: run, type: iseq
    owner class: 0x00007f6c6f88e090 [3LM    ] T_CLASS Test::Unit::TestCase
  self: 0x00007f6c6d231a78 [3LM    ] T_OBJECT (TestComprehensiveCaseMapping)len:8 ptr:0x0000555e9abc0b40
  lvars:
    runner: 0x00007f6c6f84f598 [3LM    ] T_OBJECT (Test::Unit::Worker)len:28 ptr:0x0000555e989352d0
    start_time: 0x00007f6c6d231898 [0    U ] time (Time)time
    result: 0x00007f6c721de3f0 [3LM    ] T_STRING (String) [embed] len: 0, capa: 15 ""
    time: T_NIL
    e: T_NIL
c:0011 p:0089 s:0076 e:000075 BLOCK  /tmp/ruby/v3/src/trunk-gc-asserts/tool/lib/test/unit.rb:1534 [FINISH]
  me:
    called_id: _run_suite, type: iseq
    owner class: 0x00007f6c6f8a9048 [3LM    ] T_CLASS Test::Unit::Runner
  self: 0x00007f6c6f84f598 [3LM    ] T_OBJECT (Test::Unit::Worker)len:28 ptr:0x0000555e989352d0
  lvars:
    method: T_SYMBOL test_UTF-16BE_upcase_turkic
    inst: 0x00007f6c6d231a78 [3LM    ] T_OBJECT (TestComprehensiveCaseMapping)len:8 ptr:0x0000555e9abc0b40
    start_time: T_NIL
    result: T_NIL
c:0010 p:---- s:0069 e:000068 CFUNC  :map
  me:
    called_id: map, type: cfunc
    owner class: 0x00007f6c701354a0 [3LM    ] T_CLASS Array
  self: 0x00007f6c6d3c1af0 [3LM    ] T_ARRAY (Array)[   ] len: 422, capa:422 ptr:0x0000555e9a3e8c10
c:0009 p:0117 s:0065 e:000064 METHOD /tmp/ruby/v3/src/trunk-gc-asserts/tool/lib/test/unit.rb:1521
  me:
    called_id: _run_suite, type: iseq
    owner class: 0x00007f6c6f8a9048 [3LM    ] T_CLASS Test::Unit::Runner
  self: 0x00007f6c6f84f598 [3LM    ] T_OBJECT (Test::Unit::Worker)len:28 ptr:0x0000555e989352d0
  lvars:
    suite: 0x00007f6c6eb207a0 [3LM    ] T_CLASS TestComprehensiveCaseMapping
    type: T_SYMBOL test
    header: 0x00007f6c6d3ad348 [3LM    ] T_STRING (String) len: 17, capa: 31 "test_suite_header"
    filter: 0x00007f6c6f7b5060 [3LM    ] T_REGEXP (Regexp)
    all_test_methods: 0x00007f6c6d3c1af0 [3LM    ] T_ARRAY (Array)[   ] len: 422, capa:422 ptr:0x0000555e9a3e8c10
    leakchecker: 0x00007f6c6d3c15f0 [3LM    ] T_OBJECT (LeakChecker)len:7 ptr:0x0000555e99ce2bf0
    trace: T_NIL
    assertions: T_NIL
c:0008 p:0042 s:0053 e:000052 METHOD /tmp/ruby/v3/src/trunk-gc-asserts/tool/lib/test/unit.rb:1314
  me:
    called_id: orig_run_suite, type: iseq
    owner class: 0x00007f6c6f8a95e8 [3LM    ] T_MODULE (Module)Test::Unit::ExcludesOption
    defined_class: 0x00007f6c6f8a8148 [3LM    ] T_ICLASS src:Test::Unit::ExcludesOption
  self: 0x00007f6c6f84f598 [3LM    ] T_OBJECT (Test::Unit::Worker)len:28 ptr:0x0000555e989352d0
  lvars:
    suite: 0x00007f6c6eb207a0 [3LM    ] T_CLASS TestComprehensiveCaseMapping
    type: T_SYMBOL test
    ex: T_NIL
c:0007 p:0110 s:0046 E:000590 METHOD /tmp/ruby/v3/src/trunk-gc-asserts/tool/lib/test/unit/parallel.rb:58
  me:
    called_id: _run_suite, type: iseq
    owner class: 0x00007f6c6f871cd8 [3LM    ] T_CLASS Test::Unit::Worker
  self: 0x00007f6c6f84f598 [3LM    ] T_OBJECT (Test::Unit::Worker)len:28 ptr:0x0000555e989352d0
  lvars:
    suite: 0x00007f6c6eb207a0 [3LM    ] T_CLASS TestComprehensiveCaseMapping
    type: T_SYMBOL test
    orig_testout: 0x00007f6c721c1840 [0LM  U ] T_FILE (IO)
    i: 0x00007f6c6d3ae0e0 [0LM  U ] T_FILE (IO)
    o: 0x00007f6c6d3ae040 [0LM  U ] T_FILE (IO)
    orig_stdin: 0x00007f6c721c1890 [0LM  U ] T_FILE (IO)
    orig_stdout: 0x00007f6c721c1840 [0LM  U ] T_FILE (IO)
    th: 0x00007f6c6d3adeb0 [0LM  U ] VM/thread (Thread)VM/thread
    e: T_FIXNUM 0
    f: T_FIXNUM 0
    s: T_FIXNUM 5
    result: T_NIL
c:0006 p:0007 s:0030 e:000029 BLOCK  /tmp/ruby/v3/src/trunk-gc-asserts/tool/lib/test/unit/parallel.rb:30 [FINISH]
  me:
    called_id: _run_suites, type: iseq
    owner class: 0x00007f6c6f871cd8 [3LM    ] T_CLASS Test::Unit::Worker
  self: 0x00007f6c6f84f598 [3LM    ] T_OBJECT (Test::Unit::Worker)len:28 ptr:0x0000555e989352d0
  lvars:
    suite: 0x00007f6c6eb207a0 [3LM    ] T_CLASS TestComprehensiveCaseMapping
c:0005 p:---- s:0026 e:000025 CFUNC  :map
  me:
    called_id: map, type: cfunc
    owner class: 0x00007f6c701354a0 [3LM    ] T_CLASS Array
  self: 0x00007f6c6d3ae388 [3LM    ] T_ARRAY (Array)[E ] len: 1 (embed)
c:0004 p:0005 s:0022 e:000021 METHOD /tmp/ruby/v3/src/trunk-gc-asserts/tool/lib/test/unit/parallel.rb:29
  me:
    called_id: _run_suites, type: iseq
    owner class: 0x00007f6c6f871cd8 [3LM    ] T_CLASS Test::Unit::Worker
  self: 0x00007f6c6f84f598 [3LM    ] T_OBJECT (Test::Unit::Worker)len:28 ptr:0x0000555e989352d0
  lvars:
    suites: 0x00007f6c6d3ae388 [3LM    ] T_ARRAY (Array)[E ] len: 1 (embed)
    type: T_SYMBOL test
c:0003 p:0260 s:0016 E:000090 METHOD /tmp/ruby/v3/src/trunk-gc-asserts/tool/lib/test/unit/parallel.rb:128
  me:
    called_id: run, type: iseq
    owner class: 0x00007f6c6f871cd8 [3LM    ] T_CLASS Test::Unit::Worker
  self: 0x00007f6c6f84f598 [3LM    ] T_OBJECT (Test::Unit::Worker)len:28 ptr:0x0000555e989352d0
  lvars:
    args: 0x00007f6c721c0d50 [3LM    ] T_ARRAY [E ] len: 0 (embed)
    buf: 0x00007f6c6eb0ebe0 [3LM    ] T_STRING (String) [embed] len: 84, capa: 135 "run /tmp/ruby/v3/src/trunk-gc-asserts/test/ruby/enc/test_case_comprehensive.rb test
"
    suites: 0x00007f6c6cdb8938 [3LM    ] T_ARRAY (Array)[   ] len: 92, capa:92 ptr:0x0000555e99ca2e00
    e: T_NIL
    trace: T_NIL
    err: T_NIL
c:0002 p:0127 s:0006 E:0024e0 EVAL   /tmp/ruby/v3/src/trunk-gc-asserts/tool/lib/test/unit/parallel.rb:211 [FINISH]
  self: 0x00007f6c721ace18 [3LM    ] T_OBJECT (embed) len:3
c:0001 p:0000 s:0003 E:0015f0 (none) [FINISH]
  self: 0x00007f6c721ace18 [3LM    ] T_OBJECT (embed) len:3
th: 0x555e998ff670, native_id: 0x7f6c6f71f700
-- Control frame information -----------------------------------------------
c:0003 p:---- s:0012 e:000011 CFUNC  :readpartial
  me:
    called_id: readpartial, type: cfunc
    owner class: 0x00007f6c70133e98 [3LM    ] T_CLASS IO
  self: 0x00007f6c6d3ae0e0 [0LM  U ] T_FILE (IO)
c:0002 p:0036 s:0007 e:000006 BLOCK  /tmp/ruby/v3/src/trunk-gc-asserts/tool/lib/test/unit/parallel.rb:48 [FINISH]
  me:
    called_id: _run_suite, type: iseq
    owner class: 0x00007f6c6f871cd8 [3LM    ] T_CLASS Test::Unit::Worker
  self: 0x00007f6c6f84f598 [3LM    ] T_OBJECT (Test::Unit::Worker)len:28 ptr:0x0000555e989352d0
  lvars:
    buf: 0x00007f6c6d25c4f8 [3LM    ] T_STRING (String) len: 1, capa: 1024 "."
c:0001 p:---- s:0003 e:000002 (none) [FINISH]
  self: T_NIL
$1 = 0
">>> Finish
"[Inferior 1 (process 28698) detached]
$ timeout 60 gdb -p 28696 -x /home/ko1/ruby/build-ruby/gdbscript -batch -quiet 2> /dev/null
running file: /tmp/ruby/v3/src/trunk-gc-asserts/test/ruby/enc/test_case_comprehensive.rb
Some worker was crashed. It seems ruby interpreter's bug
or, a bug of test/unit/parallel.rb. try again without -j
option.
[New LWP 6390]
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
0x00007fad2b157075 in gc_verify_heap_page (obj=0, objspace=0x55ba36a6a0b0, page=0x55ba36cefdc0) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:7673
7673		if (RVALUE_PAGE_UNCOLLECTIBLE(page, val) && RVALUE_PAGE_WB_UNPROTECTED(page, val)) {
>>> Threads  Id   Target Id                                        Frame 
* 1    Thread 0x7fad2abfef40 (LWP 28696) "ruby"         0x00007fad2b157075 in gc_verify_heap_page (obj=0, objspace=0x55ba36a6a0b0, page=0x55ba36cefdc0) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:7673
  2    Thread 0x7fad27fab700 (LWP 6390) "timeout.rb:97" futex_abstimed_wait_cancelable (private=<optimized out>, abstime=0x7fad27faae50, clockid=<optimized out>, expected=0, futex_word=0x7fad27faae88) at ../sysdeps/nptl/futex-internal.h:320
>>> Machine level backtrace
Thread 2 (Thread 0x7fad27fab700 (LWP 6390)):
#0  futex_abstimed_wait_cancelable (private=<optimized out>, abstime=0x7fad27faae50, clockid=<optimized out>, expected=0, futex_word=0x7fad27faae88) at ../sysdeps/nptl/futex-internal.h:320
#1  __pthread_cond_wait_common (abstime=0x7fad27faae50, clockid=<optimized out>, mutex=0x7fad2b497020 <thread_cache_lock>, cond=0x7fad27faae60) at pthread_cond_wait.c:520
#2  __pthread_cond_timedwait (cond=cond@entry=0x7fad27faae60, mutex=mutex@entry=0x7fad2b497020 <thread_cache_lock>, abstime=abstime@entry=0x7fad27faae50) at pthread_cond_wait.c:656
#3  0x00007fad2b2d28d8 in native_cond_timedwait (abs=<synthetic pointer>, mutex=0x7fad2b497020 <thread_cache_lock>, cond=0x7fad27faae60) at /tmp/ruby/v3/src/trunk-gc-asserts/thread_pthread.c:572
#4  register_cached_thread_and_wait (altstack=0x55ba36e8ff00) at /tmp/ruby/v3/src/trunk-gc-asserts/thread_pthread.c:1116
#5  thread_start_func_1 (th_ptr=<optimized out>) at /tmp/ruby/v3/src/trunk-gc-asserts/thread_pthread.c:1061
#6  0x00007fad2b01c609 in start_thread (arg=<optimized out>) at pthread_create.c:477
#7  0x00007fad2ad22293 in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:95
Thread 1 (Thread 0x7fad2abfef40 (LWP 28696)):
#0  0x00007fad2b157075 in gc_verify_heap_page (obj=0, objspace=0x55ba36a6a0b0, page=0x55ba36cefdc0) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:7673
#1  gc_verify_heap_pages_ (objspace=0x55ba36a6a0b0, head=0x55ba36a6a330) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:7740
#2  0x00007fad2b159d52 in gc_verify_heap_pages (objspace=<optimized out>) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:7752
#3  gc_verify_internal_consistency_ (objspace=0x55ba36a6a0b0) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:7804
#4  0x00007fad2b15f4cc in gc_verify_internal_consistency (objspace=0x55ba36a6a0b0) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:7868
#5  rb_objspace_call_finalizer (objspace=0x55ba36a6a0b0) at /tmp/ruby/v3/src/trunk-gc-asserts/gc.c:4160
#6  0x00007fad2b13a330 in rb_ec_finalize (ec=0x55ba36a6aaa0) at /tmp/ruby/v3/src/trunk-gc-asserts/vm_core.h:1860
#7  rb_ec_cleanup (ec=ec@entry=0x55ba36a6aaa0, ex0=<optimized out>) at /tmp/ruby/v3/src/trunk-gc-asserts/eval.c:256
#8  0x00007fad2b13a674 in ruby_run_node (n=0x7fad2aad43d0) at /tmp/ruby/v3/src/trunk-gc-asserts/eval.c:321
#9  0x000055ba357b72d3 in rb_main (argc=<optimized out>, argv=<optimized out>) at /tmp/ruby/v3/src/trunk-gc-asserts/main.c:47
#10 0x00007fad2ac270b3 in __libc_start_main (main=0x55ba357b7160 <main>, argc=8, argv=0x7ffd839afad8, init=<optimized out>, fini=<optimized out>, rtld_fini=<optimized out>, stack_end=0x7ffd839afac8) at ../csu/libc-start.c:308
#11 0x000055ba357b719e in _start () at /tmp/ruby/v3/src/trunk-gc-asserts/main.c:56
>>> Dump Ruby level backtrace
th: 0x55ba36a69f30, native_id: 0x7fad2abfef40
-- Control frame information -----------------------------------------------
c:0001 p:0000 s:0003 E:000520 (none) [FINISH]
  self: 0x00007fad2aa9ce08 [3LM    ] T_OBJECT (embed) len:3
$1 = 0
">>> Finish
"[Inferior 1 (process 28696) detached]
$ timeout 60 gdb -p 28688 -x /home/ko1/ruby/build-ruby/gdbscript -batch -quiet 2> /dev/null
make: *** [uncommon.mk:821: yes-test-all] Killed
>>> ThreadsNo threads.
>>> Machine level backtrace
>>> Dump Ruby level backtrace
#<Errno::ESRCH: No such process>
$ timeout 60 gdb -p 28687 -x /home/ko1/ruby/build-ruby/gdbscript -batch -quiet 2> /dev/null
>>> ThreadsNo threads.
>>> Machine level backtrace
>>> Dump Ruby level backtrace

Linux phosphorus-docker 4.9.0-17-amd64 #1 SMP Debian 4.9.290-1 (2021-12-12) x86_64 x86_64 x86_64 GNU/Linux

Logfile: /home/ko1/ruby/logs/brlog.trunk-gc-asserts.20220201-084701
#<BuildRuby:0x000056261347bd20
 @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-gc-asserts",
 @TARGET_INSTALL_DIR="/tmp/ruby/v3/install/trunk-gc-asserts",
 @TARGET_NAME="trunk-gc-asserts",
 @TARGET_SRC_DIR="/tmp/ruby/v3/src/trunk-gc-asserts",
 @build_opts="DEFS=\"-DRGENGC_CHECK_MODE=2\"",
 @configure_opts=["--enable-shared"],
 @gist=false,
 @git_branch=nil,
 @git_worktree=nil,
 @incremental=true,
 @logfile="/home/ko1/ruby/logs/brlog.trunk-gc-asserts.20220201-084701",
 @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="TESTS='-j6'",
 @timeout=10800>
                           user     system      total        real
checkout               0.000000   0.000000   0.000000 (  0.000027)
autoconf               0.000000   0.000000   0.000000 (  0.000066)
configure              0.000000   0.000000   0.000000 (  0.000050)
build_up               0.012000   0.004000   2.004000 (  2.784697)
build_miniruby         0.000000   0.000000   0.152000 (  0.184843)
build_ruby             0.004000   0.000000   0.180000 (  0.201809)
build_all              0.016000   0.000000  46.640000 ( 47.781288)
build_install          0.020000   0.016000  70.052000 ( 71.323242)
test_btest             0.004000   0.000000 702.876000 (560.704561)
test_basic             0.004000   0.008000   7.052000 (  7.215720)
test_all               0.024000   0.000000 27707.112000 (10804.219300)
/home/ko1/ruby/build-ruby/build-ruby.rb:212:in `join': execution expired (Timeout::Error)
	from /home/ko1/ruby/build-ruby/build-ruby.rb:212:in `each'
	from /home/ko1/ruby/build-ruby/build-ruby.rb:212: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:211:in `block in cmd'
	from /home/ko1/ruby/build-ruby/build-ruby.rb:203:in `popen'
	from /home/ko1/ruby/build-ruby/build-ruby.rb:203:in `cmd'
	from /home/ko1/ruby/build-ruby/build-ruby.rb:378:in `block in test_all'
	from /home/ko1/ruby/build-ruby/build-ruby.rb:298:in `block in builddir'
	from /home/ko1/ruby/build-ruby/build-ruby.rb:297:in `chdir'
	from /home/ko1/ruby/build-ruby/build-ruby.rb:297:in `builddir'
	from /home/ko1/ruby/build-ruby/build-ruby.rb:376:in `test_all'
	from /home/ko1/ruby/build-ruby/build-ruby.rb:440: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:438:in `block (3 levels) in run'
	from /home/ko1/ruby/build-ruby/build-ruby.rb:437:in `each'
	from /home/ko1/ruby/build-ruby/build-ruby.rb:437: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:436: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:435:in `run'
	from /home/ko1/ruby/build-ruby/build-ruby.rb:629:in `<main>'
total: 11494.42 sec