Re: 2.6.0-t3: vfs/ext3 do_lookup bug?!

From: Martin Zwickel
Date: Thu Aug 21 2003 - 02:18:07 EST

On Wed, 20 Aug 2003 12:06:34 -0700
Linus Torvalds <torvalds@xxxxxxxx> bubbled:

> Andrew Morton wrote:
>
> > Martin Zwickel <martin.zwickel@xxxxxxxxxxxxxx> wrote:
> >>
> >> Today I wanted to check out some src-files from cvs.
> >> But my fault was, that I ran cvs twice at the same time.
> >>
> >> so two "cvs upd -d -A" are now in 'D' state.
> >>
> >> I think they got stuck because both tried to access the same file.
> >
> > How odd. Were they the only processes which were in D state?
>
> They are probably hung on the same semaphore, ie "dir->i_sem". They almost
> certainly are not deadlocked on each other: something else has either left
> the directory semaphore locked, or is in turn waiting for something else.
>
> Martin - do you have the _full_ list of processes available?
>
> Linus

hmm, still not rebooted ;)
and i recognized that updatedb now also got stuck in the same down.
(somewhere @
/work/BuildEnv/sandbox/components/base/kernel/source/linux-2.4.21-rc1/include/c
onfig/x86/f00f/CVS/)
but where could the semaphore/mutex got locked and not unlocked?
the ps lax and lsof output is attached.
i'll reboot and fsck the fs...

and thx for the response.

Regards,
Martin

--
MyExcuse:
CPU needs bearings repacked

Martin Zwickel <martin.zwickel@xxxxxxxxxxxxxx>
Research & Development

TechnoTrend AG <http://www.technotrend.de>

Attachment: pslax.list
Description: Binary data

n+0x0/0x2e
[<c0119687>] default_wake_function+0x0/0x2e
[<c0109063>] syscall_call+0x7/0xb

cvs D C8E86424 297794096 11933 11932 (NOTLB)
d49d3e80 00000086 c03a561b c8e86424 00000001 d092d408 c2dd2080 cccee770
00000286 c2dd2080 cccee778 c0107f8e 00000001 c2dd2080 c0119687 c7ec1f3c
dc84de70 d49d3f38 dffe46c0 d49d3ee4 00000000 cccee770 cccee708 d919a980
Call Trace:
[<c0107f8e>] __down+0x7c/0xc7
[<c0119687>] default_wake_function+0x0/0x2e
[<c0108118>] __down_failed+0x8/0xc
[<c0159df3>] .text.lock.namei+0x5/0x16a
[<c0156c98>] do_lookup+0x96/0xa1
[<c0157077>] link_path_walk+0x3d4/0x762
[<c015783c>] __user_walk+0x49/0x5e
[<c0149be1>] sys_access+0x93/0x150
[<c015393d>] sys_stat64+0x37/0x39
[<c0109063>] syscall_call+0x7/0xb

xterm S 00000000 344429488 15862 32627 15863 16083 11608 (NOTLB)
dab51e8c 00000086 000000d0 00000000 000000d0 d3d55100 c62d6680 00000000
7fffffff 00000005 00000000 c01237d6 d7f51000 d7f51920 dab51f20 d7f51000
c9883d80 00000004 00000004 c0281033 d7f51000 c9883d80 dab51f20 00000000
Call Trace:
[<c01237d6>] schedule_timeout+0xb1/0xb3
[<c0281033>] tty_poll+0x7b/0x9f
[<c015b73d>] do_select+0x17b/0x2b6
[<c015b41d>] __pollwait+0x0/0xc4
[<c015bba5>] sys_select+0x308/0x549
[<c03371a4>] sock_ioctl+0xaf/0x23d
[<c0109063>] syscall_call+0x7/0xb

