Result of trunk-asserts@ruby-sp2-docker at 2023-08-21 10:03:28 +0900

NG (55f930aa7e)[LOG]
test-all:
test-spec:

commands:

 "make update-unicode  DEFS=\"-DRGENGC_CHECK_MODE=2 -DRUBY_DEBUG=1 -fno-inline\"" exit with 0.
"make update-download DEFS=\"-DRGENGC_CHECK_MODE=2 -DRUBY_DEBUG=1 -fno-inline\"" exit with 0.
From https://github.com/ruby/typeprof
 * branch            aabc019684d8b4a1ed66c2a1ca48da7bbb18dcc0 -> FETCH_HEAD
HEAD is now at aabc019 Skip VM_CALL_BLOCKISEQ for Ruby < 3.3
"make update-rubyspec DEFS=\"-DRGENGC_CHECK_MODE=2 -DRUBY_DEBUG=1 -fno-inline\"" exit with 0.
"make update-src      DEFS=\"-DRGENGC_CHECK_MODE=2 -DRUBY_DEBUG=1 -fno-inline\"" exit with 0.
From https://github.com/ruby/ruby
   812272b..55f930a  master     -> origin/master
"make after-update    DEFS=\"-DRGENGC_CHECK_MODE=2 -DRUBY_DEBUG=1 -fno-inline\"" exit with 0.
From https://github.com/ruby/typeprof
 * branch            aabc019684d8b4a1ed66c2a1ca48da7bbb18dcc0 -> FETCH_HEAD
HEAD is now at aabc019 Skip VM_CALL_BLOCKISEQ for Ruby < 3.3
"make miniruby DEFS=\"-DRGENGC_CHECK_MODE=2 -DRUBY_DEBUG=1 -fno-inline\"" exit with 0.
"make ruby DEFS=\"-DRGENGC_CHECK_MODE=2 -DRUBY_DEBUG=1 -fno-inline\"" exit with 0.
"make all DEFS=\"-DRGENGC_CHECK_MODE=2 -DRUBY_DEBUG=1 -fno-inline\"" exit with 0.
"make install DEFS=\"-DRGENGC_CHECK_MODE=2 -DRUBY_DEBUG=1 -fno-inline\"" exit with 0.
From https://github.com/ruby/typeprof
 * branch            aabc019684d8b4a1ed66c2a1ca48da7bbb18dcc0 -> FETCH_HEAD
HEAD is now at aabc019 Skip VM_CALL_BLOCKISEQ for Ruby < 3.3
"make yes-btest TESTOPTS='-q -j4'" exit with 0.
 
"make yes-test-basic TESTS='-j4'" exit with 0.
make yes-test-all TESTOPTS='--stderr-on-failure' TESTS='-j4'
/tmp/ruby/build/trunk-asserts/.ext/common/json/common.rb:111: warning: already initialized constant JSON::DEFAULT_CREATE_ID
/tmp/ruby/build/trunk-asserts/.ext/common/json/common.rb:111: warning: previous definition of DEFAULT_CREATE_ID was here
/tmp/ruby/build/trunk-asserts/.ext/common/json/common.rb:114: warning: already initialized constant JSON::CREATE_ID_TLS_KEY
/tmp/ruby/build/trunk-asserts/.ext/common/json/common.rb:114: warning: previous definition of CREATE_ID_TLS_KEY was here
/tmp/ruby/build/trunk-asserts/.ext/common/json/common.rb:130: warning: already initialized constant JSON::NaN
/tmp/ruby/build/trunk-asserts/.ext/common/json/common.rb:130: warning: previous definition of NaN was here
/tmp/ruby/build/trunk-asserts/.ext/common/json/common.rb:132: warning: already initialized constant JSON::Infinity
/tmp/ruby/build/trunk-asserts/.ext/common/json/common.rb:132: warning: previous definition of Infinity was here
/tmp/ruby/build/trunk-asserts/.ext/common/json/common.rb:134: warning: already initialized constant JSON::MinusInfinity
/tmp/ruby/build/trunk-asserts/.ext/common/json/common.rb:134: warning: previous definition of MinusInfinity was here
/tmp/ruby/build/trunk-asserts/.ext/common/json/common.rb:159: warning: already initialized constant JSON::UnparserError
/tmp/ruby/build/trunk-asserts/.ext/common/json/common.rb:159: warning: previous definition of UnparserError was here
Exception while verifying corrupt.gem
Exception while verifying corrupt.gem
$$$ #<Timeout::Error: execution expired>
### enter analyzing mode for stuck processes
$$$ ps jx
   PPID     PID    PGID     SID TTY        TPGID STAT   UID   TIME COMMAND
     11      12      12      12 ?             -1 Ss    1001   0:00 sh build-loop.sh trunk-asserts --incremental --process-num=4
     12 2333997      12      12 ?             -1 Sl    1001   0:00 ruby ./br.rb build_report trunk-asserts --incremental --process-num=4
