slow network folder read

Rancher Bob · Post by **Rancher Bob** » 2004 Jul 08, 20:07

When I first access a drive on our WinNT 4.0 server, xplorer2 displays the contents but there is a 15 second delay before xplorer responds again (it's "on the clock") and the message at the bottom left says "reading folder." This only seems to happen when I first try to access the drive. After that it work fine. For a point of comparison, Win Explorer doesn't exhibit the same behavior.

Post by **nikos** » 2004 Jul 09, 07:18

these quirks are going to drive me crazy!

please download the "german" version from the website
if you delete the dll that comes with it it will revert to english

then download dbmon, if you don't have it already:
www.ps.ic.ac.uk/~umeca74/dbmon.zip

if you run dbmon before you start the new debug version 1002 (please quit all other x2 instances first), it will show a lot of messages. The important bit is the timing of the messages generated while you read that problem folder, and especially the message that was printed last before x2 turned unresponsive

thanks!

Rancher Bob · Post by **Rancher Bob** » 2004 Jul 14, 20:46

I downloaded version 1.0.0.2 from http://netez.com/xplorer2/alldown.htm and installed it over the previous version. I see no dll to delete and all is in English... and I can't get it to repeat the problem I was having before. Do you still want me to run dbmon?

Post by **nikos** » 2004 Jul 15, 06:25

the process was valid at the time i posted the message
now it has expired

if the problem persists i'll make a separate debug version for you

Rancher Bob · Post by **Rancher Bob** » 2004 Sep 02, 20:25

OK. The same problem actually cropped up again while we were on the NT 4.0 server but I decide to wait on our new Windows Server 2003 server before I brought this up again, partly because we were having connectivity problems with the old server. Now, even with the new server, the same problem is occuring when I access mapped drives. I'm running version 1003. I downloaded www.ps.ic.ac.uk/~umeca74/dbmon.zip and extracted it into the xplorer2 program directory. What next?

Rancher Bob · Post by **Rancher Bob** » 2004 Sep 02, 21:52

OK, accessing the mapped network drive M this time took at least 20 seconds. here's the dbmon output (i was running kenny_dbg_uc.exe) up to the moment it finished reading M

3748: Frame_2304d4 handling command 32974
3748: GetTokenInformation required size: 196
3748: x2 user is ADMIN: The group SID is enabled.
3748: *** TID=99c, Cloned folder '::{20D04FE0-3AEA-1069-A2D8-08002B30309D}\C:\Program Files\zabkat\xplorer2' (type=1)
3748: Enumerated 19 objects in the folder, code=1
3748: view_180462 sorting by -1
3748: SPY(0000010f): Installed on '::{20D04FE0-3AEA-1069-A2D8-08002B30309D}\C:\Program Files\zabkat\xplorer2'
3748: *** TID=99c, Cloned folder '::{20D04FE0-3AEA-1069-A2D8-08002B30309D}\M:\' (type=1)
3748: Enumerating in bg thread 198...
3748: bg EnumObjects done
3748: ....
3748: ..Enumerated 93 objects in the folder, code=1
3748: view_e048e sorting by -1
3748: SPY(00000110): Installed on '::{20D04FE0-3AEA-1069-A2D8-08002B30309D}\M:\'
3748: MINI-ASSERT: folder destroyed has 3 outstanding references
3748: Delay-creating column handler...IShellFolder2; Columns = 35 (cached)
3748: MINI-ASSERT: folder destroyed has 4 outstanding references
3748: BG reader 198 finished
3748: Frame_2304d4 handling command 32779
3748: *** TID=99c, Generating folder instance '::{20D04FE0-3AEA-1069-A2D8-08002B30309D}'
3748: Filesystem path =
3748: Shell attributes: (0x30000000) FILESYSANCESTOR |
3748: DESCRIPTIONID: 1(ROOT_REGITEM) : {20D04FE0-3AEA-1069-A2D8-08002B30309D}
3748: Assigned folder type: FITYPE_NORMAL [deciphered]
3748: Folder CLSID: {20D04FE0-3AEA-1069-A2D8-08002B30309D}
3748: MINI-ASSERT: GetPidlType fails for: A:\
3748: MINI-ASSERT: GetPidlType fails for: D:\
3748: Enumerated 9 objects in the folder, code=1
3748: Delay-creating column handler...IShellFolder2; Columns = 6 (new)
3748: view_e048e cols: Name(0), Type(1), Total Size(2), Free Space(3), File System(4), Comments(5),
3748: view_e048e sorting by 0
3748: *** TID=99c, Generating folder instance '::{20D04FE0-3AEA-1069-A2D8-08002B30309D}\M:\'
3748: ....
3748: ..Enumerated 93 objects in the folder, code=1
3748: Delay-creating column handler...IShellFolder2; Columns = 35 (cached)
3748: view_e048e cols: Name(-1), Size(-4), Modified(-6),
3748: view_e048e sorting by -1
3748: SPY(00000111): Installed on '::{20D04FE0-3AEA-1069-A2D8-08002B30309D}\M:\'
3748: BG reader d3c finished

Post by **nikos** » 2004 Sep 03, 07:28

although this debug version is an older one, it should do for what you're after.

the question is, as these messages are being printed, where does the delay occur?

also try turning off the "show admin shares" from options to see if it makes any difference

eivind · Post by **eivind** » 2004 Sep 03, 08:09

Seems to be similar to the problem I was having (which is temporarily reduced by using another firewall). I hope you are able to solve it.

Don't hesitate to ask if you would like help with debugging, testing and so on.

Rancher Bob · Post by **Rancher Bob** » 2004 Sep 07, 15:04

OK. here's the dbmon output up to the moment it went on the clock reading the netwrok folder: (the last line was present during and after going on the clock)

1948: *** TID=7bc, Generating folder instance '::{20D04FE0-3AEA-1069-A2D8-08002B30309D}\C:\'
1948: Filesystem path = C:\
1948: Shell attributes: (0x70800000) FILESYSANCESTOR | FILESYSTEM | STORAGEANCESTOR |
1948: DESCRIPTIONID: 8(COMPUTER_FIXED) : {00000000-0000-0000-0000-000000000000}
1948: Assigned folder type: FITYPE_FILESYSTEM [deciphered]
1948: Folder CLSID: {F3364BA0-65B9-11CE-A9BA-00AA004AE837}
1948: Enumerated 53 objects in the folder, code=1
1948: Delay-creating column handler...IShellFolder2; Columns = 35 (cached)
1948: view_202a2 cols: Name(-1), Size(-4), Modified(-6),
1948: view_202a2 sorting by -1
1948: SPY(00000013): Installed on '::{20D04FE0-3AEA-1069-A2D8-08002B30309D}\C:\'
1948: Frame_30254 handling command 33016
1948: Frame_30254 handling command 32940
1948: *** TID=7bc, Generating folder instance '::{20D04FE0-3AEA-1069-A2D8-08002B30309D}\M:\'
1948: Filesystem path = M:\
1948: Shell attributes: (0x70800000) FILESYSANCESTOR | FILESYSTEM | STORAGEANCESTOR |
1948: DESCRIPTIONID: 9(COMPUTER_NETDRIVE) : {00000000-0000-0000-0000-000000000000}
1948: Assigned folder type: FITYPE_FILESYSTEM [deciphered]
1948: Folder CLSID: {F3364BA0-65B9-11CE-A9BA-00AA004AE837}
1948: Enumerating in bg thread 920...
1948: bg EnumObjects done
1948: ....
1948: ..Enumerated 94 objects in the folder, code=1
1948: view_202a2 sorting by -1
1948: SPY(00000017): Installed on '::{20D04FE0-3AEA-1069-A2D8-08002B30309D}\M:\'
1948: Delay-creating column handler...IShellFolder2; Columns = 35 (cached)
1948: BG reader 920 finished

fgagnon · Post by **fgagnon** » 2004 Sep 07, 15:32

Thanks for the info. However, FYI, ... nikos is on vacation until October, so you may have to wait a while for "analysis" of that output. (nikos indicated he would be "checking in from time to time but irregularly")
But JRz said he should be back from his vacation this week. He may or may not be able to contribute something after he digs himself out from his accumulated pile of work-related tasks. ... or maybe one of our other network & x2 literate old hands has a clue

Rancher Bob · Post by **Rancher Bob** » 2004 Sep 07, 17:56

Thanks. I'll check back periodically.

Post by **nikos** » 2004 Sep 10, 08:09

here i am interrupting my tanning process for x2 and country

Rancher Bob, it will help if you insert your comments within dbmon output hilighting the lines where the delay occured, or things like, "after this line I had to wait 2 seconds, then it printed 2 more lines followed by a further 10 second delay..."

this will help me understand which parts of the sequence are causing the problem

thanks

Rancher Bob · Post by **Rancher Bob** » 2004 Sep 14, 15:46

I hope this is what you're looking for. I looked at dbmon as soon as it delayed in reading a network folder and saw this:

2096: SPY(00000017): Raw Event 6 = UPDATEDIR
::{20D04FE0-3AEA-1069-A2D8-08002B30309D}\C:\ <NULL>
2096: SPY(00000017): Processing Disc Event = UPDATEDIR
::{20D04FE0-3AEA-1069-A2D8-08002B30309D}\C:\ <NULL>
2096: Enumerated(refresh) 53 objects in the folder, code=1
2096: *** TID=838, Generating folder instance '::{20D04FE0-3AEA-1069-A2D8-08002B30309D}\M:\Bulletin NEW'
2096: Filesystem path = M:\Bulletin NEW
2096: Shell attributes: (0x7080017f) FILESYSANCESTOR | FILESYSTEM | STORAGEANCESTOR |
2096: DESCRIPTIONID: 3(FS_DIRECTORY) : {00000000-0000-0000-0000-000000000000}
2096: Assigned folder type: FITYPE_FILESYSTEM [deciphered]
2096: Folder CLSID: {F3364BA0-65B9-11CE-A9BA-00AA004AE837}
2096: Enumerating in bg thread bec...
2096: bg EnumObjects done
2096: .Enumerated 20 objects in the folder, code=1
2096: view_202cc sorting by -1
2096: SPY(00000018): Installed on '::{20D04FE0-3AEA-1069-A2D8-08002B30309D}\M:\Bulletin NEW'
2096: Delay-creating column handler...IShellFolder2; Columns = 35 (cached)
2096: BG reader bec finished

I attempted to M:\Bulletin NEW and it went on the clock and was unresponsive (for 20 seconds altogether). when I looked at the dbmon output while it was stil on the clock, the last line here was the last line showing. When it came off the clock, this was still the last line.
Also, when I first accessed the folder it showed the contents immediately but the file icons were generic ones until it came off the clock.

zabkat support forum

slow network folder read

slow network folder read

she's healed

it's back

dbmon outout

once again