Result of master@oci-aarch64 at 2025-11-21 20:39:29 +0900

NG (b9a213f791)[LOG]
test-all:
test-spec:

commands:

 "make update-download -j3" exit with 0.
"make update-src      -j3" exit with 0.
"make after-update    -j3" exit with 0.
"make miniruby -j3" exit with 0.
"make ruby -j3" exit with 0.
"make all -j3" exit with 0.
"make install -j3" exit with 0.
make yes-btest TESTOPTS='-q -j3'
$$$ #<Timeout::Error: execution expired>
### enter analyzing mode for stuck processes
$$$ ps jx
   PPID     PID    PGID     SID TTY        TPGID STAT   UID   TIME COMMAND
      1    7805    7805    7805 ?             -1 Ss    1000   0:16 /usr/lib/systemd/systemd --user
   7805    7807    7805    7805 ?             -1 S     1000   0:00 (sd-pam)
      1    8079    8079    8079 ?             -1 Ss    1000   0:08 tmux
   8079    8080    8080    8080 pts/1    3779733 Ss    1000   0:00 -bash
3779733  458040 3779733    8080 pts/1    3779733 Sl+   1000   0:00 ruby ./br.rb build_report master --incremental
 458040  458043 3779733    8080 pts/1    3779733 Sl+   1000   0:00 ruby /home/opc/build-ruby/build-ruby.rb --target_name=master --logfile=/home/opc/ruby/logs/brlog.master.20251121-083917 --root_dir=/home/opc/ruby --timeout=10800 --configure_opts=--disable-dtrace --disable-yjit --incremental
 458043  458838 3779733    8080 pts/1    3779733 S+    1000   0:00 make yes-btest TESTOPTS=-q -j3
 458838  458855 3779733    8080 pts/1    3779733 Sl+   1000   0:02 /usr/local/bin/ruby --disable=gems /home/opc/ruby/src/master/bootstraptest/runner.rb --ruby=./miniruby -I/home/opc/ruby/src/master/lib -I. -I.ext/common  -r./aarch64-linux-fake --disable-gems -q -j3
 458855  461725 3779733    8080 pts/1    3779733 Z+    1000   0:00 [miniruby] <defunct>
      1  461732 3779733    8080 pts/1    3779733 Sl+   1000   0:00 /home/opc/ruby/build/master/miniruby -I/home/opc/ruby/src/master/lib -I/home/opc/ruby/build/master -I/home/opc/ruby/build/master/.ext/common -r/home/opc/ruby/build/master/aarch64-linux-fake --disable-gems -W0 bootstraptest.test_ractor.rb_2116_1393.rb
 458043  538302 3779733    8080 pts/1    3779733 R+    1000   0:00 ps jx
   8080 3779733 3779733    8080 pts/1    3779733 S+    1000   0:01 sh build-loop.sh master --incremental
{1=>[7805, 8079, 461732], 7805=>[7807], 8079=>[8080], 3779733=>[458040], 458040=>[458043], 458043=>[458838, 538302], 458838=>[458855], 458855=>[461725], 8080=>[3779733]}
$ timeout 60 gdb -p 461725 -x /home/opc/build-ruby/gdbscript -batch -quiet 2> /dev/null
>>> Threads
No threads.
>>> Machine level backtrace
>>> Dump Ruby level backtrace (if possible)
$ timeout 60 gdb -p 458855 -x /home/opc/build-ruby/gdbscript -batch -quiet 2> /dev/null
[New LWP 458859]
[New LWP 458861]
[New LWP 458867]
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib64/libthread_db.so.1".
0x0000fffc6c3aed20 in ppoll () from /lib64/libc.so.6
>>> Threads
  Id   Target Id                                          Frame 
* 1    Thread 0xfffc6cce6140 (LWP 458855) "ruby"          0x0000fffc6c3aed20 in ppoll () from /lib64/libc.so.6
  2    Thread 0xfffc667cf140 (LWP 458859) "runner.rb:334" 0x0000fffc6c47dd80 in pthread_cond_wait@@GLIBC_2.17 () from /lib64/libpthread.so.0
  3    Thread 0xfffc663af140 (LWP 458861) "runner.rb:546" 0x0000fffc6c3aec04 in poll () from /lib64/libc.so.6
  4    Thread 0xfffc65b6f140 (LWP 458867) "runner.rb:638" 0x0000fffc6c3aec04 in poll () from /lib64/libc.so.6