2333997 2334000      12      12 ?             -1 S     1001   0:00 sh -c ruby /home/ko1/build-ruby/build-ruby.rb --target_name=trunk-asserts --logfile=/home/ko1/ruby/logs/brlog.trunk-asserts.20230820-184222 --root_dir=/tmp/ruby --timeout=21600 --build_opts='DEFS="-DRGENGC_CHECK_MODE=2 -DRUBY_DEBUG=1 -fno-inline"'   --add-env=RUBY_TEST_SUBPROCESS_TIMEOUT_SCALE=50 --incremental --process-num=4
2334000 2334001      12      12 ?             -1 Rl    1001   0:00 ruby /home/ko1/build-ruby/build-ruby.rb --target_name=trunk-asserts --logfile=/home/ko1/ruby/logs/brlog.trunk-asserts.20230820-184222 --root_dir=/tmp/ruby --timeout=21600 --build_opts=DEFS="-DRGENGC_CHECK_MODE=2 -DRUBY_DEBUG=1 -fno-inline" --add-env=RUBY_TEST_SUBPROCESS_TIMEOUT_SCALE=50 --incremental --process-num=4
2334001 2338285      12      12 ?             -1 S     1001   0:00 sh -c make yes-test-all TESTOPTS='--stderr-on-failure' TESTS='-j4'
2338285 2338286      12      12 ?             -1 S     1001   0:00 make yes-test-all TESTOPTS=--stderr-on-failure TESTS=-j4
2338286 2338558      12      12 ?             -1 S     1001   1:46 /tmp/ruby/build/trunk-asserts/ruby --disable-gems /tmp/ruby/src/trunk-asserts/test/runner.rb --ruby=./miniruby -I/tmp/ruby/src/trunk-asserts/lib -I. -I.ext/common  /tmp/ruby/src/trunk-asserts/tool/runruby.rb --extout=.ext  -- --disable-gems --excludes-dir=/tmp/ruby/src/trunk-asserts/test/.excludes --name=!/memory_leak/ --stderr-on-failure -j4
2338558 2338561      12      12 ?             -1 Rl    1001 172:22 /tmp/ruby/src/trunk-asserts/tool/lib/test/unit/parallel.rb: TestObjSpace#test_trace_object_allocations
2334001 2346969      12      12 ?             -1 R     1001   0:00 ps jx
{11=>[12], 12=>[2333997], 2333997=>[2334000], 2334000=>[2334001], 2334001=>[2338285, 2346969], 2338285=>[2338286], 2338286=>[2338558], 2338558=>[2338561]}
$ timeout 60 gdb -p 2338561 -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 2338558 -x /home/ko1/build-ruby/gdbscript -batch -quiet 2> /dev/null
running file: /tmp/ruby/src/trunk-asserts/test/objspace/test_objspace.rb
A test worker crashed. It might be an interpreter bug or
a bug in test/unit/parallel.rb. Try again without the -j
option.
>>> Threads
No threads.
>>> Machine level backtrace
>>> Dump Ruby level backtrace (if possible)
$ timeout 60 gdb -p 2338286 -x /home/ko1/build-ruby/gdbscript -batch -quiet 2> /dev/null
make: *** [uncommon.mk:908: yes-test-all] Killed
>>> Threads
No threads.
>>> Machine level backtrace
>>> Dump Ruby level backtrace (if possible)
#<Errno::ESRCH: No such process>
$ timeout 60 gdb -p 2338285 -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 2346969 -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-sp2-docker 5.15.0-72-generic #79-Ubuntu SMP Wed Apr 19 08:22:18 UTC 2023 x86_64 x86_64 x86_64 GNU/Linux

