Re: 2.6.26-rc: nfsd hangs for a few sec

Previous message: [thread] [date] [author]
Next message: [thread] [date] [author]
From: Alexander Beregalov
Date: Saturday, June 21, 2008 - 7:10 pm

2008/6/22 Mel Gorman <mel@csn.ul.ie>:
Yes, I bisected it with about the same config (as much as possible
with changing Kconfig),
LOCKDEP was enabled for all bisected configs.

Yes, I use SLUB.

Hm, I cannot forecast the time when I will have this message, I
gathered readprofile statistics
right after the message:
   102 add_preempt_count                          1.0303
   102 net_rx_action                              0.2991
   104 __flush_tlb_all                            2.3111
   115 __tcp_push_pending_frames                  0.0626
   129 e1000_clean_rx_irq                         0.1549
   132 _read_unlock_irq                           1.7838
   136 __rcu_read_unlock                          1.3878
   137 native_read_tsc                            7.2105
   153 tcp_ack                                    0.0261
   155 __rcu_advance_callbacks                    0.8960
   197 local_bh_enable                            0.8277
   205 e1000_clean                                0.4092
   206 free_hot_cold_page                         0.5754
   308 _write_unlock_irq                          4.1622
   352 get_page_from_freelist                     0.3157
   448 lock_acquired                              0.8854
   564 acpi_pm_read                              28.2000
   618 vprintk                                    0.6897
   738 _spin_unlock_irq                           9.9730
   863 __do_softirq                               5.2945
   993 lock_release                               2.4458
  1166 netpoll_setup                              1.5630
  1633 _spin_unlock_irqrestore                   17.0104
  1712 lock_acquire                              12.7761
  1714 kfree                                      7.6178
  1724 __kmalloc_track_caller                     7.7309
  2308 kmem_cache_free                           12.3422
  3189 kmem_cache_alloc                          18.7588
 18261 default_idle                             214.8353
 43758 total                                      0.0175

Could it be useful? I am afraid it is not.
I can try to gather it for lesser time around the event.

I did not mentioned a message from e1000 right after the lockdep message:
e1000: eth0: e1000_clean_tx_irq: Detected Tx Unit Hang
  Tx Queue             <0>
  TDH                  <8f>
  TDT                  <8f>
  next_to_use          <8f>
  next_to_clean        <44>
buffer_info[next_to_clean]
  time_stamp           <601d>
  next_to_watch        <44>
  jiffies              <647c>
  next_to_watch.status <1>

Perhaps, it is actually the reason for nfsd being stalled ?

I have tried the test without lockdep and it seems it does not stall.
But I am not pretty sure, it is harder to caught hanging without
lockdep message.

I found it in 2.6.26-rc1, I think it does not need to search after rc1.
--
Previous message: [thread] [date] [author]
Next message: [thread] [date] [author]

Messages in current thread:
Re: 2.6.26-rc: nfsd hangs for a few sec, Alexander Beregalov, (Sat Jun 21, 5:57 am)
Re: 2.6.26-rc: nfsd hangs for a few sec, Linus Torvalds, (Sat Jun 21, 11:36 am)
Re: 2.6.26-rc: nfsd hangs for a few sec, Mel Gorman, (Sat Jun 21, 3:41 pm)
Re: 2.6.26-rc: nfsd hangs for a few sec, Christoph Lameter, (Sat Jun 21, 4:46 pm)
Re: 2.6.26-rc: nfsd hangs for a few sec, Linus Torvalds, (Sat Jun 21, 4:54 pm)
Re: 2.6.26-rc: nfsd hangs for a few sec, Christoph Lameter, (Sat Jun 21, 5:18 pm)
Re: 2.6.26-rc: nfsd hangs for a few sec, Mel Gorman, (Sat Jun 21, 6:38 pm)
Re: 2.6.26-rc: nfsd hangs for a few sec, Alexander Beregalov, (Sat Jun 21, 7:10 pm)
Re: 2.6.26-rc: nfsd hangs for a few sec, Christoph Lameter, (Sat Jun 21, 9:13 pm)
Re: 2.6.26-rc: nfsd hangs for a few sec, Mel Gorman, (Sun Jun 22, 10:07 am)