ruby-dev

チケット #4121 が更新されました。 (by Tomoyuki Chikanaga)


うちでも起きる環境と起きない環境がありました。

起きない
  RHEL ES 3.8 Kernel 2.4.21-47.ELsmp, Xeon 5160(2core) x 2CPU
  Ubuntu 9.04 Kernel 2.6.28-19-generic, Pentium4 x 1CPU

起きる
  RHEL ES 4.8 Kernel 2.6.9-89.ELlargesmp, Xeon X5570(2core) x 4CPU

起きた時に子プロセスのほうに gdb attach して確認してみました。
スタックトレースを最後に貼ります。

gvl_acquire での l.90 あたりの native_cond_wait で固まってますが、ここに入るのがおかしくて

(gdb) p vm->gvl.waiting_threads
$2 = (struct rb_thread_struct * volatile) 0x832f8b8
(gdb) p th
$3 = (rb_thread_t *) 0x82117a0
(gdb) p vm->gvl.acquired
$4 = 0
(gdb) p th->thread_id
$5 = 4160292544
(gdb) p vm->gvl.waiting_threads->thread_id
$6 = 4156005280
(gdb) info thread
  2 Thread 4156771232 (LWP 18806)  0xffffe410 in __kernel_vsyscall ()
* 1 Thread 4160292544 (LWP 18804)  0xffffe410 in __kernel_vsyscall ()

(gdb) p vm->gvl.waiting_threads->native_thread_data.gvl_next
$7 = (struct rb_thread_struct *) 0x82117a0
(gdb) p vm->gvl.waiting_threads->native_thread_data.gvl_next->thread_id
$8 = 4160292544
(gdb) p vm->gvl.waiting_threads->native_thread_data.gvl_next->native_thread_data.gvl_next
$9 = (struct rb_thread_struct *) 0x0

と、おそらく vm->gvl_waiting_threads が fork 後に破棄された rb_thread_t を見ているような感じです。

以下、スタックトレースを貼ります。
#0  0xffffe410 in __kernel_vsyscall ()
#1  0x00837cf6 in pthread_cond_wait@@GLIBC_2.3.2 ()
   from /lib/tls/libpthread.so.0
#2  0x0814759b in native_cond_wait (cond=0x8211824, mutex=0x82114f4)
    at thread_pthread.c:266
#3  0x08147297 in gvl_acquire (vm=0x82114f0, th=0x82117a0)
    at thread_pthread.c:90
#4  0x08149478 in blocking_region_end (th=0x82117a0, region=0xffffa398)
    at thread.c:1048
#5  0x0814a950 in do_select (n=11, read=0x0, write=0x84aa728, except=0x0,
    timeout=0x0) at thread.c:2521
#6  0x0814aaba in rb_thread_wait_fd_rw (fd=10, read=0) at thread.c:2575
#7  0x0814ab1b in rb_thread_fd_writable (fd=10) at thread.c:2597
#8  0x0806a4ba in io_fflush (fptr=0x83365a0) at io.c:676
#9  0x0806b0aa in rb_io_flush (io=137483980) at io.c:1091
#10 0x080ac18e in rb_fork_err (status=0x0, chfunc=0xf7bfc599 <chfunc>,
    charg=0xffffa6ac, fds=4, errmsg=0xffffa68c "", errmsg_buflen=32)
    at process.c:2575
#11 0xf7bfc768 in establishShell (argc=1, argv=0xf7c351bc, info=0xffffa710,
    SlaveName=0xffffa700 "/dev/pts/21") at pty.c:248
#12 0xf7bfd261 in pty_getpty (argc=1, argv=0xf7c351bc, self=137648620)
    at pty.c:545
#13 0x08134070 in call_cfunc (func=0xf7bfcf07 <pty_getpty>, recv=137648620,
    len=-1, argc=1, argv=0xf7c351bc) at vm_insnhelper.c:316
#14 0x081349b4 in vm_call_cfunc (th=0x82117a0, reg_cfp=0xf7cb4bbc, num=1,
    recv=137648620, blockptr=0x0, me=0x849b1a8) at vm_insnhelper.c:403
#15 0x08134e7e in vm_call_method (th=0x82117a0, cfp=0xf7cb4bbc, num=1,
    blockptr=0x0, flag=0, id=16952, me=0x849b1a8, recv=137648620)
    at vm_insnhelper.c:525
#16 0x081394c7 in vm_exec_core (th=0x82117a0, initial=0) at insns.def:1010
#17 0x081442d0 in vm_exec (th=0x82117a0) at vm.c:1150
#18 0x08142fd9 in invoke_block_from_c (th=0x82117a0, block=0xf7cb4d88,
    self=138349680, argc=1, argv=0xffffb170, blockptr=0x0, cref=0x0)
    at vm.c:561
