Result of trunk_asan@ruby-sp1 at 2024-08-10 15:39:54 +0900

• OK (7b7dde37f5)[LOG]
• test-all: 33662 tests, 6484424 assertions, 0 failures, 0 errors, 372 skips
• test-spec: 3432 files, 32772 examples, 135303 expectations, 0 failures, 0 errors, 0 tagged
• commands:

  "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    1035    1035    1035 ?             -1 Ss    1000   0:03 SCREEN -d -m dash -c cd build-ruby; BUILD_RUBY_WORKING_DIR=/tmp/ruby sh build-loop.sh trunk_asan --incremental
     1035    1041    1041    1041 pts/0       1041 Ss+   1000   0:00 dash -c cd build-ruby; BUILD_RUBY_WORKING_DIR=/tmp/ruby sh build-loop.sh trunk_asan --incremental
     1041    1042    1041    1041 pts/0       1041 S+    1000   0:00 sh build-loop.sh trunk_asan --incremental
     1042 2694078    1041    1041 pts/0       1041 Sl+   1000   0:00 ruby ./br.rb build_report trunk_asan --incremental
  2694078 2694081    1041    1041 pts/0       1041 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.20240810-062526 --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
  2694081 2694082    1041    1041 pts/0       1041 Sl+   1000   0:00 ruby /home/ko1/build-ruby/build-ruby.rb --target_name=trunk_asan --logfile=/home/ko1/ruby/logs/brlog.trunk_asan.20240810-062526 --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
  2694082 2694993    1041    1041 pts/0       1041 S+    1000   0:00 sh -c make yes-btest TESTOPTS='-q -j16'
  2694993 2694994    1041    1041 pts/0       1041 S+    1000   0:00 make yes-btest TESTOPTS=-q -j16
  2694994 2695009    1041    1041 pts/0       1041 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 2700860    1041    1041 pts/0       1041 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_1592.rb
  2694082 2735750    1041    1041 pts/0       1041 R+    1000   0:00 ps jx
  {1=>[1035, 2700860], 1035=>[1041], 1041=>[1042], 1042=>[2694078], 2694078=>[2694081], 2694081=>[2694082], 2694082=>[2694993, 2735750], 2694993=>[2694994], 2694994=>[2695009]}
  $ timeout 60 gdb -p 2695009 -x /home/ko1/build-ruby/gdbscript -batch -quiet 2> /dev/null
  [New LWP 2695028]
  [New LWP 2695020]
  [Thread debugging using libthread_db enabled]
  Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
  0x000079f25ef1ba00 in __GI_ppoll (fds=0x7ffd75d02ec8, nfds=1, timeout=<optimized out>, sigmask=0x0) at ../sysdeps/unix/sysv/linux/ppoll.c:42
  >>> Threads
    Id   Target Id                                           Frame 
  * 1    Thread 0x79f25f5f1740 (LWP 2695009) "ruby"          0x000079f25ef1ba00 in __GI_ppoll (fds=0x7ffd75d02ec8, nfds=1, timeout=<optimized out>, sigmask=0x0) at ../sysdeps/unix/sysv/linux/ppoll.c:42
    2    Thread 0x79f2512006c0 (LWP 2695028) "runner.rb:533" 0x000079f25ef1b4cd in __GI___poll (fds=0x79f2510ff180, nfds=1, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
    3    Thread 0x79f2532006c0 (LWP 2695020) "runner.rb:322" 0x000079f25ee98d61 in __futex_abstimed_wait_common64 (private=31218, cancel=true, abstime=0x0, op=393, expected=0, futex_word=0x5b1b5dfa7f7c) at ./nptl/futex-internal.c:57
  >>> Machine level backtrace
  Thread 3 (Thread 0x79f2532006c0 (LWP 2695020) "runner.rb:322"):
  #0  0x000079f25ee98d61 in __futex_abstimed_wait_common64 (private=31218, cancel=true, abstime=0x0, op=393, expected=0, futex_word=0x5b1b5dfa7f7c) 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=31218, abstime=0x0, clockid=0, expected=0, futex_word=0x5b1b5dfa7f7c) 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=0x5b1b5dfa7f7c, 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  0x000079f25ee9b7dd in __pthread_cond_wait_common (abstime=0x0, clockid=0, mutex=0x5b1b5df65630, cond=0x5b1b5dfa7f50) at ./nptl/pthread_cond_wait.c:503
          spin = 0
          buffer = {__routine = 0x79f25ee9b4a0 <__condvar_cleanup_waiting>, __arg = 0x79f2530ff370, __canceltype = 1572591844, __prev = 0x0}
          cbuffer = {wseq = 415, cond = 0x5b1b5dfa7f50, mutex = 0x5b1b5df65630, private = 0}
          err = <optimized out>
          g = 1
          flags = <optimized out>
          g1_start = <optimized out>
          maxspin = 0
          signals = <optimized out>
          result = 0
          wseq = 415
          seq = 207
          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=0x5b1b5dfa7f50, mutex=0x5b1b5df65630) at ./nptl/pthread_cond_wait.c:627
  No locals.
  #5  0x000079f25f40fced in rb_native_cond_wait () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #6  0x000079f25f41189c in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #7  0x000079f25f411992 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #8  0x000079f25f41679c in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #9  0x000079f25f2b7440 in rb_ensure () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #10 0x000079f25f40bf21 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #11 0x000079f25f40bfcb in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #12 0x000079f25f44d8f0 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #13 0x000079f25f4500ff in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #14 0x000079f25f4531c2 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #15 0x000079f25f457b3a in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #16 0x000079f25f45c7ae in rb_vm_invoke_proc () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #17 0x000079f25f414a6f in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #18 0x000079f25f414f61 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #19 0x000079f25f415836 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #20 0x000079f25ee9ca94 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 = {134081683654336, 8329707806831717720, 134081683654336, -136, 22, 140726580027024, 8329707806852689240, 8329701022112591192}, mask_was_saved = 0}}, priv = {pad = {0x0, 0x0, 0x0, 0x0}, data = {prev = 0x0, cleanup = 0x0, canceltype = 0}}}
          not_first_call = <optimized out>
  #21 0x000079f25ef29c3c in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:78
  No locals.
  Thread 2 (Thread 0x79f2512006c0 (LWP 2695028) "runner.rb:533"):
  #0  0x000079f25ef1b4cd in __GI___poll (fds=0x79f2510ff180, nfds=1, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
          sc_ret = -516
          sc_cancel_oldtype = 0
          sc_ret = <optimized out>
  #1  0x000079f25f2e763f in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #2  0x000079f25f2e85d9 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #3  0x000079f25f414563 in rb_thread_io_blocking_region () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #4  0x000079f25f2e89be in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #5  0x000079f25f2edbf9 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #6  0x000079f25f2b7440 in rb_ensure () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #7  0x000079f25f2e90f0 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #8  0x000079f25f2ed0f0 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #9  0x000079f25f2f0626 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #10 0x000079f25f44d8f0 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #11 0x000079f25f4500ff in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #12 0x000079f25f4531c2 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #13 0x000079f25f457b3a in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #14 0x000079f25f45c7ae in rb_vm_invoke_proc () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #15 0x000079f25f414a6f in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #16 0x000079f25f414f61 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #17 0x000079f25f415836 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #18 0x000079f25ee9ca94 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 = {134081650099904, 8329712204878228824, 134081650099904, -136, 25, 134081785360928, 8329712204899200344, 8329701022112591192}, mask_was_saved = 0}}, priv = {pad = {0x0, 0x0, 0x0, 0x0}, data = {prev = 0x0, cleanup = 0x0, canceltype = 0}}}
          not_first_call = <optimized out>
  #19 0x000079f25ef29c3c in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:78
  No locals.
  Thread 1 (Thread 0x79f25f5f1740 (LWP 2695009) "ruby"):
  #0  0x000079f25ef1ba00 in __GI_ppoll (fds=0x7ffd75d02ec8, 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 = 140726580031376, tv_nsec = 100173096510456}
  #1  0x000079f25f4109e9 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #2  0x000079f25f411aa1 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #3  0x000079f25f4142c2 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #4  0x000079f25f415a65 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #5  0x000079f25f2b7440 in rb_ensure () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #6  0x000079f25f410eab in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #7  0x000079f25f453428 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #8  0x000079f25f457b3a in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #9  0x000079f25f45c287 in rb_yield () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #10 0x000079f25f2b7440 in rb_ensure () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #11 0x000079f25f2952a6 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #12 0x000079f25f44d8f0 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #13 0x000079f25f4500ff in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #14 0x000079f25f4545dc in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #15 0x000079f25f457b3a in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #16 0x000079f25f2b4e5c in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #17 0x000079f25f2b9193 in ruby_run_node () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #18 0x00005b1b5cc91187 in ?? ()
  No symbol table info available.
  #19 0x000079f25ee2a1ca in __libc_start_call_main (main=main@entry=0x5b1b5cc91120, argc=argc@entry=6, argv=argv@entry=0x7ffd75d03d98) at ../sysdeps/nptl/libc_start_call_main.h:58
          self = <optimized out>
          result = <optimized out>
          unwind_buf = {cancel_jmp_buf = {{jmp_buf = {140726580034968, 9189415276372864344, 6, 0, 100173078936896, 134081891246080, 9189415276391738712, 8329700962866474328}, mask_was_saved = 0}}, priv = {pad = {0x0, 0x0, 0x6, 0x7ffd75d03d90}, data = {prev = 0x0, cleanup = 0x0, canceltype = 6}}}
          not_first_call = <optimized out>
  #20 0x000079f25ee2a28b in __libc_start_main_impl (main=0x5b1b5cc91120, argc=6, argv=0x7ffd75d03d98, init=<optimized out>, fini=<optimized out>, rtld_fini=<optimized out>, stack_end=0x7ffd75d03d88) at ../csu/libc-start.c:360
  No locals.
  #21 0x00005b1b5cc911d5 in _start ()
  No symbol table info available.
  >>> Dump Ruby level backtrace (if possible)
  [Inferior 1 (process 2695009) detached]
  $ timeout 60 gdb -p 2694994 -x /home/ko1/build-ruby/gdbscript -batch -quiet 2> /dev/null
   make: *** [uncommon.mk:897: yes-btest] Killed
  >>> Threads
  No threads.
  >>> Machine level backtrace
  >>> Dump Ruby level backtrace (if possible)
  #<Errno::ESRCH: No such process>
  $ timeout 60 gdb -p 2694993 -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 2735750 -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.
  

