Result of trunk_asan@ruby-sp1 at 2024-08-21 20:51:27 +0900

• OK (6ab591f80a)[LOG]
• test-all: 33705 tests, 6488234 assertions, 0 failures, 0 errors, 370 skips
• test-spec: 3432 files, 32771 examples, 133961 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:05 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:01 sh build-loop.sh trunk_asan --incremental
     1042 3006686    1041    1041 pts/0       1041 Sl+   1000   0:00 ruby ./br.rb build_report trunk_asan --incremental
  3006686 3006689    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.20240821-113713 --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
  3006689 3006690    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.20240821-113713 --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
  3006690 3007585    1041    1041 pts/0       1041 S+    1000   0:00 sh -c make yes-btest TESTOPTS='-q -j16'
  3007585 3007586    1041    1041 pts/0       1041 S+    1000   0:00 make yes-btest TESTOPTS=-q -j16
  3007586 3007601    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 3012336    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_1593.rb
  3006690 3048378    1041    1041 pts/0       1041 R+    1000   0:00 ps jx
  {1=>[1035, 3012336], 1035=>[1041], 1041=>[1042], 1042=>[3006686], 3006686=>[3006689], 3006689=>[3006690], 3006690=>[3007585, 3048378], 3007585=>[3007586], 3007586=>[3007601]}
  $ timeout 60 gdb -p 3007601 -x /home/ko1/build-ruby/gdbscript -batch -quiet 2> /dev/null
  [New LWP 3007623]
  [New LWP 3007613]
  [Thread debugging using libthread_db enabled]
  Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
  0x00007dfd7af1ba00 in __GI_ppoll (fds=0x7ffd35f718e8, nfds=1, timeout=<optimized out>, sigmask=0x0) at ../sysdeps/unix/sysv/linux/ppoll.c:42
  >>> Threads
    Id   Target Id                                           Frame 
  * 1    Thread 0x7dfd7b68a740 (LWP 3007601) "ruby"          0x00007dfd7af1ba00 in __GI_ppoll (fds=0x7ffd35f718e8, nfds=1, timeout=<optimized out>, sigmask=0x0) at ../sysdeps/unix/sysv/linux/ppoll.c:42
    2    Thread 0x7dfd6ce006c0 (LWP 3007623) "runner.rb:533" 0x00007dfd7af1b4cd in __GI___poll (fds=0x7dfd6ccff180, nfds=1, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
    3    Thread 0x7dfd6f2006c0 (LWP 3007613) "runner.rb:322" 0x00007dfd7ae98d61 in __futex_abstimed_wait_common64 (private=32253, cancel=true, abstime=0x0, op=393, expected=0, futex_word=0x64a7df38429c) at ./nptl/futex-internal.c:57
  >>> Machine level backtrace
  Thread 3 (Thread 0x7dfd6f2006c0 (LWP 3007613) "runner.rb:322"):
  #0  0x00007dfd7ae98d61 in __futex_abstimed_wait_common64 (private=32253, cancel=true, abstime=0x0, op=393, expected=0, futex_word=0x64a7df38429c) 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=32253, abstime=0x0, clockid=0, expected=0, futex_word=0x64a7df38429c) 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=0x64a7df38429c, 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  0x00007dfd7ae9b7dd in __pthread_cond_wait_common (abstime=0x0, clockid=0, mutex=0x64a7df3c6e80, cond=0x64a7df384270) at ./nptl/pthread_cond_wait.c:503
          spin = 0
          buffer = {__routine = 0x7dfd7ae9b4a0 <__condvar_cleanup_waiting>, __arg = 0x7dfd6f0ff370, __canceltype = 2042160484, __prev = 0x0}
          cbuffer = {wseq = 239, cond = 0x64a7df384270, mutex = 0x64a7df3c6e80, private = 0}
          err = <optimized out>
          g = 1
          flags = <optimized out>
          g1_start = <optimized out>
          maxspin = 0
          signals = <optimized out>
          result = 0
          wseq = 239
          seq = 119
          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=0x64a7df384270, mutex=0x64a7df3c6e80) at ./nptl/pthread_cond_wait.c:627
  No locals.
  #5  0x00007dfd7b40fced in rb_native_cond_wait () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #6  0x00007dfd7b41189c in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #7  0x00007dfd7b411992 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #8  0x00007dfd7b41679c in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #9  0x00007dfd7b2b7440 in rb_ensure () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #10 0x00007dfd7b40bf21 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #11 0x00007dfd7b40bfcb in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #12 0x00007dfd7b44d8f0 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #13 0x00007dfd7b4500ff in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #14 0x00007dfd7b4531c2 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #15 0x00007dfd7b457b3a in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #16 0x00007dfd7b45c7ae in rb_vm_invoke_proc () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #17 0x00007dfd7b414a6f in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #18 0x00007dfd7b414f61 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #19 0x00007dfd7b415836 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #20 0x00007dfd7ae9ca94 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 = {138527444567744, 634966365096264426, 138527444567744, -136, 22, 140725508835504, 634966365041738474, 634991497348399850}, mask_was_saved = 0}}, priv = {pad = {0x0, 0x0, 0x0, 0x0}, data = {prev = 0x0, cleanup = 0x0, canceltype = 0}}}
          not_first_call = <optimized out>
  #21 0x00007dfd7af29c3c in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:78
  No locals.
  Thread 2 (Thread 0x7dfd6ce006c0 (LWP 3007623) "runner.rb:533"):
  #0  0x00007dfd7af1b4cd in __GI___poll (fds=0x7dfd6ccff180, nfds=1, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
          sc_ret = -516
          sc_cancel_oldtype = 0
          sc_ret = <optimized out>
  #1  0x00007dfd7b2e763f in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #2  0x00007dfd7b2e85d9 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #3  0x00007dfd7b414563 in rb_thread_io_blocking_region () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #4  0x00007dfd7b2e89be in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #5  0x00007dfd7b2edbf9 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #6  0x00007dfd7b2b7440 in rb_ensure () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #7  0x00007dfd7b2e90f0 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #8  0x00007dfd7b2ed0f0 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #9  0x00007dfd7b2f0626 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #10 0x00007dfd7b44d8f0 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #11 0x00007dfd7b4500ff in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #12 0x00007dfd7b4531c2 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #13 0x00007dfd7b457b3a in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #14 0x00007dfd7b45c7ae in rb_vm_invoke_proc () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #15 0x00007dfd7b414a6f in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #16 0x00007dfd7b414f61 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #17 0x00007dfd7b415836 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #18 0x00007dfd7ae9ca94 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 = {138527406819008, 634969113875333866, 138527406819008, -136, 25, 138527447708192, 634969113820807914, 634991497348399850}, mask_was_saved = 0}}, priv = {pad = {0x0, 0x0, 0x0, 0x0}, data = {prev = 0x0, cleanup = 0x0, canceltype = 0}}}
          not_first_call = <optimized out>
  #19 0x00007dfd7af29c3c in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:78
  No locals.
  Thread 1 (Thread 0x7dfd7b68a740 (LWP 3007601) "ruby"):
  #0  0x00007dfd7af1ba00 in __GI_ppoll (fds=0x7ffd35f718e8, 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 = 140725508839856, tv_nsec = 138527648051481}
  #1  0x00007dfd7b4109e9 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #2  0x00007dfd7b411aa1 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #3  0x00007dfd7b4142c2 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #4  0x00007dfd7b415a65 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #5  0x00007dfd7b2b7440 in rb_ensure () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #6  0x00007dfd7b410eab in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #7  0x00007dfd7b453428 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #8  0x00007dfd7b457b3a in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #9  0x00007dfd7b45c287 in rb_yield () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #10 0x00007dfd7b2b7440 in rb_ensure () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #11 0x00007dfd7b2952a6 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #12 0x00007dfd7b44d8f0 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #13 0x00007dfd7b4500ff in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #14 0x00007dfd7b4545dc in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #15 0x00007dfd7b457b3a in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #16 0x00007dfd7b2b4e5c in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #17 0x00007dfd7b2b9193 in ruby_run_node () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #18 0x000064a7dd5a7187 in ?? ()
  No symbol table info available.
  #19 0x00007dfd7ae2a1ca in __libc_start_call_main (main=main@entry=0x64a7dd5a7120, argc=argc@entry=6, argv=argv@entry=0x7ffd35f727b8) at ../sysdeps/nptl/libc_start_call_main.h:58
          self = <optimized out>
          result = <optimized out>
          unwind_buf = {cancel_jmp_buf = {{jmp_buf = {140725508843448, 923078884384195306, 6, 0, 110672136019264, 138527651831808, 923078884331766506, 634991543438033642}, mask_was_saved = 0}}, priv = {pad = {0x0, 0x0, 0x6, 0x7ffd35f727b0}, data = {prev = 0x0, cleanup = 0x0, canceltype = 6}}}
          not_first_call = <optimized out>
  #20 0x00007dfd7ae2a28b in __libc_start_main_impl (main=0x64a7dd5a7120, argc=6, argv=0x7ffd35f727b8, init=<optimized out>, fini=<optimized out>, rtld_fini=<optimized out>, stack_end=0x7ffd35f727a8) at ../csu/libc-start.c:360
  No locals.
  #21 0x000064a7dd5a71d5 in _start ()
  No symbol table info available.
  >>> Dump Ruby level backtrace (if possible)
  [Inferior 1 (process 3007601) detached]
  $ timeout 60 gdb -p 3007586 -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 3007585 -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 3048378 -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.20240821-113713
  #<BuildRuby:0x000079e1d3ddfde0
   @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.20240821-113713",
   @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.000005   0.000002   0.000007 (  0.000007)
  autoconf               0.000010   0.000005   0.000015 (  0.000013)
  configure              0.000007   0.000004   0.000011 (  0.000010)
  build_up               0.002591   0.002301   1.618733 (  1.882270)
  build_miniruby         0.000736   0.000359   0.776501 (  0.774363)
  build_ruby             0.000849   0.000414   1.541910 (  1.539908)
  build_all              0.003572   0.001769  18.035689 (  2.228391)
  build_install          0.007962   0.002838  19.980428 (  3.652778)
  test_btest             0.005197   0.001437 411.776544 (600.286267)
  test_basic             0.001116   0.003978   1.086488 (  1.144154)
  test_all               0.143556   0.054378 1924.116255 (195.030033)
  test_rubyspec          0.053942   0.061433 562.451028 ( 47.469155)
  total: 854.01 sec