| "make update-download -j16" exit with 0. |
| "make update-src -j16" exit with 0. |
| "make after-update -j16" exit with 0. |
| "make miniruby -j16" exit with 0. |
| "make ruby -j16" exit with 0. |
| "make all -j16" exit with 0. |
| "make install -j16" exit with 0. |
| "make yes-btest TESTOPTS='-q -j16'" exit with 512. |
| $$$ #<Timeout::Error: execution expired> |
| ### enter analyzing mode for stuck processes |
| $$$ ps jx |
| PPID PID PGID SID TTY TPGID STAT UID TIME COMMAND |
| 1 947 947 947 ? -1 Ss 1000 0:00 SCREEN -d -m dash -c cd build-ruby; BUILD_RUBY_WORKING_DIR=/tmp/ruby sh build-loop.sh trunk_asan --incremental |
| 947 957 957 957 pts/0 957 Ss+ 1000 0:00 dash -c cd build-ruby; BUILD_RUBY_WORKING_DIR=/tmp/ruby sh build-loop.sh trunk_asan --incremental |
| 957 958 957 957 pts/0 957 S+ 1000 0:00 sh build-loop.sh trunk_asan --incremental |
| 1 924644 957 957 pts/0 957 Rl+ 1000 1080:36 /tmp/ruby/build/trunk_asan/ruby |
| 1 2109098 2109098 2109098 ? -1 Ss 1000 0:00 /usr/lib/systemd/systemd --user |
| 2109098 2109100 2109098 2109098 ? -1 S 1000 0:00 (sd-pam) |
| 2109044 2109233 2109044 2109044 ? -1 S 1000 0:00 sshd: ko1@pts/1 |
| 2109233 2109240 2109240 2109240 pts/1 2109240 Ss+ 1000 0:00 -bash |
| 1 2379009 957 957 pts/0 957 Sl+ 1000 0:00 /tmp/ruby/src/trunk_asan/tool/lib/test/unit/parallel.rb: TestAutoload#test_autoload_fork |
| 1 2379012 957 957 pts/0 957 Sl+ 1000 0:00 /tmp/ruby/src/trunk_asan/tool/lib/test/unit/parallel.rb: TestAutoload#test_autoload_fork |
| 958 2637615 957 957 pts/0 957 Sl+ 1000 0:00 ruby ./br.rb build_report trunk_asan --incremental |
| 2637615 2637618 957 957 pts/0 957 S+ 1000 0:00 sh -c ruby /home/ko1/build-ruby/build-ruby.rb --target_name=trunk_asan --logfile=/home/ko1/ruby/logs/brlog.trunk_asan.20240717-102804 --root_dir=/tmp/ruby --timeout=600 --no-timeout-error --configure_opts="'CC=clang-17' 'cflags=-fsanitize=address -fno-omit-frame-pointer -DUSE_MN_THREADS=0'" --incremental |
| 2637618 2637619 957 957 pts/0 957 Sl+ 1000 0:00 ruby /home/ko1/build-ruby/build-ruby.rb --target_name=trunk_asan --logfile=/home/ko1/ruby/logs/brlog.trunk_asan.20240717-102804 --root_dir=/tmp/ruby --timeout=600 --no-timeout-error --configure_opts='CC=clang-17' 'cflags=-fsanitize=address -fno-omit-frame-pointer -DUSE_MN_THREADS=0' --incremental |
| 2637619 2638508 957 957 pts/0 957 S+ 1000 0:00 sh -c make yes-btest TESTOPTS='-q -j16' |
| 2638508 2638509 957 957 pts/0 957 S+ 1000 0:00 make yes-btest TESTOPTS=-q -j16 |
| 2638509 2638524 957 957 pts/0 957 Sl+ 1000 0:03 /usr/bin/ruby --disable=gems /tmp/ruby/src/trunk_asan/bootstraptest/runner.rb --ruby=./miniruby -I/tmp/ruby/src/trunk_asan/lib -I. -I.ext/common -r./x86_64-linux-fake --disable-gems -q -j16 |
| 1 2644176 957 957 pts/0 957 Sl+ 1000 0:00 /tmp/ruby/build/trunk_asan/miniruby -I/tmp/ruby/src/trunk_asan/lib -I/tmp/ruby/build/trunk_asan -I/tmp/ruby/build/trunk_asan/.ext/common -r/tmp/ruby/build/trunk_asan/x86_64-linux-fake --disable-gems -W0 bootstraptest.test_thread.rb_449_1586.rb |
| 2637619 2679253 957 957 pts/0 957 R+ 1000 0:00 ps jx |
| {1=>[947, 924644, 2109098, 2379009, 2379012, 2644176], 947=>[957], 957=>[958], 2109098=>[2109100], 2109044=>[2109233], 2109233=>[2109240], 958=>[2637615], 2637615=>[2637618], 2637618=>[2637619], 2637619=>[2638508, 2679253], 2638508=>[2638509], 2638509=>[2638524]} |
| $ timeout 60 gdb -p 2638524 -x /home/ko1/build-ruby/gdbscript -batch -quiet 2> /dev/null |
| [New LWP 2638572] |
| [New LWP 2638542] |
| [Thread debugging using libthread_db enabled] |
| Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1". |
| 0x000071d5d691ba00 in __GI_ppoll (fds=0x7ffd98e07d48, nfds=1, timeout=<optimized out>, sigmask=0x0) at ../sysdeps/unix/sysv/linux/ppoll.c:42 |
| >>> Threads |
| Id Target Id Frame |
| * 1 Thread 0x71d5d6ff8740 (LWP 2638524) "ruby" 0x000071d5d691ba00 in __GI_ppoll (fds=0x7ffd98e07d48, nfds=1, timeout=<optimized out>, sigmask=0x0) at ../sysdeps/unix/sysv/linux/ppoll.c:42 |
| 2 Thread 0x71d5b6a006c0 (LWP 2638572) "runner.rb:519" 0x000071d5d691b4cd in __GI___poll (fds=0x71d5b68ff180, nfds=1, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29 |
| 3 Thread 0x71d5c92006c0 (LWP 2638542) "runner.rb:322" 0x000071d5d6898d61 in __futex_abstimed_wait_common64 (private=29141, cancel=true, abstime=0x0, op=393, expected=0, futex_word=0x636e2c7b2168) at ./nptl/futex-internal.c:57 |
| >>> Machine level backtrace |
| Thread 3 (Thread 0x71d5c92006c0 (LWP 2638542) "runner.rb:322"): |
| #0 0x000071d5d6898d61 in __futex_abstimed_wait_common64 (private=29141, cancel=true, abstime=0x0, op=393, expected=0, futex_word=0x636e2c7b2168) at ./nptl/futex-internal.c:57 |
| sc_cancel_oldtype = 0 |
| sc_ret = <optimized out> |
| resultvar = <optimized out> |
| __arg6 = <optimized out> |
| __arg5 = <optimized out> |
| __arg4 = <optimized out> |
| __arg3 = <optimized out> |
| __arg2 = <optimized out> |
| __arg1 = <optimized out> |
| _a6 = <optimized out> |
| _a5 = <optimized out> |
| _a4 = <optimized out> |
| _a3 = <optimized out> |
| _a2 = <optimized out> |
| _a1 = <optimized out> |
| #1 __futex_abstimed_wait_common (cancel=true, private=29141, abstime=0x0, clockid=0, expected=0, futex_word=0x636e2c7b2168) at ./nptl/futex-internal.c:87 |
| err = <optimized out> |
| clockbit = 256 |
| op = 393 |
| err = <optimized out> |
| clockbit = <optimized out> |
| op = <optimized out> |
| #2 __GI___futex_abstimed_wait_cancelable64 (futex_word=futex_word@entry=0x636e2c7b2168, expected=expected@entry=0, clockid=clockid@entry=0, abstime=abstime@entry=0x0, private=private@entry=0) at ./nptl/futex-internal.c:139 |
| No locals. |
| #3 0x000071d5d689b7dd in __pthread_cond_wait_common (abstime=0x0, clockid=0, mutex=0x636e2c7feb00, cond=0x636e2c7b2140) at ./nptl/pthread_cond_wait.c:503 |
| spin = 0 |
| buffer = {__routine = 0x71d5d689b4a0 <__condvar_cleanup_waiting>, __arg = 0x71d5c90ff370, __canceltype = -716914100, __prev = 0x0} |
| cbuffer = {wseq = 392, cond = 0x636e2c7b2140, mutex = 0x636e2c7feb00, private = 0} |
| err = <optimized out> |
| g = 0 |
| flags = <optimized out> |
| g1_start = <optimized out> |
| maxspin = 0 |
| signals = <optimized out> |
| result = 0 |
| wseq = 392 |
| seq = 196 |
| private = 0 |
| maxspin = <optimized out> |
| err = <optimized out> |
| result = <optimized out> |
| wseq = <optimized out> |
| g = <optimized out> |
| seq = <optimized out> |
| flags = <optimized out> |
| private = <optimized out> |
| signals = <optimized out> |
| done = <optimized out> |
| g1_start = <optimized out> |
| spin = <optimized out> |
| buffer = <optimized out> |
| cbuffer = <optimized out> |
| s = <optimized out> |
| #4 ___pthread_cond_wait (cond=0x636e2c7b2140, mutex=0x636e2c7feb00) at ./nptl/pthread_cond_wait.c:627 |
| No locals. |
| #5 0x000071d5d6e0fced in rb_native_cond_wait () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #6 0x000071d5d6e1189c in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #7 0x000071d5d6e11992 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #8 0x000071d5d6e1679c in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #9 0x000071d5d6cb7440 in rb_ensure () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #10 0x000071d5d6e0bf21 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #11 0x000071d5d6e0bfcb in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #12 0x000071d5d6e4d8f0 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #13 0x000071d5d6e500ff in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #14 0x000071d5d6e531c2 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #15 0x000071d5d6e57b3a in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #16 0x000071d5d6e5c7ae in rb_vm_invoke_proc () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #17 0x000071d5d6e14a6f in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #18 0x000071d5d6e14f61 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #19 0x000071d5d6e15836 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #20 0x000071d5d689ca94 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:447 |
| ret = <optimized out> |
| pd = <optimized out> |
| out = <optimized out> |
| unwind_buf = {cancel_jmp_buf = {{jmp_buf = {125163016292032, -7496678047082142916, 125163016292032, -136, 22, 140727168298256, -7496678047027616964, -7496720805883468996}, mask_was_saved = 0}}, priv = {pad = {0x0, 0x0, 0x0, 0x0}, data = {prev = 0x0, cleanup = 0x0, canceltype = 0}}} |
| not_first_call = <optimized out> |
| #21 0x000071d5d6929c3c in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:78 |
| No locals. |
| Thread 2 (Thread 0x71d5b6a006c0 (LWP 2638572) "runner.rb:519"): |
| #0 0x000071d5d691b4cd in __GI___poll (fds=0x71d5b68ff180, nfds=1, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29 |
| sc_ret = -516 |
| sc_cancel_oldtype = 0 |
| sc_ret = <optimized out> |
| #1 0x000071d5d6ce763f in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #2 0x000071d5d6ce85d9 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #3 0x000071d5d6e14563 in rb_thread_io_blocking_region () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #4 0x000071d5d6ce89be in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #5 0x000071d5d6cedbf9 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #6 0x000071d5d6cb7440 in rb_ensure () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #7 0x000071d5d6ce90f0 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #8 0x000071d5d6ced0f0 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #9 0x000071d5d6cf0626 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #10 0x000071d5d6e4d8f0 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #11 0x000071d5d6e500ff in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #12 0x000071d5d6e531c2 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #13 0x000071d5d6e57b3a in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #14 0x000071d5d6e5c7ae in rb_vm_invoke_proc () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #15 0x000071d5d6e14a6f in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #16 0x000071d5d6e14f61 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #17 0x000071d5d6e15836 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #18 0x000071d5d689ca94 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:447 |
| ret = <optimized out> |
| pd = <optimized out> |
| out = <optimized out> |
| unwind_buf = {cancel_jmp_buf = {{jmp_buf = {125162705913536, -7496650559291448516, 125162705913536, -136, 22, 125163061375520, -7496650559236922564, -7496720805883468996}, mask_was_saved = 0}}, priv = {pad = {0x0, 0x0, 0x0, 0x0}, data = {prev = 0x0, cleanup = 0x0, canceltype = 0}}} |
| not_first_call = <optimized out> |
| #19 0x000071d5d6929c3c in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:78 |
| No locals. |
| Thread 1 (Thread 0x71d5d6ff8740 (LWP 2638524) "ruby"): |
| #0 0x000071d5d691ba00 in __GI_ppoll (fds=0x7ffd98e07d48, nfds=1, timeout=<optimized out>, sigmask=0x0) at ../sysdeps/unix/sysv/linux/ppoll.c:42 |
| sc_ret = -514 |
| sc_cancel_oldtype = 0 |
| sc_ret = <optimized out> |
| tval = {tv_sec = 140727168302608, tv_nsec = 125163247038745} |
| #1 0x000071d5d6e109e9 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #2 0x000071d5d6e11aa1 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #3 0x000071d5d6e142c2 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #4 0x000071d5d6e15a65 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #5 0x000071d5d6cb7440 in rb_ensure () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #6 0x000071d5d6e10eab in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #7 0x000071d5d6e53428 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #8 0x000071d5d6e57b3a in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #9 0x000071d5d6e5c287 in rb_yield () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #10 0x000071d5d6cb7440 in rb_ensure () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #11 0x000071d5d6c952a6 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #12 0x000071d5d6e4d8f0 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #13 0x000071d5d6e500ff in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #14 0x000071d5d6e545dc in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #15 0x000071d5d6e57b3a in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #16 0x000071d5d6cb4e5c in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #17 0x000071d5d6cb9193 in ruby_run_node () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2 |
| No symbol table info available. |
| #18 0x0000636e2ad2d187 in ?? () |
| No symbol table info available. |
| #19 0x000071d5d682a1ca in __libc_start_call_main (main=main@entry=0x636e2ad2d120, argc=argc@entry=6, argv=argv@entry=0x7ffd98e08c18) at ../sysdeps/nptl/libc_start_call_main.h:58 |
| self = <optimized out> |
| result = <optimized out> |
| unwind_buf = {cancel_jmp_buf = {{jmp_buf = {140727168306200, -8383783893237292228, 6, 0, 109324816022848, 125163249680384, -8383783893256166596, -7496720744734186692}, mask_was_saved = 0}}, priv = {pad = {0x0, 0x0, 0x6, 0x7ffd98e08c10}, data = {prev = 0x0, cleanup = 0x0, canceltype = 6}}} |
| not_first_call = <optimized out> |
| #20 0x000071d5d682a28b in __libc_start_main_impl (main=0x636e2ad2d120, argc=6, argv=0x7ffd98e08c18, init=<optimized out>, fini=<optimized out>, rtld_fini=<optimized out>, stack_end=0x7ffd98e08c08) at ../csu/libc-start.c:360 |
| No locals. |
| #21 0x0000636e2ad2d1d5 in _start () |
| No symbol table info available. |
| >>> Dump Ruby level backtrace (if possible) |
| [Inferior 1 (process 2638524) detached] |
| $ timeout 60 gdb -p 2638509 -x /home/ko1/build-ruby/gdbscript -batch -quiet 2> /dev/null |
| make: *** [uncommon.mk:898: yes-btest] Killed |
| >>> Threads |
| No threads. |
| >>> Machine level backtrace |
| >>> Dump Ruby level backtrace (if possible) |
| #<Errno::ESRCH: No such process> |
| $ timeout 60 gdb -p 2638508 -x /home/ko1/build-ruby/gdbscript -batch -quiet 2> /dev/null |
| 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 |
| >>> Threads |
| No threads. |
| >>> Machine level backtrace |
| >>> Dump Ruby level backtrace (if possible) |
| $ timeout 60 gdb -p 2679253 -x /home/ko1/build-ruby/gdbscript -batch -quiet 2> /dev/null |
| >>> Threads |
| No threads. |
| >>> Machine level backtrace |
| >>> Dump Ruby level backtrace (if possible) |
| #<Errno::ESRCH: No such process> |
| "make yes-test-basic TESTS='-j16'" exit with 0. |
| "make yes-test-all TESTOPTS='--stderr-on-failure' TESTS='-j16'" exit with 0. |
| "make yes-test-rubyspec MSPECOPT='--error-output stderr -j' TESTS='-j16'" exit with 0. |