#19 0x081430ea in vm_yield (th=0x82117a0, argc=1, argv=0xffffb170) at vm.c:591
#20 0x081404af in rb_yield_0 (argc=1, argv=0xffffb170) at vm_eval.c:740
#21 0x081404e8 in rb_yield (val=137536340) at vm_eval.c:750
#22 0x081597f7 in rb_ary_collect (ary=137536260) at array.c:2160
#23 0x08134080 in call_cfunc (func=0x8159756 <rb_ary_collect>, recv=137536260,
    len=0, argc=0, argv=0xf7c35108) at vm_insnhelper.c:319
#24 0x081349b4 in vm_call_cfunc (th=0x82117a0, reg_cfp=0xf7cb4d74, num=0,
    recv=137536260, blockptr=0xf7cb4d88, me=0x8272d40) at vm_insnhelper.c:403
#25 0x08134e7e in vm_call_method (th=0x82117a0, cfp=0xf7cb4d74, num=0,
    blockptr=0xf7cb4d88, flag=0, id=1568, me=0x8272d40, recv=137536260)
    at vm_insnhelper.c:525
#26 0x081394c7 in vm_exec_core (th=0x82117a0, initial=0) at insns.def:1010
#27 0x081442d0 in vm_exec (th=0x82117a0) at vm.c:1150
#28 0x08142fd9 in invoke_block_from_c (th=0x82117a0, block=0xf7cb4e38,
    self=138349680, argc=1, argv=0xffffbbd0, blockptr=0x0, cref=0x0)
    at vm.c:561
#29 0x081430ea in vm_yield (th=0x82117a0, argc=1, argv=0xffffbbd0) at vm.c:591
#30 0x081404af in rb_yield_0 (argc=1, argv=0xffffbbd0) at vm_eval.c:740
#31 0x081404e8 in rb_yield (val=137648400) at vm_eval.c:750
#32 0x0815793d in rb_ary_each (ary=137546080) at array.c:1429
#33 0x08134080 in call_cfunc (func=0x81578cb <rb_ary_each>, recv=137546080,
    len=0, argc=0, argv=0xf7c350c0) at vm_insnhelper.c:319
#34 0x081349b4 in vm_call_cfunc (th=0x82117a0, reg_cfp=0xf7cb4e24, num=0,
    recv=137546080, blockptr=0xf7cb4e38, me=0x82725a8) at vm_insnhelper.c:403
#35 0x08134e7e in vm_call_method (th=0x82117a0, cfp=0xf7cb4e24, num=0,
    blockptr=0xf7cb4e38, flag=0, id=424, me=0x82725a8, recv=137546080)
    at vm_insnhelper.c:525
#36 0x081394c7 in vm_exec_core (th=0x82117a0, initial=0) at insns.def:1010
#37 0x081442d0 in vm_exec (th=0x82117a0) at vm.c:1150
#38 0x08142fd9 in invoke_block_from_c (th=0x82117a0, block=0xf7cb4f40,
    self=138349680, argc=1, argv=0xffffc630, blockptr=0x0, cref=0x0)
    at vm.c:561
#39 0x081430ea in vm_yield (th=0x82117a0, argc=1, argv=0xffffc630) at vm.c:591
#40 0x081404af in rb_yield_0 (argc=1, argv=0xffffc630) at vm_eval.c:740
#41 0x081404e8 in rb_yield (val=137647980) at vm_eval.c:750
#42 0x0815793d in rb_ary_each (ary=137546320) at array.c:1429
#43 0x08134080 in call_cfunc (func=0x81578cb <rb_ary_each>, recv=137546320,
    len=0, argc=0, argv=0xf7c35054) at vm_insnhelper.c:319
#44 0x081349b4 in vm_call_cfunc (th=0x82117a0, reg_cfp=0xf7cb4f2c, num=0,
    recv=137546320, blockptr=0xf7cb4f40, me=0x82725a8) at vm_insnhelper.c:403
#45 0x08134e7e in vm_call_method (th=0x82117a0, cfp=0xf7cb4f2c, num=0,
    blockptr=0xf7cb4f40, flag=0, id=424, me=0x82725a8, recv=137546320)
    at vm_insnhelper.c:525
#46 0x081394c7 in vm_exec_core (th=0x82117a0, initial=0) at insns.def:1010
#47 0x081442d0 in vm_exec (th=0x82117a0) at vm.c:1150
#48 0x08144aa6 in rb_iseq_eval_main (iseqval=136494340) at vm.c:1391
#49 0x08059780 in ruby_exec_internal (n=0x822bd04) at eval.c:225
#50 0x08059867 in ruby_exec_node (n=0x822bd04) at eval.c:272
#51 0x08059841 in ruby_run_node (n=0x822bd04) at eval.c:265
#52 0x080583ae in main (argc=4, argv=0xffffd1b4) at main.c:38