>>> Machine level backtrace
Thread 4 (Thread 0xfffc65b6f140 (LWP 458867)):
#0  0x0000fffc6c3aec04 in poll () from /lib64/libc.so.6
No symbol table info available.
Thread 3 (Thread 0xfffc663af140 (LWP 458861)):
#0  0x0000fffc6c3aec04 in poll () from /lib64/libc.so.6
No symbol table info available.
Thread 2 (Thread 0xfffc667cf140 (LWP 458859)):
#0  0x0000fffc6c47dd80 in pthread_cond_wait@@GLIBC_2.17 () from /lib64/libpthread.so.0
No symbol table info available.
Thread 1 (Thread 0xfffc6cce6140 (LWP 458855)):
#0  0x0000fffc6c3aed20 in ppoll () from /lib64/libc.so.6
No symbol table info available.
>>> Dump Ruby level backtrace (if possible)
 th: 0x3d3b1150, native_id: 0xfffc6cce6140
-- Control frame information -----------------------------------------------
c:0012 p:0023 s:0074 e:000073 METHOD <internal:thread_sync>:18
c:0011 p:0062 s:0067 E:000090 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:356
c:0010 p:0052 s:0057 e:000056 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:438
c:0009 p:0005 s:0049 e:000048 BLOCK  /home/opc/ruby/src/master/bootstraptest/runner.rb:311
c:0008 p:0002 s:0046 e:000045 BLOCK  /home/opc/ruby/src/master/bootstraptest/runner.rb:861 [FINISH]
c:0007 p:---- s:0043 e:000042 CFUNC  :chdir
c:0006 p:0007 s:0038 e:000037 BLOCK  /home/opc/ruby/src/master/bootstraptest/runner.rb:860
c:0005 p:0047 s:0034 e:000033 METHOD /usr/local/lib/ruby/3.2.0/tmpdir.rb:94
c:0004 p:0030 s:0024 e:000023 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:859
c:0003 p:0624 s:0019 e:000018 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:310
c:0002 p:0220 s:0008 E:001a08 EVAL   /home/opc/ruby/src/master/bootstraptest/runner.rb:904 [FINISH]
c:0001 p:0000 s:0003 E:000340 DUMMY  [FINISH]
th: 0x3d5bc8c0, native_id: 0xfffc667cf140
-- Control frame information -----------------------------------------------
c:0009 p:---- s:0056 e:000055 CFUNC  :value
c:0008 p:0042 s:0052 E:000a88 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:552
c:0007 p:0130 s:0043 E:000c68 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:580
c:0006 p:0010 s:0034 e:000033 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:384
c:0005 p:0014 s:0022 E:001068 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:536
c:0004 p:0011 s:0015 E:002528 BLOCK  /home/opc/ruby/src/master/bootstraptest/runner.rb:684
c:0003 p:0006 s:0011 e:000010 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:532
c:0002 p:0011 s:0007 e:000006 BLOCK  /home/opc/ruby/src/master/bootstraptest/runner.rb:336 [FINISH]
c:0001 p:---- s:0003 e:000002 DUMMY  [FINISH]
th: 0xfffc5c03dc30, native_id: 0xfffc663af140
-- Control frame information -----------------------------------------------
c:0003 p:---- s:0010 e:000009 CFUNC  :read
c:0002 p:0004 s:0006 e:000005 BLOCK  /home/opc/ruby/src/master/bootstraptest/runner.rb:546 [FINISH]
c:0001 p:---- s:0003 e:000002 DUMMY  [FINISH]
th: 0xfffc5c054140, native_id: 0xfffc65b6f140
-- Control frame information -----------------------------------------------
c:0003 p:---- s:0010 e:000009 CFUNC  :read
c:0002 p:0004 s:0006 e:000005 BLOCK  /home/opc/ruby/src/master/bootstraptest/runner.rb:638 [FINISH]
c:0001 p:---- s:0003 e:000002 DUMMY  [FINISH]
[Inferior 1 (process 458855) detached]
$ timeout 60 gdb -p 458838 -x /home/opc/build-ruby/gdbscript -batch -quiet 2> /dev/null
make: *** [uncommon.mk:848: yes-btest] Killed
>>> Threads
No threads.
>>> Machine level backtrace
>>> Dump Ruby level backtrace (if possible)
$ timeout 60 gdb -p 538302 -x /home/opc/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 oci-aarch64 5.4.17-2136.332.5.2.el8uek.aarch64 #3 SMP Tue Jun 11 18:05:48 PDT 2024 aarch64 aarch64 aarch64 GNU/Linux