• Linux ruby-sp1 6.8.0-38-generic #38-Ubuntu SMP PREEMPT_DYNAMIC Fri Jun  7 15:25:01 UTC 2024 x86_64 x86_64 x86_64 GNU/Linux
  

• Logfile: /home/ko1/ruby/logs/brlog.trunk_asan.20240810-062526
  #<BuildRuby:0x00007bca2fd5fdc0
   @BUILD_DIR="/tmp/ruby/build",
   @INSTALL_DIR="/tmp/ruby/install",
   @REPOSITORY="https://github.com/ruby/ruby.git",
   @REPOSITORY_TYPE=:git,
   @SRC_DIR="/tmp/ruby/src",
   @TARGET_BUILD_DIR="/tmp/ruby/build/trunk_asan",
   @TARGET_INSTALL_DIR="/tmp/ruby/install/trunk_asan",
   @TARGET_NAME="trunk_asan",
   @TARGET_SRC_DIR="/tmp/ruby/src/trunk_asan",
   @btest_opts="-j16",
   @build_opts="-j16",
   @configure_opts=
    ["'CC=clang-17' 'cflags=-fsanitize=address -fno-omit-frame-pointer -DUSE_MN_THREADS=0'"],
   @gist=false,
   @git_branch=nil,
   @git_worktree=nil,
   @incremental=true,
   @logfile="/home/ko1/ruby/logs/brlog.trunk_asan.20240810-062526",
   @make="make",
   @no_timeout_error=true,
   @quiet=false,
   @ruby_env=[["RUBY_DEBUG", "ci"]],
   @spec_opts="-j",
   @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='-j16'",
   @timeout=600>
                             user     system      total        real
  checkout               0.000020   0.000006   0.000026 (  0.000028)
  autoconf               0.000039   0.000013   0.000052 (  0.000052)
  configure              0.000042   0.000014   0.000056 (  0.000057)
  build_up               0.003084   0.002103   1.591768 (  1.772135)
  build_miniruby         0.001072   0.000000   0.765984 (  0.764047)
  build_ruby             0.000951   0.000331   1.484367 (  1.482516)
  build_all              0.002618   0.003033  18.888275 (  2.274095)
  build_install          0.006323   0.004554  20.740446 (  3.696257)
  test_btest             0.004934   0.001957 407.431474 (600.285348)
  test_basic             0.000376   0.004732   1.080192 (  1.138808)
  test_all               0.141617   0.059636 1898.787099 (207.772449)
  test_rubyspec          0.055575   0.062348 573.444271 ( 48.789411)
  total: 867.98 sec