Result of trunk@ruby-sp1 at 2024-04-23 16:44:06 +0900

NG (e61f76ce9e)[LOG]
test-all: 26416 tests, 9526392 assertions, 0 failures, 0 errors, 284 skips
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'" exit with 0.
 
"make yes-test-basic TESTS='-j16'" exit with 0.
make yes-test-all TESTOPTS='--stderr-on-failure' TESTS='-j16'
Failed tests:
TestMethod#test_method_list: Test::Unit::ProxyError: string contains null byte
Children under /tmp/rubytest.20240423-3003966-fn0zve:
* drwx------ 4 80 2024-04-23 04:44:16 +0000 gem_rebuild20240423-3003978-qpfs25/
  * drwxrwxr-x 2 60 2024-04-23 04:44:16 +0000 new/
    * -rw-rw-r-- 1 4096 2024-04-23 04:44:16 +0000 rebuild_test_gem-1.0.0.gem
  * drwxrwxr-x 2 60 2024-04-23 04:44:16 +0000 old/
    * -rw-rw-r-- 1 4096 2024-04-23 04:44:16 +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     831     831     831 ?             -1 Ss    1000   0:28 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:13 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
      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
    834 2962613     833     833 pts/0        833 Sl+   1000   0:00 ruby ./br.rb build_report trunk --incremental
2962613 2962616     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.20240423-044347 --root_dir=/tmp/ruby --timeout=10800 --incremental
2962616 3003641     833     833 pts/0        833 Z+    1000   0:00 [sh] <defunct>
      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
2962616 3266815     833     833 pts/0        833 R+    1000   0:00 ps jx
      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=>[2962613], 2962613=>[2962616], 2962616=>[3003641, 3266815]}
$ timeout 60 gdb -p 3003641 -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 3266815 -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.20240423-044347
#<BuildRuby:0x0000560d418f7128
 @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.20240423-044347",
 @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.000005   0.000001   0.000006 (  0.000007)
autoconf               0.000008   0.000002   0.000010 (  0.000010)
configure              0.000007   0.000002   0.000009 (  0.000009)
build_up               0.001485   0.004345   1.803133 (  1.860543)
build_miniruby         0.000715   0.000210   0.894459 (  0.894088)
build_ruby             0.000964   0.000284   2.950456 (  2.950687)
build_all              0.005255   0.005957  16.749555 (  1.529388)
build_install          0.005436   0.004811   6.046764 (  1.301105)
test_btest             0.000827   0.000322  96.069552 (  8.766272)
test_basic             0.003294   0.001281   0.776887 (  0.851303)
test_all             #<Thread:0x0000560d41974330 /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.089668   0.082096 522.137183 (10800.138768)
/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: 10818.29 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'" exit with 0.

	"make yes-test-basic TESTS='-j16'" exit with 0.
	make yes-test-all TESTOPTS='--stderr-on-failure' TESTS='-j16'
	Failed tests:
	TestMethod#test_method_list: Test::Unit::ProxyError: string contains null byte
	Children under /tmp/rubytest.20240423-3003966-fn0zve:
	* drwx------ 4 80 2024-04-23 04:44:16 +0000 gem_rebuild20240423-3003978-qpfs25/
	* drwxrwxr-x 2 60 2024-04-23 04:44:16 +0000 new/
	* -rw-rw-r-- 1 4096 2024-04-23 04:44:16 +0000 rebuild_test_gem-1.0.0.gem
	* drwxrwxr-x 2 60 2024-04-23 04:44:16 +0000 old/
	* -rw-rw-r-- 1 4096 2024-04-23 04:44:16 +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 831 831 831 ? -1 Ss 1000 0:28 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:13 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
	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
	834 2962613 833 833 pts/0 833 Sl+ 1000 0:00 ruby ./br.rb build_report trunk --incremental
	2962613 2962616 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.20240423-044347 --root_dir=/tmp/ruby --timeout=10800 --incremental
	2962616 3003641 833 833 pts/0 833 Z+ 1000 0:00 [sh] <defunct>
	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
	2962616 3266815 833 833 pts/0 833 R+ 1000 0:00 ps jx
	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=>[2962613], 2962613=>[2962616], 2962616=>[3003641, 3266815]}
	$ timeout 60 gdb -p 3003641 -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 3266815 -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>