# Logfile created on 2021-09-27 09:02:12 +0900 by logger.rb/61378
I, [2021-09-27T09:02:12.680006 #10216]  INFO -- : #<BuildRuby:0x000055b14e85f430 @REPOSITORY="https://github.com/ruby/ruby.git", @REPOSITORY_TYPE=:git, @git_branch=nil, @git_worktree=nil, @svn_revision=nil, @SRC_DIR="/tmp/ruby/v3/src", @BUILD_DIR="/tmp/ruby/v3/build", @INSTALL_DIR="/tmp/ruby/v3/install", @TARGET_NAME="trunk-test", @TARGET_SRC_DIR="/tmp/ruby/v3/src/trunk-test", @TARGET_BUILD_DIR="/tmp/ruby/v3/build/trunk-test", @TARGET_INSTALL_DIR="/tmp/ruby/v3/install/trunk-test", @configure_opts=["--enable-shared"], @build_opts="-j8", @test_opts="TESTS='-j8'", @incremental=true, @steps=["checkout", "autoconf", "configure", "build_up", "build_miniruby", "build_ruby", "build_all", "build_install", "test_btest", "test_basic", "test_all", "test_rubyspec"], @quiet=false, @gist=false, @timeout=10800, @logfile="/home/ko1/ruby/logs/brlog.trunk-test.20210927-090212", @ruby_env=[["RUBY_DEBUG", "ci"]], @make="make", @logger=#<Logger:0x000055b14e7ce908 @level=0, @progname=nil, @default_formatter=#<Logger::Formatter:0x000055b14e7ce890 @datetime_format=nil>, @formatter=nil, @logdev=#<Logger::LogDevice:0x000055b14e7ce840 @shift_period_suffix="%Y%m%d", @shift_size=1048576, @shift_age=0, @filename="/home/ko1/ruby/logs/brlog.trunk-test.20210927-090212", @dev=#<File:/home/ko1/ruby/logs/brlog.trunk-test.20210927-090212>, @mon_owner=nil, @mon_count=0, @mon_mutex=#<Thread::Mutex:0x000055b14e7ce7c8>>>>
I, [2021-09-27T09:02:12.680247 #10216]  INFO -- : $$$[beg] make update-unicode  -j8
I, [2021-09-27T09:02:12.711237 #10216]  INFO -- : Downloading Unicode 13.0.0 data and property files...
I, [2021-09-27T09:02:12.714211 #10216]  INFO -- : Downloading Unicode 13.0.0 auxiliary files...
I, [2021-09-27T09:02:12.715238 #10216]  INFO -- : Downloading Unicode UCD emoji 13.1 files...
I, [2021-09-27T09:02:12.716092 #10216]  INFO -- : Downloading Unicode emoji 13.1 files...
I, [2021-09-27T09:02:12.757418 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/UnicodeData.txt already exists
I, [2021-09-27T09:02:12.757481 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/CompositionExclusions.txt already exists
I, [2021-09-27T09:02:12.757564 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/NormalizationTest.txt already exists
I, [2021-09-27T09:02:12.757590 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/CaseFolding.txt already exists
I, [2021-09-27T09:02:12.757616 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/SpecialCasing.txt already exists
I, [2021-09-27T09:02:12.757655 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/Blocks.txt already exists
I, [2021-09-27T09:02:12.757704 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/DerivedAge.txt already exists
I, [2021-09-27T09:02:12.757743 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/DerivedCoreProperties.txt already exists
I, [2021-09-27T09:02:12.757780 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/PropList.txt already exists
I, [2021-09-27T09:02:12.757832 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/PropertyAliases.txt already exists
I, [2021-09-27T09:02:12.757870 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/PropertyValueAliases.txt already exists
I, [2021-09-27T09:02:12.757907 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/Scripts.txt already exists
I, [2021-09-27T09:02:12.759477 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/auxiliary/GraphemeBreakProperty.txt already exists
I, [2021-09-27T09:02:12.759578 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/auxiliary/GraphemeBreakTest.txt already exists
I, [2021-09-27T09:02:12.771458 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/emoji/emoji-data.txt already exists
I, [2021-09-27T09:02:12.771504 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/emoji/emoji-variation-sequences.txt already exists
I, [2021-09-27T09:02:12.772259 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/emoji/13.1/emoji-sequences.txt already exists
I, [2021-09-27T09:02:12.772287 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/emoji/13.1/emoji-test.txt already exists
I, [2021-09-27T09:02:12.772382 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/emoji/13.1/emoji-zwj-sequences.txt already exists
I, [2021-09-27T09:02:12.773464 #10216]  INFO -- : $$$[end] "make update-unicode  -j8" exit with 0.
I, [2021-09-27T09:02:12.773491 #10216]  INFO -- : $$$[beg] make update-download -j8
I, [2021-09-27T09:02:12.857030 #10216]  INFO -- : tool/config.guess already exists
I, [2021-09-27T09:02:12.857078 #10216]  INFO -- : tool/config.sub already exists
I, [2021-09-27T09:02:12.859819 #10216]  INFO -- : downloading for ext/zlib/extlibs
I, [2021-09-27T09:02:12.859939 #10216]  INFO -- : .downloaded-cache/zlib-1.2.11.tar.gz already exists
I, [2021-09-27T09:02:12.861036 #10216]  INFO -- : checking md5 of .downloaded-cache/zlib-1.2.11.tar.gz ... OK
I, [2021-09-27T09:02:12.862093 #10216]  INFO -- : checking sha512 of .downloaded-cache/zlib-1.2.11.tar.gz ... OK
I, [2021-09-27T09:02:12.862117 #10216]  INFO -- : downloading for ext/fiddle/extlibs
I, [2021-09-27T09:02:12.862184 #10216]  INFO -- : .downloaded-cache/libffi-3.2.1.tar.gz already exists
I, [2021-09-27T09:02:12.863678 #10216]  INFO -- : checking md5 of .downloaded-cache/libffi-3.2.1.tar.gz ... OK
I, [2021-09-27T09:02:12.865158 #10216]  INFO -- : checking sha512 of .downloaded-cache/libffi-3.2.1.tar.gz ... OK
I, [2021-09-27T09:02:12.866305 #10216]  INFO -- : $$$[end] "make update-download -j8" exit with 0.
I, [2021-09-27T09:02:12.866334 #10216]  INFO -- : $$$[beg] make update-rubyspec -j8
I, [2021-09-27T09:02:12.896459 #10216]  INFO -- : make: Nothing to be done for 'update-rubyspec'.
I, [2021-09-27T09:02:12.896611 #10216]  INFO -- : $$$[end] "make update-rubyspec -j8" exit with 0.
I, [2021-09-27T09:02:12.896640 #10216]  INFO -- : $$$[beg] make update-src      -j8
I, [2021-09-27T09:02:13.356485 #10216]  INFO -- : Already up to date.
I, [2021-09-27T09:02:13.389684 #10216]  INFO -- : Current branch master is up to date.
I, [2021-09-27T09:02:13.398451 #10216]  INFO -- : Latest commit hash = 00cfafc0f5
I, [2021-09-27T09:02:13.398958 #10216]  INFO -- : $$$[end] "make update-src      -j8" exit with 0.
I, [2021-09-27T09:02:13.398985 #10216]  INFO -- : $$$[beg] make after-update    -j8
I, [2021-09-27T09:02:13.459521 #10216]  INFO -- : generating enc.mk
I, [2021-09-27T09:02:13.504620 #10216]  INFO -- : downloading for ext/zlib/extlibs
I, [2021-09-27T09:02:13.504741 #10216]  INFO -- : .downloaded-cache/zlib-1.2.11.tar.gz already exists
I, [2021-09-27T09:02:13.504768 #10216]  INFO -- : downloading for ext/fiddle/extlibs
I, [2021-09-27T09:02:13.504854 #10216]  INFO -- : .downloaded-cache/libffi-3.2.1.tar.gz already exists
I, [2021-09-27T09:02:13.529372 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/revision.h unchanged
I, [2021-09-27T09:02:13.561888 #10216]  INFO -- : making srcs under enc
I, [2021-09-27T09:02:13.594647 #10216]  INFO -- : make[1]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:13.594674 #10216]  INFO -- : make[1]: Nothing to be done for 'srcs'.
I, [2021-09-27T09:02:13.594687 #10216]  INFO -- : make[1]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:13.595070 #10216]  INFO -- : $$$[end] "make after-update    -j8" exit with 0.
I, [2021-09-27T09:02:13.595169 #10216]  INFO -- : $$$[beg] make miniruby -j8
I, [2021-09-27T09:02:13.624140 #10216]  INFO -- : 	BASERUBY = /usr/bin/ruby --disable=gems
I, [2021-09-27T09:02:13.624178 #10216]  INFO -- : 	CC = gcc
I, [2021-09-27T09:02:13.624191 #10216]  INFO -- : 	LD = ld
I, [2021-09-27T09:02:13.624201 #10216]  INFO -- : 	LDSHARED = gcc -shared
I, [2021-09-27T09:02:13.624210 #10216]  INFO -- : 	CFLAGS = -O3 -fno-fast-math -ggdb3 -Wall -Wextra -Werror=deprecated-declarations -Werror=duplicated-cond -Werror=implicit-function-declaration -Werror=implicit-int -Werror=misleading-indentation -Werror=pointer-arith -Werror=write-strings -Wimplicit-fallthrough=0 -Wmissing-noreturn -Wno-cast-function-type -Wno-constant-logical-operand -Wno-long-long -Wno-missing-field-initializers -Wno-overlength-strings -Wno-packed-bitfield-compat -Wno-parentheses-equality -Wno-self-assign -Wno-tautological-compare -Wno-unused-parameter -Wno-unused-value -Wsuggest-attribute=format -Wsuggest-attribute=noreturn -Wunused-variable -Werror=undef -std=gnu99  -fPIC 
I, [2021-09-27T09:02:13.624226 #10216]  INFO -- : 	XCFLAGS = -D_FORTIFY_SOURCE=2 -fstack-protector-strong -fno-strict-overflow -DRUBY_DEVEL=1 -fvisibility=hidden -fexcess-precision=standard -DRUBY_EXPORT -I. -I.ext/include/x86_64-linux -I/tmp/ruby/v3/src/trunk-test/include -I/tmp/ruby/v3/src/trunk-test -I/tmp/ruby/v3/src/trunk-test/enc/unicode/13.0.0
I, [2021-09-27T09:02:13.624237 #10216]  INFO -- : 	CPPFLAGS =   
I, [2021-09-27T09:02:13.624247 #10216]  INFO -- : 	DLDFLAGS = -Wl,--compress-debug-sections=zlib -Wl,-soname,libruby.so.3.1  -fstack-protector-strong  
I, [2021-09-27T09:02:13.624256 #10216]  INFO -- : 	SOLIBS = -lz -lpthread -lrt -lrt -lgmp -ldl -lcrypt -lm 
I, [2021-09-27T09:02:13.624280 #10216]  INFO -- : 	LANG = en_US.UTF-8
I, [2021-09-27T09:02:13.624289 #10216]  INFO -- : 	LC_ALL = 
I, [2021-09-27T09:02:13.624298 #10216]  INFO -- : 	LC_CTYPE = 
I, [2021-09-27T09:02:13.624307 #10216]  INFO -- : 	MFLAGS = -j --jobserver-fds=4,5
I, [2021-09-27T09:02:13.625916 #10216]  INFO -- : gcc (Ubuntu 7.5.0-3ubuntu1~18.04) 7.5.0
I, [2021-09-27T09:02:13.625941 #10216]  INFO -- : Copyright (C) 2017 Free Software Foundation, Inc.
I, [2021-09-27T09:02:13.625953 #10216]  INFO -- : This is free software; see the source for copying conditions.  There is NO
I, [2021-09-27T09:02:13.625964 #10216]  INFO -- : warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE.
I, [2021-09-27T09:02:13.625973 #10216]  INFO -- : 
I, [2021-09-27T09:02:13.651325 #10216]  INFO -- : make: 'miniruby' is up to date.
I, [2021-09-27T09:02:13.651487 #10216]  INFO -- : $$$[end] "make miniruby -j8" exit with 0.
I, [2021-09-27T09:02:13.651580 #10216]  INFO -- : $$$[beg] make ruby -j8
I, [2021-09-27T09:02:13.680457 #10216]  INFO -- : 	BASERUBY = /usr/bin/ruby --disable=gems
I, [2021-09-27T09:02:13.680497 #10216]  INFO -- : 	CC = gcc
I, [2021-09-27T09:02:13.680510 #10216]  INFO -- : 	LD = ld
I, [2021-09-27T09:02:13.680521 #10216]  INFO -- : 	LDSHARED = gcc -shared
I, [2021-09-27T09:02:13.680532 #10216]  INFO -- : 	CFLAGS = -O3 -fno-fast-math -ggdb3 -Wall -Wextra -Werror=deprecated-declarations -Werror=duplicated-cond -Werror=implicit-function-declaration -Werror=implicit-int -Werror=misleading-indentation -Werror=pointer-arith -Werror=write-strings -Wimplicit-fallthrough=0 -Wmissing-noreturn -Wno-cast-function-type -Wno-constant-logical-operand -Wno-long-long -Wno-missing-field-initializers -Wno-overlength-strings -Wno-packed-bitfield-compat -Wno-parentheses-equality -Wno-self-assign -Wno-tautological-compare -Wno-unused-parameter -Wno-unused-value -Wsuggest-attribute=format -Wsuggest-attribute=noreturn -Wunused-variable -Werror=undef -std=gnu99  -fPIC 
I, [2021-09-27T09:02:13.680542 #10216]  INFO -- : 	XCFLAGS = -D_FORTIFY_SOURCE=2 -fstack-protector-strong -fno-strict-overflow -DRUBY_DEVEL=1 -fvisibility=hidden -fexcess-precision=standard -DRUBY_EXPORT -I. -I.ext/include/x86_64-linux -I/tmp/ruby/v3/src/trunk-test/include -I/tmp/ruby/v3/src/trunk-test -I/tmp/ruby/v3/src/trunk-test/enc/unicode/13.0.0
I, [2021-09-27T09:02:13.680552 #10216]  INFO -- : 	CPPFLAGS =   
I, [2021-09-27T09:02:13.680562 #10216]  INFO -- : 	DLDFLAGS = -Wl,--compress-debug-sections=zlib -Wl,-soname,libruby.so.3.1  -fstack-protector-strong  
I, [2021-09-27T09:02:13.680578 #10216]  INFO -- : 	SOLIBS = -lz -lpthread -lrt -lrt -lgmp -ldl -lcrypt -lm 
I, [2021-09-27T09:02:13.680588 #10216]  INFO -- : 	LANG = en_US.UTF-8
I, [2021-09-27T09:02:13.680597 #10216]  INFO -- : 	LC_ALL = 
I, [2021-09-27T09:02:13.680606 #10216]  INFO -- : 	LC_CTYPE = 
I, [2021-09-27T09:02:13.680619 #10216]  INFO -- : 	MFLAGS = -j --jobserver-fds=4,5
I, [2021-09-27T09:02:13.682212 #10216]  INFO -- : gcc (Ubuntu 7.5.0-3ubuntu1~18.04) 7.5.0
I, [2021-09-27T09:02:13.682242 #10216]  INFO -- : Copyright (C) 2017 Free Software Foundation, Inc.
I, [2021-09-27T09:02:13.682260 #10216]  INFO -- : This is free software; see the source for copying conditions.  There is NO
I, [2021-09-27T09:02:13.682278 #10216]  INFO -- : warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE.
I, [2021-09-27T09:02:13.682303 #10216]  INFO -- : 
I, [2021-09-27T09:02:13.709137 #10216]  INFO -- : make: 'ruby' is up to date.
I, [2021-09-27T09:02:13.709260 #10216]  INFO -- : $$$[end] "make ruby -j8" exit with 0.
I, [2021-09-27T09:02:13.709349 #10216]  INFO -- : $$$[beg] make all -j8
I, [2021-09-27T09:02:13.738217 #10216]  INFO -- : 	BASERUBY = /usr/bin/ruby --disable=gems
I, [2021-09-27T09:02:13.738255 #10216]  INFO -- : 	CC = gcc
I, [2021-09-27T09:02:13.738267 #10216]  INFO -- : 	LD = ld
I, [2021-09-27T09:02:13.738278 #10216]  INFO -- : 	LDSHARED = gcc -shared
I, [2021-09-27T09:02:13.738288 #10216]  INFO -- : 	CFLAGS = -O3 -fno-fast-math -ggdb3 -Wall -Wextra -Werror=deprecated-declarations -Werror=duplicated-cond -Werror=implicit-function-declaration -Werror=implicit-int -Werror=misleading-indentation -Werror=pointer-arith -Werror=write-strings -Wimplicit-fallthrough=0 -Wmissing-noreturn -Wno-cast-function-type -Wno-constant-logical-operand -Wno-long-long -Wno-missing-field-initializers -Wno-overlength-strings -Wno-packed-bitfield-compat -Wno-parentheses-equality -Wno-self-assign -Wno-tautological-compare -Wno-unused-parameter -Wno-unused-value -Wsuggest-attribute=format -Wsuggest-attribute=noreturn -Wunused-variable -Werror=undef -std=gnu99  -fPIC 
I, [2021-09-27T09:02:13.738298 #10216]  INFO -- : 	XCFLAGS = -D_FORTIFY_SOURCE=2 -fstack-protector-strong -fno-strict-overflow -DRUBY_DEVEL=1 -fvisibility=hidden -fexcess-precision=standard -DRUBY_EXPORT -I. -I.ext/include/x86_64-linux -I/tmp/ruby/v3/src/trunk-test/include -I/tmp/ruby/v3/src/trunk-test -I/tmp/ruby/v3/src/trunk-test/enc/unicode/13.0.0
I, [2021-09-27T09:02:13.738308 #10216]  INFO -- : 	CPPFLAGS =   
I, [2021-09-27T09:02:13.738318 #10216]  INFO -- : 	DLDFLAGS = -Wl,--compress-debug-sections=zlib -Wl,-soname,libruby.so.3.1  -fstack-protector-strong  
I, [2021-09-27T09:02:13.738327 #10216]  INFO -- : 	SOLIBS = -lz -lpthread -lrt -lrt -lgmp -ldl -lcrypt -lm 
I, [2021-09-27T09:02:13.738336 #10216]  INFO -- : 	LANG = en_US.UTF-8
I, [2021-09-27T09:02:13.738345 #10216]  INFO -- : 	LC_ALL = 
I, [2021-09-27T09:02:13.738354 #10216]  INFO -- : 	LC_CTYPE = 
I, [2021-09-27T09:02:13.738363 #10216]  INFO -- : 	MFLAGS = -j --jobserver-fds=4,5
I, [2021-09-27T09:02:13.739996 #10216]  INFO -- : gcc (Ubuntu 7.5.0-3ubuntu1~18.04) 7.5.0
I, [2021-09-27T09:02:13.740043 #10216]  INFO -- : Copyright (C) 2017 Free Software Foundation, Inc.
I, [2021-09-27T09:02:13.740056 #10216]  INFO -- : This is free software; see the source for copying conditions.  There is NO
I, [2021-09-27T09:02:13.740068 #10216]  INFO -- : warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE.
I, [2021-09-27T09:02:13.740077 #10216]  INFO -- : 
I, [2021-09-27T09:02:13.767712 #10216]  INFO -- : generating encdb.h
I, [2021-09-27T09:02:13.770210 #10216]  INFO -- : generating enc.mk
I, [2021-09-27T09:02:13.801807 #10216]  INFO -- : encdb.h unchanged
I, [2021-09-27T09:02:13.826236 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/revision.h unchanged
I, [2021-09-27T09:02:13.875639 #10216]  INFO -- : making srcs under enc
I, [2021-09-27T09:02:13.875742 #10216]  INFO -- : making enc
I, [2021-09-27T09:02:13.893382 #10216]  INFO -- : make[1]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:13.893411 #10216]  INFO -- : make[1]: Nothing to be done for 'enc'.
I, [2021-09-27T09:02:13.893423 #10216]  INFO -- : make[1]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:13.908661 #10216]  INFO -- : make[1]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:13.908693 #10216]  INFO -- : make[1]: Nothing to be done for 'srcs'.
I, [2021-09-27T09:02:13.908707 #10216]  INFO -- : make[1]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:13.909332 #10216]  INFO -- : generating transdb.h
I, [2021-09-27T09:02:14.041047 #10216]  INFO -- : transdb.h unchanged
I, [2021-09-27T09:02:14.042150 #10216]  INFO -- : generating makefiles ext/configure-ext.mk
I, [2021-09-27T09:02:14.042254 #10216]  INFO -- : making trans
I, [2021-09-27T09:02:14.061909 #10216]  INFO -- : ext/configure-ext.mk unchanged
I, [2021-09-27T09:02:14.065364 #10216]  INFO -- : make[1]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:14.093347 #10216]  INFO -- : make[1]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:14.093418 #10216]  INFO -- : make[1]: Nothing to be done for '/tmp/ruby/v3/src/trunk-test/enc/trans'.
I, [2021-09-27T09:02:14.093460 #10216]  INFO -- : make[1]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:14.094357 #10216]  INFO -- : making encs
I, [2021-09-27T09:02:14.124628 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/bigdecimal'
I, [2021-09-27T09:02:14.127495 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/digest'
I, [2021-09-27T09:02:14.128440 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/coverage'
I, [2021-09-27T09:02:14.130463 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/date'
I, [2021-09-27T09:02:14.132988 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/bigdecimal'
I, [2021-09-27T09:02:14.133358 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/coverage'
I, [2021-09-27T09:02:14.134509 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/digest'
I, [2021-09-27T09:02:14.136086 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/fiddle'
I, [2021-09-27T09:02:14.136401 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/json'
I, [2021-09-27T09:02:14.136883 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/date'
I, [2021-09-27T09:02:14.137533 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/io/console'
I, [2021-09-27T09:02:14.140834 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/monitor'
I, [2021-09-27T09:02:14.143002 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/io/console'
I, [2021-09-27T09:02:14.143037 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/nkf'
I, [2021-09-27T09:02:14.145882 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/monitor'
I, [2021-09-27T09:02:14.146725 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/objspace'
I, [2021-09-27T09:02:14.147447 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/json'
I, [2021-09-27T09:02:14.149270 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/nkf'
I, [2021-09-27T09:02:14.149599 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/fiddle'
I, [2021-09-27T09:02:14.149659 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/pathname'
I, [2021-09-27T09:02:14.153647 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/pty'
I, [2021-09-27T09:02:14.154271 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/pathname'
I, [2021-09-27T09:02:14.154302 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/objspace'
I, [2021-09-27T09:02:14.157480 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/psych'
I, [2021-09-27T09:02:14.157698 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/rubyvm'
I, [2021-09-27T09:02:14.158000 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/pty'
I, [2021-09-27T09:02:14.163717 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/ripper'
I, [2021-09-27T09:02:14.166008 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/rubyvm'
I, [2021-09-27T09:02:14.170450 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/openssl'
I, [2021-09-27T09:02:14.170861 #10216]  INFO -- : make[1]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:14.170900 #10216]  INFO -- : make[1]: Nothing to be done for 'encs'.
I, [2021-09-27T09:02:14.170940 #10216]  INFO -- : make[1]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:14.172476 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/syslog'
I, [2021-09-27T09:02:14.174114 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/socket'
I, [2021-09-27T09:02:14.175617 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/psych'
I, [2021-09-27T09:02:14.176939 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/ripper'
I, [2021-09-27T09:02:14.178127 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/syslog'
I, [2021-09-27T09:02:14.183093 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/digest/sha2'
I, [2021-09-27T09:02:14.186128 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/socket'
I, [2021-09-27T09:02:14.186913 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/digest/sha2'
I, [2021-09-27T09:02:14.191053 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/openssl'
I, [2021-09-27T09:02:14.215599 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:14.247744 #10216]  INFO -- : make[2]: 'ruby' is up to date.
I, [2021-09-27T09:02:14.247782 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:14.247986 #10216]  INFO -- : make[1]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:14.251044 #10216]  INFO -- : make[1]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:14.251069 #10216]  INFO -- : make[1]: Nothing to be done for 'note'.
I, [2021-09-27T09:02:14.251081 #10216]  INFO -- : make[1]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:14.251364 #10216]  INFO -- : $$$[end] "make all -j8" exit with 0.
I, [2021-09-27T09:02:14.251456 #10216]  INFO -- : $$$[beg] make install -j8
I, [2021-09-27T09:02:14.314483 #10216]  INFO -- : 	BASERUBY = /usr/bin/ruby --disable=gems
I, [2021-09-27T09:02:14.314538 #10216]  INFO -- : 	CC = gcc
I, [2021-09-27T09:02:14.314556 #10216]  INFO -- : 	LD = ld
I, [2021-09-27T09:02:14.314568 #10216]  INFO -- : 	LDSHARED = gcc -shared
I, [2021-09-27T09:02:14.314579 #10216]  INFO -- : 	CFLAGS = -O3 -fno-fast-math -ggdb3 -Wall -Wextra -Werror=deprecated-declarations -Werror=duplicated-cond -Werror=implicit-function-declaration -Werror=implicit-int -Werror=misleading-indentation -Werror=pointer-arith -Werror=write-strings -Wimplicit-fallthrough=0 -Wmissing-noreturn -Wno-cast-function-type -Wno-constant-logical-operand -Wno-long-long -Wno-missing-field-initializers -Wno-overlength-strings -Wno-packed-bitfield-compat -Wno-parentheses-equality -Wno-self-assign -Wno-tautological-compare -Wno-unused-parameter -Wno-unused-value -Wsuggest-attribute=format -Wsuggest-attribute=noreturn -Wunused-variable -Werror=undef -std=gnu99  -fPIC 
I, [2021-09-27T09:02:14.314589 #10216]  INFO -- : 	XCFLAGS = -D_FORTIFY_SOURCE=2 -fstack-protector-strong -fno-strict-overflow -DRUBY_DEVEL=1 -fvisibility=hidden -fexcess-precision=standard -DRUBY_EXPORT -I. -I.ext/include/x86_64-linux -I/tmp/ruby/v3/src/trunk-test/include -I/tmp/ruby/v3/src/trunk-test -I/tmp/ruby/v3/src/trunk-test/enc/unicode/13.0.0
I, [2021-09-27T09:02:14.314605 #10216]  INFO -- : 	CPPFLAGS =   
I, [2021-09-27T09:02:14.314616 #10216]  INFO -- : 	DLDFLAGS = -Wl,--compress-debug-sections=zlib -Wl,-soname,libruby.so.3.1  -fstack-protector-strong  
I, [2021-09-27T09:02:14.314625 #10216]  INFO -- : 	SOLIBS = -lz -lpthread -lrt -lrt -lgmp -ldl -lcrypt -lm 
I, [2021-09-27T09:02:14.314635 #10216]  INFO -- : 	LANG = en_US.UTF-8
I, [2021-09-27T09:02:14.314644 #10216]  INFO -- : 	LC_ALL = 
I, [2021-09-27T09:02:14.314653 #10216]  INFO -- : 	LC_CTYPE = 
I, [2021-09-27T09:02:14.314662 #10216]  INFO -- : 	MFLAGS = -j --jobserver-fds=4,5
I, [2021-09-27T09:02:14.315572 #10216]  INFO -- : gcc (Ubuntu 7.5.0-3ubuntu1~18.04) 7.5.0
I, [2021-09-27T09:02:14.315603 #10216]  INFO -- : Copyright (C) 2017 Free Software Foundation, Inc.
I, [2021-09-27T09:02:14.315621 #10216]  INFO -- : This is free software; see the source for copying conditions.  There is NO
I, [2021-09-27T09:02:14.315639 #10216]  INFO -- : warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE.
I, [2021-09-27T09:02:14.315652 #10216]  INFO -- : 
I, [2021-09-27T09:02:14.316257 #10216]  INFO -- : generating encdb.h
I, [2021-09-27T09:02:14.317428 #10216]  INFO -- : generating enc.mk
I, [2021-09-27T09:02:14.348929 #10216]  INFO -- : encdb.h unchanged
I, [2021-09-27T09:02:14.373106 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/revision.h unchanged
I, [2021-09-27T09:02:14.422445 #10216]  INFO -- : making srcs under enc
I, [2021-09-27T09:02:14.422551 #10216]  INFO -- : making enc
I, [2021-09-27T09:02:14.440270 #10216]  INFO -- : make[1]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:14.440301 #10216]  INFO -- : make[1]: Nothing to be done for 'enc'.
I, [2021-09-27T09:02:14.440319 #10216]  INFO -- : make[1]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:14.455332 #10216]  INFO -- : make[1]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:14.455357 #10216]  INFO -- : make[1]: Nothing to be done for 'srcs'.
I, [2021-09-27T09:02:14.455370 #10216]  INFO -- : make[1]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:14.455977 #10216]  INFO -- : generating transdb.h
I, [2021-09-27T09:02:14.585500 #10216]  INFO -- : transdb.h unchanged
I, [2021-09-27T09:02:14.586642 #10216]  INFO -- : generating makefiles ext/configure-ext.mk
I, [2021-09-27T09:02:14.586744 #10216]  INFO -- : making trans
I, [2021-09-27T09:02:14.606391 #10216]  INFO -- : ext/configure-ext.mk unchanged
I, [2021-09-27T09:02:14.609894 #10216]  INFO -- : make[1]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:14.637879 #10216]  INFO -- : make[1]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:14.637950 #10216]  INFO -- : make[1]: Nothing to be done for '/tmp/ruby/v3/src/trunk-test/enc/trans'.
I, [2021-09-27T09:02:14.637992 #10216]  INFO -- : make[1]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:14.638908 #10216]  INFO -- : making encs
I, [2021-09-27T09:02:14.670375 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/bigdecimal'
I, [2021-09-27T09:02:14.672475 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/coverage'
I, [2021-09-27T09:02:14.673160 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/date'
I, [2021-09-27T09:02:14.673690 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/digest'
I, [2021-09-27T09:02:14.677577 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/bigdecimal'
I, [2021-09-27T09:02:14.678681 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/coverage'
I, [2021-09-27T09:02:14.679884 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/date'
I, [2021-09-27T09:02:14.680322 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/digest'
I, [2021-09-27T09:02:14.681676 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/json'
I, [2021-09-27T09:02:14.681826 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/fiddle'
I, [2021-09-27T09:02:14.682021 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/io/console'
I, [2021-09-27T09:02:14.686292 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/nkf'
I, [2021-09-27T09:02:14.686352 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/monitor'
I, [2021-09-27T09:02:14.687605 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/io/console'
I, [2021-09-27T09:02:14.690909 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/nkf'
I, [2021-09-27T09:02:14.691229 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/monitor'
I, [2021-09-27T09:02:14.691667 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/json'
I, [2021-09-27T09:02:14.693632 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/pathname'
I, [2021-09-27T09:02:14.694322 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/fiddle'
I, [2021-09-27T09:02:14.694518 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/objspace'
I, [2021-09-27T09:02:14.697549 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/pty'
I, [2021-09-27T09:02:14.699179 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/pathname'
I, [2021-09-27T09:02:14.700947 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/objspace'
I, [2021-09-27T09:02:14.701881 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/psych'
I, [2021-09-27T09:02:14.702186 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/pty'
I, [2021-09-27T09:02:14.703642 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/rubyvm'
I, [2021-09-27T09:02:14.707701 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/ripper'
I, [2021-09-27T09:02:14.712075 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/rubyvm'
I, [2021-09-27T09:02:14.714566 #10216]  INFO -- : make[1]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:14.714607 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/ripper'
I, [2021-09-27T09:02:14.714636 #10216]  INFO -- : make[1]: Nothing to be done for 'encs'.
I, [2021-09-27T09:02:14.714675 #10216]  INFO -- : make[1]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:14.715514 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/openssl'
I, [2021-09-27T09:02:14.715693 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/syslog'
I, [2021-09-27T09:02:14.719208 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/socket'
I, [2021-09-27T09:02:14.723615 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/syslog'
I, [2021-09-27T09:02:14.727498 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/digest/sha2'
I, [2021-09-27T09:02:14.730227 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/digest/sha2'
I, [2021-09-27T09:02:14.731652 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/psych'
I, [2021-09-27T09:02:14.732207 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/socket'
I, [2021-09-27T09:02:14.737832 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/openssl'
I, [2021-09-27T09:02:14.762433 #10216]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:14.794570 #10216]  INFO -- : make[2]: 'ruby' is up to date.
I, [2021-09-27T09:02:14.794626 #10216]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:14.794956 #10216]  INFO -- : make[1]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:14.798018 #10216]  INFO -- : make[1]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:14.798044 #10216]  INFO -- : make[1]: Nothing to be done for 'note'.
I, [2021-09-27T09:02:14.798056 #10216]  INFO -- : make[1]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-27T09:02:14.798334 #10216]  INFO -- : ./miniruby -I/tmp/ruby/v3/src/trunk-test/lib -I. -I.ext/common  /tmp/ruby/v3/src/trunk-test/tool/runruby.rb --extout=.ext  -- --disable-gems -r./x86_64-linux-fake /tmp/ruby/v3/src/trunk-test/tool/rbinstall.rb --make="make" --dest-dir="" --extout=".ext" --mflags="-j --jobserver-fds=4,5" --make-flags=" -j --jobserver-fds=4,5" --data-mode=0644 --prog-mode=0755 --installed-list .installed.list --mantype="doc" --gnumake --exclude=doc
I, [2021-09-27T09:02:14.890143 #10216]  INFO -- : installing binary commands:         /tmp/ruby/v3/install/trunk-test/bin
I, [2021-09-27T09:02:14.890378 #10216]  INFO -- : installing base libraries:          /tmp/ruby/v3/install/trunk-test/lib
I, [2021-09-27T09:02:14.896616 #10216]  INFO -- : installing arch files:              /tmp/ruby/v3/install/trunk-test/lib/ruby/3.1.0/x86_64-linux
I, [2021-09-27T09:02:14.896703 #10216]  INFO -- : installing pkgconfig data:          /tmp/ruby/v3/install/trunk-test/lib/pkgconfig
I, [2021-09-27T09:02:14.896732 #10216]  INFO -- : installing extension objects:       /tmp/ruby/v3/install/trunk-test/lib/ruby/3.1.0/x86_64-linux
I, [2021-09-27T09:02:14.912008 #10216]  INFO -- : installing extension objects:       /tmp/ruby/v3/install/trunk-test/lib/ruby/site_ruby/3.1.0/x86_64-linux
I, [2021-09-27T09:02:14.912037 #10216]  INFO -- : installing extension objects:       /tmp/ruby/v3/install/trunk-test/lib/ruby/vendor_ruby/3.1.0/x86_64-linux
I, [2021-09-27T09:02:14.912111 #10216]  INFO -- : installing extension headers:       /tmp/ruby/v3/install/trunk-test/include/ruby-3.1.0/x86_64-linux
I, [2021-09-27T09:02:14.913119 #10216]  INFO -- : installing extension scripts:       /tmp/ruby/v3/install/trunk-test/lib/ruby/3.1.0
I, [2021-09-27T09:02:14.918316 #10216]  INFO -- : installing extension scripts:       /tmp/ruby/v3/install/trunk-test/lib/ruby/site_ruby/3.1.0
I, [2021-09-27T09:02:14.918342 #10216]  INFO -- : installing extension scripts:       /tmp/ruby/v3/install/trunk-test/lib/ruby/vendor_ruby/3.1.0
I, [2021-09-27T09:02:14.918354 #10216]  INFO -- : installing extension headers:       /tmp/ruby/v3/install/trunk-test/include/ruby-3.1.0/ruby
I, [2021-09-27T09:02:14.918432 #10216]  INFO -- : installing command scripts:         /tmp/ruby/v3/install/trunk-test/bin
I, [2021-09-27T09:02:14.918555 #10216]  INFO -- : installing library scripts:         /tmp/ruby/v3/install/trunk-test/lib/ruby/3.1.0
I, [2021-09-27T09:02:14.969050 #10216]  INFO -- : installing common headers:          /tmp/ruby/v3/install/trunk-test/include/ruby-3.1.0
I, [2021-09-27T09:02:14.978199 #10216]  INFO -- : installing manpages:                /tmp/ruby/v3/install/trunk-test/share/man/man1
I, [2021-09-27T09:02:14.978464 #10216]  INFO -- : installing default gems from lib:   /tmp/ruby/v3/install/trunk-test/lib/ruby/gems/3.1.0
I, [2021-09-27T09:02:14.999256 #10216]  INFO -- :                                     abbrev 0.1.0
I, [2021-09-27T09:02:15.002772 #10216]  INFO -- :                                     base64 0.1.0
I, [2021-09-27T09:02:15.016112 #10216]  INFO -- :                                     benchmark 0.1.1
I, [2021-09-27T09:02:15.029076 #10216]  INFO -- :                                     bundler 2.3.0.dev
I, [2021-09-27T09:02:15.043390 #10216]  INFO -- :                                     cgi 0.2.0
I, [2021-09-27T09:02:15.059933 #10216]  INFO -- :                                     csv 3.2.0
I, [2021-09-27T09:02:15.072983 #10216]  INFO -- :                                     debug 0.1.0
I, [2021-09-27T09:02:15.085943 #10216]  INFO -- :                                     delegate 0.2.0
I, [2021-09-27T09:02:15.098918 #10216]  INFO -- :                                     did_you_mean 1.6.0.pre.alpha
I, [2021-09-27T09:02:15.115846 #10216]  INFO -- :                                     drb 2.0.4
I, [2021-09-27T09:02:15.128809 #10216]  INFO -- :                                     english 0.7.1
I, [2021-09-27T09:02:15.141771 #10216]  INFO -- :                                     erb 2.2.3
I, [2021-09-27T09:02:15.155119 #10216]  INFO -- :                                     error_highlight 0.2.0
I, [2021-09-27T09:02:15.168328 #10216]  INFO -- :                                     fileutils 1.5.0
I, [2021-09-27T09:02:15.184918 #10216]  INFO -- :                                     find 0.1.0
I, [2021-09-27T09:02:15.197884 #10216]  INFO -- :                                     forwardable 1.3.2
I, [2021-09-27T09:02:15.210757 #10216]  INFO -- :                                     getoptlong 0.1.1
I, [2021-09-27T09:02:15.223670 #10216]  INFO -- :                                     ipaddr 1.2.2
I, [2021-09-27T09:02:15.240489 #10216]  INFO -- :                                     irb 1.3.8.pre.9
I, [2021-09-27T09:02:15.253992 #10216]  INFO -- :                                     logger 1.4.3
I, [2021-09-27T09:02:15.266937 #10216]  INFO -- :                                     mutex_m 0.1.1
I, [2021-09-27T09:02:15.279978 #10216]  INFO -- :                                     net-http 0.1.1
I, [2021-09-27T09:02:15.293262 #10216]  INFO -- :                                     net-protocol 0.1.1
I, [2021-09-27T09:02:15.309910 #10216]  INFO -- :                                     observer 0.1.1
I, [2021-09-27T09:02:15.322878 #10216]  INFO -- :                                     open-uri 0.1.0
I, [2021-09-27T09:02:15.335873 #10216]  INFO -- :                                     open3 0.1.1
I, [2021-09-27T09:02:15.348930 #10216]  INFO -- :                                     optparse 0.1.1
I, [2021-09-27T09:02:15.365835 #10216]  INFO -- :                                     ostruct 0.4.0
I, [2021-09-27T09:02:15.378828 #10216]  INFO -- :                                     pp 0.2.0
I, [2021-09-27T09:02:15.391754 #10216]  INFO -- :                                     prettyprint 0.1.0
I, [2021-09-27T09:02:15.404791 #10216]  INFO -- :                                     pstore 0.1.1
I, [2021-09-27T09:02:15.417951 #10216]  INFO -- :                                     racc 1.5.2
I, [2021-09-27T09:02:15.434923 #10216]  INFO -- :                                     rdoc 6.3.2
I, [2021-09-27T09:02:15.448909 #10216]  INFO -- :                                     readline 0.0.2
I, [2021-09-27T09:02:15.461716 #10216]  INFO -- :                                     reline 0.2.8.pre.9
I, [2021-09-27T09:02:15.474522 #10216]  INFO -- :                                     resolv 0.2.1
I, [2021-09-27T09:02:15.491132 #10216]  INFO -- :                                     resolv-replace 0.1.0
I, [2021-09-27T09:02:15.503991 #10216]  INFO -- :                                     rinda 0.1.0
I, [2021-09-27T09:02:15.516828 #10216]  INFO -- :                                     ruby2_keywords 0.0.5
I, [2021-09-27T09:02:15.529663 #10216]  INFO -- :                                     securerandom 0.1.0
I, [2021-09-27T09:02:15.542699 #10216]  INFO -- :                                     set 1.0.1
I, [2021-09-27T09:02:15.559164 #10216]  INFO -- :                                     shellwords 0.1.0
I, [2021-09-27T09:02:15.571998 #10216]  INFO -- :                                     singleton 0.1.1
I, [2021-09-27T09:02:15.584723 #10216]  INFO -- :                                     tempfile 0.1.1
I, [2021-09-27T09:02:15.597526 #10216]  INFO -- :                                     time 0.1.0
I, [2021-09-27T09:02:15.610603 #10216]  INFO -- :                                     timeout 0.1.1
I, [2021-09-27T09:02:15.626976 #10216]  INFO -- :                                     tmpdir 0.1.2
I, [2021-09-27T09:02:15.639825 #10216]  INFO -- :                                     tsort 0.1.0
I, [2021-09-27T09:02:15.652610 #10216]  INFO -- :                                     un 0.1.0
I, [2021-09-27T09:02:15.665363 #10216]  INFO -- :                                     uri 0.10.1
I, [2021-09-27T09:02:15.682117 #10216]  INFO -- :                                     weakref 0.1.1
I, [2021-09-27T09:02:15.694959 #10216]  INFO -- :                                     yaml 0.1.1
I, [2021-09-27T09:02:15.707497 #10216]  INFO -- : installing default gems from ext:   /tmp/ruby/v3/install/trunk-test/lib/ruby/gems/3.1.0
I, [2021-09-27T09:02:15.717422 #10216]  INFO -- :                                     bigdecimal 3.0.0
I, [2021-09-27T09:02:15.730846 #10216]  INFO -- :                                     date 3.1.1
I, [2021-09-27T09:02:15.747644 #10216]  INFO -- :                                     digest 3.0.1.pre
I, [2021-09-27T09:02:15.760313 #10216]  INFO -- :                                     etc 1.2.0
I, [2021-09-27T09:02:15.772969 #10216]  INFO -- :                                     fcntl 1.0.0
I, [2021-09-27T09:02:15.785507 #10216]  INFO -- :                                     fiddle 1.1.0
I, [2021-09-27T09:02:15.798332 #10216]  INFO -- :                                     io-console 0.5.9
I, [2021-09-27T09:02:15.811189 #10216]  INFO -- :                                     io-nonblock 0.1.0
I, [2021-09-27T09:02:15.824229 #10216]  INFO -- :                                     io-wait 0.1.1
I, [2021-09-27T09:02:15.840648 #10216]  INFO -- :                                     json 2.5.1
I, [2021-09-27T09:02:15.853532 #10216]  INFO -- :                                     nkf 0.1.0
I, [2021-09-27T09:02:15.866303 #10216]  INFO -- :                                     openssl 2.2.0
I, [2021-09-27T09:02:15.879074 #10216]  INFO -- :                                     pathname 0.1.0
I, [2021-09-27T09:02:15.891924 #10216]  INFO -- :                                     psych 4.0.1
I, [2021-09-27T09:02:15.908189 #10216]  INFO -- :                                     readline-ext 0.1.2
I, [2021-09-27T09:02:15.921326 #10216]  INFO -- :                                     stringio 3.0.0
I, [2021-09-27T09:02:15.934232 #10216]  INFO -- :                                     strscan 3.0.0
I, [2021-09-27T09:02:15.947274 #10216]  INFO -- :                                     syslog 0.1.0
I, [2021-09-27T09:02:15.963727 #10216]  INFO -- :                                     zlib 1.1.0
I, [2021-09-27T09:02:15.976535 #10216]  INFO -- : installing bundled gems:            /tmp/ruby/v3/install/trunk-test/lib/ruby/gems/3.1.0
I, [2021-09-27T09:02:15.977286 #10216]  INFO -- :                                     minitest 5.14.4
I, [2021-09-27T09:02:15.992869 #10216]  INFO -- :                                     power_assert 2.0.1
I, [2021-09-27T09:02:16.007251 #10216]  INFO -- :                                     rake 13.0.6
I, [2021-09-27T09:02:16.028956 #10216]  INFO -- :                                     test-unit 3.4.7
I, [2021-09-27T09:02:16.047273 #10216]  INFO -- :                                     rexml 3.2.5
I, [2021-09-27T09:02:16.065763 #10216]  INFO -- :                                     rss 0.2.9
I, [2021-09-27T09:02:16.085521 #10216]  INFO -- :                                     net-ftp 0.1.3
I, [2021-09-27T09:02:16.099779 #10216]  INFO -- :                                     net-imap 0.2.2
I, [2021-09-27T09:02:16.117986 #10216]  INFO -- :                                     net-pop 0.1.1
I, [2021-09-27T09:02:16.131846 #10216]  INFO -- :                                     net-smtp 0.2.1
I, [2021-09-27T09:02:16.145687 #10216]  INFO -- :                                     matrix 0.4.2
I, [2021-09-27T09:02:16.159396 #10216]  INFO -- :                                     prime 0.1.2
I, [2021-09-27T09:02:16.177092 #10216]  INFO -- :                                     rbs 1.6.2
I, [2021-09-27T09:02:16.213963 #10216]  INFO -- :                                     typeprof 0.15.3
I, [2021-09-27T09:02:16.250768 #10216]  INFO -- : installing bundled gem cache:       /tmp/ruby/v3/install/trunk-test/lib/ruby/gems/3.1.0/cache
I, [2021-09-27T09:02:16.254570 #10216]  INFO -- : $$$[end] "make install -j8" exit with 0.
I, [2021-09-27T09:02:16.254694 #10216]  INFO -- : $$$[beg] make yes-btest TESTS='-j8'
I, [2021-09-27T09:02:16.321914 #10216]  INFO -- : 2021-09-27 09:02:16 +0900
I, [2021-09-27T09:02:16.321962 #10216]  INFO -- : Driver is ruby 2.5.1p57 (2018-03-29 revision 63029) [x86_64-linux-gnu]
I, [2021-09-27T09:02:16.326655 #10216]  INFO -- : Target is ruby 3.1.0dev (2021-09-26T18:23:48Z master 00cfafc0f5) [x86_64-linux]
I, [2021-09-27T09:02:16.326694 #10216]  INFO -- : 
I, [2021-09-27T09:02:35.797885 #10216]  INFO -- : $$$[end] "make yes-btest TESTS='-j8'" exit with 0.
I, [2021-09-27T09:02:35.798265 #10216]  INFO -- : $$$[beg] make yes-test-basic TESTS='-j8'
I, [2021-09-27T09:02:35.866490 #10216]  INFO -- : 	BASERUBY = /usr/bin/ruby --disable=gems
I, [2021-09-27T09:02:35.866527 #10216]  INFO -- : 	CC = gcc
I, [2021-09-27T09:02:35.866541 #10216]  INFO -- : 	LD = ld
I, [2021-09-27T09:02:35.866551 #10216]  INFO -- : 	LDSHARED = gcc -shared
I, [2021-09-27T09:02:35.866562 #10216]  INFO -- : 	CFLAGS = -O3 -fno-fast-math -ggdb3 -Wall -Wextra -Werror=deprecated-declarations -Werror=duplicated-cond -Werror=implicit-function-declaration -Werror=implicit-int -Werror=misleading-indentation -Werror=pointer-arith -Werror=write-strings -Wimplicit-fallthrough=0 -Wmissing-noreturn -Wno-cast-function-type -Wno-constant-logical-operand -Wno-long-long -Wno-missing-field-initializers -Wno-overlength-strings -Wno-packed-bitfield-compat -Wno-parentheses-equality -Wno-self-assign -Wno-tautological-compare -Wno-unused-parameter -Wno-unused-value -Wsuggest-attribute=format -Wsuggest-attribute=noreturn -Wunused-variable -Werror=undef -std=gnu99  -fPIC 
I, [2021-09-27T09:02:35.866572 #10216]  INFO -- : 	XCFLAGS = -D_FORTIFY_SOURCE=2 -fstack-protector-strong -fno-strict-overflow -DRUBY_DEVEL=1 -fvisibility=hidden -fexcess-precision=standard -DRUBY_EXPORT -I. -I.ext/include/x86_64-linux -I/tmp/ruby/v3/src/trunk-test/include -I/tmp/ruby/v3/src/trunk-test -I/tmp/ruby/v3/src/trunk-test/enc/unicode/13.0.0
I, [2021-09-27T09:02:35.866592 #10216]  INFO -- : 	CPPFLAGS =   
I, [2021-09-27T09:02:35.866602 #10216]  INFO -- : 	DLDFLAGS = -Wl,--compress-debug-sections=zlib -Wl,-soname,libruby.so.3.1  -fstack-protector-strong  
I, [2021-09-27T09:02:35.866611 #10216]  INFO -- : 	SOLIBS = -lz -lpthread -lrt -lrt -lgmp -ldl -lcrypt -lm 
I, [2021-09-27T09:02:35.866620 #10216]  INFO -- : 	LANG = en_US.UTF-8
I, [2021-09-27T09:02:35.866628 #10216]  INFO -- : 	LC_ALL = 
I, [2021-09-27T09:02:35.866637 #10216]  INFO -- : 	LC_CTYPE = 
I, [2021-09-27T09:02:35.866646 #10216]  INFO -- : 	MFLAGS = 
I, [2021-09-27T09:02:35.867187 #10216]  INFO -- : gcc (Ubuntu 7.5.0-3ubuntu1~18.04) 7.5.0
I, [2021-09-27T09:02:35.867212 #10216]  INFO -- : Copyright (C) 2017 Free Software Foundation, Inc.
I, [2021-09-27T09:02:35.867225 #10216]  INFO -- : This is free software; see the source for copying conditions.  There is NO
I, [2021-09-27T09:02:35.867235 #10216]  INFO -- : warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE.
I, [2021-09-27T09:02:35.867244 #10216]  INFO -- : 
I, [2021-09-27T09:02:35.925242 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:assignment ....................................................................................................................................................................................................................................................................................................................................................................................OK 372
I, [2021-09-27T09:02:35.925296 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:condition ..OK 2
I, [2021-09-27T09:02:35.925310 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:if/unless ...OK 3
I, [2021-09-27T09:02:35.925328 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:case .....OK 5
I, [2021-09-27T09:02:35.925483 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:while/until ........OK 8
I, [2021-09-27T09:02:35.926087 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:exception ..........OK 10
I, [2021-09-27T09:02:35.926362 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:array .......................................OK 39
I, [2021-09-27T09:02:35.926528 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:hash ...........................OK 27
I, [2021-09-27T09:02:35.927506 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:iterator ...........................................................................................................OK 107
I, [2021-09-27T09:02:35.927975 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:float ................................................................................OK 80
I, [2021-09-27T09:02:35.929446 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:bignum ...............................OK 31
I, [2021-09-27T09:02:35.930670 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:string & char ..............................................................OK 62
I, [2021-09-27T09:02:35.930728 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:assignment ..........OK 10
I, [2021-09-27T09:02:35.930779 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:call ......OK 6
I, [2021-09-27T09:02:35.930872 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:proc .........OK 9
I, [2021-09-27T09:02:36.031314 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:signal ..OK 2
I, [2021-09-27T09:02:36.033396 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:eval ...........................OK 27
I, [2021-09-27T09:02:36.087171 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:system ........OK 8
I, [2021-09-27T09:02:36.087226 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:const .....OK 5
I, [2021-09-27T09:02:36.087293 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:clone .....OK 5
I, [2021-09-27T09:02:36.087579 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:marshal ....OK 4
I, [2021-09-27T09:02:36.087607 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:pack ....OK 4
I, [2021-09-27T09:02:36.087627 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:math ..OK 2
I, [2021-09-27T09:02:36.087694 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:struct ......OK 6
I, [2021-09-27T09:02:36.087828 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:variable ............OK 12
I, [2021-09-27T09:02:36.087856 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:trace ...OK 3
I, [2021-09-27T09:02:36.087912 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:defined? ............OK 12
I, [2021-09-27T09:02:36.087974 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:alias ......OK 6
I, [2021-09-27T09:02:36.089587 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:path .......................OK 23
I, [2021-09-27T09:02:36.142197 #10216]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:gc ....OK 4
I, [2021-09-27T09:02:36.144523 #10216]  INFO -- : 
I, [2021-09-27T09:02:36.144564 #10216]  INFO -- : test succeeded
I, [2021-09-27T09:02:36.145461 #10216]  INFO -- : $$$[end] "make yes-test-basic TESTS='-j8'" exit with 0.
I, [2021-09-27T09:02:36.145563 #10216]  INFO -- : $$$[beg] make yes-test-all TESTS='-j8'
I, [2021-09-27T09:02:36.270253 #10216]  INFO -- : Run options: 
I, [2021-09-27T09:02:36.270307 #10216]  INFO -- :   --seed=95797
I, [2021-09-27T09:02:36.270325 #10216]  INFO -- :   "--ruby=./miniruby -I/tmp/ruby/v3/src/trunk-test/lib -I. -I.ext/common  /tmp/ruby/v3/src/trunk-test/tool/runruby.rb --extout=.ext  -- --disable-gems"
I, [2021-09-27T09:02:36.270337 #10216]  INFO -- :   --excludes-dir=/tmp/ruby/v3/src/trunk-test/test/excludes
I, [2021-09-27T09:02:36.270346 #10216]  INFO -- :   --name=!/memory_leak/
I, [2021-09-27T09:02:36.270778 #10216]  INFO -- :   -j8
I, [2021-09-27T09:02:36.270811 #10216]  INFO -- : 
I, [2021-09-27T09:02:36.270833 #10216]  INFO -- : # Running tests:
I, [2021-09-27T09:02:36.270852 #10216]  INFO -- : 
I, [2021-09-27T09:02:39.386482 #10216]  INFO -- : Leaked file descriptor: DRbTests::TestDRbSSLCore#test_10_yield_undumped: 8 #<File::Stat dev=0x6, ino=11, mode=020666, nlink=1, uid=0, gid=0, rdev=0x109, size=0, blksize=4096, blocks=0, atime=2021-06-07 20:27:06.336000076 +0900, mtime=2021-06-07 20:27:06.336000076 +0900, ctime=2021-06-07 20:27:06.336000076 +0900>
I, [2021-09-27T09:02:39.386840 #10216]  INFO -- : Leaked file descriptor: DRbTests::TestDRbSSLCore#test_10_yield_undumped: 9 #<File::Stat dev=0x6, ino=10, mode=020666, nlink=1, uid=0, gid=0, rdev=0x108, size=0, blksize=4096, blocks=0, atime=2021-06-07 20:27:06.336000076 +0900, mtime=2021-06-07 20:27:06.336000076 +0900, ctime=2021-06-07 20:27:06.336000076 +0900>
I, [2021-09-27T09:02:39.428997 #10216]  INFO -- : COMMAND   PID USER   FD   TYPE DEVICE SIZE/OFF NODE NAME
I, [2021-09-27T09:02:39.429083 #10216]  INFO -- : ruby    14518  ko1    8r   CHR    1,9      0t0   11 /dev/urandom
I, [2021-09-27T09:02:39.429116 #10216]  INFO -- : ruby    14518  ko1    9r   CHR    1,8      0t0   10 /dev/random
I, [2021-09-27T09:02:45.481158 #10216]  INFO -- : Leaked file descriptor: DRbTests::TestDRbTCP#test_immediate_close: 11 #<File::Stat dev=0x9, ino=2832492207, mode=0140777, nlink=1, uid=1000, gid=1000, rdev=0x0, size=0, blksize=4096, blocks=0, atime=1970-01-01 09:00:00 +0900, mtime=1970-01-01 09:00:00 +0900, ctime=1970-01-01 09:00:00 +0900>
I, [2021-09-27T09:02:45.481237 #10216]  INFO -- : Leaked file descriptor: DRbTests::TestDRbTCP#test_immediate_close: 12 : #<IO:fd 12>
I, [2021-09-27T09:02:48.428361 #10216]  INFO -- : Leaked file descriptor: TestNetHTTPS#test_session_reuse_but_expire: 11 #<File::Stat dev=0x6, ino=11, mode=020666, nlink=1, uid=0, gid=0, rdev=0x109, size=0, blksize=4096, blocks=0, atime=2021-06-07 20:27:06.336000076 +0900, mtime=2021-06-07 20:27:06.336000076 +0900, ctime=2021-06-07 20:27:06.336000076 +0900>
I, [2021-09-27T09:02:48.428434 #10216]  INFO -- : Leaked file descriptor: TestNetHTTPS#test_session_reuse_but_expire: 12 #<File::Stat dev=0x6, ino=10, mode=020666, nlink=1, uid=0, gid=0, rdev=0x108, size=0, blksize=4096, blocks=0, atime=2021-06-07 20:27:06.336000076 +0900, mtime=2021-06-07 20:27:06.336000076 +0900, ctime=2021-06-07 20:27:06.336000076 +0900>
I, [2021-09-27T09:02:48.484856 #10216]  INFO -- : COMMAND   PID USER   FD   TYPE DEVICE SIZE/OFF NODE NAME
I, [2021-09-27T09:02:48.484929 #10216]  INFO -- : ruby    14517  ko1   11r   CHR    1,9      0t0   11 /dev/urandom
I, [2021-09-27T09:02:48.484953 #10216]  INFO -- : ruby    14517  ko1   12r   CHR    1,8      0t0   10 /dev/random
I, [2021-09-27T09:02:49.194695 #10216]  INFO -- : Leaked file descriptor: OpenSSL::TestASN1#test_decode_x509_certificate: 9 #<File::Stat dev=0x6, ino=11, mode=020666, nlink=1, uid=0, gid=0, rdev=0x109, size=0, blksize=4096, blocks=0, atime=2021-06-07 20:27:06.336000076 +0900, mtime=2021-06-07 20:27:06.336000076 +0900, ctime=2021-06-07 20:27:06.336000076 +0900>
I, [2021-09-27T09:02:49.194853 #10216]  INFO -- : Leaked file descriptor: OpenSSL::TestASN1#test_decode_x509_certificate: 10 #<File::Stat dev=0x6, ino=10, mode=020666, nlink=1, uid=0, gid=0, rdev=0x108, size=0, blksize=4096, blocks=0, atime=2021-06-07 20:27:06.336000076 +0900, mtime=2021-06-07 20:27:06.336000076 +0900, ctime=2021-06-07 20:27:06.336000076 +0900>
I, [2021-09-27T09:02:49.248643 #10216]  INFO -- : COMMAND   PID USER   FD   TYPE DEVICE SIZE/OFF NODE NAME
I, [2021-09-27T09:02:49.248713 #10216]  INFO -- : ruby    14521  ko1    9r   CHR    1,9      0t0   11 /dev/urandom
I, [2021-09-27T09:02:49.248733 #10216]  INFO -- : ruby    14521  ko1   10r   CHR    1,8      0t0   10 /dev/random
I, [2021-09-27T09:02:49.977876 #10216]  INFO -- : Leaked file descriptor: OpenSSL::TestPKey#test_s_generate_key: 9 #<File::Stat dev=0x6, ino=11, mode=020666, nlink=1, uid=0, gid=0, rdev=0x109, size=0, blksize=4096, blocks=0, atime=2021-06-07 20:27:06.336000076 +0900, mtime=2021-06-07 20:27:06.336000076 +0900, ctime=2021-06-07 20:27:06.336000076 +0900>
I, [2021-09-27T09:02:49.979506 #10216]  INFO -- : Leaked file descriptor: OpenSSL::TestPKey#test_s_generate_key: 10 #<File::Stat dev=0x6, ino=10, mode=020666, nlink=1, uid=0, gid=0, rdev=0x108, size=0, blksize=4096, blocks=0, atime=2021-06-07 20:27:06.336000076 +0900, mtime=2021-06-07 20:27:06.336000076 +0900, ctime=2021-06-07 20:27:06.336000076 +0900>
I, [2021-09-27T09:02:50.019040 #10216]  INFO -- : COMMAND   PID USER   FD   TYPE DEVICE SIZE/OFF NODE NAME
I, [2021-09-27T09:02:50.019109 #10216]  INFO -- : ruby    14524  ko1    9r   CHR    1,9      0t0   11 /dev/urandom
I, [2021-09-27T09:02:50.019127 #10216]  INFO -- : ruby    14524  ko1   10r   CHR    1,8      0t0   10 /dev/random
I, [2021-09-27T09:02:50.145856 #10216]  INFO -- : Leaked file descriptor: OpenSSL::TestPKeyRSA#test_sign_verify_raw_legacy: 9 #<File::Stat dev=0x6, ino=11, mode=020666, nlink=1, uid=0, gid=0, rdev=0x109, size=0, blksize=4096, blocks=0, atime=2021-06-07 20:27:06.336000076 +0900, mtime=2021-06-07 20:27:06.336000076 +0900, ctime=2021-06-07 20:27:06.336000076 +0900>
I, [2021-09-27T09:02:50.146033 #10216]  INFO -- : Leaked file descriptor: OpenSSL::TestPKeyRSA#test_sign_verify_raw_legacy: 10 #<File::Stat dev=0x6, ino=10, mode=020666, nlink=1, uid=0, gid=0, rdev=0x108, size=0, blksize=4096, blocks=0, atime=2021-06-07 20:27:06.336000076 +0900, mtime=2021-06-07 20:27:06.336000076 +0900, ctime=2021-06-07 20:27:06.336000076 +0900>
I, [2021-09-27T09:02:50.182779 #10216]  INFO -- : COMMAND   PID USER   FD   TYPE DEVICE SIZE/OFF NODE NAME
I, [2021-09-27T09:02:50.182834 #10216]  INFO -- : ruby    14519  ko1    9r   CHR    1,9      0t0   11 /dev/urandom
I, [2021-09-27T09:02:50.182848 #10216]  INFO -- : ruby    14519  ko1   10r   CHR    1,8      0t0   10 /dev/random
I, [2021-09-27T09:03:32.426376 #10216]  INFO -- : Leaked file descriptor: TestBundledCA#test_accessing_www_rubygems: 9 #<File::Stat dev=0x6, ino=11, mode=020666, nlink=1, uid=0, gid=0, rdev=0x109, size=0, blksize=4096, blocks=0, atime=2021-06-07 20:27:06.336000076 +0900, mtime=2021-06-07 20:27:06.336000076 +0900, ctime=2021-06-07 20:27:06.336000076 +0900>
I, [2021-09-27T09:03:32.426533 #10216]  INFO -- : Leaked file descriptor: TestBundledCA#test_accessing_www_rubygems: 10 #<File::Stat dev=0x6, ino=10, mode=020666, nlink=1, uid=0, gid=0, rdev=0x108, size=0, blksize=4096, blocks=0, atime=2021-06-07 20:27:06.336000076 +0900, mtime=2021-06-07 20:27:06.336000076 +0900, ctime=2021-06-07 20:27:06.336000076 +0900>
I, [2021-09-27T09:03:32.468952 #10216]  INFO -- : COMMAND   PID USER   FD   TYPE DEVICE SIZE/OFF NODE NAME
I, [2021-09-27T09:03:32.469016 #10216]  INFO -- : ruby    14522  ko1    9r   CHR    1,9      0t0   11 /dev/urandom
I, [2021-09-27T09:03:32.469036 #10216]  INFO -- : ruby    14522  ko1   10r   CHR    1,8      0t0   10 /dev/random
I, [2021-09-27T09:03:33.755782 #10216]  INFO -- : Leaked file descriptor: TestGemCommandsBuildCommand#test_build_signed_gem_with_cert_expiration_length_days: 8 #<File::Stat dev=0x6, ino=11, mode=020666, nlink=1, uid=0, gid=0, rdev=0x109, size=0, blksize=4096, blocks=0, atime=2021-06-07 20:27:06.336000076 +0900, mtime=2021-06-07 20:27:06.336000076 +0900, ctime=2021-06-07 20:27:06.336000076 +0900>
I, [2021-09-27T09:03:33.755982 #10216]  INFO -- : Leaked file descriptor: TestGemCommandsBuildCommand#test_build_signed_gem_with_cert_expiration_length_days: 9 #<File::Stat dev=0x6, ino=10, mode=020666, nlink=1, uid=0, gid=0, rdev=0x108, size=0, blksize=4096, blocks=0, atime=2021-06-07 20:27:06.336000076 +0900, mtime=2021-06-07 20:27:06.336000076 +0900, ctime=2021-06-07 20:27:06.336000076 +0900>
I, [2021-09-27T09:03:33.770248 #10216]  INFO -- : Leaked file descriptor: TestGemCommandsCertCommand#test_execute_sign_default: 7 #<File::Stat dev=0x6, ino=11, mode=020666, nlink=1, uid=0, gid=0, rdev=0x109, size=0, blksize=4096, blocks=0, atime=2021-06-07 20:27:06.336000076 +0900, mtime=2021-06-07 20:27:06.336000076 +0900, ctime=2021-06-07 20:27:06.336000076 +0900>
I, [2021-09-27T09:03:33.772292 #10216]  INFO -- : Leaked file descriptor: TestGemCommandsCertCommand#test_execute_sign_default: 8 #<File::Stat dev=0x6, ino=10, mode=020666, nlink=1, uid=0, gid=0, rdev=0x108, size=0, blksize=4096, blocks=0, atime=2021-06-07 20:27:06.336000076 +0900, mtime=2021-06-07 20:27:06.336000076 +0900, ctime=2021-06-07 20:27:06.336000076 +0900>
I, [2021-09-27T09:03:33.803516 #10216]  INFO -- : COMMAND   PID USER   FD   TYPE DEVICE SIZE/OFF NODE NAME
I, [2021-09-27T09:03:33.803581 #10216]  INFO -- : ruby    14520  ko1    7r   CHR    1,9      0t0   11 /dev/urandom
I, [2021-09-27T09:03:33.803603 #10216]  INFO -- : ruby    14520  ko1    8r   CHR    1,8      0t0   10 /dev/random
I, [2021-09-27T09:03:33.803978 #10216]  INFO -- : COMMAND   PID USER   FD   TYPE DEVICE SIZE/OFF NODE NAME
I, [2021-09-27T09:03:33.804014 #10216]  INFO -- : ruby    14523  ko1    8r   CHR    1,9      0t0   11 /dev/urandom
I, [2021-09-27T09:03:33.804036 #10216]  INFO -- : ruby    14523  ko1    9r   CHR    1,8      0t0   10 /dev/random
I, [2021-09-27T09:03:40.383661 #10216]  INFO -- : Leaked file descriptor: TestGemRemoteFetcher#test_fetch_s3_env_creds_with_region: 11 : #<TCPServer:fd 11, AF_INET, 0.0.0.0, 36697>
I, [2021-09-27T09:03:40.383730 #10216]  INFO -- : Leaked file descriptor: TestGemRemoteFetcher#test_fetch_s3_env_creds_with_region: 12 : #<TCPServer:fd 12, AF_INET6, ::, 36697>
I, [2021-09-27T09:03:40.383747 #10216]  INFO -- : Leaked file descriptor: TestGemRemoteFetcher#test_fetch_s3_env_creds_with_region: 13 : #<IO:fd 13>
I, [2021-09-27T09:03:40.383766 #10216]  INFO -- : Leaked file descriptor: TestGemRemoteFetcher#test_fetch_s3_env_creds_with_region: 14 : #<IO:fd 14>
I, [2021-09-27T09:03:40.423612 #10216]  INFO -- : COMMAND   PID USER   FD   TYPE     DEVICE SIZE/OFF       NODE NAME
I, [2021-09-27T09:03:40.423671 #10216]  INFO -- : ruby    14524  ko1   11u  IPv4 2832514318      0t0        TCP *:36697 (LISTEN)
I, [2021-09-27T09:03:40.423689 #10216]  INFO -- : ruby    14524  ko1   12u  IPv6 2832514319      0t0        TCP *:36697 (LISTEN)
I, [2021-09-27T09:03:40.423704 #10216]  INFO -- : ruby    14524  ko1   13r  FIFO       0,12      0t0 2832514320 pipe
I, [2021-09-27T09:03:40.423719 #10216]  INFO -- : ruby    14524  ko1   14w  FIFO       0,12      0t0 2832514320 pipe
I, [2021-09-27T09:03:40.509770 #10216]  INFO -- : Closed file descriptor: TestGemRemoteFetcher#test_implicit_upper_case_proxy: 11
I, [2021-09-27T09:03:40.509835 #10216]  INFO -- : Closed file descriptor: TestGemRemoteFetcher#test_implicit_upper_case_proxy: 12
I, [2021-09-27T09:03:40.509853 #10216]  INFO -- : Closed file descriptor: TestGemRemoteFetcher#test_implicit_upper_case_proxy: 13
I, [2021-09-27T09:03:40.509869 #10216]  INFO -- : Closed file descriptor: TestGemRemoteFetcher#test_implicit_upper_case_proxy: 14
I, [2021-09-27T09:03:40.783333 #10216]  INFO -- : Leaked file descriptor: TestGemRemoteFetcher#test_download_local_space: 15 : #<TCPServer:fd 15, AF_INET, 0.0.0.0, 33371>
I, [2021-09-27T09:03:40.783440 #10216]  INFO -- : Leaked file descriptor: TestGemRemoteFetcher#test_download_local_space: 16 : #<TCPServer:fd 16, AF_INET6, ::, 33371>
I, [2021-09-27T09:03:40.783657 #10216]  INFO -- : Leaked file descriptor: TestGemRemoteFetcher#test_download_local_space: 17 : #<IO:fd 17>
I, [2021-09-27T09:03:40.783690 #10216]  INFO -- : Leaked file descriptor: TestGemRemoteFetcher#test_download_local_space: 18 : #<IO:fd 18>
I, [2021-09-27T09:03:40.836754 #10216]  INFO -- : COMMAND   PID USER   FD   TYPE     DEVICE SIZE/OFF       NODE NAME
I, [2021-09-27T09:03:40.836834 #10216]  INFO -- : ruby    14524  ko1   15u  IPv4 2832517172      0t0        TCP *:33371 (LISTEN)
I, [2021-09-27T09:03:40.836861 #10216]  INFO -- : ruby    14524  ko1   16u  IPv6 2832517173      0t0        TCP *:33371 (LISTEN)
I, [2021-09-27T09:03:40.836880 #10216]  INFO -- : ruby    14524  ko1   17r  FIFO       0,12      0t0 2832517174 pipe
I, [2021-09-27T09:03:40.836899 #10216]  INFO -- : ruby    14524  ko1   18w  FIFO       0,12      0t0 2832517174 pipe
I, [2021-09-27T09:03:40.924495 #10216]  INFO -- : Closed file descriptor: TestGemRemoteFetcher#test_fetch_s3_no_host: 15
I, [2021-09-27T09:03:40.924579 #10216]  INFO -- : Closed file descriptor: TestGemRemoteFetcher#test_fetch_s3_no_host: 16
I, [2021-09-27T09:03:40.924602 #10216]  INFO -- : Closed file descriptor: TestGemRemoteFetcher#test_fetch_s3_no_host: 17
I, [2021-09-27T09:03:40.924623 #10216]  INFO -- : Closed file descriptor: TestGemRemoteFetcher#test_fetch_s3_no_host: 18
I, [2021-09-27T09:03:46.158279 #10216]  INFO -- : 
I, [2021-09-27T09:03:46.158353 #10216]  INFO -- : Retrying...
I, [2021-09-27T09:03:46.202131 #10216]  INFO -- : Finished tests in 69.935137s, 307.6136 tests/s, 83314.1857 assertions/s.
I, [2021-09-27T09:03:46.202505 #10216]  INFO -- : 21513 tests, 5826589 assertions, 0 failures, 0 errors, 98 skips
I, [2021-09-27T09:03:46.202531 #10216]  INFO -- : 
I, [2021-09-27T09:03:46.202550 #10216]  INFO -- : ruby -v: ruby 3.1.0dev (2021-09-26T18:23:48Z master 00cfafc0f5) [x86_64-linux]
I, [2021-09-27T09:03:46.203804 #10216]  INFO -- : $$$[end] "make yes-test-all TESTS='-j8'" exit with 0.
I, [2021-09-27T09:03:46.203893 #10216]  INFO -- : $$$[beg] make yes-test-rubyspec TESTS='-j8'
I, [2021-09-27T09:03:46.392534 #10216]  INFO -- : ruby 3.1.0dev (2021-09-26T18:23:48Z master 00cfafc0f5) [x86_64-linux]
I, [2021-09-27T09:04:31.463816 #10216]  INFO -- : ........................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................
I, [2021-09-27T09:04:31.463884 #10216]  INFO -- : 
I, [2021-09-27T09:04:31.463899 #10216]  INFO -- : Finished in 45.071284 seconds
I, [2021-09-27T09:04:31.463909 #10216]  INFO -- : 
I, [2021-09-27T09:04:31.463919 #10216]  INFO -- : 3800 files, 30442 examples, 200687 expectations, 0 failures, 0 errors, 0 tagged
I, [2021-09-27T09:04:31.471340 #10216]  INFO -- : $$$[end] "make yes-test-rubyspec TESTS='-j8'" exit with 0.