----------------------------------------
http://redmine.ruby-lang.org/issues/show/4121

----------------------------------------
http://redmine.ruby-lang.org

Thread

Prev Next

In This Thread

Prev Next

[#42666] Errno::EINTR: Interrupted system call on console#echo= — SASADA Koichi <ko1@...>

[#42668] [Ruby 1.9-Bug#4109][Open] test_timeout.rbが失敗する — Kouhei Yanagita <redmine@...>

[#42670] webrick log remote port: %{remote}p — Tanaka Akira <akr@...>

[#42672] [Ruby 1.9-Bug#4110][Open] ホスト名の先頭が数字であるとき、WEBrickのテストでErrorが出る — Kouhei Yanagita <redmine@...>

[#42674] [Ruby 1.9-Bug#4112][Assigned] StringIO#gets(limit) returns incomplete string — Nobuyoshi Nakada <redmine@...>

[#42677] Fwd: [ruby-list:47675] Bignum#* を Toom3 乗法に対応させる patch — Kenta Murata <muraken@...>

[#42679] ruby -x で実行すると行がずれる？ — "KISHIMOTO, Makoto" <ksmakoto@...4u.or.jp>

[#42680] [Ruby 1.9-Bug#4118][Open] ruby -x で実行すると行がずれる — Makoto Kishimoto <redmine@...>

[#42681] Re: Enumerable#categorize — Yukihiro Matsumoto <matz@...>

[#42684] [Ruby 1.9-Bug#4120][Assigned] 2 failures on test/mkmf/test_convertible.rb — Usaku NAKAMURA <redmine@...>

[#42686] [Ruby 1.9-Bug#4121][Open] test_getpty_nonexistentで止まることがある — Kouhei Yanagita <redmine@...>

[#42687] [Ruby 1.9-Bug#4122][Open] test_x509store.rbのtest_set_errorsが失敗する — Kouhei Yanagita <redmine@...>

[#42690] [Ruby 1.9-Bug#4124][Open] optparse: needless argument: --help=zshcomplete=COMMAND — Kazuhiro NISHIYAMA <redmine@...>

[#42692] [Feature: trunk] String#encode(:fallback) should accept default handler — SASADA Koichi <ko1@...>

[#42693] [Ruby 1.9-Bug#4126][Assigned] Pathname#+ サブクラスの場合 — Shyouhei Urabe <redmine@...>

[#42696] [Ruby 1.9-Bug#4128][Open] String#kconvでfrom_encを指定していないときにString#encodingを使うようになっていない — Kouhei Yanagita <redmine@...>

[#42701] 1.9.x release and trunk branch policy — Yusuke ENDOH <mame@...>

[#42716] [Ruby 1.9-Bug#4129][Open] multi-tk を require すると、おかしい — Makoto Kishimoto <redmine@...>

[#42718] [Ruby 1.9-Bug#4130][Assigned] wrong line number with shadowing and unused variable — Nobuyoshi Nakada <redmine@...>

[#42719] [Ruby 1.9-Bug#4131][Assigned] can't set length of shared string error in IO#read — Masaya Tarui <redmine@...>

[#42722] [Ruby 1.9-Bug#4134][Open] assigned but unused variable — Kouhei Yanagita <redmine@...>

[#42724] [Ruby 1.9-Bug#4137][Assigned] Test Failure because of assigned but unused variable: ruby/test_rubyoptions.rb — Yui NARUSE <redmine@...>

[#42725] [Ruby 1.9-Bug#4138][Assigned] Test Failure because of method redefined: test/irb/test_option.rb — Yui NARUSE <redmine@...>

[#42729] [Ruby 1.9-Feature#4142][Open] multipart/form-data for net/http — Yui NARUSE <redmine@...>

[#42730] [Ruby 1.9-Bug#4143][Open] warning: "SUPPORT_JOKE" is not defined — Kazuhiro NISHIYAMA <redmine@...>

[#42731] [Ruby 1.9-Bug#4144][Open] check_signedness("size_t") — Kazuhiro NISHIYAMA <redmine@...>

[#42733] [Ruby 1.9-Feature#4146][Open] Improvement of Symbol and Proc — Nobuyoshi Nakada <redmine@...>

[#42735] [Ruby 1.9-Feature#4147][Open] Array#sample で重みを指定したい — Yoji Ojima <redmine@...>

[#42754] [Ruby 1.9-Bug#4152][Open] optparseのzsh compsysでrspecの補完が出来ない — Kazuhiro NISHIYAMA <redmine@...>

[#42758] [Ruby 1.9-Bug#4157][Open] test_pty で、たまに出る Failure — Makoto Kishimoto <redmine@...>

[#42761] [Ruby 1.9-Bug#4158][Open] X509V3_set_nconf が使用できないと openssl がコンパイルエラー — Tomoyuki Chikanaga <redmine@...>

[#42763] [Ruby 1.9-Bug#4159][Open] test_block_variables(TestRipper::ParserEvents) が失敗する — Kouhei Yanagita <redmine@...>

[#42771] [Ruby 1.9-Bug#4160][Open] test_core_03_notify(Rinda::TupleSpaceProxyTest) が失敗する — Kouhei Yanagita <redmine@...>

[#42775] --program-prefix option of configure.bat(mswin32) — "羽田 憲克 (HANEDA Norikatsu)" <haneda@...>

[#42777] [Ruby 1.9-Bug#4164][Assigned] tool/rbinstall.rb doesn't transform script names — Usaku NAKAMURA <redmine@...>

[#42778] BasicObject#object_id — keiju@... (Keiju ISHITSUKA)

[#42782] [Ruby 1.9-Feature#4165][Open] win32ビルドでbaserubyを設定しなかったときのエラーが非常に不親切 — Motohiro KOSAKI <redmine@...>

[#42788] Re: [ruby-changes:18220] Ruby:r30241 (trunk): * compile.c (setup_args, iseq_compile_each): optimize AMPER LAMBDA — SASADA Koichi <ko1@...>

[#42790] Re: [ruby-changes:18222] Ruby:r30243 (trunk): * compile.c (setup_args), vm.c (invoke_block_from_c), — SASADA Koichi <ko1@...>

[#42804] [Backport87-Backport#4171][Open] Warn Array#choice — Yui NARUSE <redmine@...>

[#42818] [Ruby 1.9-Bug#4173][Open] TestProcess#test_wait_and_sigchild が、たまに失敗する — Makoto Kishimoto <redmine@...>

[#42827] [Ruby 1.9-Bug#4176][Assigned] wrong fixed value at test_contrib.rb(test_pos) — Masaya Tarui <redmine@...>

[#42828] [Ruby 1.9-Bug#4177][Assigned] wrong fixed value at test/rexml/test_sax.rb(test_socket) — Masaya Tarui <redmine@...>

[#42832] [Ruby 1.9-Bug#4178][Open] test/rubygems/gemutilities.rb で、よくわからない ArgumentError — Makoto Kishimoto <redmine@...>

[#42833] [Ruby 1.9-Feature#4180][Open] Add Zlib.deflate / Zlib.inflate — Yui NARUSE <redmine@...>

[#42859] [Ruby 1.9-Bug#4186][Open] Failure: test_imaps_with_ca_file(IMAPTest) — Kazuhiro NISHIYAMA <redmine@...>

[#42860] [Ruby 1.9-Bug#4187][Open] Error: test_starttls(IMAPTest) — Kazuhiro NISHIYAMA <redmine@...>

[#42869] [feature:trunk] option for Socket#sendmsg — Nobuyoshi Nakada <nobu@...>

[#42872] Ruby 1.9.2 is going to be released — "Yuki Sonoda (Yugui)" <yugui@...>

[#42884] [Ruby 1.9-Bug#4201][Open] open fails with Encoding object — Nobuyoshi Nakada <redmine@...>

[#42887] [Ruby 1.9-Feature#4204][Open] IO#advise should raise error for unknown symbol — Tomoyuki Chikanaga <redmine@...>

[#42893] [Ruby 1.8-Bug#4206][Open] failed to set ext option for win32/configure.bat — Akio Tajima <redmine@...>

[#42894] [Ruby 1.8-Feature#4207][Open] これから「1.8.8」の話をしよう -- 1.8がこの先生きのこるには — Shyouhei Urabe <redmine@...>

[#42896] [Ruby 1.9-Bug#4209][Assigned] nmake reports warning in ext/ripper — Usaku NAKAMURA <redmine@...>

[#42907] [Ruby 1.9-Bug#4223][Open] GC.stress = true で謎の ArgumentError — Makoto Kishimoto <redmine@...>

[#42912] cut off an array at C level — Tanaka Akira <akr@...>

[ruby-dev:42855] [Ruby 1.9-Bug#4121] test_getpty_nonexistentで止まることがある

Thread

In This Thread

[#42775] --program-prefix option of configure.bat(mswin32) — "羽田　憲克 (HANEDA Norikatsu)" <haneda@...>