Result of master@oci-aarch64 at 2025-07-30 22:52:24 +0900

• NG (cbe5241c77)[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   8:25 /usr/lib/systemd/systemd --user
     2547    2550    2547    2547 ?             -1 S     1000   0:00 (sd-pam)
        1    3030    3030    3030 ?             -1 Ss    1000   9:12 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
        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:07 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
        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 1668105  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_2030_1396.rb
        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 Sl+   1000 32538:59 /home/opc/ruby/build/master/ruby --parser=prism -W0
   550734 2300639  550734    3031 pts/1     550734 Sl+   1000   0:00 ruby ./br.rb build_report master --incremental
  2300639 2328397  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.20250730-105211 --root_dir=/home/opc/ruby --timeout=10800 --configure_opts=--disable-dtrace --disable-yjit --incremental
  2328397 2603233  550734    3031 pts/1     550734 S+    1000   0:00 make yes-btest TESTOPTS=-q -j3
  2603233 2606861  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
        1 2725834  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
  2606861 2755859  550734    3031 pts/1     550734 Z+    1000   0:00 [miniruby] <defunct>
        1 2755875  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_2118_1402.rb
        1 2769870  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_2118_1402.rb
        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 3126227  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_2030_1396.rb
        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 4053980  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
  2328397 4061237  550734    3031 pts/1     550734 R+    1000   0:00 ps jx
  {1=>[2547, 3030, 51080, 104652, 110879, 178643, 504419, 570281, 583958, 767462, 805450, 968356, 1010816, 1168951, 1279056, 1479478, 1499050, 1668105, 1904634, 2058937, 2135572, 2725834, 2755875, 2769870, 2813263, 2964324, 2977397, 3028846, 3126227, 3195009, 3220787, 3524312, 3700981, 3841424, 4053980], 2547=>[2550], 3030=>[3031], 3031=>[550734], 550734=>[2300639], 2300639=>[2328397], 2328397=>[2603233, 4061237], 2603233=>[2606861], 2606861=>[2755859]}
  $ timeout 60 gdb -p 2755859 -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 2606861 -x /home/opc/build-ruby/gdbscript -batch -quiet 2> /dev/null
  [New LWP 2610801]
  [New LWP 2610822]
  [New LWP 2610832]
  [Thread debugging using libthread_db enabled]
  Using host libthread_db library "/lib64/libthread_db.so.1".
  0x0000fffbf214ed20 in ppoll () from /lib64/libc.so.6
  >>> Threads
    Id   Target Id                                           Frame 
  * 1    Thread 0xfffbf2a86140 (LWP 2606861) "ruby"          0x0000fffbf214ed20 in ppoll () from /lib64/libc.so.6
    2    Thread 0xfffbecf1f140 (LWP 2610801) "runner.rb:334" 0x0000fffbf221dd80 in pthread_cond_wait@@GLIBC_2.17 () from /lib64/libpthread.so.0
    3    Thread 0xfffbec39f140 (LWP 2610822) "runner.rb:546" 0x0000fffbf214ec04 in poll () from /lib64/libc.so.6
    4    Thread 0xfffbdf9cf140 (LWP 2610832) "runner.rb:638" 0x0000fffbf214ec04 in poll () from /lib64/libc.so.6
  >>> Machine level backtrace
  Thread 4 (Thread 0xfffbdf9cf140 (LWP 2610832)):
  #0  0x0000fffbf214ec04 in poll () from /lib64/libc.so.6
  No symbol table info available.
  Thread 3 (Thread 0xfffbec39f140 (LWP 2610822)):
  #0  0x0000fffbf214ec04 in poll () from /lib64/libc.so.6
  No symbol table info available.
  Thread 2 (Thread 0xfffbecf1f140 (LWP 2610801)):
  #0  0x0000fffbf221dd80 in pthread_cond_wait@@GLIBC_2.17 () from /lib64/libpthread.so.0
  No symbol table info available.
  Thread 1 (Thread 0xfffbf2a86140 (LWP 2606861)):
  #0  0x0000fffbf214ed20 in ppoll () from /lib64/libc.so.6
  No symbol table info available.
  >>> Dump Ruby level backtrace (if possible)
   th: 0x15691150, native_id: 0xfffbf2a86140
  -- Control frame information -----------------------------------------------
  c:0012 p:0023 s:0074 e:000073 METHOD <internal:thread_sync>:18
  c:0011 p:0062 s:0067 E:000ef0 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:861 [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:860
  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:859
  c:0003 p:0624 s:0019 e:000018 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:310
  c:0002 p:0220 s:0008 E:000a78 EVAL   /home/opc/ruby/src/master/bootstraptest/runner.rb:904 [FINISH]
  c:0001 p:0000 s:0003 E:001ac0 DUMMY  [FINISH]
  th: 0x15899d50, native_id: 0xfffbecf1f140
  -- Control frame information -----------------------------------------------
  c:0009 p:---- s:0056 e:000055 CFUNC  :value
  c:0008 p:0042 s:0052 E:000168 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:552
  c:0007 p:0130 s:0043 E:0018b8 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:000e58 METHOD /home/opc/ruby/src/master/bootstraptest/runner.rb:536
  c:0004 p:0011 s:0015 E:000f88 BLOCK  /home/opc/ruby/src/master/bootstraptest/runner.rb:684
  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: 0xfffbe80de280, native_id: 0xfffbec39f140
  -- 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: 0xfffbe803fd00, native_id: 0xfffbdf9cf140
  -- 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:638 [FINISH]
  c:0001 p:---- s:0003 e:000002 DUMMY  [FINISH]
  [Inferior 1 (process 2606861) detached]
  $ timeout 60 gdb -p 2603233 -x /home/opc/build-ruby/gdbscript -batch -quiet 2> /dev/null
  make: *** [uncommon.mk:913: yes-btest] Killed
  >>> Threads
  No threads.
  >>> Machine level backtrace
  >>> Dump Ruby level backtrace (if possible)
  $ timeout 60 gdb -p 4061237 -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.20250730-105211
  #<BuildRuby:0x0000fffc7e81fdc8
   @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.20250730-105211",
   @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.000013   0.000002   0.000015 (  0.000015)
  autoconf               0.000022   0.000004   0.000026 (  0.000025)
  configure              0.000012   0.000002   0.000014 (  0.000014)
  build_up               0.004738   0.000791   2.141048 (  1.847665)
  build_miniruby         0.001267   0.000000   1.262609 (  1.267402)
  build_ruby             0.001640   0.000000   1.871911 (  4.186579)
  build_all              0.007159   0.000000   3.192742 (  1.670524)
  build_install          0.008342   0.008761   4.745583 (  2.791499)
  test_btest             0.008519   0.000050  37.326824 (10801.065788)
  /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: 10812.83 sec