Logfile: /home/ko1/ruby/logs/brlog.trunk-asserts.20230820-184222
#<BuildRuby:0x0000561dcc870a88
 @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-asserts",
 @TARGET_INSTALL_DIR="/tmp/ruby/install/trunk-asserts",
 @TARGET_NAME="trunk-asserts",
 @TARGET_SRC_DIR="/tmp/ruby/src/trunk-asserts",
 @btest_opts="-j4",
 @build_opts="DEFS=\"-DRGENGC_CHECK_MODE=2 -DRUBY_DEBUG=1 -fno-inline\"",
 @configure_opts=["--enable-shared"],
 @gist=false,
 @git_branch=nil,
 @git_worktree=nil,
 @incremental=true,
 @logfile="/home/ko1/ruby/logs/brlog.trunk-asserts.20230820-184222",
 @make="make",
 @quiet=false,
 @ruby_env=
  [["RUBY_DEBUG", "ci"], ["RUBY_TEST_SUBPROCESS_TIMEOUT_SCALE", "50"]],
 @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=21600>
                           user     system      total        real
checkout               0.000018   0.000004   0.000022 (  0.000022)
autoconf               0.000030   0.000006   0.000036 (  0.000036)
configure              0.000021   0.000004   0.000025 (  0.000025)
build_up               0.007454   0.000000   3.100725 (  5.673584)
build_miniruby         0.002681   0.000377   2.332835 (  3.088440)
build_ruby             0.001811   0.000312  37.142696 ( 38.251269)
build_all              0.013226   0.001511  94.450808 ( 98.615005)
build_install          0.019551   0.003259 104.294247 (106.193518)
test_btest             0.000915   0.000153 2511.052420 (989.348330)
test_basic             0.006748   0.004759  20.073381 ( 23.501821)
test_all               0.013568   0.001696 47594.694062 (21601.010547)
/home/ko1/build-ruby/build-ruby.rb:214:in `join': execution expired (Timeout::Error)
	from /home/ko1/build-ruby/build-ruby.rb:214:in `each'
	from /home/ko1/build-ruby/build-ruby.rb:214: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:213:in `block in cmd'
	from /home/ko1/build-ruby/build-ruby.rb:205:in `popen'
	from /home/ko1/build-ruby/build-ruby.rb:205:in `cmd'
	from /home/ko1/build-ruby/build-ruby.rb:381:in `block in test_all'
	from /home/ko1/build-ruby/build-ruby.rb:301:in `block in builddir'
	from /home/ko1/build-ruby/build-ruby.rb:300:in `chdir'
	from /home/ko1/build-ruby/build-ruby.rb:300:in `builddir'
	from /home/ko1/build-ruby/build-ruby.rb:379:in `test_all'
	from /home/ko1/build-ruby/build-ruby.rb:443: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:441:in `block (3 levels) in run'
	from /home/ko1/build-ruby/build-ruby.rb:440:in `each'
	from /home/ko1/build-ruby/build-ruby.rb:440: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:439:in `block in run'
	from /usr/lib/ruby/3.0.0/benchmark.rb:293:in `measure'
	from /home/ko1/build-ruby/build-ruby.rb:438:in `run'
	from /home/ko1/build-ruby/build-ruby.rb:632:in `<main>'