bash S C0282EEA 3980833712 15863 15862 (NOTLB)
c4037e78 00000082 0000000b c0282eea d2b19000 00000000 d6bca680 00000008
7fffffff d2b19928 00000001 c01237d6 d2b19000 dedd9640 00000092 c4036000
c02822b3 0000001c dfb5f3e0 db811bc8 c0123f8d c0131d4d 00000246 00000008
Call Trace:
[<c0282eea>] opost_block+0x116/0x1e0
[<c01237d6>] schedule_timeout+0xb1/0xb3
[<c02822b3>] tty_default_put_char+0x33/0x37
[<c0123f8d>] __dequeue_signal+0xe8/0x184
[<c0131d4d>] unlock_page+0x15/0x53
[<c028489d>] read_chan+0x29f/0x83a
[<c0284fb9>] write_chan+0x181/0x244
[<c0119687>] default_wake_function+0x0/0x2e
[<c0119687>] default_wake_function+0x0/0x2e
[<c0119687>] default_wake_function+0x0/0x2e
[<c027fc85>] tty_read+0xe5/0x10e
[<c014ae09>] vfs_read+0xbc/0x127
[<c014b094>] sys_read+0x42/0x63
[<c0109063>] syscall_call+0x7/0xb

xterm S 00000000 112604080 16083 32627 16084 20370 15862 (NOTLB)
ce933e8c 00000082 000000d0 00000000 000000d0 cfe92980 c7dce680 00000000
7fffffff 00000005 00000000 c01237d6 c7ba6000 c7ba6920 ce933f20 c7ba6000
d6f06780 00000004 00000004 c0281033 c7ba6000 d6f06780 ce933f20 00000000
Call Trace:
[<c01237d6>] schedule_timeout+0xb1/0xb3
[<c0281033>] tty_poll+0x7b/0x9f
[<c015b73d>] do_select+0x17b/0x2b6
[<c015b41d>] __pollwait+0x0/0xc4
[<c015bba5>] sys_select+0x308/0x549
[<c03371a4>] sock_ioctl+0xaf/0x23d
[<c0109063>] syscall_call+0x7/0xb

bash S C0282EEA 3833189296 16084 16083 16112 (NOTLB)
c2f23e78 00000086 0000000a c0282eea d4ebf000 00000000 de784680 00000008
7fffffff d4ebf928 00000001 c01237d6 d4ebf000 c57304c0 0000000a c2f22000
c02822b3 d4ebf000 00000000 c2f23ea7 00000001 c0131d4d 00000246 00000008
Call Trace:
[<c0282eea>] opost_block+0x116/0x1e0
[<c01237d6>] schedule_timeout+0xb1/0xb3
[<c02822b3>] tty_default_put_char+0x33/0x37
[<c0131d4d>] unlock_page+0x15/0x53
[<c028489d>] read_chan+0x29f/0x83a
[<c0284fb9>] write_chan+0x181/0x244
[<c0119687>] default_wake_function+0x0/0x2e
[<c0119687>] default_wake_function+0x0/0x2e
[<c0119687>] default_wake_function+0x0/0x2e
[<c027fc85>] tty_read+0xe5/0x10e
[<c014ae09>] vfs_read+0xbc/0x127
[<c014b094>] sys_read+0x42/0x63
[<c0109063>] syscall_call+0x7/0xb

xmms S C015B45E 4269691824 16112 16084 16113 (NOTLB)
d0bcff04 00000086 00000000 c015b45e 00000246 d0bcff18 d23e8680 2db9a07c
d0bcff18 d0bcff60 0000000a c0123784 d0bcff18 c96b1f00 c619c940 c0412668
c0412668 2db9a07c 4b87ad6e c012371c d23e8680 c0412280 d0bcff5c 00000000
Call Trace:
[<c015b45e>] __pollwait+0x41/0xc4
[<c0123784>] schedule_timeout+0x5f/0xb3
[<c012371c>] process_timeout+0x0/0x9
[<c015bf1c>] do_poll+0xa6/0xc5
[<c015c0d8>] sys_poll+0x19d/0x28d
[<c015b41d>] __pollwait+0x0/0xc4
[<c0109063>] syscall_call+0x7/0xb

