Result of trunk@ruby-sp3 at 2024-05-01 17:38:31 +0900

NG (9f7e0d2bb4)[LOG]
test-all: 26368 tests, 9528719 assertions, 0 failures, 0 errors, 296 skips
test-spec:

commands:

 "make update-unicode  -j20" exit with 0.
"make update-download -j20" exit with 0.
"make update-rubyspec -j20" exit with 0.
"make update-src      -j20" exit with 0.
"make after-update    -j20" exit with 0.
"make miniruby -j20" exit with 0.
"make ruby -j20" exit with 0.
"make all -j20" exit with 0.
"make install -j20" exit with 0.
"make yes-btest TESTOPTS='-q -j20'" exit with 0.
 
"make yes-test-basic TESTS='-j20'" exit with 0.
make yes-test-all TESTOPTS='--stderr-on-failure' TESTS='-j20'
Children under /tmp/rubytest.9cojvw:
* drwx------ 4 80 2024-05-01 05:38:34 +0000 gem_rebuild20240501-3895433-se44ys/
  * drwxrwxr-x 2 60 2024-05-01 05:38:34 +0000 new/
    * -rw-rw-r-- 1 4096 2024-05-01 05:38:34 +0000 rebuild_test_gem-1.0.0.gem
  * drwxrwxr-x 2 60 2024-05-01 05:38:34 +0000 old/
    * -rw-rw-r-- 1 4096 2024-05-01 05:38:34 +0000 rebuild_test_gem-1.0.0.gem
$$$ #<Timeout::Error: execution expired>
### enter analyzing mode for stuck processes
$$$ ps jx
   PPID     PID    PGID     SID TTY        TPGID STAT   UID   TIME COMMAND
      1     869     869     869 ?             -1 Ss    1000   0:29 SCREEN -d -m dash -c cd build-ruby; BUILD_RUBY_WORKING_DIR=/tmp/ruby sh build-loop.sh trunk --incremental
    869     878     878     878 pts/0        878 Ss+   1000   0:00 dash -c cd build-ruby; BUILD_RUBY_WORKING_DIR=/tmp/ruby sh build-loop.sh trunk --incremental
    878     884     878     878 pts/0        878 S+    1000   0:07 sh build-loop.sh trunk --incremental
3854045  179055     878     878 pts/0        878 R+    1000   0:00 ps jx
      1  379643     878     878 pts/0        878 Rl+   1000 9392:57 /tmp/ruby/build/trunk/ruby
      1  856310     878     878 pts/0        878 S+    1000   0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: JSONGeneratorTest#test_broken_bignum
      1  932191     878     878 pts/0        878 S+    1000   0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestRand#test_fork_shuffle
      1 2374380     878     878 pts/0        878 S+    1000   0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: JSONGeneratorTest#test_broken_bignum
      1 2449306     878     878 pts/0        878 S+    1000   0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestIO#test_fcntl_lock_linux
      1 2517516     878     878 pts/0        878 S+    1000   0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestRand#test_fork_shuffle
      1 2949012     878     878 pts/0        878 S+    1000   0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestProcess#test_daemon_no_threads
      1 3083394     878     878 pts/0        878 Sl+   1000   0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestProcess#test_concurrent_group_and_pid_wait
      1 3083397     878     878 pts/0        878 S+    1000   0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestProcess#test_concurrent_group_and_pid_wait
      1 3228729     878     878 pts/0        878 S+    1000   0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestIOBuffer#test_shared
    884 3854042     878     878 pts/0        878 Sl+   1000   0:00 ruby ./br.rb build_report trunk --incremental
3854042 3854045     878     878 pts/0        878 Sl+   1000   0:00 ruby /home/ko1/build-ruby/build-ruby.rb --target_name=trunk --logfile=/home/ko1/ruby/logs/brlog.trunk.20240501-053818 --root_dir=/tmp/ruby --timeout=10800 --incremental
3854045 3895098     878     878 pts/0        878 Z+    1000   0:00 [sh] <defunct>
      1 4043061     878     878 pts/0        878 S+    1000   0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestThread#test_fork_while_mutex_locked_by_forker
      1 4138579     878     878 pts/0        878 Sl+   1000   0:00 /tmp/ruby/build/trunk/ruby --disable=gems
{1=>[869, 379643, 856310, 932191, 2374380, 2449306, 2517516, 2949012, 3083394, 3083397, 3228729, 4043061, 4138579], 869=>[878], 878=>[884], 3854045=>[179055, 3895098], 884=>[3854042], 3854042=>[3854045]}
$ timeout 60 gdb -p 179055 -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 3895098 -x /home/ko1/build-ruby/gdbscript -batch -quiet 2> /dev/null
>>> Threads
No threads.
>>> Machine level backtrace
>>> Dump Ruby level backtrace (if possible)

Linux ruby-sp3 5.15.0-97-generic #107-Ubuntu SMP Wed Feb 7 13:26:48 UTC 2024 x86_64 x86_64 x86_64 GNU/Linux

Logfile: /home/ko1/ruby/logs/brlog.trunk.20240501-053818
#<BuildRuby:0x000055977e4b7100
 @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="-j20",
 @build_opts="-j20",
 @configure_opts=["--enable-shared"],
 @gist=false,
 @git_branch=nil,
 @git_worktree=nil,
 @incremental=true,
 @logfile="/home/ko1/ruby/logs/brlog.trunk.20240501-053818",
 @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='-j20'",
 @timeout=10800>
                           user     system      total        real
