rev: 91c542ad05
test-all :
test-spec:
exit statuses:
"make update-unicode -j6" exit with 0.
"make update-download -j6" exit with 0.
"make update-rubyspec -j6" exit with 0.
"make update-src -j6" exit with 0.
"make after-update -j6" exit with 0.
"make miniruby -j6" exit with 0.
"make ruby -j6" exit with 0.
"make all -j6" exit with 0.
"make install -j6" exit with 0.
Logfile: /home/ko1/ruby/logs/brlog.trunk-mjit.20210605-010552
#<BuildRuby:0x000055e420493180
@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",
@TARGET_INSTALL_DIR="/tmp/ruby/v3/install/trunk-mjit",
@TARGET_NAME="trunk-mjit",
@TARGET_SRC_DIR="/tmp/ruby/v3/src/trunk-mjit",
@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.20210605-010552",
@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\"",
@timeout=10800>
user system total real
checkout 0.000000 0.000000 0.000000 ( 0.000029)
autoconf 0.000000 0.000000 0.000000 ( 0.000067)
configure 0.000000 0.000000 0.000000 ( 0.000068)
build_up 0.008000 0.004000 9.916000 ( 6.492980)
build_miniruby 0.000000 0.004000 0.164000 ( 0.186771)
build_ruby 0.000000 0.000000 0.148000 ( 0.179930)
build_all 0.016000 0.000000 13.904000 ( 8.153657)
build_install 0.024000 0.008000 27.888000 ( 16.245041)
test_btest test_attr.rb ..
test_autoload.rb ........
test_block.rb ..........................................................
test_class.rb ................................................
test_env.rb ..
test_eval.rb .....................................
test_exception.rb ..................................
test_fiber.rb .....
test_finalizer.rb .
test_flip.rb .
test_flow.rb ..............................................................
test_fork.rb ....
test_gc.rb ..
test_insns.rb ...............................................................................................................................................................................................................................................................................................................................................................................................
test_io.rb .........
test_jump.rb .............................
test_literal.rb ............................................................................................................................................................
test_literal_suffix.rb ................................................
test_load.rb ..
test_marshal.rb .
test_massign.rb ..................................
test_method.rb ...............................................................................................................................................................................................................................
test_objectspace.rb ......
test_proc.rb .....................................
test_ractor.rb .....................................................................................$$$ #<Timeout::Error: execution expired>
### enter analyzing mode for stuck processes
$$$ ps jx
PPID PID PGID SID TTY TPGID STAT UID TIME COMMAND
10 11 11 11 ? -1 Ss 1001 0:00 sh build-loop.sh trunk-mjit --incremental --process-num=6
11 23688 11 11 ? -1 Sl 1001 0:00 ruby ./br.rb build_report trunk-mjit --incremental --process-num=6
23688 23690 11 11 ? -1 S 1001 0:00 sh -c ruby /home/ko1/ruby/build-ruby/build-ruby.rb --target_name=trunk-mjit --logfile=/home/ko1/ruby/logs/brlog.trunk-mjit.20210605-010552 --root_dir=/tmp/ruby --timeout=10800 --configure_opts=cppflags="-DMJIT_FORCE_ENABLE" --add-env=RUBY_TEST_SUBPROCESS_TIMEOUT_SCALE=30 --test_opts='RUN_OPTS="--disable-gems --jit-debug=-ggdb3"' --incremental --process-num=6
23690 23691 11 11 ? -1 Sl 1001 0:00 ruby /home/ko1/ruby/build-ruby/build-ruby.rb --target_name=trunk-mjit --logfile=/home/ko1/ruby/logs/brlog.trunk-mjit.20210605-010552 --root_dir=/tmp/ruby --timeout=10800 --configure_opts=cppflags=-DMJIT_FORCE_ENABLE --add-env=RUBY_TEST_SUBPROCESS_TIMEOUT_SCALE=30 --test_opts=RUN_OPTS="--disable-gems --jit-debug=-ggdb3" --incremental --process-num=6
23691 24311 11 11 ? -1 S 1001 0:00 sh -c make yes-btest RUN_OPTS="--disable-gems --jit-debug=-ggdb3"
24311 24312 11 11 ? -1 S 1001 0:00 make yes-btest RUN_OPTS=--disable-gems --jit-debug=-ggdb3
24312 24318 11 11 ? -1 Sl 1001 0:01 /usr/bin/ruby --disable=gems /tmp/ruby/v3/src/trunk-mjit/bootstraptest/runner.rb --ruby=./miniruby -I/tmp/ruby/v3/src/trunk-mjit/lib -I. -I.ext/common --disable-gems --jit-debug=-ggdb3
24318 29697 11 11 ? -1 Sl 1001 164:36 /tmp/ruby/v3/build/trunk-mjit/miniruby -I/tmp/ruby/v3/src/trunk-mjit/lib -I/tmp/ruby/v3/build/trunk-mjit -I/tmp/ruby/v3/build/trunk-mjit/.ext/common --disable-gems --jit-debug=-ggdb3 -W0 bootstraptest.tmp.rb
23691 29703 11 11 ? -1 R 1001 0:00 ps jx
{10=>[11], 11=>[23688], 23688=>[23690], 23690=>[23691], 23691=>[24311, 29703], 24311=>[24312], 24312=>[24318], 24318=>[29697]}
"timeout 60 gdb -p 29697 -x /home/ko1/ruby/build-ruby/gdbscript -batch -quiet"
[New LWP 29698]
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
52 lowlevellock.c: No such file or directory.
__lll_lock_wait (futex=futex@entry=0x555abdf63b20 <mjit_engine_mutex>, private=0) at lowlevellock.c:52
>>> Threads Id Target Id Frame
* 1 Thread 0x7f0d9c5f7b80 (LWP 29697) "miniruby" __lll_lock_wait (futex=futex@entry=0x555abdf63b20 <mjit_engine_mutex>, private=0) at lowlevellock.c:52
2 Thread 0x7f0d98fef700 (LWP 29698) "ruby-mjitworker" 0x0000555abdcaae14 in get_from_list (list=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit/ccan/list/list.h:761
>>> Machine level backtrace
Thread 2 (Thread 0x7f0d98fef700 (LWP 29698)):
#0 0x0000555abdcaae14 in get_from_list (list=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit/ccan/list/list.h:761
#1 mjit_worker () at /tmp/ruby/v3/src/trunk-mjit/mjit_worker.c:1477
#2 0x0000555abddcb4de in mjit_worker (arg=0x555abdcaa790 <mjit_worker>) at /tmp/ruby/v3/src/trunk-mjit/thread_pthread.c:2018
#3 0x00007f0d9ca15609 in start_thread (arg=<optimized out>) at pthread_create.c:477
#4 0x00007f0d9c71b293 in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:95
Thread 1 (Thread 0x7f0d9c5f7b80 (LWP 29697)):
#0 __lll_lock_wait (futex=futex@entry=0x555abdf63b20 <mjit_engine_mutex>, private=0) at lowlevellock.c:52
#1 0x00007f0d9ca1a07b in __pthread_mutex_cond_lock (mutex=mutex@entry=0x555abdf63b20 <mjit_engine_mutex>) at ../nptl/pthread_mutex_lock.c:80
#2 0x00007f0d9ca1c260 in __pthread_cond_wait_common (abstime=0x0, clockid=0, mutex=0x555abdf63b20 <mjit_engine_mutex>, cond=0x555abdf63ae0 <mjit_pch_wakeup>) at pthread_cond_wait.c:627
#3 __pthread_cond_wait (cond=cond@entry=0x555abdf63ae0 <mjit_pch_wakeup>, mutex=mutex@entry=0x555abdf63b20 <mjit_engine_mutex>) at pthread_cond_wait.c:638
#4 0x0000555abddd0b6d in rb_native_cond_wait (cond=cond@entry=0x555abdf63ae0 <mjit_pch_wakeup>, mutex=mutex@entry=0x555abdf63b20 <mjit_engine_mutex>) at /tmp/ruby/v3/src/trunk-mjit/thread_pthread.c:545
#5 0x0000555abdcad2ea in mjit_finish (close_handle_p=close_handle_p@entry=true) at /tmp/ruby/v3/src/trunk-mjit/mjit.c:882
#6 0x0000555abdc35e2e in rb_ec_cleanup (ec=ec@entry=0x555abfd07680, ex=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit/eval.c:293
#7 0x0000555abdc36759 in ruby_run_node (n=0x7f0d9c4ed490) at /tmp/ruby/v3/src/trunk-mjit/eval.c:375
#8 0x0000555abdb8dd23 in main (argc=<optimized out>, argv=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit/main.c:47
>>> Dump Ruby level backtrace
$1 = 0
">>> Finish
"[Inferior 1 (process 29697) detached]
[nil, 29697]
"timeout 60 gdb -p 24318 -x /home/ko1/ruby/build-ruby/gdbscript -batch -quiet"
Fstderr output is not empty
th: 0x555abfd06e10, native_id: 0x7f0d9c5f7b80
-- Control frame information -----------------------------------------------
c:0001 p:0000 s:0003 E:001d20 (none) [FINISH]
self: 0x00007f0d9c4944d0 [3LM ] T_OBJECT (embed) len:3
[New LWP 24320]
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
26 ../sysdeps/unix/sysv/linux/read.c: No such file or directory.
__GI___libc_read (nbytes=8192, buf=0x56102dcce7e0, fd=6) at ../sysdeps/unix/sysv/linux/read.c:26
>>> Threads Id Target Id Frame
* 1 Thread 0x7f68f4096740 (LWP 24318) "ruby" __GI___libc_read (nbytes=8192, buf=0x56102dcce7e0, fd=6) at ../sysdeps/unix/sysv/linux/read.c:26
2 Thread 0x7f68f0b3c700 (LWP 24320) "runner.rb:476" __GI___libc_read (nbytes=8192, buf=0x7f68ec005b70, fd=5) at ../sysdeps/unix/sysv/linux/read.c:26
>>> Machine level backtrace
Thread 2 (Thread 0x7f68f0b3c700 (LWP 24320)):
#0 __GI___libc_read (nbytes=8192, buf=0x7f68ec005b70, fd=5) at ../sysdeps/unix/sysv/linux/read.c:26
#1 __GI___libc_read (fd=5, buf=0x7f68ec005b70, nbytes=8192) at ../sysdeps/unix/sysv/linux/read.c:24
#2 0x00007f68f45a1799 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#3 0x00007f68f46ae3ff in rb_thread_io_blocking_region () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#4 0x00007f68f45a83ea in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#5 0x00007f68f457b797 in rb_ensure () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#6 0x00007f68f45a31ac in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#7 0x00007f68f45a7b66 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#8 0x00007f68f45aabbb in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#9 0x00007f68f46dd026 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#10 0x00007f68f46d0406 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#11 0x00007f68f46e10ba in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#12 0x00007f68f46e7870 in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#13 0x00007f68f46eb336 in rb_vm_invoke_proc () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#14 0x00007f68f46acac3 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#15 0x00007f68f46aec10 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#16 0x00007f68f46af04d in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#17 0x00007f68f42c3609 in start_thread (arg=<optimized out>) at pthread_create.c:477
#18 0x00007f68f43ff293 in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:95
Thread 1 (Thread 0x7f68f4096740 (LWP 24318)):
#0 __GI___libc_read (nbytes=8192, buf=0x56102dcce7e0, fd=6) at ../sysdeps/unix/sysv/linux/read.c:26
#1 __GI___libc_read (fd=6, buf=0x56102dcce7e0, nbytes=8192) at ../sysdeps/unix/sysv/linux/read.c:24
#2 0x00007f68f45a1799 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#3 0x00007f68f46ae3ff in rb_thread_io_blocking_region () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#4 0x00007f68f45a83ea in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#5 0x00007f68f457b797 in rb_ensure () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#6 0x00007f68f45a31ac in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#7 0x00007f68f45a7b66 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#8 0x00007f68f45b3f77 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#9 0x00007f68f46dd026 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#10 0x00007f68f46d0406 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#11 0x00007f68f46e10ba in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#12 0x00007f68f46e7870 in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#13 0x00007f68f45c1663 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#14 0x00007f68f45c180b in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#15 0x00007f68f46dd026 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#16 0x00007f68f46d0406 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#17 0x00007f68f46e10ba in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#18 0x00007f68f46e7870 in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#19 0x00007f68f46f49f1 in rb_yield () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#20 0x00007f68f44fc45c in rb_ary_each () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#21 0x00007f68f46dd026 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#22 0x00007f68f46e9dab in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#23 0x00007f68f46d0406 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#24 0x00007f68f46e1131 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#25 0x00007f68f46e7870 in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#26 0x00007f68f46f49f1 in rb_yield () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#27 0x00007f68f457b797 in rb_ensure () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#28 0x00007f68f455bebf in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#29 0x00007f68f46dd026 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#30 0x00007f68f46e9dab in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#31 0x00007f68f46d0406 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#32 0x00007f68f46e1131 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#33 0x00007f68f46e7870 in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#34 0x00007f68f4578491 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#35 0x00007f68f457d2ee in ruby_run_node () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#36 0x000056102d8ef17f in ?? ()
#37 0x00007f68f43040b3 in __libc_start_main (main=0x56102d8ef120, argc=4, argv=0x7ffebd95c328, init=<optimized out>, fini=<optimized out>, rtld_fini=<optimized out>, stack_end=0x7ffebd95c318) at ../csu/libc-start.c:308
#38 0x000056102d8ef1ce in _start ()
>>> Dump Ruby level backtrace
/home/ko1/ruby/build-ruby/gdbscript:12: Error in sourced command file:
No symbol "rb_vmdebug_stack_dump_all_threads" in current context.
[Inferior 1 (process 24318) detached]
[nil, 24318]
"timeout 60 gdb -p 24312 -x /home/ko1/ruby/build-ruby/gdbscript -batch -quiet"
make: *** [uncommon.mk:763: yes-btest] Killed
ptrace: No such process.
>>> ThreadsNo threads.
>>> Machine level backtrace
>>> Dump Ruby level backtrace
/home/ko1/ruby/build-ruby/gdbscript:12: Error in sourced command file:
No symbol table is loaded. Use the "file" command.
[nil, 24312]
#<Errno::ESRCH: No such process>
"timeout 60 gdb -p 24311 -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 24311 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, 24311]
"timeout 60 gdb -p 29703 -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, 29703]
#<Errno::ESRCH: No such process>
0.004000 0.004000 10790.128000 (10802.124274)
/home/ko1/ruby/build-ruby/build-ruby.rb:174:in `each_line': execution expired (Timeout::Error)
from /home/ko1/ruby/build-ruby/build-ruby.rb:174:in `block (2 levels) in cmd'
from /usr/lib/ruby/2.7.0/timeout.rb:110:in `timeout'
from /home/ko1/ruby/build-ruby/build-ruby.rb:173:in `block in cmd'
from /home/ko1/ruby/build-ruby/build-ruby.rb:170:in `popen'
from /home/ko1/ruby/build-ruby/build-ruby.rb:170:in `cmd'
from /home/ko1/ruby/build-ruby/build-ruby.rb:308:in `block in test_btest'
from /home/ko1/ruby/build-ruby/build-ruby.rb:243:in `block in builddir'
from /home/ko1/ruby/build-ruby/build-ruby.rb:242:in `chdir'
from /home/ko1/ruby/build-ruby/build-ruby.rb:242:in `builddir'
from /home/ko1/ruby/build-ruby/build-ruby.rb:307:in `test_btest'
from /home/ko1/ruby/build-ruby/build-ruby.rb:382:in `block (4 levels) in run'
from /usr/lib/ruby/2.7.0/benchmark.rb:293:in `measure'
from /usr/lib/ruby/2.7.0/benchmark.rb:375:in `item'
from /home/ko1/ruby/build-ruby/build-ruby.rb:380:in `block (3 levels) in run'
from /home/ko1/ruby/build-ruby/build-ruby.rb:379:in `each'
from /home/ko1/ruby/build-ruby/build-ruby.rb:379:in `block (2 levels) in run'
from /usr/lib/ruby/2.7.0/benchmark.rb:173:in `benchmark'
from /usr/lib/ruby/2.7.0/benchmark.rb:205:in `bm'
from /home/ko1/ruby/build-ruby/build-ruby.rb:378:in `block in run'
from /usr/lib/ruby/2.7.0/benchmark.rb:293:in `measure'
from /home/ko1/ruby/build-ruby/build-ruby.rb:377:in `run'
from /home/ko1/ruby/build-ruby/build-ruby.rb:551:in `<main>'
total: 10833.38 sec