xmms S CB07DFA0 75725104 16113 16112 16114 (NOTLB)
cb07df04 00000086 c96b1480 cb07dfa0 00000246 cb07df18 c6844100 2db9a77e
cb07df18 cb07df60 000007d1 c0123784 cb07df18 c96b1480 c57301c0 cc201f18
dfd6128c 2db9a77e 4b87ad6e c012371c c6844100 c0412280 cb07df5c 00000000
Call Trace:
[<c0123784>] schedule_timeout+0x5f/0xb3
[<c012371c>] process_timeout+0x0/0x9
[<c015bf1c>] do_poll+0xa6/0xc5
[<c015c0d8>] sys_poll+0x19d/0x28d
[<c015b41d>] __pollwait+0x0/0xc4
[<c0109063>] syscall_call+0x7/0xb

xmms S 00000000 227344688 16114 16113 16115 (NOTLB)
d4117e8c 00000086 000000d0 00000000 00000246 d4117ea0 c6845900 2db9a0ca
d4117ea0 00000005 00000000 c0123784 d4117ea0 dd7ca200 00000010 c04128d8
c04128d8 2db9a0ca 4b87ad6e c012371c c6845900 c0412280 c9edb980 00000000
Call Trace:
[<c0123784>] schedule_timeout+0x5f/0xb3
[<c012371c>] process_timeout+0x0/0x9
[<c015b73d>] do_select+0x17b/0x2b6
[<c015b41d>] __pollwait+0x0/0xc4
[<c015bba5>] sys_select+0x308/0x549
[<c015f229>] dput+0xd5/0x161
[<c014bdac>] __fput+0x9f/0xf5
[<c0109063>] syscall_call+0x7/0xb

xmms S 00000000 340643120 16115 16113 16114 (NOTLB)
dad23ef8 00000086 00000000 00000000 00000246 dad23f68 c6844d00 dad22000
dad23f68 00000000 00000000 c012c5a0 dad23f68 dad23f18 00000000 dad23f20
c04d0fa0 dad2201c 00000000 1dcd6500 2db9a0cd 00000001 00000000 c6844d00
Call Trace:
[<c012c5a0>] do_clock_nanosleep+0x1b6/0x303
[<c0119687>] default_wake_function+0x0/0x2e
[<e0a39cdd>] __nvsym00795+0x31/0x50 [nvidia]
[<c0119687>] default_wake_function+0x0/0x2e
[<e0a22947>] nv_kern_isr+0x25/0x5c [nvidia]
[<c012c1a2>] nanosleep_wake_up+0x0/0x9
[<c012c23c>] sys_nanosleep+0x80/0x105
[<c0109063>] syscall_call+0x7/0xb

mozilla-bin S 00000001 4077705648 16443 8324 8412 (NOTLB)
d2975f8c 00000086 00000000 00000001 c014b000 c3868280 df8a6080 d2974000
d2975fc4 d2975fa8 00000000 c010827c d2975fa8 429b48ac 00000008 80000000
00000000 00000000 00000000 429b48ac 400f1078 00000000 d2974000 c0109063
Call Trace:
[<c014b000>] vfs_write+0xd5/0x127
[<c010827c>] sys_rt_sigsuspend+0xc7/0xfb
[<c0109063>] syscall_call+0x7/0xb

xterm S 00000000 229380916 20370 32627 20371 27545 16083 (NOTLB)
d4307e8c 00000082 000000d0 00000000 000000d0 ca507f80 c6844700 00000000
7fffffff 00000005 00000000 c01237d6 d728b000 d728b920 d4307f20 d728b000
ca507300 00000004 00000004 c0281033 d728b000 ca507300 00000000 00000000
Call Trace:
[<c01237d6>] schedule_timeout+0xb1/0xb3
[<c0281033>] tty_poll+0x7b/0x9f
[<c015b73d>] do_select+0x17b/0x2b6
[<c015b41d>] __pollwait+0x0/0xc4
[<c015bba5>] sys_select+0x308/0x549
[<c03371a4>] sock_ioctl+0xaf/0x23d
[<c0109063>] syscall_call+0x7/0xb

