Result of trunk@lpi4a at 2025-05-22 05:31:07 +0900

• NG (ef935705cf)[LOG]
• test-all:
• test-spec:
• commands:

  "make update-download -j4" exit with 0.
  "make update-src      -j4" exit with 0.
  From https://github.com/ruby/ruby
     6df6aaa..ef93570  master     -> origin/master
  "make after-update    -j4" exit with 0.
  "make miniruby -j4" exit with 0.
  "make ruby -j4" exit with 0.
  "make all -j4" exit with 0.
  "make install -j4" exit with 0.
  make yes-btest TESTOPTS='-q -j4'
  $$$ #<Timeout::Error: execution expired>
  ### enter analyzing mode for stuck processes
  $$$ ps jx
     PPID     PID    PGID     SID TTY        TPGID STAT   UID   TIME COMMAND
        1     374     374     374 ?             -1 Ss    1001   0:00 SCREEN -d -m dash -c cd build-ruby; LANG=C.UTF-8 BUILD_RUBY_WORKING_DIR=/tmp/ruby sh build-loop.sh trunk --incremental
      374     375     375     375 pts/0        375 Ss+   1001   0:00 dash -c cd build-ruby; LANG=C.UTF-8 BUILD_RUBY_WORKING_DIR=/tmp/ruby sh build-loop.sh trunk --incremental
      375     377     375     375 pts/0        375 S+    1001   0:00 sh build-loop.sh trunk --incremental
        1     455     455     455 ?             -1 Ss    1001   0:01 /lib/systemd/systemd --user
      455     456     455     455 ?             -1 S     1001   0:00 (sd-pam)
      587     592     592     592 ?             -1 Ssl   1001   0:01 xfce4-session
      455     602     602     602 ?             -1 Ss    1001   0:43 /usr/bin/dbus-daemon --session --address=systemd: --nofork --nopidfile --systemd-activation --syslog-only
      592     634     634     634 ?             -1 Ss    1001   0:00 /usr/bin/ssh-agent x-session-manager
      455     661     661     661 ?             -1 SLs   1001   0:00 /usr/bin/gpg-agent --supervised
      592     663     592     592 ?             -1 Sl    1001   0:03 xfwm4 --display :0.0 --sm-client-id 2500f3af8-d108-47c6-a29b-dd8186507528
      455     667     667     667 ?             -1 Ssl   1001   0:00 /usr/libexec/gvfsd
      592     689     592     592 ?             -1 Sl    1001   0:00 xfsettingsd --display :0.0 --sm-client-id 2a69b8c8d-784e-4b6d-967e-1ee90f69478b
      592     693     592     592 ?             -1 Sl    1001   0:11 xfce4-panel --display :0.0 --sm-client-id 2155bac9d-3af7-4369-9eef-0584cd5c32dc
      592     698     592     592 ?             -1 Sl    1001   0:00 Thunar --sm-client-id 247af977f-7385-44fa-9a04-b9c210ca9e6b --daemon
      592     704     592     592 ?             -1 Sl    1001   0:02 xfdesktop --display :0.0 --sm-client-id 2d89d4454-121b-48bc-ac11-1a6ef463cdc4
      592     708     592     592 ?             -1 Sl    1001   0:00 xfce4-power-manager --restart --sm-client-id 26c45af61-50ad-4d27-915f-d0fd7bdaad1f
      455     710     710     710 ?             -1 Ssl   1001   0:00 /usr/libexec/gvfs-udisks2-volume-monitor
      592     715     592     592 ?             -1 Sl    1001   0:00 nm-applet
      592     725     592     592 ?             -1 Sl    1001   0:00 /usr/lib/policykit-1-gnome/polkit-gnome-authentication-agent-1
      455     732     732     732 ?             -1 Ssl   1001   0:00 /usr/lib/riscv64-linux-gnu/xfce4/notifyd/xfce4-notifyd
      455     768     768     768 ?             -1 Ssl   1001   0:04 /usr/libexec/gvfs-afc-volume-monitor
      455     780     780     780 ?             -1 Ssl   1001   0:00 /usr/libexec/gvfs-mtp-volume-monitor
      455     802     802     802 ?             -1 Ssl   1001   0:00 /usr/libexec/gvfs-gphoto2-volume-monitor
      455     818     818     818 ?             -1 Ssl   1001   0:00 /usr/libexec/gvfs-goa-volume-monitor
      667     826     667     667 ?             -1 Sl    1001   0:00 /usr/libexec/gvfsd-trash --spawner :1.9 /org/gtk/gvfs/exec_spaw/0
      455     838     838     838 ?             -1 Ssl   1001   0:00 /usr/libexec/gvfsd-metadata
      693     842     592     592 ?             -1 Sl    1001   0:00 /usr/lib/riscv64-linux-gnu/xfce4/panel/wrapper-2.0 /usr/lib/riscv64-linux-gnu/xfce4/panel/plugins/libsystray.so 6 12582924 systray Status Tray Plugin Provides status notifier items (application indicators) and legacy systray items
      693     843     592     592 ?             -1 Sl    1001   3:19 /usr/lib/riscv64-linux-gnu/xfce4/panel/wrapper-2.0 /usr/lib/riscv64-linux-gnu/xfce4/panel/plugins/libpulseaudio-plugin.so 8 12582925 pulseaudio PulseAudio Plugin Adjust the audio volume of the PulseAudio sound system
      693     844     592     592 ?             -1 Sl    1001   0:00 /usr/lib/riscv64-linux-gnu/xfce4/panel/wrapper-2.0 /usr/lib/riscv64-linux-gnu/xfce4/panel/plugins/libnotification-plugin.so 10 12582926 notification-plugin Notification Plugin Notification plugin for the Xfce panel
      693     859     592     592 ?             -1 Sl    1001   0:00 /usr/lib/riscv64-linux-gnu/xfce4/panel/wrapper-2.0 /usr/lib/riscv64-linux-gnu/xfce4/panel/plugins/libactions.so 14 12582927 actions Action Buttons Log out, lock or other system actions
      377 3056317     375     375 pts/0        375 Sl+   1001   0:01 ruby ./br.rb build_report trunk --incremental
  3056317 3056320     375     375 pts/0        375 Sl+   1001   0:00 ruby /home/sipeed/build-ruby/build-ruby.rb --target_name=trunk --logfile=/home/sipeed/ruby/logs/brlog.trunk.20250521-172817 --root_dir=/tmp/ruby --timeout=10800 --incremental
  3056320 3057715     375     375 pts/0        375 S+    1001   0:00 sh -c make yes-btest TESTOPTS='-q -j4'
  3057715 3057716     375     375 pts/0        375 S+    1001   0:00 make yes-btest TESTOPTS=-q -j4
  3057716 3057731     375     375 pts/0        375 Sl+   1001   0:14 /usr/bin/ruby --disable=gems /tmp/ruby/src/trunk/bootstraptest/runner.rb --ruby=./miniruby -I/tmp/ruby/src/trunk/lib -I. -I.ext/common  -r./riscv64-linux-fake --disable-gems -q -j4
  3057731 3096168     375     375 pts/0        375 Z+    1001   0:00 [miniruby] <defunct>
        1 3096176     375     375 pts/0        375 Sl+   1001   0:00 /tmp/ruby/build/trunk/miniruby -I/tmp/ruby/src/trunk/lib -I/tmp/ruby/build/trunk -I/tmp/ruby/build/trunk/.ext/common -r/tmp/ruby/build/trunk/riscv64-linux-fake --disable-gems -W0 bootstraptest.test_ractor.rb_2275_1409.rb
  3056320 3097826     375     375 pts/0        375 R+    1001   0:00 ps jx
  {1=>[374, 455, 3096176], 374=>[375], 375=>[377], 455=>[456, 602, 661, 667, 710, 732, 768, 780, 802, 818, 838], 587=>[592], 592=>[634, 663, 689, 693, 698, 704, 708, 715, 725], 667=>[826], 693=>[842, 843, 844, 859], 377=>[3056317], 3056317=>[3056320], 3056320=>[3057715, 3097826], 3057715=>[3057716], 3057716=>[3057731], 3057731=>[3096168]}
  $ timeout 60 gdb -p 3096168 -x /home/sipeed/build-ruby/gdbscript -batch -quiet 2> /dev/null
  >>> Threads
  No threads.
  >>> Machine level backtrace
  >>> Dump Ruby level backtrace (if possible)
  $ timeout 60 gdb -p 3057731 -x /home/sipeed/build-ruby/gdbscript -batch -quiet 2> /dev/null
  [New LWP 3057735]
  [New LWP 3057739]
  [New LWP 3057740]
  [Thread debugging using libthread_db enabled]
  Using host libthread_db library "/lib/riscv64-linux-gnu/libthread_db.so.1".
  0x0000003fb90e8f58 in __GI_ppoll (fds=0x3fff8ff768, nfds=1, timeout=<optimized out>, sigmask=0x0) at ../sysdeps/unix/sysv/linux/ppoll.c:42
  >>> Threads
    Id   Target Id                                         Frame 
  * 1    Thread 0x3fb901f020 (LWP 3057731) "ruby"          0x0000003fb90e8f58 in __GI_ppoll (fds=0x3fff8ff768, nfds=1, timeout=<optimized out>, sigmask=0x0) at ../sysdeps/unix/sysv/linux/ppoll.c:42
    2    Thread 0x3fb4f8a180 (LWP 3057735) "runner.rb:334" 0x0000003fb908fd42 in __futex_abstimed_wait_common64 (private=0, cancel=true, abstime=0x0, op=393, expected=0, futex_word=0x2ad33efcf4) at ./nptl/futex-internal.c:57
    3    Thread 0x3fb4786180 (LWP 3057739) "runner.rb:636" 0x0000003fb90e8b7a in __GI___poll (fds=0x3fb4684bc8, nfds=1, timeout=<optimized out>) at ../sysdeps/unix/sysv/linux/poll.c:41
    4    Thread 0x3fb4585180 (LWP 3057740) "runner.rb:546" 0x0000003fb90e8b7a in __GI___poll (fds=0x3fb4483bc8, nfds=1, timeout=<optimized out>) at ../sysdeps/unix/sysv/linux/poll.c:41
  >>> Machine level backtrace
  Thread 4 (Thread 0x3fb4585180 (LWP 3057740) "runner.rb:546"):
  #0  0x0000003fb90e8b7a in __GI___poll (fds=0x3fb4483bc8, nfds=1, timeout=<optimized out>) at ../sysdeps/unix/sysv/linux/poll.c:41
          sc_ret = -514
          sc_cancel_oldtype = 0
          sc_ret = <optimized out>
          timeout_ts = {tv_sec = 273691312420, tv_nsec = 1000000000}
          timeout_ts_p = <optimized out>
  #1  0x0000003fb938204c in ?? () from /lib/riscv64-linux-gnu/libruby-3.1.so.3.1
  No symbol table info available.
  Thread 3 (Thread 0x3fb4786180 (LWP 3057739) "runner.rb:636"):
  #0  0x0000003fb90e8b7a in __GI___poll (fds=0x3fb4684bc8, nfds=1, timeout=<optimized out>) at ../sysdeps/unix/sysv/linux/poll.c:41
          sc_ret = -514
          sc_cancel_oldtype = 0
          sc_ret = <optimized out>
          timeout_ts = {tv_sec = 183929946464, tv_nsec = 1000000000}
          timeout_ts_p = <optimized out>
  #1  0x0000003fb938204c in ?? () from /lib/riscv64-linux-gnu/libruby-3.1.so.3.1
  No symbol table info available.
  Thread 2 (Thread 0x3fb4f8a180 (LWP 3057735) "runner.rb:334"):
  #0  0x0000003fb908fd42 in __futex_abstimed_wait_common64 (private=0, cancel=true, abstime=0x0, op=393, expected=0, futex_word=0x2ad33efcf4) at ./nptl/futex-internal.c:57
          __a7 = 98
          __a1 = 393
          __a3 = 0
          __a5 = 4294967295
          __a0 = -512
          __a2 = 0
          __a4 = 0
          _arg0 = 183932746996
          _arg2 = 0
          _arg4 = 0
          _sys_result = <optimized out>
          _arg1 = 393
          _arg3 = 0
          _arg5 = 4294967295
          sc_cancel_oldtype = 0
          sc_ret = <optimized out>
  #1  __futex_abstimed_wait_common (futex_word=futex_word@entry=0x2ad33efcf4, expected=expected@entry=0, clockid=clockid@entry=0, abstime=abstime@entry=0x0, private=private@entry=0, cancel=cancel@entry=true) at ./nptl/futex-internal.c:87
          err = <optimized out>
          clockbit = 256
          op = 393
  #2  0x0000003fb908fd64 in __GI___futex_abstimed_wait_cancelable64 (futex_word=futex_word@entry=0x2ad33efcf4, 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  0x0000003fb9092fc4 in __pthread_cond_wait_common (abstime=0x0, clockid=0, mutex=0x2ad33efd20, cond=0x2ad33efcc8) at ./nptl/pthread_cond_wait.c:503
          spin = 0
          buffer = {__routine = 0x3fb9092d58 <__condvar_cleanup_waiting>, __arg = 0x3fb4e88da8, __canceltype = 0, __prev = 0x0}
          cbuffer = {wseq = 2153, cond = 0x2ad33efcc8, mutex = 0x2ad33efd20, private = 0}
          err = <optimized out>
          g = 1
          flags = <optimized out>
          g1_start = <optimized out>
          maxspin = 0
          signals = <optimized out>
          result = 0
          wseq = 2153
          seq = 1076
          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=0x2ad33efcc8, mutex=0x2ad33efd20) at ./nptl/pthread_cond_wait.c:618
  No locals.
  #5  0x0000003fb9460124 in rb_native_cond_wait () from /lib/riscv64-linux-gnu/libruby-3.1.so.3.1
  No symbol table info available.
  #6  0x0000003fb94621ac in ?? () from /lib/riscv64-linux-gnu/libruby-3.1.so.3.1
  No symbol table info available.
  Thread 1 (Thread 0x3fb901f020 (LWP 3057731) "ruby"):
  #0  0x0000003fb90e8f58 in __GI_ppoll (fds=0x3fff8ff768, 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 = 273691306838, tv_nsec = 0}
  #1  0x0000003fb9460c14 in ?? () from /lib/riscv64-linux-gnu/libruby-3.1.so.3.1
  No symbol table info available.
  >>> Dump Ruby level backtrace (if possible)
  [Inferior 1 (process 3057731) detached]
  $ timeout 60 gdb -p 3057716 -x /home/sipeed/build-ruby/gdbscript -batch -quiet 2> /dev/null
   make: *** [uncommon.mk:908: yes-btest] Killed
  >>> Threads
  No threads.
  >>> Machine level backtrace
  >>> Dump Ruby level backtrace (if possible)
  #<Errno::ESRCH: No such process>
  $ timeout 60 gdb -p 3057715 -x /home/sipeed/build-ruby/gdbscript -batch -quiet 2> /dev/null
  >>> Threads
  No threads.
  >>> Machine level backtrace
  >>> Dump Ruby level backtrace (if possible)
  $ timeout 60 gdb -p 3097826 -x /home/sipeed/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>
  

