Result of trunk_asan@ruby-sp1 at 2024-08-23 16:47:12 +0900

• OK (73a946c618)[LOG]
• test-all: 33721 tests, 6489554 assertions, 0 failures, 0 errors, 370 skips
• test-spec: 3432 files, 32771 examples, 134170 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
        1 2279650    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
     1042 2358340    1041    1041 pts/0       1041 Sl+   1000   0:00 ruby ./br.rb build_report trunk_asan --incremental
  2358340 2358343    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.20240823-073306 --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
  2358343 2358344    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.20240823-073306 --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
  2358344 2359251    1041    1041 pts/0       1041 S+    1000   0:00 sh -c make yes-btest TESTOPTS='-q -j16'
  2359251 2359252    1041    1041 pts/0       1041 S+    1000   0:00 make yes-btest TESTOPTS=-q -j16
  2359252 2359267    1041    1041 pts/0       1041 Sl+   1000   0:04 /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 2367765    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
  2358344 2400042    1041    1041 pts/0       1041 R+    1000   0:00 ps jx
  {1=>[1035, 2279650, 2367765], 1035=>[1041], 1041=>[1042], 1042=>[2358340], 2358340=>[2358343], 2358343=>[2358344], 2358344=>[2359251, 2400042], 2359251=>[2359252], 2359252=>[2359267]}
  $ timeout 60 gdb -p 2359267 -x /home/ko1/build-ruby/gdbscript -batch -quiet 2> /dev/null
  [New LWP 2359297]
  [New LWP 2359271]
  [Thread debugging using libthread_db enabled]
  Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
  0x00007210da11ba00 in __GI_ppoll (fds=0x7ffe45ca1b38, nfds=1, timeout=<optimized out>, sigmask=0x0) at ../sysdeps/unix/sysv/linux/ppoll.c:42
  >>> Threads
    Id   Target Id                                           Frame 
  * 1    Thread 0x7210da7c8740 (LWP 2359267) "ruby"          0x00007210da11ba00 in __GI_ppoll (fds=0x7ffe45ca1b38, nfds=1, timeout=<optimized out>, sigmask=0x0) at ../sysdeps/unix/sysv/linux/ppoll.c:42
    2    Thread 0x7210c5a006c0 (LWP 2359297) "runner.rb:533" 0x00007210da11b4cd in __GI___poll (fds=0x7210c58ff180, nfds=1, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
    3    Thread 0x7210d46006c0 (LWP 2359271) "runner.rb:322" 0x00007210da098d61 in __futex_abstimed_wait_common64 (private=29200, cancel=true, abstime=0x0, op=393, expected=0, futex_word=0x5c3b5f9b4b3c) at ./nptl/futex-internal.c:57
  >>> Machine level backtrace
  Thread 3 (Thread 0x7210d46006c0 (LWP 2359271) "runner.rb:322"):
  #0  0x00007210da098d61 in __futex_abstimed_wait_common64 (private=29200, cancel=true, abstime=0x0, op=393, expected=0, futex_word=0x5c3b5f9b4b3c) 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=29200, abstime=0x0, clockid=0, expected=0, futex_word=0x5c3b5f9b4b3c) 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=0x5c3b5f9b4b3c, 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  0x00007210da09b7dd in __pthread_cond_wait_common (abstime=0x0, clockid=0, mutex=0x5c3b5f9e62b0, cond=0x5c3b5f9b4b10) at ./nptl/pthread_cond_wait.c:503
          spin = 0
          buffer = {__routine = 0x7210da09b4a0 <__condvar_cleanup_waiting>, __arg = 0x7210d44ff370, __canceltype = -656809884, __prev = 0x0}
          cbuffer = {wseq = 787, cond = 0x5c3b5f9b4b10, mutex = 0x5c3b5f9e62b0, private = 0}
          err = <optimized out>
          g = 1
          flags = <optimized out>
          g1_start = <optimized out>
          maxspin = 0
          signals = <optimized out>
          result = 0
          wseq = 787
          seq = 393
          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=0x5c3b5f9b4b10, mutex=0x5c3b5f9e62b0) at ./nptl/pthread_cond_wait.c:627
  No locals.
  #5  0x00007210da60fced in rb_native_cond_wait () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #6  0x00007210da61189c in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #7  0x00007210da611992 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #8  0x00007210da61679c in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #9  0x00007210da4b7440 in rb_ensure () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #10 0x00007210da60bf21 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #11 0x00007210da60bfcb in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #12 0x00007210da64d8f0 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #13 0x00007210da6500ff in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #14 0x00007210da6531c2 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #15 0x00007210da657b3a in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #16 0x00007210da65c7ae in rb_vm_invoke_proc () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #17 0x00007210da614a6f in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #18 0x00007210da614f61 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #19 0x00007210da615836 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #20 0x00007210da09ca94 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 = {125416608106176, -8960057471968855444, 125416608106176, -136, 22, 140730069289728, -8960057471914329492, -8960078997525611924}, mask_was_saved = 0}}, priv = {pad = {0x0, 0x0, 0x0, 0x0}, data = {prev = 0x0, cleanup = 0x0, canceltype = 0}}}
          not_first_call = <optimized out>
  #21 0x00007210da129c3c in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:78
  No locals.
  Thread 2 (Thread 0x7210c5a006c0 (LWP 2359297) "runner.rb:533"):
  #0  0x00007210da11b4cd in __GI___poll (fds=0x7210c58ff180, nfds=1, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
          sc_ret = -516
          sc_cancel_oldtype = 0
          sc_ret = <optimized out>
  #1  0x00007210da4e763f in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #2  0x00007210da4e85d9 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #3  0x00007210da614563 in rb_thread_io_blocking_region () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #4  0x00007210da4e89be in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #5  0x00007210da4edbf9 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #6  0x00007210da4b7440 in rb_ensure () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #7  0x00007210da4e90f0 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #8  0x00007210da4ed0f0 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #9  0x00007210da4f0626 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #10 0x00007210da64d8f0 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #11 0x00007210da6500ff in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #12 0x00007210da6531c2 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #13 0x00007210da657b3a in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #14 0x00007210da65c7ae in rb_vm_invoke_proc () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #15 0x00007210da614a6f in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #16 0x00007210da614f61 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #17 0x00007210da615836 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #18 0x00007210da09ca94 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 = {125416360642240, -8960095405120013716, 125416360642240, -136, 25, 125416506389024, -8960095405065487764, -8960078997525611924}, mask_was_saved = 0}}, priv = {pad = {0x0, 0x0, 0x0, 0x0}, data = {prev = 0x0, cleanup = 0x0, canceltype = 0}}}
          not_first_call = <optimized out>
  #19 0x00007210da129c3c in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:78
  No locals.
  Thread 1 (Thread 0x7210da7c8740 (LWP 2359267) "ruby"):
  #0  0x00007210da11ba00 in __GI_ppoll (fds=0x7ffe45ca1b38, 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 = 140730069294080, tv_nsec = 125416708829465}
  #1  0x00007210da6109e9 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #2  0x00007210da611aa1 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #3  0x00007210da6142c2 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #4  0x00007210da615a65 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #5  0x00007210da4b7440 in rb_ensure () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #6  0x00007210da610eab in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #7  0x00007210da653428 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #8  0x00007210da657b3a in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #9  0x00007210da65c287 in rb_yield () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #10 0x00007210da4b7440 in rb_ensure () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #11 0x00007210da4952a6 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #12 0x00007210da64d8f0 in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #13 0x00007210da6500ff in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #14 0x00007210da6545dc in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #15 0x00007210da657b3a in rb_vm_exec () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #16 0x00007210da4b4e5c in ?? () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #17 0x00007210da4b9193 in ruby_run_node () from /lib/x86_64-linux-gnu/libruby-3.2.so.3.2
  No symbol table info available.
  #18 0x00005c3b5f67c187 in ?? ()
  No symbol table info available.
  #19 0x00007210da02a1ca in __libc_start_call_main (main=main@entry=0x5c3b5f67c120, argc=argc@entry=6, argv=argv@entry=0x7ffe45ca2a08) at ../sysdeps/nptl/libc_start_call_main.h:58
          self = <optimized out>
          result = <optimized out>
          unwind_buf = {cancel_jmp_buf = {{jmp_buf = {140730069297672, -7459552972451202452, 6, 0, 101410073472320, 125416712769536, -7459552972428133780, -8960079095021684116}, mask_was_saved = 0}}, priv = {pad = {0x0, 0x0, 0x6, 0x7ffe45ca2a00}, data = {prev = 0x0, cleanup = 0x0, canceltype = 6}}}
          not_first_call = <optimized out>
  #20 0x00007210da02a28b in __libc_start_main_impl (main=0x5c3b5f67c120, argc=6, argv=0x7ffe45ca2a08, init=<optimized out>, fini=<optimized out>, rtld_fini=<optimized out>, stack_end=0x7ffe45ca29f8) at ../csu/libc-start.c:360
  No locals.
  #21 0x00005c3b5f67c1d5 in _start ()
  No symbol table info available.
  >>> Dump Ruby level backtrace (if possible)
  [Inferior 1 (process 2359267) detached]
  $ timeout 60 gdb -p 2359252 -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 2359251 -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 2400042 -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.20240823-073306
  #<BuildRuby:0x00007f0e50b7fdd0
   @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.20240823-073306",
   @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.000000   0.000047   0.000047 (  0.000047)
  autoconf               0.000000   0.000045   0.000045 (  0.000044)
  configure              0.000000   0.000033   0.000033 (  0.000033)
  build_up               0.003085   0.002456   1.584170 (  2.051267)
  build_miniruby         0.001044   0.000015   0.780937 (  0.778907)
  build_ruby             0.000000   0.001362   1.540343 (  1.538771)
  build_all              0.002849   0.002484  18.653312 (  2.228496)
  build_install          0.007474   0.003460  20.907858 (  3.699489)
  test_btest             0.004448   0.002501 429.634142 (600.285391)
  test_basic             0.001178   0.003788   1.096673 (  1.154142)
  test_all               0.153495   0.049831 2027.842873 (185.925609)
  test_rubyspec          0.070560   0.048032 574.514165 ( 48.597264)
  total: 846.26 sec