checkout               0.000004   0.000000   0.000004 (  0.000004)
autoconf               0.000008   0.000000   0.000008 (  0.000008)
configure              0.000006   0.000000   0.000006 (  0.000006)
build_up               0.003854   0.003960   1.513639 (  1.468661)
build_miniruby         0.000000   0.001260   0.712845 (  0.712625)
build_ruby             0.000000   0.001336   2.237932 (  2.238671)
build_all              0.003471   0.005081  12.687552 (  1.042925)
build_install          0.011338   0.004800   4.497406 (  1.055001)
test_btest             0.000901   0.000000  71.008966 (  6.164791)
test_basic             0.001299   0.003599   0.374809 (  0.455761)
test_all             #<Thread:0x000055977e63bb70 /home/ko1/build-ruby/build-ruby.rb:211 run> terminated with exception (report_on_exception is true):
/home/ko1/build-ruby/build-ruby.rb:211:in `each_line': stream closed in another thread (IOError)
	from /home/ko1/build-ruby/build-ruby.rb:211:in `block (2 levels) in cmd'
  0.075920   0.028004 420.575997 (10800.072446)
/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:383:in `block in test_all'
	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:381:in `test_all'
	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: 10813.21 sec

	"make update-unicode -j20" exit with 0.
	"make update-download -j20" exit with 0.
	"make update-rubyspec -j20" exit with 0.
	"make update-src -j20" exit with 0.
	"make after-update -j20" exit with 0.
	"make miniruby -j20" exit with 0.
	"make ruby -j20" exit with 0.
	"make all -j20" exit with 0.
	"make install -j20" exit with 0.
	"make yes-btest TESTOPTS='-q -j20'" exit with 0.

	"make yes-test-basic TESTS='-j20'" exit with 0.
	make yes-test-all TESTOPTS='--stderr-on-failure' TESTS='-j20'
	Children under /tmp/rubytest.9cojvw:
	* drwx------ 4 80 2024-05-01 05:38:34 +0000 gem_rebuild20240501-3895433-se44ys/
	* drwxrwxr-x 2 60 2024-05-01 05:38:34 +0000 new/
	* -rw-rw-r-- 1 4096 2024-05-01 05:38:34 +0000 rebuild_test_gem-1.0.0.gem
	* drwxrwxr-x 2 60 2024-05-01 05:38:34 +0000 old/
	* -rw-rw-r-- 1 4096 2024-05-01 05:38:34 +0000 rebuild_test_gem-1.0.0.gem
	$$$ #<Timeout::Error: execution expired>
	### enter analyzing mode for stuck processes
	$$$ ps jx
	PPID PID PGID SID TTY TPGID STAT UID TIME COMMAND
	1 869 869 869 ? -1 Ss 1000 0:29 SCREEN -d -m dash -c cd build-ruby; BUILD_RUBY_WORKING_DIR=/tmp/ruby sh build-loop.sh trunk --incremental
	869 878 878 878 pts/0 878 Ss+ 1000 0:00 dash -c cd build-ruby; BUILD_RUBY_WORKING_DIR=/tmp/ruby sh build-loop.sh trunk --incremental
	878 884 878 878 pts/0 878 S+ 1000 0:07 sh build-loop.sh trunk --incremental
	3854045 179055 878 878 pts/0 878 R+ 1000 0:00 ps jx
	1 379643 878 878 pts/0 878 Rl+ 1000 9392:57 /tmp/ruby/build/trunk/ruby
	1 856310 878 878 pts/0 878 S+ 1000 0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: JSONGeneratorTest#test_broken_bignum
	1 932191 878 878 pts/0 878 S+ 1000 0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestRand#test_fork_shuffle
	1 2374380 878 878 pts/0 878 S+ 1000 0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: JSONGeneratorTest#test_broken_bignum
	1 2449306 878 878 pts/0 878 S+ 1000 0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestIO#test_fcntl_lock_linux
	1 2517516 878 878 pts/0 878 S+ 1000 0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestRand#test_fork_shuffle
	1 2949012 878 878 pts/0 878 S+ 1000 0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestProcess#test_daemon_no_threads
	1 3083394 878 878 pts/0 878 Sl+ 1000 0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestProcess#test_concurrent_group_and_pid_wait
	1 3083397 878 878 pts/0 878 S+ 1000 0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestProcess#test_concurrent_group_and_pid_wait
	1 3228729 878 878 pts/0 878 S+ 1000 0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestIOBuffer#test_shared
	884 3854042 878 878 pts/0 878 Sl+ 1000 0:00 ruby ./br.rb build_report trunk --incremental
	3854042 3854045 878 878 pts/0 878 Sl+ 1000 0:00 ruby /home/ko1/build-ruby/build-ruby.rb --target_name=trunk --logfile=/home/ko1/ruby/logs/brlog.trunk.20240501-053818 --root_dir=/tmp/ruby --timeout=10800 --incremental
	3854045 3895098 878 878 pts/0 878 Z+ 1000 0:00 [sh] <defunct>
	1 4043061 878 878 pts/0 878 S+ 1000 0:00 /tmp/ruby/src/trunk/tool/lib/test/unit/parallel.rb: TestThread#test_fork_while_mutex_locked_by_forker
	1 4138579 878 878 pts/0 878 Sl+ 1000 0:00 /tmp/ruby/build/trunk/ruby --disable=gems
	{1=>[869, 379643, 856310, 932191, 2374380, 2449306, 2517516, 2949012, 3083394, 3083397, 3228729, 4043061, 4138579], 869=>[878], 878=>[884], 3854045=>[179055, 3895098], 884=>[3854042], 3854042=>[3854045]}
	$ timeout 60 gdb -p 179055 -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 3895098 -x /home/ko1/build-ruby/gdbscript -batch -quiet 2> /dev/null
	>>> Threads
	No threads.
	>>> Machine level backtrace
	>>> Dump Ruby level backtrace (if possible)