Result of trunk@ruby-sp1 at 2024-04-27 02:36:00 +0900

NG (69c1bd90be)[LOG]
test-all:
test-spec:

commands:

 "make update-unicode  -j16" exit with 0.
"make update-download -j16" exit with 0.
"make update-rubyspec -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'
$$$ #<Timeout::Error: execution expired>
### enter analyzing mode for stuck processes
$$$ ps jx
   PPID     PID    PGID     SID TTY        TPGID STAT   UID   TIME COMMAND
      1     831     831     831 ?             -1 Ss    1000   0:30 SCREEN -d -m dash -c cd build-ruby; BUILD_RUBY_WORKING_DIR=/tmp/ruby sh build-loop.sh trunk --incremental
    831     833     833     833 pts/0        833 Ss+   1000   0:00 dash -c cd build-ruby; BUILD_RUBY_WORKING_DIR=/tmp/ruby sh build-loop.sh trunk --incremental
    833     834     833     833 pts/0        833 S+    1000   0:14 sh build-loop.sh trunk --incremental
      1  595787     833     833 pts/0        833 S+    1000   0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestThreadQueue#test_fork_while_queue_waiting
      1 1325073     833     833 pts/0        833 S+    1000   0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestIOBuffer#test_shared
    834 2320098     833     833 pts/0        833 Sl+   1000   0:00 ruby ./br.rb build_report trunk --incremental
