Result of master@oci-aarch64 at 2025-06-19 12:34:40 +0900

• NG (3290d3d7f0)[LOG]
• test-all:
• test-spec:
• commands:

  "make update-download -j3" exit with 0.
  "make update-src      -j3" exit with 0.
  "make after-update    -j3" exit with 0.
  "make miniruby -j3" exit with 0.
  "make ruby -j3" exit with 0.
  "make all -j3" exit with 0.
  "make install -j3" exit with 0.
  make yes-btest TESTOPTS='-q -j3'
  $$$ #<Timeout::Error: execution expired>
  ### enter analyzing mode for stuck processes
  $$$ ps jx
     PPID     PID    PGID     SID TTY        TPGID STAT   UID   TIME COMMAND
        1    2547    2547    2547 ?             -1 Ss    1000   7:51 /usr/lib/systemd/systemd --user
     2547    2550    2547    2547 ?             -1 S     1000   0:00 (sd-pam)
        1    3030    3030    3030 ?             -1 Ss    1000   8:39 tmux
     3030    3031    3031    3031 pts/1     550734 Ss    1000   0:00 -bash
        1   51080  550734    3031 pts/1     550734 S+    1000   0:00 /home/opc/ruby/src/master/tool/lib/test/unit/parallel.rb: TestIOBuffer#test_shared
        1  104652  550734    3031 pts/1     550734 Sl+   1000   0:00 /home/opc/ruby/build/master/miniruby -I/home/opc/ruby/src/master/lib -I/home/opc/ruby/build/master -I/home/opc/ruby/build/master/.ext/common -r/home/opc/ruby/build/master/aarch64-linux-fake --disable-gems -W0 bootstraptest.test_ractor.rb_2256_1408.rb
        1  110879  550734    3031 pts/1     550734 S+    1000   0:00 /home/opc/ruby/src/master/tool/lib/test/unit/parallel.rb: TestBeginEndBlock#test_internal_errinfo_at_exit
        1  178643  550734    3031 pts/1     550734 S+    1000   0:00 /home/opc/ruby/src/master/tool/lib/test/unit/parallel.rb: TestIOBuffer#test_shared
   550734  353058  550734    3031 pts/1     550734 Sl+   1000   0:00 ruby ./br.rb build_report master --incremental
   353058  381659  550734    3031 pts/1     550734 Sl+   1000   0:00 ruby /home/opc/build-ruby/build-ruby.rb --target_name=master --logfile=/home/opc/ruby/logs/brlog.master.20250619-003428 --root_dir=/home/opc/ruby --timeout=10800 --configure_opts=--disable-dtrace --disable-yjit --incremental
        1  504419  550734    3031 pts/1     550734 S+    1000   0:00 /home/opc/ruby/src/master/tool/lib/test/unit/parallel.rb: TestTimeout#test_fork
     3031  550734  550734    3031 pts/1     550734 S+    1000   2:00 sh build-loop.sh master --incremental
        1  570281  550734    3031 pts/1     550734 S+    1000   0:00 /home/opc/ruby/src/master/tool/lib/test/unit/parallel.rb: TestProcess#test_daemon_detached
        1  583958  550734    3031 pts/1     550734 S+    1000   0:00 /home/opc/ruby/src/master/tool/lib/test/unit/parallel.rb: TestTimeout#test_fork
   381659  654092  550734    3031 pts/1     550734 S+    1000   0:00 make yes-btest TESTOPTS=-q -j3
   654092  657733  550734    3031 pts/1     550734 Sl+   1000   0:02 /usr/local/bin/ruby --disable=gems /home/opc/ruby/src/master/bootstraptest/runner.rb --ruby=./miniruby -I/home/opc/ruby/src/master/lib -I. -I.ext/common  -r./aarch64-linux-fake --disable-gems -q -j3
   657733  767455  550734    3031 pts/1     550734 Z+    1000   0:00 [miniruby] <defunct>
        1  767462  550734    3031 pts/1     550734 Sl+   1000   0:00 /home/opc/ruby/build/master/miniruby -I/home/opc/ruby/src/master/lib -I/home/opc/ruby/build/master -I/home/opc/ruby/build/master/.ext/common -r/home/opc/ruby/build/master/aarch64-linux-fake --disable-gems -W0 bootstraptest.test_ractor.rb_2013_1395.rb
        1  805450  550734    3031 pts/1     550734 S+    1000   0:00 /home/opc/ruby/src/master/tool/lib/test/unit/parallel.rb: TestProcess#test_daemon_noclose
        1  968356  550734    3031 pts/1     550734 S+    1000   0:00 /home/opc/ruby/src/master/tool/lib/test/unit/parallel.rb: JSONGeneratorTest#test_broken_bignum
        1 1010816  550734    3031 pts/1     550734 Sl+   1000   0:00 /home/opc/ruby/build/master/miniruby -I/home/opc/ruby/src/master/lib -I/home/opc/ruby/build/master -I/home/opc/ruby/build/master/.ext/common -r/home/opc/ruby/build/master/aarch64-linux-fake --disable-gems -W0 bootstraptest.test_ractor.rb_2226_1406.rb
        1 1168951  550734    3031 pts/1     550734 Sl+   1000   0:00 /home/opc/ruby/build/master/miniruby -I/home/opc/ruby/src/master/lib -I/home/opc/ruby/build/master -I/home/opc/ruby/build/master/.ext/common -r/home/opc/ruby/build/master/aarch64-linux-fake --disable-gems -W0 bootstraptest.test_ractor.rb_2226_1406.rb
        1 1279056  550734    3031 pts/1     550734 S+    1000   0:00 /home/opc/ruby/src/master/tool/lib/test/unit/parallel.rb: TestIOBuffer#test_shared
        1 1479478  550734    3031 pts/1     550734 Sl+   1000   0:00 /home/opc/ruby/build/master/miniruby -I/home/opc/ruby/src/master/lib -I/home/opc/ruby/build/master -I/home/opc/ruby/build/master/.ext/common -r/home/opc/ruby/build/master/aarch64-linux-fake --disable-gems -W0 bootstraptest.test_ractor.rb_2013_1395.rb
        1 1499050  550734    3031 pts/1     550734 S+    1000   0:00 /home/opc/ruby/src/master/tool/lib/test/unit/parallel.rb: TestTimeout#test_fork
        1 1904634 2286718    3031 pts/1     550734 S     1000   0:00 /home/opc/ruby/src/master/tool/lib/test/unit/parallel.rb: JSONGeneratorTest#test_broken_bignum
        1 2058937  550734    3031 pts/1     550734 S+    1000   0:00 /home/opc/ruby/src/master/tool/lib/test/unit/parallel.rb: TestFiberProcess#test_fork
        1 2135572  550734    3031 pts/1     550734 Rl+   1000 12072:24 /home/opc/ruby/build/master/ruby --parser=prism -W0
   381659 2623800  550734    3031 pts/1     550734 R+    1000   0:00 ps jx
        1 2813263  550734    3031 pts/1     550734 S+    1000   0:00 /home/opc/ruby/src/master/tool/lib/test/unit/parallel.rb: TestAutoload#test_autoload_fork
        1 2964324 2286718    3031 pts/1     550734 S     1000   0:00 /home/opc/ruby/src/master/tool/lib/test/unit/parallel.rb: TestIOBuffer#test_shared
        1 2977397  550734    3031 pts/1     550734 S+    1000   0:00 /home/opc/ruby/src/master/tool/lib/test/unit/parallel.rb: TestSyslog#test_log
        1 3028846  550734    3031 pts/1     550734 S+    1000   0:00 /home/opc/ruby/src/master/tool/lib/test/unit/parallel.rb: TestIOBuffer#test_shared
        1 3195009 2286718    3031 pts/1     550734 S     1000   0:00 /home/opc/ruby/src/master/tool/lib/test/unit/parallel.rb: TestSyslog#test_log
        1 3220787  550734    3031 pts/1     550734 Sl+   1000   0:00 /home/opc/ruby/build/master/miniruby -I/home/opc/ruby/src/master/lib -I/home/opc/ruby/build/master -I/home/opc/ruby/build/master/.ext/common -r/home/opc/ruby/build/master/aarch64-linux-fake --disable-gems -W0 bootstraptest.test_ractor.rb_2013_1394.rb
        1 3524312  550734    3031 pts/1     550734 S+    1000   0:00 /home/opc/ruby/src/master/tool/lib/test/unit/parallel.rb: TestSyslog#test_log
        1 3700981  550734    3031 pts/1     550734 S+    1000   0:00 /home/opc/ruby/src/master/tool/lib/test/unit/parallel.rb: TestSyslog#test_log
        1 3841424  550734    3031 pts/1     550734 Sl+   1000   0:00 /home/opc/ruby/build/master/miniruby -I/home/opc/ruby/src/master/lib -I/home/opc/ruby/build/master -I/home/opc/ruby/build/master/.ext/common -r/home/opc/ruby/build/master/aarch64-linux-fake --disable-gems -W0 bootstraptest.test_ractor.rb_2013_1394.rb
  {1=>[2547, 3030, 51080, 104652, 110879, 178643, 504419, 570281, 583958, 767462, 805450, 968356, 1010816, 1168951, 1279056, 1479478, 1499050, 1904634, 2058937, 2135572, 2813263, 2964324, 2977397, 3028846, 3195009, 3220787, 3524312, 3700981, 3841424], 2547=>[2550], 3030=>[3031], 550734=>[353058], 353058=>[381659], 3031=>[550734], 381659=>[654092, 2623800], 654092=>[657733], 657733=>[767455]}
  $ timeout 60 gdb -p 767455 -x /home/opc/build-ruby/gdbscript -batch -quiet 2> /dev/null
  >>> Threads
  No threads.
  >>> Machine level backtrace
  >>> Dump Ruby level backtrace (if possible)
  $ timeout 60 gdb -p 657733 -x /home/opc/build-ruby/gdbscript -batch -quiet 2> /dev/null
  [New LWP 661566]
  [New LWP 661586]
  [New LWP 661691]
  [Thread debugging using libthread_db enabled]
  Using host libthread_db library "/lib64/libthread_db.so.1".
  0x0000fffc009bed20 in ppoll () from /lib64/libc.so.6
  >>> Threads
    Id   Target Id                                          Frame 
  * 1    Thread 0xfffc012f6140 (LWP 657733) "ruby"          0x0000fffc009bed20 in ppoll () from /lib64/libc.so.6
    2    Thread 0xfffbfb57f140 (LWP 661566) "runner.rb:334" 0x0000fffc00a8dd80 in pthread_cond_wait@@GLIBC_2.17 () from /lib64/libpthread.so.0
    3    Thread 0xfffbfa7ef140 (LWP 661586) "runner.rb:546" 0x0000fffc009bec04 in poll () from /lib64/libc.so.6
    4    Thread 0xfffbfa5df140 (LWP 661691) "runner.rb:636" 0x0000fffc009bec04 in poll () from /lib64/libc.so.6
  >>> Machine level backtrace
  Thread 4 (Thread 0xfffbfa5df140 (LWP 661691)):
  #0  0x0000fffc009bec04 in poll () from /lib64/libc.so.6
  No symbol table info available.
  Thread 3 (Thread 0xfffbfa7ef140 (LWP 661586)):
  #0  0x0000fffc009bec04 in poll () from /lib64/libc.so.6
  No symbol table info available.
  Thread 2 (Thread 0xfffbfb57f140 (LWP 661566)):
  #0  0x0000fffc00a8dd80 in pthread_cond_wait@@GLIBC_2.17 () from /lib64/libpthread.so.0
  No symbol table info available.
  Thread 1 (Thread 0xfffc012f6140 (LWP 657733)):
  #0  0x0000fffc009bed20 in ppoll () from /lib64/libc.so.6
  No symbol table info available.
  >>> Dump Ruby level backtrace (if possible)
   th: 0x22061150, native_id: 0xfffc012f6140
  -- Control frame information -----------------------------------------------
  c:0012 p:0023 s:0074 e:000073 METHOD <internal:thread_sync>:18
  c:0011 p:0062 s:0067 E:002450 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:356
  c:0010 p:0052 s:0057 e:000056 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:438
  c:0009 p:0005 s:0049 e:000048 BLOCK  /home/opc/ruby/src/master/bootstraptest/runner.rb:311
  c:0008 p:0002 s:0046 e:000045 BLOCK  /home/opc/ruby/src/master/bootstraptest/runner.rb:855 [FINISH]
  c:0007 p:---- s:0043 e:000042 CFUNC  :chdir
  c:0006 p:0007 s:0038 e:000037 BLOCK  /home/opc/ruby/src/master/bootstraptest/runner.rb:854
  c:0005 p:0047 s:0034 e:000033 METHOD /usr/local/lib/ruby/3.2.0/tmpdir.rb:94
  c:0004 p:0030 s:0024 e:000023 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:853
  c:0003 p:0624 s:0019 e:000018 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:310
  c:0002 p:0217 s:0008 E:002508 EVAL   /home/opc/ruby/src/master/bootstraptest/runner.rb:894 [FINISH]
  c:0001 p:0000 s:0003 E:000a20 DUMMY  [FINISH]
  th: 0x222bb3a0, native_id: 0xfffbfb57f140
  -- Control frame information -----------------------------------------------
  c:0009 p:---- s:0056 e:000055 CFUNC  :value
  c:0008 p:0042 s:0052 E:0005d8 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:552
  c:0007 p:0130 s:0043 E:000cb8 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:580
  c:0006 p:0010 s:0034 e:000033 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:384
  c:0005 p:0014 s:0022 E:001a08 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:536
  c:0004 p:0011 s:0015 E:000b18 BLOCK  /home/opc/ruby/src/master/bootstraptest/runner.rb:678
  c:0003 p:0006 s:0011 e:000010 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:532
  c:0002 p:0011 s:0007 e:000006 BLOCK  /home/opc/ruby/src/master/bootstraptest/runner.rb:336 [FINISH]
  c:0001 p:---- s:0003 e:000002 DUMMY  [FINISH]
  th: 0xfffbe404dd30, native_id: 0xfffbfa7ef140
  -- Control frame information -----------------------------------------------
  c:0003 p:---- s:0010 e:000009 CFUNC  :read
  c:0002 p:0004 s:0006 e:000005 BLOCK  /home/opc/ruby/src/master/bootstraptest/runner.rb:546 [FINISH]
  c:0001 p:---- s:0003 e:000002 DUMMY  [FINISH]
  th: 0xfffbe4011c90, native_id: 0xfffbfa5df140
  -- Control frame information -----------------------------------------------
  c:0003 p:---- s:0010 e:000009 CFUNC  :read
  c:0002 p:0004 s:0006 e:000005 BLOCK  /home/opc/ruby/src/master/bootstraptest/runner.rb:636 [FINISH]
  c:0001 p:---- s:0003 e:000002 DUMMY  [FINISH]
  [Inferior 1 (process 657733) detached]
  $ timeout 60 gdb -p 654092 -x /home/opc/build-ruby/gdbscript -batch -quiet 2> /dev/null
  make: *** [uncommon.mk:910: yes-btest] Killed
  >>> Threads
  No threads.
  >>> Machine level backtrace
  >>> Dump Ruby level backtrace (if possible)
  $ timeout 60 gdb -p 2623800 -x /home/opc/build-ruby/gdbscript -batch -quiet 2> /dev/null
  >>> Threads
  No threads.
  >>> Machine level backtrace
  >>> Dump Ruby level backtrace (if possible)
  #<Errno::ESRCH: No such process>
  