Logfile: /home/opc/ruby/logs/brlog.master.20251121-083917
#<BuildRuby:0x0000fffd53effdc0
 @BUILD_DIR="/home/opc/ruby/build",
 @INSTALL_DIR="/home/opc/ruby/install",
 @REPOSITORY="https://github.com/ruby/ruby.git",
 @REPOSITORY_TYPE=:git,
 @SRC_DIR="/home/opc/ruby/src",
 @TARGET_BUILD_DIR="/home/opc/ruby/build/master",
 @TARGET_INSTALL_DIR="/home/opc/ruby/install/master",
 @TARGET_NAME="master",
 @TARGET_SRC_DIR="/home/opc/ruby/src/master",
 @btest_opts="-j3",
 @build_opts="-j3",
 @configure_opts=["--disable-dtrace --disable-yjit"],
 @gist=false,
 @git_branch=nil,
 @git_tag=nil,
 @git_worktree=nil,
 @incremental=true,
 @logfile="/home/opc/ruby/logs/brlog.master.20251121-083917",
 @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='-j3'",
 @timeout=10800>
                           user     system      total        real
checkout               0.000012   0.000001   0.000013 (  0.000013)
autoconf               0.000018   0.000002   0.000020 (  0.000020)
configure              0.000013   0.000001   0.000014 (  0.000014)
build_up               0.004148   0.000438   1.380800 (  1.588032)
build_miniruby         0.001131   0.000119   1.234980 (  1.233888)
build_ruby             0.001775   0.000000   1.895300 (  4.058167)
build_all              0.006653   0.000000   3.189433 (  1.595000)
build_install          0.014126   0.000000   4.209274 (  2.683623)
test_btest             0.004826   0.004035  38.537563 (10801.014466)
/home/opc/build-ruby/build-ruby.rb:223:in `join': execution expired (Timeout::Error)
	from /home/opc/build-ruby/build-ruby.rb:223:in `each'
	from /home/opc/build-ruby/build-ruby.rb:223:in `block (2 levels) in cmd'
	from /usr/local/lib/ruby/3.2.0/timeout.rb:189:in `block in timeout'
	from /usr/local/lib/ruby/3.2.0/timeout.rb:36:in `block in catch'
	from /usr/local/lib/ruby/3.2.0/timeout.rb:36:in `catch'
	from /usr/local/lib/ruby/3.2.0/timeout.rb:36:in `catch'
	from /usr/local/lib/ruby/3.2.0/timeout.rb:198:in `timeout'
	from /home/opc/build-ruby/build-ruby.rb:222:in `block in cmd'
	from /home/opc/build-ruby/build-ruby.rb:214:in `popen'
	from /home/opc/build-ruby/build-ruby.rb:214:in `cmd'
	from /home/opc/build-ruby/build-ruby.rb:389:in `block in test_btest'
	from /home/opc/build-ruby/build-ruby.rb:322:in `block in builddir'
	from /home/opc/build-ruby/build-ruby.rb:321:in `chdir'
	from /home/opc/build-ruby/build-ruby.rb:321:in `builddir'
	from /home/opc/build-ruby/build-ruby.rb:388:in `test_btest'
	from /home/opc/build-ruby/build-ruby.rb:464:in `block (4 levels) in run'
	from /usr/local/lib/ruby/3.2.0/benchmark.rb:296:in `measure'
	from /usr/local/lib/ruby/3.2.0/benchmark.rb:378:in `item'
	from /home/opc/build-ruby/build-ruby.rb:462:in `block (3 levels) in run'
	from /home/opc/build-ruby/build-ruby.rb:461:in `each'
	from /home/opc/build-ruby/build-ruby.rb:461:in `block (2 levels) in run'
	from /usr/local/lib/ruby/3.2.0/benchmark.rb:176:in `benchmark'
	from /usr/local/lib/ruby/3.2.0/benchmark.rb:208:in `bm'
	from /home/opc/build-ruby/build-ruby.rb:460:in `block in run'
	from /usr/local/lib/ruby/3.2.0/benchmark.rb:296:in `measure'
	from /home/opc/build-ruby/build-ruby.rb:459:in `run'
	from /home/opc/build-ruby/build-ruby.rb:659:in `<main>'