2320098 2320101     833     833 pts/0        833 Sl+   1000   0:00 ruby /home/ko1/build-ruby/build-ruby.rb --target_name=trunk --logfile=/home/ko1/ruby/logs/brlog.trunk.20240426-143551 --root_dir=/tmp/ruby --timeout=10800 --incremental
2320101 2321546     833     833 pts/0        833 S+    1000   0:00 sh -c make yes-btest TESTOPTS='-q -j16'
2321546 2321547     833     833 pts/0        833 S+    1000   0:00 make yes-btest TESTOPTS=-q -j16
2321547 2321562     833     833 pts/0        833 Sl+   1000   0:02 /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./x86_64-linux-fake --disable-gems -q -j16
2321562 2360281     833     833 pts/0        833 Sl+   1000   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/x86_64-linux-fake --disable-gems -W0 bootstraptest.test_ractor.rb_259_1252.rb
2320101 2376151     833     833 pts/0        833 R+    1000   0:00 ps jx
      1 2482885     833     833 pts/0        833 S+    1000   0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestRand#test_fork_shuffle
      1 2495219     833     833 pts/0        833 S+    1000   0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestThread#test_fork_while_parent_locked
      1 3111240     833     833 pts/0        833 S+    1000   0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestThread#test_fork_while_parent_locked
      1 3427579     833     833 pts/0        833 S+    1000   0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestIOBuffer#test_shared
      1 3723384     833     833 pts/0        833 S+    1000   0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestThreadQueue#test_fork_while_queue_waiting
{1=>[831, 595787, 1325073, 2482885, 2495219, 3111240, 3427579, 3723384], 831=>[833], 833=>[834], 834=>[2320098], 2320098=>[2320101], 2320101=>[2321546, 2376151], 2321546=>[2321547], 2321547=>[2321562], 2321562=>[2360281]}
$ timeout 60 gdb -p 2360281 -x /home/ko1/build-ruby/gdbscript -batch -quiet 2> /dev/null
>>> Threads
No threads.
>>> Machine level backtrace
>>> Dump Ruby level backtrace (if possible)
$ timeout 60 gdb -p 2321562 -x /home/ko1/build-ruby/gdbscript -batch -quiet 2> /dev/null
 Fstderr output is not empty
   <internal:ractor>:274: [BUG] Segmentation fault at 0x00007fc96b79ba00
   ruby 3.4.0dev (2024-04-26T14:31:36Z master 69c1bd90be) [x86_64-linux]
   
   -- Control frame information -----------------------------------------------
   c:0013 p:0003 s:0059 e:000058 METHOD <internal:ractor>:274
   c:0012 p:0007 s:0049 E:001838 BLOCK  bootstraptest.test_ractor.rb_259_1252.rb:6 [FINISH]
   c:0011 p:---- s:0045 e:000044 IFUNC 
   c:0010 p:---- s:0042 e:000041 CFUNC  :each
   c:0009 p:---- s:0039 e:000038 CFUNC  :map
   c:0008 p:0008 s:0035 E:002100 METHOD bootstraptest.test_ractor.rb_259_1252.rb:5
   c:0007 p:0005 s:0027 e:000026 BLOCK  bootstraptest.test_ractor.rb_259_1252.rb:28 [FINISH]
   c:0006 p:---- s:0023 e:000022 IFUNC 
   c:0005 p:0024 s:0020 e:000018 METHOD <internal:numeric>:238 [FINISH]
   c:0004 p:---- s:0014 e:000013 CFUNC  :each
   c:0003 p:---- s:0011 e:000010 CFUNC  :map
   c:0002 p:0023 s:0007 e:000005 EVAL   bootstraptest.test_ractor.rb_259_1252.rb:27 [FINISH]
   c:0001 p:0000 s:0003 E:0018d0 DUMMY  [FINISH]
   
   -- Ruby level backtrace information ----------------------------------------
   bootstraptest.test_ractor.rb_259_1252.rb:27:in '<main>'
   bootstraptest.test_ractor.rb_259_1252.rb:27:in 'map'
   bootstraptest.test_ractor.rb_259_1252.rb:27:in 'each'
   <internal:numeric>:238:in 'times'
   bootstraptest.test_ractor.rb_259_1252.rb:28:in 'block in <main>'
   bootstraptest.test_ractor.rb_259_1252.rb:5:in 'test'
   bootstraptest.test_ractor.rb_259_1252.rb:5:in 'map'
   bootstraptest.test_ractor.rb_259_1252.rb:5:in 'each'
   bootstraptest.test_ractor.rb_259_1252.rb:6:in 'block in test'
   <internal:ractor>:274:in 'new'
   
   -- Threading information ---------------------------------------------------
   Total ractor count: 3
   Ruby thread count for this ractor: 1
   
   -- Machine register context ------------------------------------------------
    RIP: 0x00007fcc7099dcf9 RBP: 0x0000000000000028 RSP: 0x00007ffd9967dfb0
    RAX: 0x0000000000000006 RBX: 0x0000000000000011 RCX: 0x00007fcc70b14c98
    RDX: 0x00007fc96b79b9f0 RDI: 0x00007fcc70b14c88 RSI: 0x0000000000000001
     R8: 0x000000055c2db6c8  R9: 0x000055c2db6c8800 R10: 0x000055c2db1cb8a0
    R11: 0x0000000000000001 R12: 0xffffffffffffff30 R13: 0x0000000000000030
    R14: 0x0000000000000003 R15: 0x00007fcc7089cd38 EFL: 0x0000000000010246
   
   -- C level backtrace information -------------------------------------------
#1252 test_ractor.rb:259: 
     def test n
       rs = (1..n).map do |i|
         Ractor.new(i) do |i|
           "r#{i}"
         end
       end
       as = []
       all_rs = rs.dup
   
       n.times{
         r, obj = Ractor.select(*rs)
         as << [r, obj]
         rs.delete(r)
       }
   
       if as.map{|r, o| r.object_id}.sort == all_rs.map{|r| r.object_id}.sort &&
          as.map{|r, o| o}.sort == (1..n).map{|i| "r#{i}"}.sort
         'ok'
       else
         'ng'
       end
     end
   
     30.times.map{|i|
       test i
     }
  #=> "" (expected "[\"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\"]")  