bash S C0282EEA 106789296 20371 20370 (NOTLB)
cc8afe78 00000082 00000007 c0282eea c3a5b000 00000000 c62d6080 00000008
7fffffff c3a5b928 00000001 c01237d6 c3a5b000 df6a91c0 0000000a cc8ae000
c02822b3 c3a5b000 00000000 cc8afea7 00000001 0a28b000 00000246 00000008
Call Trace:
[<c0282eea>] opost_block+0x116/0x1e0
[<c01237d6>] schedule_timeout+0xb1/0xb3
[<c02822b3>] tty_default_put_char+0x33/0x37
[<c028489d>] read_chan+0x29f/0x83a
[<c0284fb9>] write_chan+0x181/0x244
[<c0119687>] default_wake_function+0x0/0x2e
[<c0119687>] default_wake_function+0x0/0x2e
[<c0119687>] default_wake_function+0x0/0x2e
[<c027fc85>] tty_read+0xe5/0x10e
[<c014ae09>] vfs_read+0xbc/0x127
[<c014b094>] sys_read+0x42/0x63
[<c0109063>] syscall_call+0x7/0xb

cron S 00000001 10410416 22082 3778 22083 (NOTLB)
c87bdedc 00000086 cb0cc058 00000001 c013e2a8 de711a80 c7dce080 df9ab568
df9ab500 c87bdf04 00001000 c01557bb 00000000 c7dce080 c011a810 c87bdf10
c87bdf10 df9ab500 df9ab53c df9ab500 00000000 c7dce080 c011a810 d6882480
Call Trace:
[<c013e2a8>] do_anonymous_page+0x10b/0x1e5
[<c01557bb>] pipe_wait+0x97/0xb6
[<c011a810>] autoremove_wake_function+0x0/0x4f
[<c011a810>] autoremove_wake_function+0x0/0x4f
[<c015591e>] pipe_read+0x144/0x242
[<c014ae09>] vfs_read+0xbc/0x127
[<c014b094>] sys_read+0x42/0x63
[<c0109063>] syscall_call+0x7/0xb

sh S DBE74E24 4093152536 22083 22082 22084 (NOTLB)
c2b25f50 00000082 00030002 dbe74e24 00000000 c2b25f58 ceb9ad80 ceb9ae1c
fffffe00 ceb9ad80 ceb9ae1c c011e99e ffffffff 00000000 dbe74d80 bffff910
c2b24000 00000001 00000000 ceb9ad80 c0119687 00000000 00000000 fffffff2
Call Trace:
[<c011e99e>] sys_wait4+0x1c0/0x267
[<c0119687>] default_wake_function+0x0/0x2e
[<c0119687>] default_wake_function+0x0/0x2e
[<c0109063>] syscall_call+0x7/0xb

run-crons S CAFBB924 20630704 22084 22083 22099 (NOTLB)
dd223f50 00000086 00030002 cafbb924 00000000 dd223f58 dbe74d80 dbe74e1c
fffffe00 dbe74d80 dbe74e1c c011e99e ffffffff 00000000 cafbb880 bffff670
dd222000 00000001 00000000 dbe74d80 c0119687 00000000 00000000 fffffff2
Call Trace:
[<c011e99e>] sys_wait4+0x1c0/0x267
[<c0119687>] default_wake_function+0x0/0x2e
[<c0119687>] default_wake_function+0x0/0x2e
[<c0109063>] syscall_call+0x7/0xb

slocate.cron S DF8A7324 4255745384 22099 22084 22100 (NOTLB)
c8a55f50 00000082 00030002 df8a7324 00000000 c8a55f58 cafbb880 cafbb91c
fffffe00 cafbb880 cafbb91c c011e99e ffffffff 00000000 df8a7280 bffff880
c8a54000 00000001 00000000 cafbb880 c0119687 00000000 00000000 fffffff2
Call Trace:
[<c011e99e>] sys_wait4+0x1c0/0x267
[<c0119687>] default_wake_function+0x0/0x2e
[<c0119687>] default_wake_function+0x0/0x2e
[<c0109063>] syscall_call+0x7/0xb