• Linux oci-aarch64 5.4.17-2136.314.6.2.el8uek.aarch64 #2 SMP Fri Dec 9 16:22:23 PST 2022 aarch64 aarch64 aarch64 GNU/Linux
  

• Logfile: /home/opc/ruby/logs/brlog.master.20250619-003428
  #<BuildRuby:0x0000fffda9adfdc0
   @BUILD_DIR="/home/opc/ruby/build",
   @INSTALL_DIR="/home/opc/ruby/install",
   @REPOSITORY="https://github.com/ruby/ruby.git",
   @REPOSITORY_TYPE=:git,
   @SRC_DIR="/home/opc/ruby/src",
   @TARGET_BUILD_DIR="/home/opc/ruby/build/master",
   @TARGET_INSTALL_DIR="/home/opc/ruby/install/master",
   @TARGET_NAME="master",
   @TARGET_SRC_DIR="/home/opc/ruby/src/master",
   @btest_opts="-j3",
   @build_opts="-j3",
   @configure_opts=["--disable-dtrace --disable-yjit"],
   @gist=false,
   @git_branch=nil,
   @git_tag=nil,
   @git_worktree=nil,
   @incremental=true,
   @logfile="/home/opc/ruby/logs/brlog.master.20250619-003428",
   @make="make",
   @no_timeout_error=nil,
   @quiet=false,
   @ruby_env=[["RUBY_DEBUG", "ci"]],
   @spec_opts="-j",
   @steps=
    ["checkout",
     "autoconf",
     "configure",
     "build_up",
     "build_miniruby",
     "build_ruby",
     "build_all",
     "build_install",
     "test_btest",
     "test_basic",
     "test_all",
     "test_rubyspec"],
   @svn_revision=nil,
   @test_opts="TESTS='-j3'",
   @timeout=10800>
                             user     system      total        real
  checkout               0.000016   0.000001   0.000017 (  0.000016)
  autoconf               0.000030   0.000001   0.000031 (  0.000031)
  configure              0.000019   0.000001   0.000020 (  0.000020)
  build_up               0.004909   0.000256   1.994586 (  1.834446)
  build_miniruby         0.001088   0.000057   1.200619 (  1.204249)
  build_ruby             0.001500   0.000000   1.812784 (  3.800483)
  build_all              0.006774   0.000000   3.152446 (  1.785716)
  build_install          0.003190   0.012168   4.486234 (  2.546235)
  test_btest             0.000956   0.007312  34.924556 (10800.815774)
  /home/opc/build-ruby/build-ruby.rb:223:in `join': execution expired (Timeout::Error)
  	from /home/opc/build-ruby/build-ruby.rb:223:in `each'
  	from /home/opc/build-ruby/build-ruby.rb:223:in `block (2 levels) in cmd'
  	from /usr/local/lib/ruby/3.2.0/timeout.rb:189:in `block in timeout'
  	from /usr/local/lib/ruby/3.2.0/timeout.rb:36:in `block in catch'
  	from /usr/local/lib/ruby/3.2.0/timeout.rb:36:in `catch'
  	from /usr/local/lib/ruby/3.2.0/timeout.rb:36:in `catch'
  	from /usr/local/lib/ruby/3.2.0/timeout.rb:198:in `timeout'
  	from /home/opc/build-ruby/build-ruby.rb:222:in `block in cmd'
  	from /home/opc/build-ruby/build-ruby.rb:214:in `popen'
  	from /home/opc/build-ruby/build-ruby.rb:214:in `cmd'
  	from /home/opc/build-ruby/build-ruby.rb:389:in `block in test_btest'
  	from /home/opc/build-ruby/build-ruby.rb:322:in `block in builddir'
  	from /home/opc/build-ruby/build-ruby.rb:321:in `chdir'
  	from /home/opc/build-ruby/build-ruby.rb:321:in `builddir'
  	from /home/opc/build-ruby/build-ruby.rb:388:in `test_btest'
  	from /home/opc/build-ruby/build-ruby.rb:464:in `block (4 levels) in run'
  	from /usr/local/lib/ruby/3.2.0/benchmark.rb:296:in `measure'
  	from /usr/local/lib/ruby/3.2.0/benchmark.rb:378:in `item'
  	from /home/opc/build-ruby/build-ruby.rb:462:in `block (3 levels) in run'
  	from /home/opc/build-ruby/build-ruby.rb:461:in `each'
  	from /home/opc/build-ruby/build-ruby.rb:461:in `block (2 levels) in run'
  	from /usr/local/lib/ruby/3.2.0/benchmark.rb:176:in `benchmark'
  	from /usr/local/lib/ruby/3.2.0/benchmark.rb:208:in `bm'
  	from /home/opc/build-ruby/build-ruby.rb:460:in `block in run'
  	from /usr/local/lib/ruby/3.2.0/benchmark.rb:296:in `measure'
  	from /home/opc/build-ruby/build-ruby.rb:459:in `run'
  	from /home/opc/build-ruby/build-ruby.rb:659:in `<main>'
  total: 10811.99 sec