# Logfile created on 2021-09-25 05:03:53 +0900 by logger.rb/61378
I, [2021-09-25T05:03:53.383872 #3926]  INFO -- : #<BuildRuby:0x000055d7901f7260 @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.20210925-050353", @ruby_env=[["RUBY_DEBUG", "ci"]], @make="make", @logger=#<Logger:0x000055d79016a810 @level=0, @progname=nil, @default_formatter=#<Logger::Formatter:0x000055d79016a798 @datetime_format=nil>, @formatter=nil, @logdev=#<Logger::LogDevice:0x000055d79016a748 @shift_period_suffix="%Y%m%d", @shift_size=1048576, @shift_age=0, @filename="/home/ko1/ruby/logs/brlog.trunk-test.20210925-050353", @dev=#<File:/home/ko1/ruby/logs/brlog.trunk-test.20210925-050353>, @mon_owner=nil, @mon_count=0, @mon_mutex=#<Thread::Mutex:0x000055d79016a6d0>>>>
I, [2021-09-25T05:03:53.384121 #3926]  INFO -- : $$$[beg] make update-unicode  -j8
I, [2021-09-25T05:03:53.415076 #3926]  INFO -- : Downloading Unicode 13.0.0 data and property files...
I, [2021-09-25T05:03:53.417961 #3926]  INFO -- : Downloading Unicode 13.0.0 auxiliary files...
I, [2021-09-25T05:03:53.418920 #3926]  INFO -- : Downloading Unicode UCD emoji 13.1 files...
I, [2021-09-25T05:03:53.419740 #3926]  INFO -- : Downloading Unicode emoji 13.1 files...
I, [2021-09-25T05:03:53.462392 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/emoji/emoji-data.txt already exists
I, [2021-09-25T05:03:53.462441 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/auxiliary/GraphemeBreakProperty.txt already exists
I, [2021-09-25T05:03:53.462478 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/emoji/emoji-variation-sequences.txt already exists
I, [2021-09-25T05:03:53.462490 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/auxiliary/GraphemeBreakTest.txt already exists
I, [2021-09-25T05:03:53.486036 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/UnicodeData.txt already exists
I, [2021-09-25T05:03:53.486085 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/CompositionExclusions.txt already exists
I, [2021-09-25T05:03:53.486226 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/NormalizationTest.txt already exists
I, [2021-09-25T05:03:53.486297 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/CaseFolding.txt already exists
I, [2021-09-25T05:03:53.486368 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/SpecialCasing.txt already exists
I, [2021-09-25T05:03:53.486438 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/Blocks.txt already exists
I, [2021-09-25T05:03:53.486523 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/DerivedAge.txt already exists
I, [2021-09-25T05:03:53.486591 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/DerivedCoreProperties.txt already exists
I, [2021-09-25T05:03:53.486625 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/PropList.txt already exists
I, [2021-09-25T05:03:53.486709 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/PropertyAliases.txt already exists
I, [2021-09-25T05:03:53.486776 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/PropertyValueAliases.txt already exists
I, [2021-09-25T05:03:53.486841 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/13.0.0/ucd/Scripts.txt already exists
I, [2021-09-25T05:03:53.488712 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/emoji/13.1/emoji-sequences.txt already exists
I, [2021-09-25T05:03:53.488762 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/emoji/13.1/emoji-test.txt already exists
I, [2021-09-25T05:03:53.488837 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/enc/unicode/data/emoji/13.1/emoji-zwj-sequences.txt already exists
I, [2021-09-25T05:03:53.489859 #3926]  INFO -- : $$$[end] "make update-unicode  -j8" exit with 0.
I, [2021-09-25T05:03:53.489887 #3926]  INFO -- : $$$[beg] make update-download -j8
I, [2021-09-25T05:03:53.562471 #3926]  INFO -- : tool/config.guess already exists
I, [2021-09-25T05:03:53.562520 #3926]  INFO -- : tool/config.sub already exists
I, [2021-09-25T05:03:53.565456 #3926]  INFO -- : downloading for ext/zlib/extlibs
I, [2021-09-25T05:03:53.565589 #3926]  INFO -- : .downloaded-cache/zlib-1.2.11.tar.gz already exists
I, [2021-09-25T05:03:53.566659 #3926]  INFO -- : checking md5 of .downloaded-cache/zlib-1.2.11.tar.gz ... OK
I, [2021-09-25T05:03:53.567703 #3926]  INFO -- : checking sha512 of .downloaded-cache/zlib-1.2.11.tar.gz ... OK
I, [2021-09-25T05:03:53.567728 #3926]  INFO -- : downloading for ext/fiddle/extlibs
I, [2021-09-25T05:03:53.567804 #3926]  INFO -- : .downloaded-cache/libffi-3.2.1.tar.gz already exists
I, [2021-09-25T05:03:53.569303 #3926]  INFO -- : checking md5 of .downloaded-cache/libffi-3.2.1.tar.gz ... OK
I, [2021-09-25T05:03:53.570739 #3926]  INFO -- : checking sha512 of .downloaded-cache/libffi-3.2.1.tar.gz ... OK
I, [2021-09-25T05:03:53.571871 #3926]  INFO -- : $$$[end] "make update-download -j8" exit with 0.
I, [2021-09-25T05:03:53.571900 #3926]  INFO -- : $$$[beg] make update-rubyspec -j8
I, [2021-09-25T05:03:53.601915 #3926]  INFO -- : make: Nothing to be done for 'update-rubyspec'.
I, [2021-09-25T05:03:53.602060 #3926]  INFO -- : $$$[end] "make update-rubyspec -j8" exit with 0.
I, [2021-09-25T05:03:53.602088 #3926]  INFO -- : $$$[beg] make update-src      -j8
I, [2021-09-25T05:03:54.077781 #3926]  INFO -- : Already up to date.
I, [2021-09-25T05:03:54.110534 #3926]  INFO -- : Current branch master is up to date.
I, [2021-09-25T05:03:54.119110 #3926]  INFO -- : Latest commit hash = bbdfce96a2
I, [2021-09-25T05:03:54.119652 #3926]  INFO -- : $$$[end] "make update-src      -j8" exit with 0.
I, [2021-09-25T05:03:54.119680 #3926]  INFO -- : $$$[beg] make after-update    -j8
I, [2021-09-25T05:03:54.179935 #3926]  INFO -- : generating enc.mk
I, [2021-09-25T05:03:54.225048 #3926]  INFO -- : downloading for ext/zlib/extlibs
I, [2021-09-25T05:03:54.225173 #3926]  INFO -- : .downloaded-cache/zlib-1.2.11.tar.gz already exists
I, [2021-09-25T05:03:54.225199 #3926]  INFO -- : downloading for ext/fiddle/extlibs
I, [2021-09-25T05:03:54.225289 #3926]  INFO -- : .downloaded-cache/libffi-3.2.1.tar.gz already exists
I, [2021-09-25T05:03:54.250020 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/revision.h unchanged
I, [2021-09-25T05:03:54.281873 #3926]  INFO -- : making srcs under enc
I, [2021-09-25T05:03:54.314541 #3926]  INFO -- : make[1]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:54.314569 #3926]  INFO -- : make[1]: Nothing to be done for 'srcs'.
I, [2021-09-25T05:03:54.314581 #3926]  INFO -- : make[1]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:54.315011 #3926]  INFO -- : $$$[end] "make after-update    -j8" exit with 0.
I, [2021-09-25T05:03:54.315101 #3926]  INFO -- : $$$[beg] make miniruby -j8
I, [2021-09-25T05:03:54.344254 #3926]  INFO -- : 	BASERUBY = /usr/bin/ruby --disable=gems
I, [2021-09-25T05:03:54.344292 #3926]  INFO -- : 	CC = gcc
I, [2021-09-25T05:03:54.344304 #3926]  INFO -- : 	LD = ld
I, [2021-09-25T05:03:54.344315 #3926]  INFO -- : 	LDSHARED = gcc -shared
I, [2021-09-25T05:03:54.344326 #3926]  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-25T05:03:54.344343 #3926]  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-25T05:03:54.344353 #3926]  INFO -- : 	CPPFLAGS =   
I, [2021-09-25T05:03:54.344364 #3926]  INFO -- : 	DLDFLAGS = -Wl,--compress-debug-sections=zlib -Wl,-soname,libruby.so.3.1  -fstack-protector-strong  
I, [2021-09-25T05:03:54.344387 #3926]  INFO -- : 	SOLIBS = -lz -lpthread -lrt -lrt -lgmp -ldl -lcrypt -lm 
I, [2021-09-25T05:03:54.344397 #3926]  INFO -- : 	LANG = en_US.UTF-8
I, [2021-09-25T05:03:54.344406 #3926]  INFO -- : 	LC_ALL = 
I, [2021-09-25T05:03:54.344415 #3926]  INFO -- : 	LC_CTYPE = 
I, [2021-09-25T05:03:54.344425 #3926]  INFO -- : 	MFLAGS = -j --jobserver-fds=4,5
I, [2021-09-25T05:03:54.346033 #3926]  INFO -- : gcc (Ubuntu 7.5.0-3ubuntu1~18.04) 7.5.0
I, [2021-09-25T05:03:54.346059 #3926]  INFO -- : Copyright (C) 2017 Free Software Foundation, Inc.
I, [2021-09-25T05:03:54.346071 #3926]  INFO -- : This is free software; see the source for copying conditions.  There is NO
I, [2021-09-25T05:03:54.346081 #3926]  INFO -- : warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE.
I, [2021-09-25T05:03:54.346091 #3926]  INFO -- : 
I, [2021-09-25T05:03:54.371878 #3926]  INFO -- : make: 'miniruby' is up to date.
I, [2021-09-25T05:03:54.371980 #3926]  INFO -- : $$$[end] "make miniruby -j8" exit with 0.
I, [2021-09-25T05:03:54.372070 #3926]  INFO -- : $$$[beg] make ruby -j8
I, [2021-09-25T05:03:54.401144 #3926]  INFO -- : 	BASERUBY = /usr/bin/ruby --disable=gems
I, [2021-09-25T05:03:54.401181 #3926]  INFO -- : 	CC = gcc
I, [2021-09-25T05:03:54.401194 #3926]  INFO -- : 	LD = ld
I, [2021-09-25T05:03:54.401204 #3926]  INFO -- : 	LDSHARED = gcc -shared
I, [2021-09-25T05:03:54.401215 #3926]  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-25T05:03:54.401226 #3926]  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-25T05:03:54.401235 #3926]  INFO -- : 	CPPFLAGS =   
I, [2021-09-25T05:03:54.401246 #3926]  INFO -- : 	DLDFLAGS = -Wl,--compress-debug-sections=zlib -Wl,-soname,libruby.so.3.1  -fstack-protector-strong  
I, [2021-09-25T05:03:54.401263 #3926]  INFO -- : 	SOLIBS = -lz -lpthread -lrt -lrt -lgmp -ldl -lcrypt -lm 
I, [2021-09-25T05:03:54.401272 #3926]  INFO -- : 	LANG = en_US.UTF-8
I, [2021-09-25T05:03:54.401281 #3926]  INFO -- : 	LC_ALL = 
I, [2021-09-25T05:03:54.401290 #3926]  INFO -- : 	LC_CTYPE = 
I, [2021-09-25T05:03:54.401299 #3926]  INFO -- : 	MFLAGS = -j --jobserver-fds=4,5
I, [2021-09-25T05:03:54.402941 #3926]  INFO -- : gcc (Ubuntu 7.5.0-3ubuntu1~18.04) 7.5.0
I, [2021-09-25T05:03:54.402966 #3926]  INFO -- : Copyright (C) 2017 Free Software Foundation, Inc.
I, [2021-09-25T05:03:54.402978 #3926]  INFO -- : This is free software; see the source for copying conditions.  There is NO
I, [2021-09-25T05:03:54.403001 #3926]  INFO -- : warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE.
I, [2021-09-25T05:03:54.403012 #3926]  INFO -- : 
I, [2021-09-25T05:03:54.429565 #3926]  INFO -- : make: 'ruby' is up to date.
I, [2021-09-25T05:03:54.429720 #3926]  INFO -- : $$$[end] "make ruby -j8" exit with 0.
I, [2021-09-25T05:03:54.429805 #3926]  INFO -- : $$$[beg] make all -j8
I, [2021-09-25T05:03:54.458977 #3926]  INFO -- : 	BASERUBY = /usr/bin/ruby --disable=gems
I, [2021-09-25T05:03:54.459011 #3926]  INFO -- : 	CC = gcc
I, [2021-09-25T05:03:54.459024 #3926]  INFO -- : 	LD = ld
I, [2021-09-25T05:03:54.459034 #3926]  INFO -- : 	LDSHARED = gcc -shared
I, [2021-09-25T05:03:54.459044 #3926]  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-25T05:03:54.459055 #3926]  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-25T05:03:54.459064 #3926]  INFO -- : 	CPPFLAGS =   
I, [2021-09-25T05:03:54.459075 #3926]  INFO -- : 	DLDFLAGS = -Wl,--compress-debug-sections=zlib -Wl,-soname,libruby.so.3.1  -fstack-protector-strong  
I, [2021-09-25T05:03:54.459084 #3926]  INFO -- : 	SOLIBS = -lz -lpthread -lrt -lrt -lgmp -ldl -lcrypt -lm 
I, [2021-09-25T05:03:54.459093 #3926]  INFO -- : 	LANG = en_US.UTF-8
I, [2021-09-25T05:03:54.459102 #3926]  INFO -- : 	LC_ALL = 
I, [2021-09-25T05:03:54.459112 #3926]  INFO -- : 	LC_CTYPE = 
I, [2021-09-25T05:03:54.459121 #3926]  INFO -- : 	MFLAGS = -j --jobserver-fds=4,5
I, [2021-09-25T05:03:54.460777 #3926]  INFO -- : gcc (Ubuntu 7.5.0-3ubuntu1~18.04) 7.5.0
I, [2021-09-25T05:03:54.460802 #3926]  INFO -- : Copyright (C) 2017 Free Software Foundation, Inc.
I, [2021-09-25T05:03:54.460815 #3926]  INFO -- : This is free software; see the source for copying conditions.  There is NO
I, [2021-09-25T05:03:54.460825 #3926]  INFO -- : warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE.
I, [2021-09-25T05:03:54.460834 #3926]  INFO -- : 
I, [2021-09-25T05:03:54.488583 #3926]  INFO -- : generating encdb.h
I, [2021-09-25T05:03:54.491043 #3926]  INFO -- : generating enc.mk
I, [2021-09-25T05:03:54.522264 #3926]  INFO -- : encdb.h unchanged
I, [2021-09-25T05:03:54.546845 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/revision.h unchanged
I, [2021-09-25T05:03:54.596751 #3926]  INFO -- : making srcs under enc
I, [2021-09-25T05:03:54.596858 #3926]  INFO -- : making enc
I, [2021-09-25T05:03:54.614627 #3926]  INFO -- : make[1]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:54.614656 #3926]  INFO -- : make[1]: Nothing to be done for 'enc'.
I, [2021-09-25T05:03:54.614670 #3926]  INFO -- : make[1]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:54.629345 #3926]  INFO -- : make[1]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:54.629370 #3926]  INFO -- : make[1]: Nothing to be done for 'srcs'.
I, [2021-09-25T05:03:54.629390 #3926]  INFO -- : make[1]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:54.630047 #3926]  INFO -- : generating transdb.h
I, [2021-09-25T05:03:54.760994 #3926]  INFO -- : transdb.h unchanged
I, [2021-09-25T05:03:54.762114 #3926]  INFO -- : generating makefiles ext/configure-ext.mk
I, [2021-09-25T05:03:54.762222 #3926]  INFO -- : making trans
I, [2021-09-25T05:03:54.781951 #3926]  INFO -- : ext/configure-ext.mk unchanged
I, [2021-09-25T05:03:54.785512 #3926]  INFO -- : make[1]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:54.810969 #3926]  INFO -- : make[1]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:54.811041 #3926]  INFO -- : make[1]: Nothing to be done for '/tmp/ruby/v3/src/trunk-test/enc/trans'.
I, [2021-09-25T05:03:54.811085 #3926]  INFO -- : make[1]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:54.812398 #3926]  INFO -- : making encs
I, [2021-09-25T05:03:54.845213 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/bigdecimal'
I, [2021-09-25T05:03:54.848220 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/digest'
I, [2021-09-25T05:03:54.848880 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/coverage'
I, [2021-09-25T05:03:54.850208 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/date'
I, [2021-09-25T05:03:54.851380 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/bigdecimal'
I, [2021-09-25T05:03:54.853449 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/coverage'
I, [2021-09-25T05:03:54.855039 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/digest'
I, [2021-09-25T05:03:54.857798 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/date'
I, [2021-09-25T05:03:54.857835 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/json'
I, [2021-09-25T05:03:54.858257 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/io/console'
I, [2021-09-25T05:03:54.858618 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/fiddle'
I, [2021-09-25T05:03:54.862237 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/monitor'
I, [2021-09-25T05:03:54.864080 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/nkf'
I, [2021-09-25T05:03:54.864117 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/io/console'
I, [2021-09-25T05:03:54.865730 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/json'
I, [2021-09-25T05:03:54.867402 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/monitor'
I, [2021-09-25T05:03:54.868656 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/nkf'
I, [2021-09-25T05:03:54.870618 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/pathname'
I, [2021-09-25T05:03:54.870755 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/fiddle'
I, [2021-09-25T05:03:54.871504 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/objspace'
I, [2021-09-25T05:03:54.874180 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/pty'
I, [2021-09-25T05:03:54.874851 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/pathname'
I, [2021-09-25T05:03:54.877744 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/psych'
I, [2021-09-25T05:03:54.878817 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/pty'
I, [2021-09-25T05:03:54.878992 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/objspace'
I, [2021-09-25T05:03:54.881520 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/rubyvm'
I, [2021-09-25T05:03:54.883982 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/ripper'
I, [2021-09-25T05:03:54.886894 #3926]  INFO -- : make[1]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:54.886935 #3926]  INFO -- : make[1]: Nothing to be done for 'encs'.
I, [2021-09-25T05:03:54.886976 #3926]  INFO -- : make[1]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:54.889453 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/rubyvm'
I, [2021-09-25T05:03:54.891015 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/openssl'
I, [2021-09-25T05:03:54.892644 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/ripper'
I, [2021-09-25T05:03:54.893816 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/syslog'
I, [2021-09-25T05:03:54.897400 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/socket'
I, [2021-09-25T05:03:54.898589 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/syslog'
I, [2021-09-25T05:03:54.899319 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/psych'
I, [2021-09-25T05:03:54.902731 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/digest/sha2'
I, [2021-09-25T05:03:54.905813 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/socket'
I, [2021-09-25T05:03:54.906446 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/digest/sha2'
I, [2021-09-25T05:03:54.914501 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/openssl'
I, [2021-09-25T05:03:54.939383 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:54.971704 #3926]  INFO -- : make[2]: 'ruby' is up to date.
I, [2021-09-25T05:03:54.971742 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:54.972012 #3926]  INFO -- : make[1]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:54.975010 #3926]  INFO -- : make[1]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:54.975036 #3926]  INFO -- : make[1]: Nothing to be done for 'note'.
I, [2021-09-25T05:03:54.975085 #3926]  INFO -- : make[1]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:54.975432 #3926]  INFO -- : $$$[end] "make all -j8" exit with 0.
I, [2021-09-25T05:03:54.975522 #3926]  INFO -- : $$$[beg] make install -j8
I, [2021-09-25T05:03:55.038724 #3926]  INFO -- : 	BASERUBY = /usr/bin/ruby --disable=gems
I, [2021-09-25T05:03:55.038770 #3926]  INFO -- : 	CC = gcc
I, [2021-09-25T05:03:55.038783 #3926]  INFO -- : 	LD = ld
I, [2021-09-25T05:03:55.038793 #3926]  INFO -- : 	LDSHARED = gcc -shared
I, [2021-09-25T05:03:55.038804 #3926]  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-25T05:03:55.038814 #3926]  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-25T05:03:55.038824 #3926]  INFO -- : 	CPPFLAGS =   
I, [2021-09-25T05:03:55.038835 #3926]  INFO -- : 	DLDFLAGS = -Wl,--compress-debug-sections=zlib -Wl,-soname,libruby.so.3.1  -fstack-protector-strong  
I, [2021-09-25T05:03:55.038851 #3926]  INFO -- : 	SOLIBS = -lz -lpthread -lrt -lrt -lgmp -ldl -lcrypt -lm 
I, [2021-09-25T05:03:55.038861 #3926]  INFO -- : 	LANG = en_US.UTF-8
I, [2021-09-25T05:03:55.038870 #3926]  INFO -- : 	LC_ALL = 
I, [2021-09-25T05:03:55.038880 #3926]  INFO -- : 	LC_CTYPE = 
I, [2021-09-25T05:03:55.038889 #3926]  INFO -- : 	MFLAGS = -j --jobserver-fds=4,5
I, [2021-09-25T05:03:55.039818 #3926]  INFO -- : gcc (Ubuntu 7.5.0-3ubuntu1~18.04) 7.5.0
I, [2021-09-25T05:03:55.039846 #3926]  INFO -- : Copyright (C) 2017 Free Software Foundation, Inc.
I, [2021-09-25T05:03:55.039858 #3926]  INFO -- : This is free software; see the source for copying conditions.  There is NO
I, [2021-09-25T05:03:55.039872 #3926]  INFO -- : warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE.
I, [2021-09-25T05:03:55.039882 #3926]  INFO -- : 
I, [2021-09-25T05:03:55.040492 #3926]  INFO -- : generating encdb.h
I, [2021-09-25T05:03:55.041683 #3926]  INFO -- : generating enc.mk
I, [2021-09-25T05:03:55.073286 #3926]  INFO -- : encdb.h unchanged
I, [2021-09-25T05:03:55.097513 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/revision.h unchanged
I, [2021-09-25T05:03:55.146649 #3926]  INFO -- : making srcs under enc
I, [2021-09-25T05:03:55.146760 #3926]  INFO -- : making enc
I, [2021-09-25T05:03:55.164508 #3926]  INFO -- : make[1]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:55.164537 #3926]  INFO -- : make[1]: Nothing to be done for 'enc'.
I, [2021-09-25T05:03:55.164550 #3926]  INFO -- : make[1]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:55.179228 #3926]  INFO -- : make[1]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:55.179254 #3926]  INFO -- : make[1]: Nothing to be done for 'srcs'.
I, [2021-09-25T05:03:55.179267 #3926]  INFO -- : make[1]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:55.179942 #3926]  INFO -- : generating transdb.h
I, [2021-09-25T05:03:55.308580 #3926]  INFO -- : transdb.h unchanged
I, [2021-09-25T05:03:55.309694 #3926]  INFO -- : generating makefiles ext/configure-ext.mk
I, [2021-09-25T05:03:55.309801 #3926]  INFO -- : making trans
I, [2021-09-25T05:03:55.329517 #3926]  INFO -- : ext/configure-ext.mk unchanged
I, [2021-09-25T05:03:55.333046 #3926]  INFO -- : make[1]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:55.358558 #3926]  INFO -- : make[1]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:55.358619 #3926]  INFO -- : make[1]: Nothing to be done for '/tmp/ruby/v3/src/trunk-test/enc/trans'.
I, [2021-09-25T05:03:55.358641 #3926]  INFO -- : make[1]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:55.359451 #3926]  INFO -- : making encs
I, [2021-09-25T05:03:55.394182 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/bigdecimal'
I, [2021-09-25T05:03:55.394660 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/coverage'
I, [2021-09-25T05:03:55.396106 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/digest'
I, [2021-09-25T05:03:55.398992 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/date'
I, [2021-09-25T05:03:55.401044 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/coverage'
I, [2021-09-25T05:03:55.402488 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/bigdecimal'
I, [2021-09-25T05:03:55.403947 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/digest'
I, [2021-09-25T05:03:55.404374 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/fiddle'
I, [2021-09-25T05:03:55.405265 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/json'
I, [2021-09-25T05:03:55.405463 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/date'
I, [2021-09-25T05:03:55.405958 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/io/console'
I, [2021-09-25T05:03:55.411495 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/nkf'
I, [2021-09-25T05:03:55.411669 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/io/console'
I, [2021-09-25T05:03:55.412993 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/monitor'
I, [2021-09-25T05:03:55.413914 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/objspace'
I, [2021-09-25T05:03:55.415598 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/json'
I, [2021-09-25T05:03:55.416236 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/nkf'
I, [2021-09-25T05:03:55.417573 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/pathname'
I, [2021-09-25T05:03:55.417961 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/monitor'
I, [2021-09-25T05:03:55.421010 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/objspace'
I, [2021-09-25T05:03:55.422195 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/pathname'
I, [2021-09-25T05:03:55.422400 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/pty'
I, [2021-09-25T05:03:55.422907 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/fiddle'
I, [2021-09-25T05:03:55.426658 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/psych'
I, [2021-09-25T05:03:55.426700 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/rubyvm'
I, [2021-09-25T05:03:55.426719 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/pty'
I, [2021-09-25T05:03:55.432698 #3926]  INFO -- : make[1]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:55.432755 #3926]  INFO -- : make[1]: Nothing to be done for 'encs'.
I, [2021-09-25T05:03:55.432796 #3926]  INFO -- : make[1]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:55.434180 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/rubyvm'
I, [2021-09-25T05:03:55.434551 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/ripper'
I, [2021-09-25T05:03:55.437270 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/openssl'
I, [2021-09-25T05:03:55.439754 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/syslog'
I, [2021-09-25T05:03:55.444199 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/socket'
I, [2021-09-25T05:03:55.445341 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/syslog'
I, [2021-09-25T05:03:55.446907 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/psych'
I, [2021-09-25T05:03:55.448207 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/ripper'
I, [2021-09-25T05:03:55.450425 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test/ext/digest/sha2'
I, [2021-09-25T05:03:55.454547 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/digest/sha2'
I, [2021-09-25T05:03:55.455272 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/socket'
I, [2021-09-25T05:03:55.461915 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test/ext/openssl'
I, [2021-09-25T05:03:55.486720 #3926]  INFO -- : make[2]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:55.518652 #3926]  INFO -- : make[2]: 'ruby' is up to date.
I, [2021-09-25T05:03:55.518689 #3926]  INFO -- : make[2]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:55.518963 #3926]  INFO -- : make[1]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:55.522035 #3926]  INFO -- : make[1]: Entering directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:55.522067 #3926]  INFO -- : make[1]: Nothing to be done for 'note'.
I, [2021-09-25T05:03:55.522080 #3926]  INFO -- : make[1]: Leaving directory '/tmp/ruby/v3/build/trunk-test'
I, [2021-09-25T05:03:55.522323 #3926]  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-25T05:03:55.614460 #3926]  INFO -- : installing binary commands:         /tmp/ruby/v3/install/trunk-test/bin
I, [2021-09-25T05:03:55.614703 #3926]  INFO -- : installing base libraries:          /tmp/ruby/v3/install/trunk-test/lib
I, [2021-09-25T05:03:55.620977 #3926]  INFO -- : installing arch files:              /tmp/ruby/v3/install/trunk-test/lib/ruby/3.1.0/x86_64-linux
I, [2021-09-25T05:03:55.621064 #3926]  INFO -- : installing pkgconfig data:          /tmp/ruby/v3/install/trunk-test/lib/pkgconfig
I, [2021-09-25T05:03:55.621090 #3926]  INFO -- : installing extension objects:       /tmp/ruby/v3/install/trunk-test/lib/ruby/3.1.0/x86_64-linux
I, [2021-09-25T05:03:55.636407 #3926]  INFO -- : installing extension objects:       /tmp/ruby/v3/install/trunk-test/lib/ruby/site_ruby/3.1.0/x86_64-linux
I, [2021-09-25T05:03:55.636508 #3926]  INFO -- : installing extension objects:       /tmp/ruby/v3/install/trunk-test/lib/ruby/vendor_ruby/3.1.0/x86_64-linux
I, [2021-09-25T05:03:55.636620 #3926]  INFO -- : installing extension headers:       /tmp/ruby/v3/install/trunk-test/include/ruby-3.1.0/x86_64-linux
I, [2021-09-25T05:03:55.637639 #3926]  INFO -- : installing extension scripts:       /tmp/ruby/v3/install/trunk-test/lib/ruby/3.1.0
I, [2021-09-25T05:03:55.642844 #3926]  INFO -- : installing extension scripts:       /tmp/ruby/v3/install/trunk-test/lib/ruby/site_ruby/3.1.0
I, [2021-09-25T05:03:55.642873 #3926]  INFO -- : installing extension scripts:       /tmp/ruby/v3/install/trunk-test/lib/ruby/vendor_ruby/3.1.0
I, [2021-09-25T05:03:55.642886 #3926]  INFO -- : installing extension headers:       /tmp/ruby/v3/install/trunk-test/include/ruby-3.1.0/ruby
I, [2021-09-25T05:03:55.642971 #3926]  INFO -- : installing command scripts:         /tmp/ruby/v3/install/trunk-test/bin
I, [2021-09-25T05:03:55.643079 #3926]  INFO -- : installing library scripts:         /tmp/ruby/v3/install/trunk-test/lib/ruby/3.1.0
I, [2021-09-25T05:03:55.693396 #3926]  INFO -- : installing common headers:          /tmp/ruby/v3/install/trunk-test/include/ruby-3.1.0
I, [2021-09-25T05:03:55.702577 #3926]  INFO -- : installing manpages:                /tmp/ruby/v3/install/trunk-test/share/man/man1
I, [2021-09-25T05:03:55.702839 #3926]  INFO -- : installing default gems from lib:   /tmp/ruby/v3/install/trunk-test/lib/ruby/gems/3.1.0
I, [2021-09-25T05:03:55.723943 #3926]  INFO -- :                                     abbrev 0.1.0
I, [2021-09-25T05:03:55.727173 #3926]  INFO -- :                                     base64 0.1.0
I, [2021-09-25T05:03:55.740561 #3926]  INFO -- :                                     benchmark 0.1.1
I, [2021-09-25T05:03:55.753536 #3926]  INFO -- :                                     bundler 2.3.0.dev
I, [2021-09-25T05:03:55.767968 #3926]  INFO -- :                                     cgi 0.2.0
I, [2021-09-25T05:03:55.784688 #3926]  INFO -- :                                     csv 3.2.0
I, [2021-09-25T05:03:55.797905 #3926]  INFO -- :                                     debug 0.1.0
I, [2021-09-25T05:03:55.810836 #3926]  INFO -- :                                     delegate 0.2.0
I, [2021-09-25T05:03:55.823795 #3926]  INFO -- :                                     did_you_mean 1.6.0.pre.alpha
I, [2021-09-25T05:03:55.840841 #3926]  INFO -- :                                     drb 2.0.4
I, [2021-09-25T05:03:55.853877 #3926]  INFO -- :                                     english 0.7.1
I, [2021-09-25T05:03:55.866884 #3926]  INFO -- :                                     erb 2.2.3
I, [2021-09-25T05:03:55.880300 #3926]  INFO -- :                                     error_highlight 0.2.0
I, [2021-09-25T05:03:55.893541 #3926]  INFO -- :                                     fileutils 1.5.0
I, [2021-09-25T05:03:55.910247 #3926]  INFO -- :                                     find 0.1.0
I, [2021-09-25T05:03:55.923205 #3926]  INFO -- :                                     forwardable 1.3.2
I, [2021-09-25T05:03:55.936171 #3926]  INFO -- :                                     getoptlong 0.1.1
I, [2021-09-25T05:03:55.949151 #3926]  INFO -- :                                     ipaddr 1.2.2
I, [2021-09-25T05:03:55.966131 #3926]  INFO -- :                                     irb 1.3.8.pre.9
I, [2021-09-25T05:03:55.979689 #3926]  INFO -- :                                     logger 1.4.3
I, [2021-09-25T05:03:55.992823 #3926]  INFO -- :                                     mutex_m 0.1.1
I, [2021-09-25T05:03:56.005848 #3926]  INFO -- :                                     net-http 0.1.1
I, [2021-09-25T05:03:56.019285 #3926]  INFO -- :                                     net-protocol 0.1.1
I, [2021-09-25T05:03:56.035996 #3926]  INFO -- :                                     observer 0.1.1
I, [2021-09-25T05:03:56.049135 #3926]  INFO -- :                                     open-uri 0.1.0
I, [2021-09-25T05:03:56.062252 #3926]  INFO -- :                                     open3 0.1.1
I, [2021-09-25T05:03:56.075504 #3926]  INFO -- :                                     optparse 0.1.1
I, [2021-09-25T05:03:56.092322 #3926]  INFO -- :                                     ostruct 0.4.0
I, [2021-09-25T05:03:56.105378 #3926]  INFO -- :                                     pp 0.2.0
I, [2021-09-25T05:03:56.118445 #3926]  INFO -- :                                     prettyprint 0.1.0
I, [2021-09-25T05:03:56.131518 #3926]  INFO -- :                                     pstore 0.1.1
I, [2021-09-25T05:03:56.144809 #3926]  INFO -- :                                     racc 1.5.2
I, [2021-09-25T05:03:56.161818 #3926]  INFO -- :                                     rdoc 6.3.2
I, [2021-09-25T05:03:56.175786 #3926]  INFO -- :                                     readline 0.0.2
I, [2021-09-25T05:03:56.188656 #3926]  INFO -- :                                     reline 0.2.8.pre.9
I, [2021-09-25T05:03:56.201696 #3926]  INFO -- :                                     resolv 0.2.1
I, [2021-09-25T05:03:56.218082 #3926]  INFO -- :                                     resolv-replace 0.1.0
I, [2021-09-25T05:03:56.231061 #3926]  INFO -- :                                     rinda 0.1.0
I, [2021-09-25T05:03:56.243913 #3926]  INFO -- :                                     ruby2_keywords 0.0.5
I, [2021-09-25T05:03:56.256713 #3926]  INFO -- :                                     securerandom 0.1.0
I, [2021-09-25T05:03:56.269887 #3926]  INFO -- :                                     set 1.0.1
I, [2021-09-25T05:03:56.286348 #3926]  INFO -- :                                     shellwords 0.1.0
I, [2021-09-25T05:03:56.299192 #3926]  INFO -- :                                     singleton 0.1.1
I, [2021-09-25T05:03:56.312032 #3926]  INFO -- :                                     tempfile 0.1.1
I, [2021-09-25T05:03:56.325191 #3926]  INFO -- :                                     time 0.1.0
I, [2021-09-25T05:03:56.341827 #3926]  INFO -- :                                     timeout 0.1.1
I, [2021-09-25T05:03:56.354669 #3926]  INFO -- :                                     tmpdir 0.1.2
I, [2021-09-25T05:03:56.367462 #3926]  INFO -- :                                     tsort 0.1.0
I, [2021-09-25T05:03:56.380337 #3926]  INFO -- :                                     un 0.1.0
I, [2021-09-25T05:03:56.393352 #3926]  INFO -- :                                     uri 0.10.1
I, [2021-09-25T05:03:56.409934 #3926]  INFO -- :                                     weakref 0.1.1
I, [2021-09-25T05:03:56.422800 #3926]  INFO -- :                                     yaml 0.1.1
I, [2021-09-25T05:03:56.435386 #3926]  INFO -- : installing default gems from ext:   /tmp/ruby/v3/install/trunk-test/lib/ruby/gems/3.1.0
I, [2021-09-25T05:03:56.445415 #3926]  INFO -- :                                     bigdecimal 3.0.0
I, [2021-09-25T05:03:56.458672 #3926]  INFO -- :                                     date 3.1.1
I, [2021-09-25T05:03:56.475555 #3926]  INFO -- :                                     digest 3.0.1.pre
I, [2021-09-25T05:03:56.488647 #3926]  INFO -- :                                     etc 1.2.0
I, [2021-09-25T05:03:56.501505 #3926]  INFO -- :                                     fcntl 1.0.0
I, [2021-09-25T05:03:56.514333 #3926]  INFO -- :                                     fiddle 1.1.0
I, [2021-09-25T05:03:56.527243 #3926]  INFO -- :                                     io-console 0.5.9
I, [2021-09-25T05:03:56.543629 #3926]  INFO -- :                                     io-nonblock 0.1.0
I, [2021-09-25T05:03:56.556714 #3926]  INFO -- :                                     io-wait 0.1.1
I, [2021-09-25T05:03:56.569503 #3926]  INFO -- :                                     json 2.5.1
I, [2021-09-25T05:03:56.582474 #3926]  INFO -- :                                     nkf 0.1.0
I, [2021-09-25T05:03:56.598830 #3926]  INFO -- :                                     openssl 2.2.0
I, [2021-09-25T05:03:56.611696 #3926]  INFO -- :                                     pathname 0.1.0
I, [2021-09-25T05:03:56.624600 #3926]  INFO -- :                                     psych 4.0.1
I, [2021-09-25T05:03:56.637498 #3926]  INFO -- :                                     readline-ext 0.1.2
I, [2021-09-25T05:03:56.654207 #3926]  INFO -- :                                     stringio 3.0.0
I, [2021-09-25T05:03:56.667318 #3926]  INFO -- :                                     strscan 3.0.0
I, [2021-09-25T05:03:56.680268 #3926]  INFO -- :                                     syslog 0.1.0
I, [2021-09-25T05:03:56.693384 #3926]  INFO -- :                                     zlib 1.1.0
I, [2021-09-25T05:03:56.709689 #3926]  INFO -- : installing bundled gems:            /tmp/ruby/v3/install/trunk-test/lib/ruby/gems/3.1.0
I, [2021-09-25T05:03:56.710469 #3926]  INFO -- :                                     minitest 5.14.4
I, [2021-09-25T05:03:56.726131 #3926]  INFO -- :                                     power_assert 2.0.1
I, [2021-09-25T05:03:56.740642 #3926]  INFO -- :                                     rake 13.0.6
I, [2021-09-25T05:03:56.758745 #3926]  INFO -- :                                     test-unit 3.4.7
I, [2021-09-25T05:03:56.780777 #3926]  INFO -- :                                     rexml 3.2.5
I, [2021-09-25T05:03:56.799246 #3926]  INFO -- :                                     rss 0.2.9
I, [2021-09-25T05:03:56.819183 #3926]  INFO -- :                                     net-ftp 0.1.3
I, [2021-09-25T05:03:56.833335 #3926]  INFO -- :                                     net-imap 0.2.2
I, [2021-09-25T05:03:56.847881 #3926]  INFO -- :                                     net-pop 0.1.1
I, [2021-09-25T05:03:56.865493 #3926]  INFO -- :                                     net-smtp 0.2.1
I, [2021-09-25T05:03:56.879344 #3926]  INFO -- :                                     matrix 0.4.2
I, [2021-09-25T05:03:56.893045 #3926]  INFO -- :                                     prime 0.1.2
I, [2021-09-25T05:03:56.907327 #3926]  INFO -- :                                     rbs 1.6.2
I, [2021-09-25T05:03:56.948243 #3926]  INFO -- :                                     typeprof 0.15.3
I, [2021-09-25T05:03:56.985454 #3926]  INFO -- : installing bundled gem cache:       /tmp/ruby/v3/install/trunk-test/lib/ruby/gems/3.1.0/cache
I, [2021-09-25T05:03:56.989093 #3926]  INFO -- : $$$[end] "make install -j8" exit with 0.
I, [2021-09-25T05:03:56.989217 #3926]  INFO -- : $$$[beg] make yes-btest TESTS='-j8'
I, [2021-09-25T05:03:57.057103 #3926]  INFO -- : 2021-09-25 05:03:57 +0900
I, [2021-09-25T05:03:57.057150 #3926]  INFO -- : Driver is ruby 2.5.1p57 (2018-03-29 revision 63029) [x86_64-linux-gnu]
I, [2021-09-25T05:03:57.061792 #3926]  INFO -- : Target is ruby 3.1.0dev (2021-09-24T15:35:19Z master bbdfce96a2) [x86_64-linux]
I, [2021-09-25T05:03:57.061830 #3926]  INFO -- : 
I, [2021-09-25T05:04:15.177290 #3926]  INFO -- : $$$[end] "make yes-btest TESTS='-j8'" exit with 0.
I, [2021-09-25T05:04:15.177672 #3926]  INFO -- : $$$[beg] make yes-test-basic TESTS='-j8'
I, [2021-09-25T05:04:15.247185 #3926]  INFO -- : 	BASERUBY = /usr/bin/ruby --disable=gems
I, [2021-09-25T05:04:15.247225 #3926]  INFO -- : 	CC = gcc
I, [2021-09-25T05:04:15.247238 #3926]  INFO -- : 	LD = ld
I, [2021-09-25T05:04:15.247249 #3926]  INFO -- : 	LDSHARED = gcc -shared
I, [2021-09-25T05:04:15.247259 #3926]  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-25T05:04:15.247280 #3926]  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-25T05:04:15.247292 #3926]  INFO -- : 	CPPFLAGS =   
I, [2021-09-25T05:04:15.247302 #3926]  INFO -- : 	DLDFLAGS = -Wl,--compress-debug-sections=zlib -Wl,-soname,libruby.so.3.1  -fstack-protector-strong  
I, [2021-09-25T05:04:15.247311 #3926]  INFO -- : 	SOLIBS = -lz -lpthread -lrt -lrt -lgmp -ldl -lcrypt -lm 
I, [2021-09-25T05:04:15.247320 #3926]  INFO -- : 	LANG = en_US.UTF-8
I, [2021-09-25T05:04:15.247329 #3926]  INFO -- : 	LC_ALL = 
I, [2021-09-25T05:04:15.247338 #3926]  INFO -- : 	LC_CTYPE = 
I, [2021-09-25T05:04:15.247347 #3926]  INFO -- : 	MFLAGS = 
I, [2021-09-25T05:04:15.247855 #3926]  INFO -- : gcc (Ubuntu 7.5.0-3ubuntu1~18.04) 7.5.0
I, [2021-09-25T05:04:15.247865 #3926]  INFO -- : Copyright (C) 2017 Free Software Foundation, Inc.
I, [2021-09-25T05:04:15.247875 #3926]  INFO -- : This is free software; see the source for copying conditions.  There is NO
I, [2021-09-25T05:04:15.247885 #3926]  INFO -- : warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE.
I, [2021-09-25T05:04:15.247894 #3926]  INFO -- : 
I, [2021-09-25T05:04:15.306147 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:assignment ....................................................................................................................................................................................................................................................................................................................................................................................OK 372
I, [2021-09-25T05:04:15.306205 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:condition ..OK 2
I, [2021-09-25T05:04:15.306219 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:if/unless ...OK 3
I, [2021-09-25T05:04:15.306232 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:case .....OK 5
I, [2021-09-25T05:04:15.306394 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:while/until ........OK 8
I, [2021-09-25T05:04:15.306485 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:exception ..........OK 10
I, [2021-09-25T05:04:15.306759 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:array .......................................OK 39
I, [2021-09-25T05:04:15.306929 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:hash ...........................OK 27
I, [2021-09-25T05:04:15.307877 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:iterator ...........................................................................................................OK 107
I, [2021-09-25T05:04:15.308358 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:float ................................................................................OK 80
I, [2021-09-25T05:04:15.310160 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:bignum ...............................OK 31
I, [2021-09-25T05:04:15.311294 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:string & char ..............................................................OK 62
I, [2021-09-25T05:04:15.311353 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:assignment ..........OK 10
I, [2021-09-25T05:04:15.311404 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:call ......OK 6
I, [2021-09-25T05:04:15.311505 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:proc .........OK 9
I, [2021-09-25T05:04:15.411937 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:signal ..OK 2
I, [2021-09-25T05:04:15.414048 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:eval ...........................OK 27
I, [2021-09-25T05:04:15.469925 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:system ........OK 8
I, [2021-09-25T05:04:15.469981 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:const .....OK 5
I, [2021-09-25T05:04:15.470054 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:clone .....OK 5
I, [2021-09-25T05:04:15.470221 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:marshal ....OK 4
I, [2021-09-25T05:04:15.470263 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:pack ....OK 4
I, [2021-09-25T05:04:15.470287 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:math ..OK 2
I, [2021-09-25T05:04:15.470365 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:struct ......OK 6
I, [2021-09-25T05:04:15.470488 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:variable ............OK 12
I, [2021-09-25T05:04:15.470518 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:trace ...OK 3
I, [2021-09-25T05:04:15.470609 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:defined? ............OK 12
I, [2021-09-25T05:04:15.470674 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:alias ......OK 6
I, [2021-09-25T05:04:15.471198 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:path .......................OK 23
I, [2021-09-25T05:04:15.530148 #3926]  INFO -- : /tmp/ruby/v3/src/trunk-test/basictest/test.rb:gc ....OK 4
I, [2021-09-25T05:04:15.532463 #3926]  INFO -- : 
I, [2021-09-25T05:04:15.532504 #3926]  INFO -- : test succeeded
I, [2021-09-25T05:04:15.533393 #3926]  INFO -- : $$$[end] "make yes-test-basic TESTS='-j8'" exit with 0.
I, [2021-09-25T05:04:15.533490 #3926]  INFO -- : $$$[beg] make yes-test-all TESTS='-j8'
I, [2021-09-25T05:04:15.657247 #3926]  INFO -- : Run options: 
I, [2021-09-25T05:04:15.657302 #3926]  INFO -- :   --seed=26140
I, [2021-09-25T05:04:15.657316 #3926]  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-25T05:04:15.657328 #3926]  INFO -- :   --excludes-dir=/tmp/ruby/v3/src/trunk-test/test/excludes
I, [2021-09-25T05:04:15.657337 #3926]  INFO -- :   --name=!/memory_leak/
I, [2021-09-25T05:04:15.657692 #3926]  INFO -- :   -j8
I, [2021-09-25T05:04:15.657713 #3926]  INFO -- : 
I, [2021-09-25T05:04:15.657738 #3926]  INFO -- : # Running tests:
I, [2021-09-25T05:04:15.657757 #3926]  INFO -- : 
I, [2021-09-25T05:04:18.655045 #3926]  INFO -- : Leaked file descriptor: DRbTests::TestDRbSSLCore#test_04: 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-25T05:04:18.655120 #3926]  INFO -- : Leaked file descriptor: DRbTests::TestDRbSSLCore#test_04: 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-25T05:04:18.703093 #3926]  INFO -- : COMMAND  PID USER   FD   TYPE DEVICE SIZE/OFF NODE NAME
I, [2021-09-25T05:04:18.703161 #3926]  INFO -- : ruby    8252  ko1    8r   CHR    1,9      0t0   11 /dev/urandom
I, [2021-09-25T05:04:18.703176 #3926]  INFO -- : ruby    8252  ko1    9r   CHR    1,8      0t0   10 /dev/random
I, [2021-09-25T05:04:27.997190 #3926]  INFO -- : Leaked file descriptor: TestNetHTTPS#test_get_SNI_proxy: 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-25T05:04:28.004343 #3926]  INFO -- : Leaked file descriptor: TestNetHTTPS#test_get_SNI_proxy: 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-25T05:04:28.053195 #3926]  INFO -- : COMMAND  PID USER   FD   TYPE DEVICE SIZE/OFF NODE NAME
I, [2021-09-25T05:04:28.053266 #3926]  INFO -- : ruby    8251  ko1   11r   CHR    1,9      0t0   11 /dev/urandom
I, [2021-09-25T05:04:28.053291 #3926]  INFO -- : ruby    8251  ko1   12r   CHR    1,8      0t0   10 /dev/random
I, [2021-09-25T05:04:29.092162 #3926]  INFO -- : .Leaked file descriptor: TestOpenURISSL#test_proxy_cacert_dir: 10 #<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-25T05:04:29.098071 #3926]  INFO -- : Leaked file descriptor: TestOpenURISSL#test_proxy_cacert_dir: 11 #<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-25T05:04:29.100383 #3926]  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-25T05:04:29.100557 #3926]  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-25T05:04:29.143873 #3926]  INFO -- : COMMAND  PID USER   FD   TYPE DEVICE SIZE/OFF NODE NAME
I, [2021-09-25T05:04:29.143932 #3926]  INFO -- : ruby    8246  ko1    9r   CHR    1,9      0t0   11 /dev/urandom
I, [2021-09-25T05:04:29.143955 #3926]  INFO -- : ruby    8246  ko1   10r   CHR    1,8      0t0   10 /dev/random
I, [2021-09-25T05:04:29.143975 #3926]  INFO -- : COMMAND  PID USER   FD   TYPE DEVICE SIZE/OFF NODE NAME
I, [2021-09-25T05:04:29.144022 #3926]  INFO -- : ruby    8247  ko1   10r   CHR    1,9      0t0   11 /dev/urandom
I, [2021-09-25T05:04:29.144043 #3926]  INFO -- : ruby    8247  ko1   11r   CHR    1,8      0t0   10 /dev/random
I, [2021-09-25T05:04:29.904338 #3926]  INFO -- : Leaked file descriptor: OpenSSL::TestPKCS7#test_set_type_encrypted: 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-25T05:04:29.904400 #3926]  INFO -- : Leaked file descriptor: OpenSSL::TestPKCS7#test_set_type_encrypted: 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-25T05:04:29.947910 #3926]  INFO -- : COMMAND  PID USER   FD   TYPE DEVICE SIZE/OFF NODE NAME
I, [2021-09-25T05:04:29.947978 #3926]  INFO -- : ruby    8250  ko1    9r   CHR    1,9      0t0   11 /dev/urandom
I, [2021-09-25T05:04:29.947997 #3926]  INFO -- : ruby    8250  ko1   10r   CHR    1,8      0t0   10 /dev/random
I, [2021-09-25T05:05:12.560758 #3926]  INFO -- : Leaked file descriptor: TestGemCommandsBuildCommand#test_build_signed_gem: 10 #<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-25T05:05:12.560831 #3926]  INFO -- : Leaked file descriptor: TestGemCommandsBuildCommand#test_build_signed_gem: 11 #<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-25T05:05:12.612996 #3926]  INFO -- : COMMAND  PID USER   FD   TYPE DEVICE SIZE/OFF NODE NAME
I, [2021-09-25T05:05:12.613060 #3926]  INFO -- : ruby    8253  ko1   10r   CHR    1,9      0t0   11 /dev/urandom
I, [2021-09-25T05:05:12.613083 #3926]  INFO -- : ruby    8253  ko1   11r   CHR    1,8      0t0   10 /dev/random
I, [2021-09-25T05:05:19.232267 #3926]  INFO -- : Leaked file descriptor: TestGemSecuritySigner#test_sign: 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-25T05:05:19.232347 #3926]  INFO -- : Leaked file descriptor: TestGemSecuritySigner#test_sign: 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-25T05:05:19.268276 #3926]  INFO -- : COMMAND  PID USER   FD   TYPE DEVICE SIZE/OFF NODE NAME
I, [2021-09-25T05:05:19.268356 #3926]  INFO -- : ruby    8248  ko1    7r   CHR    1,9      0t0   11 /dev/urandom
I, [2021-09-25T05:05:19.268383 #3926]  INFO -- : ruby    8248  ko1    8r   CHR    1,8      0t0   10 /dev/random
I, [2021-09-25T05:05:19.698128 #3926]  INFO -- : Leaked file descriptor: TestGemRemoteFetcher#test_download_local: 13 : #<TCPServer:fd 13, AF_INET, 0.0.0.0, 35253>
I, [2021-09-25T05:05:19.698196 #3926]  INFO -- : Leaked file descriptor: TestGemRemoteFetcher#test_download_local: 14 : #<TCPServer:fd 14, AF_INET6, ::, 35253>
I, [2021-09-25T05:05:19.698221 #3926]  INFO -- : Leaked file descriptor: TestGemRemoteFetcher#test_download_local: 15 : #<IO:fd 15>
I, [2021-09-25T05:05:19.698241 #3926]  INFO -- : Leaked file descriptor: TestGemRemoteFetcher#test_download_local: 16 : #<IO:fd 16>
I, [2021-09-25T05:05:19.747701 #3926]  INFO -- : COMMAND  PID USER   FD   TYPE     DEVICE SIZE/OFF       NODE NAME
I, [2021-09-25T05:05:19.747766 #3926]  INFO -- : ruby    8252  ko1   13u  IPv4 2777025554      0t0        TCP *:35253 (LISTEN)
I, [2021-09-25T05:05:19.747790 #3926]  INFO -- : ruby    8252  ko1   14u  IPv6 2777025555      0t0        TCP *:35253 (LISTEN)
I, [2021-09-25T05:05:19.747822 #3926]  INFO -- : ruby    8252  ko1   15r  FIFO       0,12      0t0 2777025556 pipe
I, [2021-09-25T05:05:19.747835 #3926]  INFO -- : ruby    8252  ko1   16w  FIFO       0,12      0t0 2777025556 pipe
I, [2021-09-25T05:05:19.802716 #3926]  INFO -- : Closed file descriptor: TestGemRemoteFetcher#test_fetch_s3_instance_profile_creds_with_token: 13
I, [2021-09-25T05:05:19.802787 #3926]  INFO -- : Closed file descriptor: TestGemRemoteFetcher#test_fetch_s3_instance_profile_creds_with_token: 14
I, [2021-09-25T05:05:19.802812 #3926]  INFO -- : Closed file descriptor: TestGemRemoteFetcher#test_fetch_s3_instance_profile_creds_with_token: 15
I, [2021-09-25T05:05:19.802831 #3926]  INFO -- : Closed file descriptor: TestGemRemoteFetcher#test_fetch_s3_instance_profile_creds_with_token: 16
I, [2021-09-25T05:05:25.306649 #3926]  INFO -- : 
I, [2021-09-25T05:05:25.306709 #3926]  INFO -- : Retrying...
I, [2021-09-25T05:05:25.514440 #3926]  INFO -- : Finished tests in 69.860478s, 306.3535 tests/s, 83391.5563 assertions/s.
I, [2021-09-25T05:05:25.515087 #3926]  INFO -- : 21402 tests, 5825774 assertions, 0 failures, 0 errors, 98 skips
I, [2021-09-25T05:05:25.515112 #3926]  INFO -- : 
I, [2021-09-25T05:05:25.515125 #3926]  INFO -- : ruby -v: ruby 3.1.0dev (2021-09-24T15:35:19Z master bbdfce96a2) [x86_64-linux]
I, [2021-09-25T05:05:25.516694 #3926]  INFO -- : $$$[end] "make yes-test-all TESTS='-j8'" exit with 0.
I, [2021-09-25T05:05:25.516790 #3926]  INFO -- : $$$[beg] make yes-test-rubyspec TESTS='-j8'
I, [2021-09-25T05:05:25.705354 #3926]  INFO -- : ruby 3.1.0dev (2021-09-24T15:35:19Z master bbdfce96a2) [x86_64-linux]
I, [2021-09-25T05:06:10.763761 #3926]  INFO -- : ........................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................
I, [2021-09-25T05:06:10.763830 #3926]  INFO -- : 
I, [2021-09-25T05:06:10.763845 #3926]  INFO -- : Finished in 45.058382 seconds
I, [2021-09-25T05:06:10.763856 #3926]  INFO -- : 
I, [2021-09-25T05:06:10.763866 #3926]  INFO -- : 3800 files, 30442 examples, 200789 expectations, 0 failures, 0 errors, 0 tagged
I, [2021-09-25T05:06:10.771588 #3926]  INFO -- : $$$[end] "make yes-test-rubyspec TESTS='-j8'" exit with 0.