updatedb D 001AC5CA 3898705852 22100 22099 (NOTLB)
c7ec1f28 00000082 00000000 001ac5ca 000041ed 00000002 df8a7280 cccee770
00000286 df8a7280 cccee778 c0107f8e 00000001 df8a7280 c0119687 cccee778
d49d3e94 00000000 3f4320b9 00000000 cccee770 cccee708 c7246f00 fffffff7
Call Trace:
[<c0107f8e>] __down+0x7c/0xc7
[<c0119687>] default_wake_function+0x0/0x2e
[<c0108118>] __down_failed+0x8/0xc
[<c017a1e3>] ext3_readdir+0x0/0x4f1
[<c015b3b4>] .text.lock.readdir+0x5/0x15
[<c015b376>] sys_getdents64+0x98/0xd1
[<c015b1a4>] filldir64+0x0/0x13a
[<c0109063>] syscall_call+0x7/0xb

pickup S 00000000 4209842608 23295 3527 3551 (NOTLB)
d1a9de8c 00000086 000000d0 00000000 00000246 d1a9dea0 d6bca080 2dbb2318
d1a9dea0 00000007 00000000 c0123784 d1a9dea0 df2efe00 00000020 c0412de8
c0412de8 2dbb2318 4b87ad6e c012371c d6bca080 c0412280 de866680 00000000
Call Trace:
[<c0123784>] schedule_timeout+0x5f/0xb3
[<c012371c>] process_timeout+0x0/0x9
[<c015b73d>] do_select+0x17b/0x2b6
[<c015b41d>] __pollwait+0x0/0xc4
[<c015bba5>] sys_select+0x308/0x549
[<c011ee62>] do_setitimer+0x1af/0x1d9
[<c0109063>] syscall_call+0x7/0xb

xterm S 00000000 4263759024 27545 32627 27546 27584 20370 (NOTLB)
c5ef5e8c 00000082 000000d0 00000000 000000d0 d7fdcd80 c7cb6d80 00000000
7fffffff 00000005 00000000 c01237d6 c56bd000 c56bd920 c5ef5f20 c56bd000
d7d50f00 00000004 00000004 c0281033 c56bd000 d7d50f00 c5ef5f20 00000000
Call Trace:
[<c01237d6>] schedule_timeout+0xb1/0xb3
[<c0281033>] tty_poll+0x7b/0x9f
[<c015b73d>] do_select+0x17b/0x2b6
[<c015b41d>] __pollwait+0x0/0xc4
[<c015bba5>] sys_select+0x308/0x549
[<c03371a4>] sock_ioctl+0xaf/0x23d
[<c0109063>] syscall_call+0x7/0xb

bash S C0282EEA 88078512 27546 27545 (NOTLB)
cd0b7e78 00000082 00000007 c0282eea dd0fb000 00000000 c7cb6180 00000008
7fffffff dd0fb928 00000001 c01237d6 dd0fb000 d9e6a440 0000000a cd0b6000
c02822b3 dd0fb000 00000000 cd0b7ea7 00000001 c0131d4d 00000246 00000008
Call Trace:
[<c0282eea>] opost_block+0x116/0x1e0
[<c01237d6>] schedule_timeout+0xb1/0xb3
[<c02822b3>] tty_default_put_char+0x33/0x37
[<c0131d4d>] unlock_page+0x15/0x53
[<c028489d>] read_chan+0x29f/0x83a
[<c0284fb9>] write_chan+0x181/0x244
[<c0119687>] default_wake_function+0x0/0x2e
[<c0119687>] default_wake_function+0x0/0x2e
[<c0119687>] default_wake_function+0x0/0x2e
[<c027fc85>] tty_read+0xe5/0x10e
[<c014ae09>] vfs_read+0xbc/0x127
[<c014b094>] sys_read+0x42/0x63
[<c0109063>] syscall_call+0x7/0xb