FAIL 1/0 tests failed
make: *** [uncommon.mk:898: yes-btest] Error 1
>>> Threads
No threads.
>>> Machine level backtrace
>>> Dump Ruby level backtrace (if possible)
#<Errno::ESRCH: No such process>
$ timeout 60 gdb -p 2321547 -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>
$ timeout 60 gdb -p 2321546 -x /home/ko1/build-ruby/gdbscript -batch -quiet 2> /dev/null
>>> Threads
No threads.
>>> Machine level backtrace
>>> Dump Ruby level backtrace (if possible)
$ timeout 60 gdb -p 2376151 -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>

Linux ruby-sp1 5.15.0-94-generic #104-Ubuntu SMP Tue Jan 9 15:25:40 UTC 2024 x86_64 x86_64 x86_64 GNU/Linux

Logfile: /home/ko1/ruby/logs/brlog.trunk.20240426-143551
#<BuildRuby:0x000055a3b5efee68
 @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="-j16",
 @build_opts="-j16",
 @configure_opts=["--enable-shared"],
 @gist=false,
 @git_branch=nil,
 @git_worktree=nil,
 @incremental=true,
 @logfile="/home/ko1/ruby/logs/brlog.trunk.20240426-143551",
 @make="make",
 @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=10800>
                           user     system      total        real
checkout               0.000006   0.000001   0.000007 (  0.000007)
autoconf               0.000012   0.000002   0.000014 (  0.000014)
configure              0.000010   0.000002   0.000012 (  0.000011)
build_up               0.006467   0.000000   1.735786 (  1.818109)
build_miniruby         0.001015   0.000000   0.913737 (  0.913354)
build_ruby             0.001167   0.000114   2.836376 (  2.837136)
build_all              0.010202   0.000881  16.532425 (  1.556740)
build_install          0.006390   0.003937   5.989389 (  1.280089)
test_btest             0.001118   0.004481  99.133779 (10800.334690)
/home/ko1/build-ruby/build-ruby.rb:216:in `join': execution expired (Timeout::Error)
	from /home/ko1/build-ruby/build-ruby.rb:216:in `each'
	from /home/ko1/build-ruby/build-ruby.rb:216:in `block (2 levels) in cmd'
	from /usr/lib/ruby/3.0.0/timeout.rb:112:in `timeout'
	from /home/ko1/build-ruby/build-ruby.rb:215:in `block in cmd'
	from /home/ko1/build-ruby/build-ruby.rb:207:in `popen'
	from /home/ko1/build-ruby/build-ruby.rb:207:in `cmd'
	from /home/ko1/build-ruby/build-ruby.rb:370:in `block in test_btest'
	from /home/ko1/build-ruby/build-ruby.rb:303:in `block in builddir'
	from /home/ko1/build-ruby/build-ruby.rb:302:in `chdir'
	from /home/ko1/build-ruby/build-ruby.rb:302:in `builddir'
	from /home/ko1/build-ruby/build-ruby.rb:369:in `test_btest'
	from /home/ko1/build-ruby/build-ruby.rb:445:in `block (4 levels) in run'
	from /usr/lib/ruby/3.0.0/benchmark.rb:293:in `measure'
	from /usr/lib/ruby/3.0.0/benchmark.rb:375:in `item'
	from /home/ko1/build-ruby/build-ruby.rb:443:in `block (3 levels) in run'
	from /home/ko1/build-ruby/build-ruby.rb:442:in `each'
	from /home/ko1/build-ruby/build-ruby.rb:442:in `block (2 levels) in run'
	from /usr/lib/ruby/3.0.0/benchmark.rb:173:in `benchmark'
	from /usr/lib/ruby/3.0.0/benchmark.rb:205:in `bm'
	from /home/ko1/build-ruby/build-ruby.rb:441:in `block in run'
	from /usr/lib/ruby/3.0.0/benchmark.rb:293:in `measure'
	from /home/ko1/build-ruby/build-ruby.rb:440:in `run'
	from /home/ko1/build-ruby/build-ruby.rb:634:in `<main>'