total: 22865.68 sec

	"make update-unicode DEFS=\"-DRGENGC_CHECK_MODE=2 -DRUBY_DEBUG=1 -fno-inline\"" exit with 0.
	"make update-download DEFS=\"-DRGENGC_CHECK_MODE=2 -DRUBY_DEBUG=1 -fno-inline\"" exit with 0.
	From https://github.com/ruby/typeprof
	* branch aabc019684d8b4a1ed66c2a1ca48da7bbb18dcc0 -> FETCH_HEAD
	HEAD is now at aabc019 Skip VM_CALL_BLOCKISEQ for Ruby < 3.3
	"make update-rubyspec DEFS=\"-DRGENGC_CHECK_MODE=2 -DRUBY_DEBUG=1 -fno-inline\"" exit with 0.
	"make update-src DEFS=\"-DRGENGC_CHECK_MODE=2 -DRUBY_DEBUG=1 -fno-inline\"" exit with 0.
	From https://github.com/ruby/ruby
	812272b..55f930a master -> origin/master
	"make after-update DEFS=\"-DRGENGC_CHECK_MODE=2 -DRUBY_DEBUG=1 -fno-inline\"" exit with 0.
	From https://github.com/ruby/typeprof
	* branch aabc019684d8b4a1ed66c2a1ca48da7bbb18dcc0 -> FETCH_HEAD
	HEAD is now at aabc019 Skip VM_CALL_BLOCKISEQ for Ruby < 3.3
	"make miniruby DEFS=\"-DRGENGC_CHECK_MODE=2 -DRUBY_DEBUG=1 -fno-inline\"" exit with 0.
	"make ruby DEFS=\"-DRGENGC_CHECK_MODE=2 -DRUBY_DEBUG=1 -fno-inline\"" exit with 0.
	"make all DEFS=\"-DRGENGC_CHECK_MODE=2 -DRUBY_DEBUG=1 -fno-inline\"" exit with 0.
	"make install DEFS=\"-DRGENGC_CHECK_MODE=2 -DRUBY_DEBUG=1 -fno-inline\"" exit with 0.
	From https://github.com/ruby/typeprof
	* branch aabc019684d8b4a1ed66c2a1ca48da7bbb18dcc0 -> FETCH_HEAD
	HEAD is now at aabc019 Skip VM_CALL_BLOCKISEQ for Ruby < 3.3
	"make yes-btest TESTOPTS='-q -j4'" exit with 0.

	"make yes-test-basic TESTS='-j4'" exit with 0.
	make yes-test-all TESTOPTS='--stderr-on-failure' TESTS='-j4'
	/tmp/ruby/build/trunk-asserts/.ext/common/json/common.rb:111: warning: already initialized constant JSON::DEFAULT_CREATE_ID
	/tmp/ruby/build/trunk-asserts/.ext/common/json/common.rb:111: warning: previous definition of DEFAULT_CREATE_ID was here
	/tmp/ruby/build/trunk-asserts/.ext/common/json/common.rb:114: warning: already initialized constant JSON::CREATE_ID_TLS_KEY
	/tmp/ruby/build/trunk-asserts/.ext/common/json/common.rb:114: warning: previous definition of CREATE_ID_TLS_KEY was here
	/tmp/ruby/build/trunk-asserts/.ext/common/json/common.rb:130: warning: already initialized constant JSON::NaN
	/tmp/ruby/build/trunk-asserts/.ext/common/json/common.rb:130: warning: previous definition of NaN was here
	/tmp/ruby/build/trunk-asserts/.ext/common/json/common.rb:132: warning: already initialized constant JSON::Infinity
	/tmp/ruby/build/trunk-asserts/.ext/common/json/common.rb:132: warning: previous definition of Infinity was here
	/tmp/ruby/build/trunk-asserts/.ext/common/json/common.rb:134: warning: already initialized constant JSON::MinusInfinity
	/tmp/ruby/build/trunk-asserts/.ext/common/json/common.rb:134: warning: previous definition of MinusInfinity was here
	/tmp/ruby/build/trunk-asserts/.ext/common/json/common.rb:159: warning: already initialized constant JSON::UnparserError
	/tmp/ruby/build/trunk-asserts/.ext/common/json/common.rb:159: warning: previous definition of UnparserError was here
	Exception while verifying corrupt.gem
	Exception while verifying corrupt.gem
	$$$ #<Timeout::Error: execution expired>
	### enter analyzing mode for stuck processes
	$$$ ps jx
	PPID PID PGID SID TTY TPGID STAT UID TIME COMMAND
	11 12 12 12 ? -1 Ss 1001 0:00 sh build-loop.sh trunk-asserts --incremental --process-num=4
	12 2333997 12 12 ? -1 Sl 1001 0:00 ruby ./br.rb build_report trunk-asserts --incremental --process-num=4
	2333997 2334000 12 12 ? -1 S 1001 0:00 sh -c ruby /home/ko1/build-ruby/build-ruby.rb --target_name=trunk-asserts --logfile=/home/ko1/ruby/logs/brlog.trunk-asserts.20230820-184222 --root_dir=/tmp/ruby --timeout=21600 --build_opts='DEFS="-DRGENGC_CHECK_MODE=2 -DRUBY_DEBUG=1 -fno-inline"' --add-env=RUBY_TEST_SUBPROCESS_TIMEOUT_SCALE=50 --incremental --process-num=4
	2334000 2334001 12 12 ? -1 Rl 1001 0:00 ruby /home/ko1/build-ruby/build-ruby.rb --target_name=trunk-asserts --logfile=/home/ko1/ruby/logs/brlog.trunk-asserts.20230820-184222 --root_dir=/tmp/ruby --timeout=21600 --build_opts=DEFS="-DRGENGC_CHECK_MODE=2 -DRUBY_DEBUG=1 -fno-inline" --add-env=RUBY_TEST_SUBPROCESS_TIMEOUT_SCALE=50 --incremental --process-num=4
	2334001 2338285 12 12 ? -1 S 1001 0:00 sh -c make yes-test-all TESTOPTS='--stderr-on-failure' TESTS='-j4'
	2338285 2338286 12 12 ? -1 S 1001 0:00 make yes-test-all TESTOPTS=--stderr-on-failure TESTS=-j4
	2338286 2338558 12 12 ? -1 S 1001 1:46 /tmp/ruby/build/trunk-asserts/ruby --disable-gems /tmp/ruby/src/trunk-asserts/test/runner.rb --ruby=./miniruby -I/tmp/ruby/src/trunk-asserts/lib -I. -I.ext/common /tmp/ruby/src/trunk-asserts/tool/runruby.rb --extout=.ext -- --disable-gems --excludes-dir=/tmp/ruby/src/trunk-asserts/test/.excludes --name=!/memory_leak/ --stderr-on-failure -j4
	2338558 2338561 12 12 ? -1 Rl 1001 172:22 /tmp/ruby/src/trunk-asserts/tool/lib/test/unit/parallel.rb: TestObjSpace#test_trace_object_allocations
	2334001 2346969 12 12 ? -1 R 1001 0:00 ps jx
	{11=>[12], 12=>[2333997], 2333997=>[2334000], 2334000=>[2334001], 2334001=>[2338285, 2346969], 2338285=>[2338286], 2338286=>[2338558], 2338558=>[2338561]}
	$ timeout 60 gdb -p 2338561 -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 2338558 -x /home/ko1/build-ruby/gdbscript -batch -quiet 2> /dev/null
	running file: /tmp/ruby/src/trunk-asserts/test/objspace/test_objspace.rb
	A test worker crashed. It might be an interpreter bug or
	a bug in test/unit/parallel.rb. Try again without the -j
	option.
	>>> Threads
	No threads.
	>>> Machine level backtrace
	>>> Dump Ruby level backtrace (if possible)
	$ timeout 60 gdb -p 2338286 -x /home/ko1/build-ruby/gdbscript -batch -quiet 2> /dev/null
	make: *** [uncommon.mk:908: yes-test-all] Killed
	>>> Threads
	No threads.
	>>> Machine level backtrace
	>>> Dump Ruby level backtrace (if possible)
	#<Errno::ESRCH: No such process>
	$ timeout 60 gdb -p 2338285 -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 2346969 -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>