xterm S 00000000 4096252336 27584 32627 27585 27654 27545 (NOTLB)
c6667e8c 00000086 000000d0 00000000 000000d0 da6c4e00 d23e8080 00000000
7fffffff 00000005 00000000 c01237d6 dcc43000 dcc43920 c6667f20 dcc43000
cbdb3300 00000004 00000004 c0281033 dcc43000 cbdb3300 c6667f20 00000000
Call Trace:
[<c01237d6>] schedule_timeout+0xb1/0xb3
[<c0281033>] tty_poll+0x7b/0x9f
[<c015b73d>] do_select+0x17b/0x2b6
[<c015b41d>] __pollwait+0x0/0xc4
[<c015bba5>] sys_select+0x308/0x549
[<c012a33d>] rcu_check_quiescent_state+0x6b/0x6d
[<c012a40a>] rcu_process_callbacks+0xcb/0xe6
[<c03371a4>] sock_ioctl+0xaf/0x23d
[<c0109063>] syscall_call+0x7/0xb

bash S C0282EEA 104777520 27585 27584 (NOTLB)
dba3be78 00000086 0000000a c0282eea cc0a5000 00000000 d564d300 00000008
7fffffff cc0a5928 00000001 c01237d6 cc0a5000 c2271800 0000000a dba3a000
c02822b3 cc0a5000 00000000 dba3bea7 00000001 c0131d4d 00000246 00000008
Call Trace:
[<c0282eea>] opost_block+0x116/0x1e0
[<c01237d6>] schedule_timeout+0xb1/0xb3
[<c02822b3>] tty_default_put_char+0x33/0x37
[<c0131d4d>] unlock_page+0x15/0x53
[<c028489d>] read_chan+0x29f/0x83a
[<c0284fb9>] write_chan+0x181/0x244
[<c0119687>] default_wake_function+0x0/0x2e
[<c0119687>] default_wake_function+0x0/0x2e
[<c0119687>] default_wake_function+0x0/0x2e
[<c027fc85>] tty_read+0xe5/0x10e
[<c014ae09>] vfs_read+0xbc/0x127
[<c014b094>] sys_read+0x42/0x63
[<c0109063>] syscall_call+0x7/0xb

xterm S 00000000 79599920 27654 32627 27655 27584 (NOTLB)
d51e7e8c 00000082 000000d0 00000000 000000d0 da6c4700 d05fc100 00000000
7fffffff 00000005 00000000 c01237d6 c2e9e000 c2e9e920 d51e7f20 c2e9e000
cd3c1c00 00000004 00000004 c0281033 c2e9e000 cd3c1c00 d51e7f20 00000000
Call Trace:
[<c01237d6>] schedule_timeout+0xb1/0xb3
[<c0281033>] tty_poll+0x7b/0x9f
[<c015b73d>] do_select+0x17b/0x2b6
[<c015b41d>] __pollwait+0x0/0xc4
[<c015bba5>] sys_select+0x308/0x549
[<c03371a4>] sock_ioctl+0xaf/0x23d
[<c0109063>] syscall_call+0x7/0xb

bash S C0282EEA 78911792 27655 27654 (NOTLB)
da18fe78 00000086 0000000a c0282eea cb33e000 00000000 d564c100 00000008
7fffffff cb33e928 00000001 c01237d6 cb33e000 d9e6a280 0000000a da18e000
c02822b3 cb33e000 00000000 da18fea7 00000001 0ae9e000 00000246 00000008
Call Trace:
[<c0282eea>] opost_block+0x116/0x1e0
[<c01237d6>] schedule_timeout+0xb1/0xb3
[<c02822b3>] tty_default_put_char+0x33/0x37
[<c028489d>] read_chan+0x29f/0x83a
[<c0284fb9>] write_chan+0x181/0x244
[<c0119687>] default_wake_function+0x0/0x2e
[<c0119687>] default_wake_function+0x0/0x2e
[<c0119687>] default_wake_function+0x0/0x2e
[<c027fc85>] tty_read+0xe5/0x10e
[<c014ae09>] vfs_read+0xbc/0x127
[<c014b094>] sys_read+0x42/0x63
[<c0109063>] syscall_call+0x7/0xb

Attachment: lsof.updatedb
Description: Binary data

Attachment: lsof.cvs
Description: Binary data