total: 10808.74 sec

	"make update-unicode -j16" exit with 0.
	"make update-download -j16" exit with 0.
	"make update-rubyspec -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'
	$$$ #<Timeout::Error: execution expired>
	### enter analyzing mode for stuck processes
	$$$ ps jx
	PPID PID PGID SID TTY TPGID STAT UID TIME COMMAND
	1 831 831 831 ? -1 Ss 1000 0:30 SCREEN -d -m dash -c cd build-ruby; BUILD_RUBY_WORKING_DIR=/tmp/ruby sh build-loop.sh trunk --incremental
	831 833 833 833 pts/0 833 Ss+ 1000 0:00 dash -c cd build-ruby; BUILD_RUBY_WORKING_DIR=/tmp/ruby sh build-loop.sh trunk --incremental
	833 834 833 833 pts/0 833 S+ 1000 0:14 sh build-loop.sh trunk --incremental
	1 595787 833 833 pts/0 833 S+ 1000 0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestThreadQueue#test_fork_while_queue_waiting
	1 1325073 833 833 pts/0 833 S+ 1000 0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestIOBuffer#test_shared
	834 2320098 833 833 pts/0 833 Sl+ 1000 0:00 ruby ./br.rb build_report trunk --incremental
	2320098 2320101 833 833 pts/0 833 Sl+ 1000 0:00 ruby /home/ko1/build-ruby/build-ruby.rb --target_name=trunk --logfile=/home/ko1/ruby/logs/brlog.trunk.20240426-143551 --root_dir=/tmp/ruby --timeout=10800 --incremental
	2320101 2321546 833 833 pts/0 833 S+ 1000 0:00 sh -c make yes-btest TESTOPTS='-q -j16'
	2321546 2321547 833 833 pts/0 833 S+ 1000 0:00 make yes-btest TESTOPTS=-q -j16
	2321547 2321562 833 833 pts/0 833 Sl+ 1000 0:02 /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./x86_64-linux-fake --disable-gems -q -j16
	2321562 2360281 833 833 pts/0 833 Sl+ 1000 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/x86_64-linux-fake --disable-gems -W0 bootstraptest.test_ractor.rb_259_1252.rb
	2320101 2376151 833 833 pts/0 833 R+ 1000 0:00 ps jx
	1 2482885 833 833 pts/0 833 S+ 1000 0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestRand#test_fork_shuffle
	1 2495219 833 833 pts/0 833 S+ 1000 0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestThread#test_fork_while_parent_locked
	1 3111240 833 833 pts/0 833 S+ 1000 0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestThread#test_fork_while_parent_locked
	1 3427579 833 833 pts/0 833 S+ 1000 0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestIOBuffer#test_shared
	1 3723384 833 833 pts/0 833 S+ 1000 0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestThreadQueue#test_fork_while_queue_waiting
	{1=>[831, 595787, 1325073, 2482885, 2495219, 3111240, 3427579, 3723384], 831=>[833], 833=>[834], 834=>[2320098], 2320098=>[2320101], 2320101=>[2321546, 2376151], 2321546=>[2321547], 2321547=>[2321562], 2321562=>[2360281]}
	$ timeout 60 gdb -p 2360281 -x /home/ko1/build-ruby/gdbscript -batch -quiet 2> /dev/null
	>>> Threads
	No threads.
	>>> Machine level backtrace
	>>> Dump Ruby level backtrace (if possible)
	$ timeout 60 gdb -p 2321562 -x /home/ko1/build-ruby/gdbscript -batch -quiet 2> /dev/null
	Fstderr output is not empty
	<internal:ractor>:274: [BUG] Segmentation fault at 0x00007fc96b79ba00
	ruby 3.4.0dev (2024-04-26T14:31:36Z master 69c1bd90be) [x86_64-linux]

	-- Control frame information -----------------------------------------------
	c:0013 p:0003 s:0059 e:000058 METHOD <internal:ractor>:274
	c:0012 p:0007 s:0049 E:001838 BLOCK bootstraptest.test_ractor.rb_259_1252.rb:6 [FINISH]
	c:0011 p:---- s:0045 e:000044 IFUNC
	c:0010 p:---- s:0042 e:000041 CFUNC :each
	c:0009 p:---- s:0039 e:000038 CFUNC :map
	c:0008 p:0008 s:0035 E:002100 METHOD bootstraptest.test_ractor.rb_259_1252.rb:5
	c:0007 p:0005 s:0027 e:000026 BLOCK bootstraptest.test_ractor.rb_259_1252.rb:28 [FINISH]
	c:0006 p:---- s:0023 e:000022 IFUNC
	c:0005 p:0024 s:0020 e:000018 METHOD <internal:numeric>:238 [FINISH]
	c:0004 p:---- s:0014 e:000013 CFUNC :each
	c:0003 p:---- s:0011 e:000010 CFUNC :map
	c:0002 p:0023 s:0007 e:000005 EVAL bootstraptest.test_ractor.rb_259_1252.rb:27 [FINISH]
	c:0001 p:0000 s:0003 E:0018d0 DUMMY [FINISH]

	-- Ruby level backtrace information ----------------------------------------
	bootstraptest.test_ractor.rb_259_1252.rb:27:in '<main>'
	bootstraptest.test_ractor.rb_259_1252.rb:27:in 'map'
	bootstraptest.test_ractor.rb_259_1252.rb:27:in 'each'
	<internal:numeric>:238:in 'times'
	bootstraptest.test_ractor.rb_259_1252.rb:28:in 'block in <main>'
	bootstraptest.test_ractor.rb_259_1252.rb:5:in 'test'
	bootstraptest.test_ractor.rb_259_1252.rb:5:in 'map'
	bootstraptest.test_ractor.rb_259_1252.rb:5:in 'each'
	bootstraptest.test_ractor.rb_259_1252.rb:6:in 'block in test'
	<internal:ractor>:274:in 'new'

	-- Threading information ---------------------------------------------------
	Total ractor count: 3
	Ruby thread count for this ractor: 1

	-- Machine register context ------------------------------------------------
	RIP: 0x00007fcc7099dcf9 RBP: 0x0000000000000028 RSP: 0x00007ffd9967dfb0
	RAX: 0x0000000000000006 RBX: 0x0000000000000011 RCX: 0x00007fcc70b14c98
	RDX: 0x00007fc96b79b9f0 RDI: 0x00007fcc70b14c88 RSI: 0x0000000000000001
	R8: 0x000000055c2db6c8 R9: 0x000055c2db6c8800 R10: 0x000055c2db1cb8a0
	R11: 0x0000000000000001 R12: 0xffffffffffffff30 R13: 0x0000000000000030
	R14: 0x0000000000000003 R15: 0x00007fcc7089cd38 EFL: 0x0000000000010246

	-- C level backtrace information -------------------------------------------
	#1252 test_ractor.rb:259:
	def test n
	rs = (1..n).map do \|i\|
	Ractor.new(i) do \|i\|
	"r#{i}"
	end
	end
	as = []
	all_rs = rs.dup

	n.times{
	r, obj = Ractor.select(*rs)
	as << [r, obj]
	rs.delete(r)
	}

	if as.map{\|r, o\| r.object_id}.sort == all_rs.map{\|r\| r.object_id}.sort &&
	as.map{\|r, o\| o}.sort == (1..n).map{\|i\| "r#{i}"}.sort
	'ok'
	else
	'ng'
	end
	end

	30.times.map{\|i\|
	test i
	}
	#=> "" (expected "[\"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\", \"ok\"]")
	FAIL 1/0 tests failed
	make: *** [uncommon.mk:898: yes-btest] Error 1
	>>> Threads
	No threads.
	>>> Machine level backtrace
	>>> Dump Ruby level backtrace (if possible)
	#<Errno::ESRCH: No such process>
	$ timeout 60 gdb -p 2321547 -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>
	$ timeout 60 gdb -p 2321546 -x /home/ko1/build-ruby/gdbscript -batch -quiet 2> /dev/null
	>>> Threads
	No threads.
	>>> Machine level backtrace
	>>> Dump Ruby level backtrace (if possible)
	$ timeout 60 gdb -p 2376151 -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>