• Linux lpi4a 5.10.113-g387b6863253c-dirty #21 SMP PREEMPT Fri Jul 7 03:29:22 SAST 2023 riscv64 GNU/Linux
  

• Logfile: /home/sipeed/ruby/logs/brlog.trunk.20250521-172817
  #<BuildRuby:0x0000003fe60bc900
   @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",
   @TARGET_INSTALL_DIR="/tmp/ruby/install/trunk",
   @TARGET_NAME="trunk",
   @TARGET_SRC_DIR="/tmp/ruby/src/trunk",
   @btest_opts="-j4",
   @build_opts="-j4",
   @configure_opts=["--enable-shared"],
   @gist=false,
   @git_branch=nil,
   @git_worktree=nil,
   @incremental=true,
   @logfile="/home/sipeed/ruby/logs/brlog.trunk.20250521-172817",
   @make="make",
   @no_timeout_error=nil,
   @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='-j4'",
   @timeout=10800>
                             user     system      total        real
  checkout               0.000073   0.000007   0.000080 (  0.000083)
  autoconf               0.000103   0.000010   0.000113 (  0.000112)
  configure              0.000092   0.000010   0.000102 (  0.000102)
  build_up               0.016671   0.000885  13.580955 (  9.860592)
  build_miniruby         0.005258   0.000534  59.367503 ( 58.336469)
  build_ruby             0.007093   0.000000  53.516595 ( 53.597757)
  build_all              0.048184   0.007154  99.378227 ( 29.670982)
  build_install          0.065929   0.005832  30.621283 ( 14.804682)
  test_btest             0.034719   0.009381 236.615774 (10803.318336)
  /home/sipeed/build-ruby/build-ruby.rb:219:in `join': execution expired (Timeout::Error)
  	from /home/sipeed/build-ruby/build-ruby.rb:219:in `each'
  	from /home/sipeed/build-ruby/build-ruby.rb:219:in `block (2 levels) in cmd'
  	from /usr/lib/ruby/3.1.0/timeout.rb:123:in `timeout'
  	from /home/sipeed/build-ruby/build-ruby.rb:218:in `block in cmd'
  	from /home/sipeed/build-ruby/build-ruby.rb:210:in `popen'
  	from /home/sipeed/build-ruby/build-ruby.rb:210:in `cmd'
  	from /home/sipeed/build-ruby/build-ruby.rb:382:in `block in test_btest'
  	from /home/sipeed/build-ruby/build-ruby.rb:315:in `block in builddir'
  	from /home/sipeed/build-ruby/build-ruby.rb:314:in `chdir'
  	from /home/sipeed/build-ruby/build-ruby.rb:314:in `builddir'
  	from /home/sipeed/build-ruby/build-ruby.rb:381:in `test_btest'
  	from /home/sipeed/build-ruby/build-ruby.rb:457:in `block (4 levels) in run'
  	from /usr/lib/ruby/3.1.0/benchmark.rb:296:in `measure'
  	from /usr/lib/ruby/3.1.0/benchmark.rb:378:in `item'
  	from /home/sipeed/build-ruby/build-ruby.rb:455:in `block (3 levels) in run'
  	from /home/sipeed/build-ruby/build-ruby.rb:454:in `each'
  	from /home/sipeed/build-ruby/build-ruby.rb:454:in `block (2 levels) in run'
  	from /usr/lib/ruby/3.1.0/benchmark.rb:176:in `benchmark'
  	from /usr/lib/ruby/3.1.0/benchmark.rb:208:in `bm'
  	from /home/sipeed/build-ruby/build-ruby.rb:453:in `block in run'
  	from /usr/lib/ruby/3.1.0/benchmark.rb:296:in `measure'
  	from /home/sipeed/build-ruby/build-ruby.rb:452:in `run'
  	from /home/sipeed/build-ruby/build-ruby.rb:649:in `<main>'
  total: 10969.59 sec