total: 10812.17 sec

	"make update-download -j3" exit with 0.
	"make update-src -j3" exit with 0.
	"make after-update -j3" exit with 0.
	"make miniruby -j3" exit with 0.
	"make ruby -j3" exit with 0.
	"make all -j3" exit with 0.
	"make install -j3" exit with 0.
	make yes-btest TESTOPTS='-q -j3'
	$$$ #<Timeout::Error: execution expired>
	### enter analyzing mode for stuck processes
	$$$ ps jx
	PPID PID PGID SID TTY TPGID STAT UID TIME COMMAND
	1 7805 7805 7805 ? -1 Ss 1000 0:16 /usr/lib/systemd/systemd --user
	7805 7807 7805 7805 ? -1 S 1000 0:00 (sd-pam)
	1 8079 8079 8079 ? -1 Ss 1000 0:08 tmux
	8079 8080 8080 8080 pts/1 3779733 Ss 1000 0:00 -bash
	3779733 458040 3779733 8080 pts/1 3779733 Sl+ 1000 0:00 ruby ./br.rb build_report master --incremental
	458040 458043 3779733 8080 pts/1 3779733 Sl+ 1000 0:00 ruby /home/opc/build-ruby/build-ruby.rb --target_name=master --logfile=/home/opc/ruby/logs/brlog.master.20251121-083917 --root_dir=/home/opc/ruby --timeout=10800 --configure_opts=--disable-dtrace --disable-yjit --incremental
	458043 458838 3779733 8080 pts/1 3779733 S+ 1000 0:00 make yes-btest TESTOPTS=-q -j3
	458838 458855 3779733 8080 pts/1 3779733 Sl+ 1000 0:02 /usr/local/bin/ruby --disable=gems /home/opc/ruby/src/master/bootstraptest/runner.rb --ruby=./miniruby -I/home/opc/ruby/src/master/lib -I. -I.ext/common -r./aarch64-linux-fake --disable-gems -q -j3
	458855 461725 3779733 8080 pts/1 3779733 Z+ 1000 0:00 [miniruby] <defunct>
	1 461732 3779733 8080 pts/1 3779733 Sl+ 1000 0:00 /home/opc/ruby/build/master/miniruby -I/home/opc/ruby/src/master/lib -I/home/opc/ruby/build/master -I/home/opc/ruby/build/master/.ext/common -r/home/opc/ruby/build/master/aarch64-linux-fake --disable-gems -W0 bootstraptest.test_ractor.rb_2116_1393.rb
	458043 538302 3779733 8080 pts/1 3779733 R+ 1000 0:00 ps jx
	8080 3779733 3779733 8080 pts/1 3779733 S+ 1000 0:01 sh build-loop.sh master --incremental
	{1=>[7805, 8079, 461732], 7805=>[7807], 8079=>[8080], 3779733=>[458040], 458040=>[458043], 458043=>[458838, 538302], 458838=>[458855], 458855=>[461725], 8080=>[3779733]}
	$ timeout 60 gdb -p 461725 -x /home/opc/build-ruby/gdbscript -batch -quiet 2> /dev/null
	>>> Threads
	No threads.
	>>> Machine level backtrace
	>>> Dump Ruby level backtrace (if possible)
	$ timeout 60 gdb -p 458855 -x /home/opc/build-ruby/gdbscript -batch -quiet 2> /dev/null
	[New LWP 458859]
	[New LWP 458861]
	[New LWP 458867]
	[Thread debugging using libthread_db enabled]
	Using host libthread_db library "/lib64/libthread_db.so.1".
	0x0000fffc6c3aed20 in ppoll () from /lib64/libc.so.6
	>>> Threads
	Id Target Id Frame
	* 1 Thread 0xfffc6cce6140 (LWP 458855) "ruby" 0x0000fffc6c3aed20 in ppoll () from /lib64/libc.so.6
	2 Thread 0xfffc667cf140 (LWP 458859) "runner.rb:334" 0x0000fffc6c47dd80 in pthread_cond_wait@@GLIBC_2.17 () from /lib64/libpthread.so.0
	3 Thread 0xfffc663af140 (LWP 458861) "runner.rb:546" 0x0000fffc6c3aec04 in poll () from /lib64/libc.so.6
	4 Thread 0xfffc65b6f140 (LWP 458867) "runner.rb:638" 0x0000fffc6c3aec04 in poll () from /lib64/libc.so.6
	>>> Machine level backtrace
	Thread 4 (Thread 0xfffc65b6f140 (LWP 458867)):
	#0 0x0000fffc6c3aec04 in poll () from /lib64/libc.so.6
	No symbol table info available.
	Thread 3 (Thread 0xfffc663af140 (LWP 458861)):
	#0 0x0000fffc6c3aec04 in poll () from /lib64/libc.so.6
	No symbol table info available.
	Thread 2 (Thread 0xfffc667cf140 (LWP 458859)):
	#0 0x0000fffc6c47dd80 in pthread_cond_wait@@GLIBC_2.17 () from /lib64/libpthread.so.0
	No symbol table info available.
	Thread 1 (Thread 0xfffc6cce6140 (LWP 458855)):
	#0 0x0000fffc6c3aed20 in ppoll () from /lib64/libc.so.6
	No symbol table info available.
	>>> Dump Ruby level backtrace (if possible)
	th: 0x3d3b1150, native_id: 0xfffc6cce6140
	-- Control frame information -----------------------------------------------
	c:0012 p:0023 s:0074 e:000073 METHOD <internal:thread_sync>:18
	c:0011 p:0062 s:0067 E:000090 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:356
	c:0010 p:0052 s:0057 e:000056 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:438
	c:0009 p:0005 s:0049 e:000048 BLOCK /home/opc/ruby/src/master/bootstraptest/runner.rb:311
	c:0008 p:0002 s:0046 e:000045 BLOCK /home/opc/ruby/src/master/bootstraptest/runner.rb:861 [FINISH]
	c:0007 p:---- s:0043 e:000042 CFUNC :chdir
	c:0006 p:0007 s:0038 e:000037 BLOCK /home/opc/ruby/src/master/bootstraptest/runner.rb:860
	c:0005 p:0047 s:0034 e:000033 METHOD /usr/local/lib/ruby/3.2.0/tmpdir.rb:94
	c:0004 p:0030 s:0024 e:000023 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:859
	c:0003 p:0624 s:0019 e:000018 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:310
	c:0002 p:0220 s:0008 E:001a08 EVAL /home/opc/ruby/src/master/bootstraptest/runner.rb:904 [FINISH]
	c:0001 p:0000 s:0003 E:000340 DUMMY [FINISH]
	th: 0x3d5bc8c0, native_id: 0xfffc667cf140
	-- Control frame information -----------------------------------------------
	c:0009 p:---- s:0056 e:000055 CFUNC :value
	c:0008 p:0042 s:0052 E:000a88 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:552
	c:0007 p:0130 s:0043 E:000c68 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:580
	c:0006 p:0010 s:0034 e:000033 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:384
	c:0005 p:0014 s:0022 E:001068 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:536
	c:0004 p:0011 s:0015 E:002528 BLOCK /home/opc/ruby/src/master/bootstraptest/runner.rb:684
	c:0003 p:0006 s:0011 e:000010 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:532
	c:0002 p:0011 s:0007 e:000006 BLOCK /home/opc/ruby/src/master/bootstraptest/runner.rb:336 [FINISH]
	c:0001 p:---- s:0003 e:000002 DUMMY [FINISH]
	th: 0xfffc5c03dc30, native_id: 0xfffc663af140
	-- Control frame information -----------------------------------------------
	c:0003 p:---- s:0010 e:000009 CFUNC :read
	c:0002 p:0004 s:0006 e:000005 BLOCK /home/opc/ruby/src/master/bootstraptest/runner.rb:546 [FINISH]
	c:0001 p:---- s:0003 e:000002 DUMMY [FINISH]
	th: 0xfffc5c054140, native_id: 0xfffc65b6f140
	-- Control frame information -----------------------------------------------
	c:0003 p:---- s:0010 e:000009 CFUNC :read
	c:0002 p:0004 s:0006 e:000005 BLOCK /home/opc/ruby/src/master/bootstraptest/runner.rb:638 [FINISH]
	c:0001 p:---- s:0003 e:000002 DUMMY [FINISH]
	[Inferior 1 (process 458855) detached]
	$ timeout 60 gdb -p 458838 -x /home/opc/build-ruby/gdbscript -batch -quiet 2> /dev/null
	make: *** [uncommon.mk:848: yes-btest] Killed
	>>> Threads
	No threads.
	>>> Machine level backtrace
	>>> Dump Ruby level backtrace (if possible)
	$ timeout 60 gdb -p 538302 -x /home/opc/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>