rev: 09f284c052
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.20210224-191304
#<BuildRuby:0x000055fb8f657198
@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.20210224-191304",
@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.000027)
autoconf 0.000000 0.000000 0.000000 ( 0.000057)
configure 0.000000 0.000000 0.000000 ( 0.000052)
build_up 0.004000 0.008000 10.800000 ( 6.985303)
build_miniruby 0.000000 0.004000 0.112000 ( 0.120702)
build_ruby 0.000000 0.000000 0.152000 ( 0.164809)
build_all 0.008000 0.004000 18.708000 ( 8.667816)
build_install 0.032000 0.000000 34.676000 ( 17.354360)
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 17186 11 11 ? -1 Sl 1001 0:00 ruby ./br.rb build_report trunk-mjit --incremental --process-num=6
17186 17188 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.20210224-191304 --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
17188 17189 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.20210224-191304 --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
17189 17886 11 11 ? -1 S 1001 0:00 sh -c make yes-btest RUN_OPTS="--disable-gems --jit-debug=-ggdb3"
17886 17887 11 11 ? -1 S 1001 0:00 make yes-btest RUN_OPTS=--disable-gems --jit-debug=-ggdb3
17887 17893 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
17893 22875 11 11 ? -1 Sl 1001 166:15 /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
17189 22882 11 11 ? -1 R 1001 0:00 ps jx
{10=>[11], 11=>[17186], 17186=>[17188], 17188=>[17189], 17189=>[17886, 22882], 17886=>[17887], 17887=>[17893], 17893=>[22875]}
"timeout 60 gdb -p 22875 -x /home/ko1/ruby/build-ruby/gdbscript -batch -quiet"
[New LWP 22876]
[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=0x55c5f0531b40 <mjit_engine_mutex>, private=0) at lowlevellock.c:52
>>> Threads Id Target Id Frame
* 1 Thread 0x7f2755817b80 (LWP 22875) "miniruby" __lll_lock_wait (futex=futex@entry=0x55c5f0531b40 <mjit_engine_mutex>, private=0) at lowlevellock.c:52
2 Thread 0x7f275226b700 (LWP 22876) "ruby-mjitworker" get_from_list (list=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit/ccan/list/list.h:761
>>> Machine level backtrace
Thread 2 (Thread 0x7f275226b700 (LWP 22876)):
#0 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:1408
#2 0x000055c5f039b09e in mjit_worker (arg=0x55c5f027bd20 <mjit_worker>) at /tmp/ruby/v3/src/trunk-mjit/thread_pthread.c:1980
#3 0x00007f2755c35609 in start_thread (arg=<optimized out>) at pthread_create.c:477
#4 0x00007f275593b293 in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:95
Thread 1 (Thread 0x7f2755817b80 (LWP 22875)):
#0 __lll_lock_wait (futex=futex@entry=0x55c5f0531b40 <mjit_engine_mutex>, private=0) at lowlevellock.c:52
#1 0x00007f2755c3a07b in __pthread_mutex_cond_lock (mutex=mutex@entry=0x55c5f0531b40 <mjit_engine_mutex>) at ../nptl/pthread_mutex_lock.c:80
#2 0x00007f2755c3c260 in __pthread_cond_wait_common (abstime=0x0, clockid=0, mutex=0x55c5f0531b40 <mjit_engine_mutex>, cond=0x55c5f0531b00 <mjit_pch_wakeup>) at pthread_cond_wait.c:627
#3 __pthread_cond_wait (cond=cond@entry=0x55c5f0531b00 <mjit_pch_wakeup>, mutex=mutex@entry=0x55c5f0531b40 <mjit_engine_mutex>) at pthread_cond_wait.c:638
#4 0x000055c5f03a06dd in rb_native_cond_wait (cond=cond@entry=0x55c5f0531b00 <mjit_pch_wakeup>, mutex=mutex@entry=0x55c5f0531b40 <mjit_engine_mutex>) at /tmp/ruby/v3/src/trunk-mjit/thread_pthread.c:542
#5 0x000055c5f027db0a in mjit_finish (close_handle_p=close_handle_p@entry=true) at /tmp/ruby/v3/src/trunk-mjit/mjit.c:873
#6 0x000055c5f0209a3e in rb_ec_cleanup (ec=ec@entry=0x55c5f05e3680, ex=<optimized out>) at /tmp/ruby/v3/src/trunk-mjit/eval.c:293
#7 0x000055c5f020a369 in ruby_run_node (n=0x55c5f05ee730) at /tmp/ruby/v3/src/trunk-mjit/eval.c:375
#8 0x000055c5f0162183 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 22875) detached]
[nil, 22875]
"timeout 60 gdb -p 17893 -x /home/ko1/ruby/build-ruby/gdbscript -batch -quiet"
Fstderr output is not empty
th: 0x55c5f05e2e20, native_id: 0x7f2755817b80
-- Control frame information -----------------------------------------------
c:0001 p:0000 s:0003 E:002360 (none) [FINISH]
self: 0x000055c5f069c498 [3LM ] T_OBJECT (embed) len:3
[New LWP 17895]
[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=0x557732c023b0, fd=6) at ../sysdeps/unix/sysv/linux/read.c:26
>>> Threads Id Target Id Frame
* 1 Thread 0x7f26c1f80740 (LWP 17893) "ruby" __GI___libc_read (nbytes=8192, buf=0x557732c023b0, fd=6) at ../sysdeps/unix/sysv/linux/read.c:26
2 Thread 0x7f26bea26700 (LWP 17895) "runner.rb:476" __GI___libc_read (nbytes=8192, buf=0x7f26b8004df0, fd=5) at ../sysdeps/unix/sysv/linux/read.c:26
>>> Machine level backtrace
Thread 2 (Thread 0x7f26bea26700 (LWP 17895)):
#0 __GI___libc_read (nbytes=8192, buf=0x7f26b8004df0, fd=5) at ../sysdeps/unix/sysv/linux/read.c:26
#1 __GI___libc_read (fd=5, buf=0x7f26b8004df0, nbytes=8192) at ../sysdeps/unix/sysv/linux/read.c:24
#2 0x00007f26c248b799 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#3 0x00007f26c25983ff in rb_thread_io_blocking_region () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#4 0x00007f26c24923ea in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#5 0x00007f26c2465797 in rb_ensure () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#6 0x00007f26c248d1ac in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#7 0x00007f26c2491b66 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#8 0x00007f26c2494bbb in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#9 0x00007f26c25c7026 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#10 0x00007f26c25ba406 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#11 0x00007f26c25cb0ba in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#12 0x00007f26c25d1870 in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#13 0x00007f26c25d5336 in rb_vm_invoke_proc () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#14 0x00007f26c2596ac3 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#15 0x00007f26c2598c10 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#16 0x00007f26c259904d in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#17 0x00007f26c21ad609 in start_thread (arg=<optimized out>) at pthread_create.c:477
#18 0x00007f26c22e9293 in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:95
Thread 1 (Thread 0x7f26c1f80740 (LWP 17893)):
#0 __GI___libc_read (nbytes=8192, buf=0x557732c023b0, fd=6) at ../sysdeps/unix/sysv/linux/read.c:26
#1 __GI___libc_read (fd=6, buf=0x557732c023b0, nbytes=8192) at ../sysdeps/unix/sysv/linux/read.c:24
#2 0x00007f26c248b799 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#3 0x00007f26c25983ff in rb_thread_io_blocking_region () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#4 0x00007f26c24923ea in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#5 0x00007f26c2465797 in rb_ensure () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#6 0x00007f26c248d1ac in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#7 0x00007f26c2491b66 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#8 0x00007f26c249df77 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#9 0x00007f26c25c7026 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#10 0x00007f26c25ba406 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#11 0x00007f26c25cb0ba in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#12 0x00007f26c25d1870 in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#13 0x00007f26c24ab663 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#14 0x00007f26c24ab80b in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#15 0x00007f26c25c7026 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#16 0x00007f26c25ba406 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#17 0x00007f26c25cb0ba in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#18 0x00007f26c25d1870 in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#19 0x00007f26c25de9f1 in rb_yield () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#20 0x00007f26c23e645c in rb_ary_each () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#21 0x00007f26c25c7026 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#22 0x00007f26c25d3dab in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#23 0x00007f26c25ba406 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#24 0x00007f26c25cb131 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#25 0x00007f26c25d1870 in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#26 0x00007f26c25de9f1 in rb_yield () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#27 0x00007f26c2465797 in rb_ensure () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#28 0x00007f26c2445ebf in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#29 0x00007f26c25c7026 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#30 0x00007f26c25d3dab in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#31 0x00007f26c25ba406 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#32 0x00007f26c25cb131 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#33 0x00007f26c25d1870 in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#34 0x00007f26c2462491 in ?? () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#35 0x00007f26c24672ee in ruby_run_node () from /lib/x86_64-linux-gnu/libruby-2.7.so.2.7
#36 0x00005577327c317f in ?? ()
#37 0x00007f26c21ee0b3 in __libc_start_main (main=0x5577327c3120, argc=4, argv=0x7fffa0711c28, init=<optimized out>, fini=<optimized out>, rtld_fini=<optimized out>, stack_end=0x7fffa0711c18) at ../csu/libc-start.c:308
#38 0x00005577327c31ce 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 17893) detached]
[nil, 17893]
"timeout 60 gdb -p 17887 -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, 17887]
#<Errno::ESRCH: No such process>
"timeout 60 gdb -p 17886 -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 17886 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, 17886]
"timeout 60 gdb -p 22882 -x /home/ko1/ruby/build-ruby/gdbscript -batch -quiet"
ptrace: No such process.
/home/ko1/ruby/build-ruby/gdbscript:12: Error in sourced command file:
No symbol table is loaded. Use the "file" command.
>>> ThreadsNo threads.
>>> Machine level backtrace
>>> Dump Ruby level backtrace
[nil, 22882]
#<Errno::ESRCH: No such process>
0.004000 0.004000 10785.124000 (10802.078520)
/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: 10835.37 sec