deadlock: NtfsWaitForIoAtEof

OSR_Community_User · June 15, 2007, 6:56am

I have a dead-lock condition where my system thread below is waiting on an
event object. How can I determine what this thread is waiting for (e.g. who
is holding it up? I am holding no resources and mutex locks within my driver
or in this thread. My driver has opened this file during startup. In the
code Only one thread is allowed to write to that file at any particular
time. I have copied the dump. Please have an insight into the dump and let
me know the problem. Actually my driver is volume driver that is residing
below file system

f78d563c 80832f7a 8619c948 8619c8d0 8619c978 nt!KiSwapContext+0x26 (FPO:
[Uses EBP] [0,0,4])
f78d5668 8082925c 00000000 <javascript:void> e5d000d0 e5d000d0
nt!KiSwapThread+0x284 (FPO: [Non-Fpo])
f78d56b0 f719edf6 f78d56e 0 00000000 <javascript:void>
00000000<javascript:void>nt!KeWaitForSingleObject+0x346 (FPO:
[Non-Fpo])
f78d56f0 f71619f3 e5d000d0 f78d58c0 00001000
<javascript:void>Ntfs!NtfsWaitForIoAtEof+0x49 (FPO: [Non-Fpo])
f78d58e4 f715adf7 f78d58f4 856a4008 0108070a Ntfs!NtfsCommonWrite+0xbe0
(FPO: [Non-Fpo])
f78d5a60 8081dcdf 85d70198 856a4008 860c62d8 Ntfs!NtfsFsdWrite+0x16a (FPO:
[Non-Fpo])
f78d5a74 f7215c53 860c62d8 856a41bc 0000000f nt!IofCallDriver+0x45 (FPO:
[Non-Fpo])
f78d5a9c 8081dcdf 85d84020 856a4008 856a41e0 fltmgr!FltpDispatch+0x6f (FPO:
[Non-Fpo])
f78d5ab0 f6445bbe 856a4008 857b 0700 85735888
<javascript:void>nt!IofCallDriver+0x45 (FPO: [Non-Fpo])
WARNING: Stack unwind information not available. Following frames may be
wrong.
f78d5adc f644b2ce 856a4008 f78d5b 24 85735888
<javascript:void>naiavf5x+0x1bbe
f78d5b1c f 6446520 <javascript:void> 856a4008
85735888<javascript:void>857f1f38 naiavf5x+0x72ce
f78d5b30 8081dcdf 857b3828 856a4008 2b801000
<javascript:void>naiavf5x+0x2520
f78d5b44 8081e3f9 00000000 <javascript:void> f78d5b80 85749df0
nt!IofCallDriver+0x45 (FPO: [Non-Fpo])
f78d5b58 80835f26 8573580a f78d5b80 f78d5c48 nt!IoSynchronousPageWrite+0xaf
(FPO: [Non-Fpo])
f78d5c 74 80837339 <javascript:void> e5bdd008 e5bdd010 85749df0
nt!MiFlushSectionInternal+0x6ba (FPO: [Non-Fpo])
f78d5cb8 8080ef30 85e17a68 f78d5d00 01000400
<javascript:void>nt!MmFlushSection+0x23f (FPO: [Non-Fpo])
f78d5cd0 8080edad 857364a0 00000000 <javascript:void>
00000000<javascript:void>nt!CcMapAndCopy+0x43c (FPO: [SEH])
f78d5d4c 8080c7d5 857364a0 f7b4ca00 f78d5d90 nt!CcMapAndCopy+0x2b9 (FPO:
[Non-Fpo])
f78d5ddc f715b36c 85735888 <javascript:void> f78d5fb 4
00000400<javascript:void>nt!CcCopyWrite+0x29b (FPO: [Non-Fpo])
f78d5fd8 f715adf7 85d5e4c0 856a76a8 85d84020 Ntfs!NtfsCommonWrite+0x1cea
(FPO: [Non-Fpo])
f78d604c 8081dcdf 85d70198 856a76a8 860c62d8 Ntfs!NtfsFsdWrite+0x16a (FPO:
[Non-Fpo])
f78d6060 f7215c53 860c62d8 856a785c ffffffff nt!IofCallDriver+0x45 (FPO:
[Non-Fpo])
f78d6088 8081dcdf 85d84020 856a76a8 856a7880 fltmgr!FltpDispatch+0x6f (FPO:
[Non-Fpo])
f78d609c f6445bbe 856a76a8 857b 0700 85735888
<javascript:void>nt!IofCallDriver+0x45 (FPO: [Non-Fpo])
f78d60c8 f644b2ce 856a76a8 f78d6110 856a76a8 naiavf5x+0x1bbe
f78d6108 f 6446520 <javascript:void> 856a76a8 856a76a8 857f1f38
naiavf5x+0x72ce
f78d611c 8081dcdf 857b3828 856a76a 8 00000001
<javascript:void>naiavf5x+0x2520
f78d6130 808f47b7 856a785c 00000001 <javascript:void> 856a76a8
nt!IofCallDriver+0x45 (FPO: [Non-Fpo])
f78d6144 808f24ee 857b3828 856a76a8 85735888
<javascript:void>nt!IopSynchronousServiceTail+0x10b (FPO:
[Non-Fpo])
f78d61ec 80888c7c 80000568 00000000 <javascript:void>
00000000<javascript:void>nt!NtWriteFile+0x65a (FPO: [Non-Fpo])
f78d61ec 8082f 421 80000568 <javascript:void> 00000000
00000000<javascript:void>nt!KiFastCallEntry+0xfc (FPO: [0,0]
TrapFrame @ f78d6218)
f78d6288 f639abcc 80000568 00000000 <javascript:void>
00000000<javascript:void>nt!ZwWriteFile+0x11 (FPO: [9,0,0])
f78d62c0 f639ab46 86017d50 f7b4bc 00 00000400
<javascript:void>MyDrv!InWriteFile+0x2c (FPO: [Non-Fpo]) (CONV:
stdcall)
f78d62ec f 6396647 <javascript:void> 86017d50 f7b4bc00 2b
801200<javascript:void>MyDrv!WRITE_FILE+0x36 (FPO: [Non-Fpo])
(CONV: stdcall)
f78d6320 f63967f6 00000000 <javascript:void> 85d5c530 f7b4bc00
MyDrv!VsWrite+0xa7 (FPO: [Non-Fpo]) (CONV: stdcall)
f78d6350 f63975be f7b4bc00 85d5c530 00000400
<javascript:void>MyDrv!VsWriteToLog+0x136 (FPO: [Non-Fpo]) (CONV:
stdcall)
f78d63e8 f6397bf6 f7b4b000 60db4000 00000000
<javascript:void>MyDrv!VsWriteMap+0x9ee (FPO: [Non-Fpo]) (CONV:
stdcall)
f78d6410 f6392ce0 f7b4b000 60db4000 00000000
<javascript:void>MyDrv!VolumeWrite+0x46 (FPO: [Non-Fpo]) (CONV:
stdcall)
f78d6454 f638c498 857250e8 857168a8 00000001
<javascript:void>MyDrv!ProcessWriteRequest+0xf0 (FPO: [Non-Fpo])
(CONV: stdcall)
f78d6488 f6385686 85725030 <javascript:void> 85b6bbd 0
00000004<javascript:void>MyDrv!ImageWrite+0x298 (FPO: [Non-Fpo])
(CONV: stdcall)
f78d64a4 8081dcdf 85725030 <javascript:void> 85b6bbd0 85b6bbd0
MyDrv!DispatchWrite+0xb6 (FPO: [Non-Fpo]) (CONV: stdcall)
f78d64b8 f715b0ce f78d68b0 f78d669c f715a702 nt!IofCallDriver+0x45 (FPO:
[Non-Fpo])
f78d64c4 f715a702 f78d68b0 85725030 <javascript:void> 60db4000
Ntfs!NtfsSingleAsync+0x91 (FPO: [Non-Fpo])
f78d669c f715ac1f f78d68b0 85b6bbd0 e132d0d0 Ntfs!NtfsNonCachedIo+0x2db
(FPO: [Non-Fpo])
f78d68a0 f715adf7 f78d68b0 85b6bbd0 0108070a Ntfs!NtfsCommonWrite+0x18e6
(FPO: [Non-Fpo])
f78d6a1c 8081dcdf 8577f718 85b6bbd0 860c62d8 Ntfs!NtfsFsdWrite+0x16a (FPO:
[Non-Fpo])
f78d6a30 f7215c53 860c62d8 85b6bcac 00000400
<javascript:void>nt!IofCallDriver+0x45 (FPO: [Non-Fpo])
f78d6a58 8081dcdf 8577b358 85b6bbd0 85b6bcd0 fltmgr!FltpDispatch+0x6f (FPO:
[Non-Fpo])
f78d6a6c f6445bbe 85b6bbd0 857b0700 85f699c0 nt!IofCallDriver+0x45 (FPO:
[Non-Fpo])
f78d6a98 f644b2ce 85b6bbd0 f78d6ae0 85f699c0 naiavf5x+0x1bbe
f78d6ad8 f 6446520 <javascript:void> 85b6bbd0 85f699c0 857f1f38
naiavf5x+0x72ce
f78d6aec 8081dcdf 85760e78 85b6bbd 0 00000000
<javascript:void>naiavf5x+0x2520
f78d6b00 8081e3f9 00000000 <javascript:void> f78d6b3c 8573bf20
nt!IofCallDriver+0x45 (FPO: [Non-Fpo])
f78d6b14 80835f26 85f69904 f78d6b3c f78d6c04 nt!IoSynchronousPageWrite+0xaf
(FPO: [Non-Fpo])
f78d6c30 8083730b e 1487008 <javascript:void>
e1487010<javascript:void>8573bf20 nt!MiFlushSectionInternal+0x6ba
(FPO: [Non-Fpo])
f78d6c74 8080f7e6 8573bee8 f78d6c00 00001000
<javascript:void>nt!MmFlushSection+0x211 (FPO: [Non-Fpo])
f78d6cfc 8080fb59 00001000 <javascript:void> 00000000
00000001<javascript:void>nt!CcFlushCache+0x3a6 (FPO: [Non-Fpo])
f78d6d 40 80812502 <javascript:void> 8619c8d0 808ae5c0 8619c280
nt!CcWriteBehind+0x11b (FPO: [Non-Fpo])
f78d6d80 8087f92f 8619c280 00000000 <javascript:void> 8619c8d0
nt!CcWorkerThread+0x12c (FPO: [Non-Fpo])
f78d6dac 80948bd0 8619c280 00000000 <javascript:void>
00000000<javascript:void>nt!ExpWorkerThread+0xeb (FPO: [Non-Fpo])
f78d6ddc 8088d4e2 8087f 844 00000000 <javascript:void>
00000000<javascript:void>nt!PspSystemThreadStartup+0x2e (FPO:
[Non-Fpo])
00000000 00000000 <javascript:void> 00000000 00000000<javascript:void>
00000000 <javascript:void> nt!KiThreadStartup+0x16</javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void></javascript:void>

OSR_Community_User · June 15, 2007, 7:07am

some more information

0: kd> !irp 856a4008
Irp is active with 10 stacks 9 is current (= 0x856a4198)
Mdl=f78d5b80: No System Buffer: Thread 8619c8d0: Irp stack trace.
cmd flg cl Device File Completion-Context
[0, 0] 0 0 00000000 00000000 00000000-00000000

Args: 00000000 00000000 00000000 00000000
[0, 0] 0 0 00000000 00000000 00000000-00000000

Args: 00000000 00000000 00000000 00000000

[4, 0] 0 e0 85d70198 85735888 f6445b50-f78d5ac4 Success Error Cancel
\FileSystem\Ntfs naiavf5x
Args: 00001000 00000000 2b801000 00000000
[4, 0] 0 0 857b3828 85735888 00000000-00000000
\FileSystem\NaiAvFilter1
Args: 00001000 00000000 2b801000 00000000

0: kd> !irp 856a76a8
Irp is active with 10 stacks 9 is current (= 0x856a7838)
No Mdl: No System Buffer: Thread 8619c8d0: Irp stack trace.
cmd flg cl Device File Completion-Context
[0, 0] 0 0 00000000 00000000 00000000-00000000

Args: 00000000 00000000 00000000 00000000
[0, 0] 0 0 00000000 00000000 00000000-00000000

Args: 00000000 00000000 00000000 00000000

[4, 0] 4 e0 85d70198 85735888 f6445b50-f78d60b0 Success Error Cancel
\FileSystem\Ntfs naiavf5x
Args: 00000400 00000000 2b801200 00000000
[4, 0] 4 0 857b3828 85735888 00000000-00000000
\FileSystem\NaiAvFilter1
Args: 00000400 00000000 2b801200 00000000

0: kd> dt nt!_FILE_OBJECT 0x85735888
+0x000 Type : 5
+0x002 Size : 0x70
+0x004 DeviceObject : 0x860f2d48 _DEVICE_OBJECT
+0x008 Vpb : 0x860f1518 _VPB
+0x00c FsContext : 0xe5d000d0
+0x010 FsContext2 : 0xe5c24b80
+0x014 SectionObjectPointer : 0x85e30e2c _SECTION_OBJECT_POINTERS
+0x018 PrivateCacheMap : 0x85736578
+0x01c FinalStatus : 0
+0x020 RelatedFileObject : (null)
+0x024 LockOperation : 0 ‘’
+0x025 DeletePending : 0 ‘’
+0x026 ReadAccess : 0x1 ‘’
+0x027 WriteAccess : 0x1 ‘’
+0x028 DeleteAccess : 0 ‘’
+0x029 SharedRead : 0x1 ‘’
+0x02a SharedWrite : 0 ‘’
+0x02b SharedDelete : 0 ‘’
+0x02c Flags : 0x1c3052
+0x030 FileName : _UNICODE_STRING “\data\WriteData1”
+0x038 CurrentByteOffset : _LARGE_INTEGER 0x2b801200
+0x040 Waiters : 0
+0x044 Busy : 1
+0x048 LastLock : (null)
+0x04c Lock : _KEVENT
+0x05c Event : _KEVENT
+0x06c CompletionContext : (null)