PST Collector Task won't copy pst

New install EV8.0.4.

Attemptng a PST migration.

In the admin console under Personal Sore Management\Files I have a discovered pst. The status is 'Ready to Copy'. I ran the Collector Task and it failed with an error that another process had the .pst locked. I assumed this was because Outlook was open. I closed Outlook and re-ran the Collector Task but nothing gets copied and nothing shows as being copied in the report. How do I this .pst to process?

Thanks

13 Replies

Any errors in the event log?

Any errors in the event log? Is the PST located on a server share or on local machine? Can you dtrace PST collector Task and post results?

http://support.veritas.com/docs/276120         

 

 

 

No errors in event log.

No errors in event log. Nothing happens.

PST is local on a Vista box.

 


Enabled Trace options

Id    Name                             Detail     Include Events
70  - PstCollectorTask                 Verbose    Yes        

-----


Display Filter:
  Include strings:
    EV-
    EV:
    EV~

  Exclude strings:
    CMMStream
    DBFramework
    DirectoryConnection
-----


Running in Terminal Services session...
  Monitoring debug output from processes running in the console session
  Monitoring debug output from processes running in the current Terminal Services session

1 15:53:16.621  [3992] (PstCollectorTask) <644> EV-M {ManagedProcess.KVS.EnterpriseVault.Management.IAdminControl.Stop} Current State:Running
2 15:53:16.621  [3992] (PstCollectorTask) <644> EV-M {ManagedObject.KVS.EnterpriseVault.Management.IAdminControl.Stop} TitleSmiley TonguestThreadController Current State:Running
3 15:53:16.621  [3992] (PstCollectorTask) <644> EV-M {DirectorySync.Abandon} Is waiting? False
4 15:53:16.621  [3992] (PstCollectorTask) <ThreadController:556> EV-L {PstLogFile.LogMessage} PST Collector Task normal completion after a stop request or at end of schedule
5 15:53:16.621  [3992] (PstCollectorTask) <ThreadController:556> EV~I |Event ID: 41032 The task 'PST Collector Task' has completed.
6 15:53:16.621  [3992] (PstCollectorTask) <644> EV-M {ManagedProcess.ObjectStateChanged} PstThreadController NewSmiley Frustratedtopped OldSmiley Frustratedtopping MySmiley Frustratedtopping
7 15:53:16.621  [3992] (PstCollectorTask) <644> EV-M {ManagedProcess.CheckProcessState} New StateSmiley Frustratedtopped Quorum:True
8 15:53:16.621  [3992] (PstCollectorTask) <644> EV-M {ManagedProcess.NotifyPMStateChanged} PstCollectorTask New StateSmiley Frustratedtopped OldSmiley Frustratedtopping MySmiley Frustratedtopped
9 15:53:16.636  [3992] (PstCollectorTask) <644> EV-M {ManagedProcess.CheckProcessState} New StateSmiley Frustratedtopped Quorum:True
11 15:53:21.636  [3992] (PstCollectorTask) <2256> EV-H {ManagedProcess.Run} Process exiting
12 15:53:21.667  [3992] (PstCollectorTask) <2256> EV:H DirectoryVault: Termination: DLL_PROCESS_DETACH received by the DirectoryVault DLL. |
19 15:53:29.744  [988] (PstCollectorTask) <2936> EV-M {ManagedObject.KVS.EnterpriseVault.Management.IAdminControl.RegisterStateChangedHandler} TitleSmiley TonguestThreadController
20 15:53:29.744  [988] (PstCollectorTask) <2936> EV-M {ManagedObjectState.RegisterStateChangedHandler} OwnerSmiley TonguestThreadController
21 15:53:29.760  [988] (PstCollectorTask) <2936> EV-H {ManagedProcess.Run} Process starting - "D:\Program Files (x86)\Enterprise Vault\PstCollectorTask.exe" -URL:tcp://10.140.14.177:41742/ccb7c9a1_38bd_486e_9c7e_a66b00338c36/KVS.EnterpriseVault.ProcessManager66480020 -CUSTOM:12C1FD9A5EBAB464CBAB434684FF446771012300vault01|False|
22 15:53:29.776  [988] (PstCollectorTask) <2936> EV-L {ManagedProcess.LoadConfigurationSettings} Config Settings - debugWaitSeconds=0
23 15:53:29.807  [988] (PstCollectorTask) <2936> EV-M {ManagedProcess.RemoteThis} URL[0]: tcp://10.140.14.177:42511/cee8ac98_e323_40d6_a22a_e21c58bc2d20/EVProcessManager41c958c1_6e0d_4705_951f_1699ca9dd8ff
24 15:53:29.807  [988] (PstCollectorTask) <2936> EV-M {ManagedProcess.NotifyAllPresentAndCorrect} Using Process manager URL:tcp://10.140.14.177:41742/ccb7c9a1_38bd_486e_9c7e_a66b00338c36/KVS.EnterpriseVault.ProcessManage... Title:12C1FD9A5EBAB464CBAB434684FF446771012300vault01
25 15:53:29.807  [988] (PstCollectorTask) <2936> EV-M {ManagedObjectState.RegisterStateChangedHandler} OwnerSmiley TonguestCollectorTask
26 15:53:29.823  [988] (PstCollectorTask) <1932> EV-M {ManagedProcess.KVS.EnterpriseVault.Management.IAdminControl.Start} Current StateSmiley Frustratedtopped
27 15:53:29.823  [988] (PstCollectorTask) <1932> EV-M {CollectorThreadController} NameSmiley TonguestThreadController Current StateSmiley Frustratedtopped startOptions: ''.
28 15:53:29.823  [988] (PstCollectorTask) <1932> EV-L {PstThreadController.OnStart} PST Task startup
29 15:53:29.948  [988] (PstCollectorTask) <ThreadController:4892> EV-M {CollectorThreadController.ThreadProc} PST Collector Task custom args: 12C1FD9A5EBAB464CBAB434684FF446771012300vault01|False|
36 15:53:29.948  [988] (PstCollectorTask) <1932> EV-M {ManagedProcess.ObjectStateChanged} PstThreadController New:Running OldSmiley Frustratedtarting MySmiley Frustratedtarting
37 15:53:29.948  [988] (PstCollectorTask) <1932> EV-M {ManagedProcess.CheckProcessState} New State:Running Quorum:True
38 15:53:29.948  [988] (PstCollectorTask) <1932> EV-M {ManagedProcess.NotifyPMStateChanged} PstCollectorTask New State:Running OldSmiley Frustratedtarting My:Running
39 15:53:29.948  [988] (PstCollectorTask) <4892> EV:M CBaseDirectoryServiceWrapper::GetInterface - RegKey UseLocalDirectory [False]
41 15:53:29.948  [988] (PstCollectorTask) <4892> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
42 15:53:29.948  [988] (PstCollectorTask) <4892> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
43 15:53:29.963  [988] (PstCollectorTask) <1932> EV-M {ManagedProcess.CheckProcessState} New State:Running Quorum:True
44 15:53:29.963  [988] (PstCollectorTask) <2936> EV-L {ManagedProcess.Run} Loading... State:Running Countdown:0
45 15:53:29.963  [988] (PstCollectorTask) <4892> EV:M DirectoryVault: Initialization: DLL_PROCESS_ATTACH received by the DirectoryVault DLL. |
46 15:53:29.979  [988] (PstCollectorTask) <4892> EV:H DirectoryVault: Initialization: DirectoryVault DLL version is: v1.2.| |
48 15:53:29.979  [988] (PstCollectorTask) <4892> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
49 15:53:29.979  [988] (PstCollectorTask) <4892> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
50 15:53:29.979  [988] (PstCollectorTask) <4892> EV:L CDirectoryVaultObject::GetAttributeListFromType Unknown type - PstCollectorTaskView
52 15:53:29.979  [988] (PstCollectorTask) <4892> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
53 15:53:29.979  [988] (PstCollectorTask) <4892> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
54 15:53:29.979  [988] (PstCollectorTask) <ThreadController:4892> EV-L {PstLogFile.LogMessage} Number of retries after a networking error: 7
55 15:53:29.979  [988] (PstCollectorTask) <ThreadController:4892> EV-L {PstLogFile.LogMessage} Delay time before a retry after a networking error: 1 Day
57 15:53:29.979  [988] (PstCollectorTask) <4892> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
58 15:53:29.994  [988] (PstCollectorTask) <4892> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
59 15:53:29.994  [988] (PstCollectorTask) <ThreadController:4892> EV-L {PstLogFile.LogMessage} Location of the holding folder: \\ASPRTKEV1\PST_Holding
60 15:53:29.994  [988] (PstCollectorTask) <ThreadController:4892> EV-L {PstLogFile.LogMessage} Maximum amount of data allowed in the holding folder: 10GB
61 15:53:29.994  [988] (PstCollectorTask) <ThreadController:4892> EV-L {PstLogFile.LogMessage} Maximum number of PSTs for this server to be held in the holding folder: 100
62 15:53:29.994  [988] (PstCollectorTask) <ThreadController:4892> EV-L {PstLogFile.LogMessage} PSTs get backed up before being migrated: False
63 15:53:29.994  [988] (PstCollectorTask) <ThreadController:4892> EV-L {PstLogFile.LogMessage} Archive attribute reset denotes a PST has been backed up: False
64 15:53:29.994  [988] (PstCollectorTask) <ThreadController:4892> EV-H {PstThreadController.AreWeLicensed} Checking for a valid license
65 15:53:29.994  [988] (PstCollectorTask) <4892> EV:M CLicense2::LoadLicense - Calling SlicCreateLicenseManager()|Status: 0x00000000
66 15:53:29.994  [988] (PstCollectorTask) <4892> EV:M CLicense2::LoadLicense - Calling SlicCreateLicenseEx()|Status: 0x00000000|Feature Code: EVPSTM
67 15:53:29.994  [988] (PstCollectorTask) <4892> EV:M CLicense2:Smiley Very HappyoLicenseCheck - EVPSTM License is valid
69 15:53:30.010  [988] (PstCollectorTask) <4892> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
70 15:53:30.010  [988] (PstCollectorTask) <4892> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
72 15:53:30.010  [988] (PstCollectorTask) <4892> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
73 15:53:30.010  [988] (PstCollectorTask) <4892> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
75 15:53:30.010  [988] (PstCollectorTask) <4892> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
76 15:53:30.010  [988] (PstCollectorTask) <4892> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
77 15:53:30.010  [988] (PstCollectorTask) <ThreadController:4892> EV-L {CollectorThreadController.ThreadProc} Storage Service Entry ID = 103B65F4528D0B84088911066BB7528BE1e10000vault01
78 15:53:30.026  [988] (PstCollectorTask) <ThreadController:4892> EV~I |Event ID: 41031 The task 'PST Collector Task' has started processing.
80 15:53:30.026  [988] (PstCollectorTask) <4892> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
81 15:53:30.026  [988] (PstCollectorTask) <4892> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
82 15:53:30.026  [988] (PstCollectorTask) <CollectorThread:2944> EV-L {CollectorThread.ThreadAction} Collector Thread in action
84 15:53:30.026  [988] (PstCollectorTask) <2944> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
85 15:53:30.026  [988] (PstCollectorTask) <2944> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
87 15:53:30.026  [988] (PstCollectorTask) <2944> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
88 15:53:30.026  [988] (PstCollectorTask) <2944> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
92 15:54:30.021  [988] (PstCollectorTask) <4892> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
93 15:54:30.021  [988] (PstCollectorTask) <4892> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
94 15:54:30.021  [988] (PstCollectorTask) <CollectorThread:5288> EV-L {CollectorThread.ThreadAction} Collector Thread in action
96 15:54:30.021  [988] (PstCollectorTask) <5288> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
97 15:54:30.021  [988] (PstCollectorTask) <5288> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
99 15:54:30.021  [988] (PstCollectorTask) <5288> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
100 15:54:30.021  [988] (PstCollectorTask) <5288> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
103 15:55:30.016  [988] (PstCollectorTask) <4892> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
104 15:55:30.016  [988] (PstCollectorTask) <4892> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
105 15:55:30.016  [988] (PstCollectorTask) <CollectorThread:2684> EV-L {CollectorThread.ThreadAction} Collector Thread in action
107 15:55:30.016  [988] (PstCollectorTask) <2684> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
108 15:55:30.016  [988] (PstCollectorTask) <2684> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
110 15:55:30.016  [988] (PstCollectorTask) <2684> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
111 15:55:30.016  [988] (PstCollectorTask) <2684> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
118 15:56:30.011  [988] (PstCollectorTask) <4892> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
119 15:56:30.011  [988] (PstCollectorTask) <4892> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
120 15:56:30.011  [988] (PstCollectorTask) <CollectorThread:3120> EV-L {CollectorThread.ThreadAction} Collector Thread in action
122 15:56:30.011  [988] (PstCollectorTask) <3120> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
123 15:56:30.011  [988] (PstCollectorTask) <3120> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
125 15:56:30.011  [988] (PstCollectorTask) <3120> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
126 15:56:30.011  [988] (PstCollectorTask) <3120> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
129 15:57:30.007  [988] (PstCollectorTask) <4892> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
130 15:57:30.007  [988] (PstCollectorTask) <4892> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
131 15:57:30.007  [988] (PstCollectorTask) <CollectorThread:3820> EV-L {CollectorThread.ThreadAction} Collector Thread in action
133 15:57:30.007  [988] (PstCollectorTask) <3820> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
134 15:57:30.007  [988] (PstCollectorTask) <3820> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
136 15:57:30.007  [988] (PstCollectorTask) <3820> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
137 15:57:30.007  [988] (PstCollectorTask) <3820> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
142 15:58:30.005  [988] (PstCollectorTask) <4892> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
143 15:58:30.005  [988] (PstCollectorTask) <4892> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
144 15:58:30.005  [988] (PstCollectorTask) <4892> EV:L CDirectoryVaultObject::GetAttributeListFromType Unknown type - PstCollectorTaskView
146 15:58:30.005  [988] (PstCollectorTask) <4892> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
147 15:58:30.005  [988] (PstCollectorTask) <4892> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
149 15:58:30.005  [988] (PstCollectorTask) <4892> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
150 15:58:30.005  [988] (PstCollectorTask) <4892> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
151 15:58:30.005  [988] (PstCollectorTask) <CollectorThread:5792> EV-L {CollectorThread.ThreadAction} Collector Thread in action
153 15:58:30.021  [988] (PstCollectorTask) <5792> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
154 15:58:30.021  [988] (PstCollectorTask) <5792> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
156 15:58:30.021  [988] (PstCollectorTask) <5792> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
157 15:58:30.021  [988] (PstCollectorTask) <5792> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine

**** DTrace exit - log terminated

Well one solution is to

Well one solution is to rename the pst, rerun the Locator and  Collector Task. This worked  but there must be a cleaner way.

Now, is there any reason that

Now, is there any reason that I should or should not delete the old file (the one that never gets collected) in the Files container?

So I don't see any collection

So I don't see any collection happening in that Dtrace, unless I'm looking at it wrong.  After the restart of the task, did you do a run now?

Working for Quadrotech-it.com

To make sure this wasn't a

To make sure this wasn't a one time fluke, I re-created the situation with a new pst. I ran the collector task with Outlook running and connected to the pst. It came back with the error that another process has the file locked. I closed Outlook and re-ran the Collector task, but nothing is processed.

 

 

[2956] (PstCollectorTask) <4496> EV-M {ManagedProcess.KVS.EnterpriseVault.Management.IAdminControl.Stop} Current State:Running
178 10:10:51.740  [2956] (PstCollectorTask) <4496> EV-M {ManagedObject.KVS.EnterpriseVault.Management.IAdminControl.Stop} TitleSmiley TonguestThreadController Current State:Running
179 10:10:51.740  [2956] (PstCollectorTask) <4496> EV-M {DirectorySync.Abandon} Is waiting? False
180 10:10:51.740  [2956] (PstCollectorTask) <ThreadController:3280> EV-L {PstLogFile.LogMessage} PST Collector Task normal completion after a stop request or at end of schedule
181 10:10:51.755  [2956] (PstCollectorTask) <ThreadController:3280> EV~I |Event ID: 41032 The task 'PST Collector Task' has completed.
182 10:10:51.755  [2956] (PstCollectorTask) <4496> EV-M {ManagedProcess.ObjectStateChanged} PstThreadController NewSmiley Frustratedtopped OldSmiley Frustratedtopping MySmiley Frustratedtopping
183 10:10:51.755  [2956] (PstCollectorTask) <4496> EV-M {ManagedProcess.CheckProcessState} New StateSmiley Frustratedtopped Quorum:True
184 10:10:51.755  [2956] (PstCollectorTask) <4496> EV-M {ManagedProcess.NotifyPMStateChanged} PstCollectorTask New StateSmiley Frustratedtopped OldSmiley Frustratedtopping MySmiley Frustratedtopped
185 10:10:51.755  [2956] (PstCollectorTask) <4496> EV-M {ManagedProcess.CheckProcessState} New StateSmiley Frustratedtopped Quorum:True
186 10:10:56.755  [2956] (PstCollectorTask) <6764> EV-H {ManagedProcess.Run} Process exiting
187 10:10:56.771  [2956] (PstCollectorTask) <6764> EV:H DirectoryVault: Termination: DLL_PROCESS_DETACH received by the DirectoryVault DLL. |
194 10:11:04.380  [5248] (PstCollectorTask) <5296> EV-M {ManagedObject.KVS.EnterpriseVault.Management.IAdminControl.RegisterStateChangedHandler} TitleSmiley TonguestThreadController
195 10:11:04.380  [5248] (PstCollectorTask) <5296> EV-M {ManagedObjectState.RegisterStateChangedHandler} OwnerSmiley TonguestThreadController
196 10:11:04.396  [5248] (PstCollectorTask) <5296> EV-H {ManagedProcess.Run} Process starting - "D:\Program Files (x86)\Enterprise Vault\PstCollectorTask.exe" -URL:tcp://10.140.14.177:41742/ccb7c9a1_38bd_486e_9c7e_a66b00338c36/KVS.EnterpriseVault.ProcessManager51160013 -CUSTOM:12C1FD9A5EBAB464CBAB434684FF446771012300vault01|False|
197 10:11:04.412  [5248] (PstCollectorTask) <5296> EV-L {ManagedProcess.LoadConfigurationSettings} Config Settings - debugWaitSeconds=0
198 10:11:04.443  [5248] (PstCollectorTask) <5296> EV-M {ManagedProcess.RemoteThis} URL[0]: tcp://10.140.14.177:62485/751d71f5_5992_47cc_b47b_bc55a1631e9c/EVProcessManagerc729d25f_9706_4369_a247_51c2c2f19933
199 10:11:04.443  [5248] (PstCollectorTask) <5296> EV-M {ManagedProcess.NotifyAllPresentAndCorrect} Using Process manager URL:tcp://10.140.14.177:41742/ccb7c9a1_38bd_486e_9c7e_a66b00338c36/KVS.EnterpriseVault.ProcessManage... Title:12C1FD9A5EBAB464CBAB434684FF446771012300vault01
200 10:11:04.458  [5248] (PstCollectorTask) <5296> EV-M {ManagedObjectState.RegisterStateChangedHandler} OwnerSmiley TonguestCollectorTask
201 10:11:04.458  [5248] (PstCollectorTask) <6664> EV-M {ManagedProcess.KVS.EnterpriseVault.Management.IAdminControl.Start} Current StateSmiley Frustratedtopped
202 10:11:04.458  [5248] (PstCollectorTask) <6664> EV-M {CollectorThreadController} NameSmiley TonguestThreadController Current StateSmiley Frustratedtopped startOptions: ''.
203 10:11:04.458  [5248] (PstCollectorTask) <6664> EV-L {PstThreadController.OnStart} PST Task startup
204 10:11:04.599  [5248] (PstCollectorTask) <ThreadController:4528> EV-M {CollectorThreadController.ThreadProc} PST Collector Task custom args: 12C1FD9A5EBAB464CBAB434684FF446771012300vault01|False|
211 10:11:04.599  [5248] (PstCollectorTask) <6664> EV-M {ManagedProcess.ObjectStateChanged} PstThreadController New:Running OldSmiley Frustratedtarting MySmiley Frustratedtarting
212 10:11:04.599  [5248] (PstCollectorTask) <6664> EV-M {ManagedProcess.CheckProcessState} New State:Running Quorum:True
213 10:11:04.599  [5248] (PstCollectorTask) <6664> EV-M {ManagedProcess.NotifyPMStateChanged} PstCollectorTask New State:Running OldSmiley Frustratedtarting My:Running
214 10:11:04.599  [5248] (PstCollectorTask) <4528> EV:M CBaseDirectoryServiceWrapper::GetInterface - RegKey UseLocalDirectory [False]
216 10:11:04.615  [5248] (PstCollectorTask) <4528> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
217 10:11:04.615  [5248] (PstCollectorTask) <4528> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
218 10:11:04.615  [5248] (PstCollectorTask) <6664> EV-M {ManagedProcess.CheckProcessState} New State:Running Quorum:True
219 10:11:04.615  [5248] (PstCollectorTask) <5296> EV-L {ManagedProcess.Run} Loading... State:Running Countdown:0
220 10:11:04.615  [5248] (PstCollectorTask) <4528> EV:M DirectoryVault: Initialization: DLL_PROCESS_ATTACH received by the DirectoryVault DLL. |
221 10:11:04.630  [5248] (PstCollectorTask) <4528> EV:H DirectoryVault: Initialization: DirectoryVault DLL version is: v1.2.| |
223 10:11:04.630  [5248] (PstCollectorTask) <4528> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
224 10:11:04.630  [5248] (PstCollectorTask) <4528> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
225 10:11:04.630  [5248] (PstCollectorTask) <4528> EV:L CDirectoryVaultObject::GetAttributeListFromType Unknown type - PstCollectorTaskView
227 10:11:04.630  [5248] (PstCollectorTask) <4528> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
228 10:11:04.630  [5248] (PstCollectorTask) <4528> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
229 10:11:04.646  [5248] (PstCollectorTask) <ThreadController:4528> EV-L {PstLogFile.LogMessage} Number of retries after a networking error: 7
230 10:11:04.646  [5248] (PstCollectorTask) <ThreadController:4528> EV-L {PstLogFile.LogMessage} Delay time before a retry after a networking error: 1 Day
232 10:11:04.646  [5248] (PstCollectorTask) <4528> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
233 10:11:04.646  [5248] (PstCollectorTask) <4528> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
234 10:11:04.646  [5248] (PstCollectorTask) <ThreadController:4528> EV-L {PstLogFile.LogMessage} Location of the holding folder: \\ASPRTKEV1\PST_Holding
235 10:11:04.646  [5248] (PstCollectorTask) <ThreadController:4528> EV-L {PstLogFile.LogMessage} Maximum amount of data allowed in the holding folder: 10GB
236 10:11:04.646  [5248] (PstCollectorTask) <ThreadController:4528> EV-L {PstLogFile.LogMessage} Maximum number of PSTs for this server to be held in the holding folder: 100
237 10:11:04.646  [5248] (PstCollectorTask) <ThreadController:4528> EV-L {PstLogFile.LogMessage} PSTs get backed up before being migrated: False
238 10:11:04.646  [5248] (PstCollectorTask) <ThreadController:4528> EV-L {PstLogFile.LogMessage} Archive attribute reset denotes a PST has been backed up: False
239 10:11:04.646  [5248] (PstCollectorTask) <ThreadController:4528> EV-H {PstThreadController.AreWeLicensed} Checking for a valid license
240 10:11:04.646  [5248] (PstCollectorTask) <4528> EV:M CLicense2::LoadLicense - Calling SlicCreateLicenseManager()|Status: 0x00000000
241 10:11:04.662  [5248] (PstCollectorTask) <4528> EV:M CLicense2::LoadLicense - Calling SlicCreateLicenseEx()|Status: 0x00000000|Feature Code: EVPSTM
242 10:11:04.662  [5248] (PstCollectorTask) <4528> EV:M CLicense2:Smiley Very HappyoLicenseCheck - EVPSTM License is valid
244 10:11:04.662  [5248] (PstCollectorTask) <4528> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
245 10:11:04.662  [5248] (PstCollectorTask) <4528> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
247 10:11:04.662  [5248] (PstCollectorTask) <4528> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
248 10:11:04.662  [5248] (PstCollectorTask) <4528> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
250 10:11:04.662  [5248] (PstCollectorTask) <4528> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
251 10:11:04.662  [5248] (PstCollectorTask) <4528> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
252 10:11:04.677  [5248] (PstCollectorTask) <ThreadController:4528> EV-L {CollectorThreadController.ThreadProc} Storage Service Entry ID = 103B65F4528D0B84088911066BB7528BE1e10000vault01
253 10:11:04.677  [5248] (PstCollectorTask) <ThreadController:4528> EV~I |Event ID: 41031 The task 'PST Collector Task' has started processing.
255 10:11:04.677  [5248] (PstCollectorTask) <4528> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
256 10:11:04.677  [5248] (PstCollectorTask) <4528> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
257 10:11:04.693  [5248] (PstCollectorTask) <CollectorThread:5924> EV-L {CollectorThread.ThreadAction} Collector Thread in action
259 10:11:04.693  [5248] (PstCollectorTask) <5924> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
260 10:11:04.693  [5248] (PstCollectorTask) <5924> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
262 10:11:04.693  [5248] (PstCollectorTask) <5924> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
263 10:11:04.693  [5248] (PstCollectorTask) <5924> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
267 10:12:04.693  [5248] (PstCollectorTask) <4528> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
268 10:12:04.693  [5248] (PstCollectorTask) <4528> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
269 10:12:04.693  [5248] (PstCollectorTask) <CollectorThread:6276> EV-L {CollectorThread.ThreadAction} Collector Thread in action
271 10:12:04.693  [5248] (PstCollectorTask) <6276> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
272 10:12:04.693  [5248] (PstCollectorTask) <6276> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
274 10:12:04.693  [5248] (PstCollectorTask) <6276> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
275 10:12:04.693  [5248] (PstCollectorTask) <6276> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
278 10:13:04.694  [5248] (PstCollectorTask) <4528> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
279 10:13:04.694  [5248] (PstCollectorTask) <4528> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
280 10:13:04.694  [5248] (PstCollectorTask) <CollectorThread:3900> EV-L {CollectorThread.ThreadAction} Collector Thread in action
282 10:13:04.694  [5248] (PstCollectorTask) <3900> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
283 10:13:04.694  [5248] (PstCollectorTask) <3900> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
285 10:13:04.694  [5248] (PstCollectorTask) <3900> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
286 10:13:04.694  [5248] (PstCollectorTask) <3900> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
291 10:14:04.694  [5248] (PstCollectorTask) <4528> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
292 10:14:04.694  [5248] (PstCollectorTask) <4528> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
293 10:14:04.694  [5248] (PstCollectorTask) <CollectorThread:1196> EV-L {CollectorThread.ThreadAction} Collector Thread in action
295 10:14:04.694  [5248] (PstCollectorTask) <1196> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
296 10:14:04.694  [5248] (PstCollectorTask) <1196> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
298 10:14:04.694  [5248] (PstCollectorTask) <1196> EV:M CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40]
299 10:14:04.694  [5248] (PstCollectorTask) <1196> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine

So let me get this

So let me get this right...

 

You create a new PST, and drop in (say) a handful of items.

Is this on a server or a workstation?

You leave Outlook open, and run the locator (run now) and it finds the PST?

When you do a run now on the collector task, it reports that the file can't be copied because it's locked?

When you then close Outlook and run the collector task again, it doesn't pick up the file (which is now not locked)

 

Is that all correct so far?

Working for Quadrotech-it.com

That is correct. The only

That is correct.

The only solution I found so far is to either delete the entry from Personal Store Management\Files and re-locate it or rename the .pst (on a Vista workstation) and re-locate it.

Highlighted

After you close outlook are

After you close outlook are you having the EV client rescan for PST's?

This should trigger the client to the server that you have a PST ready.

 

Sounds like this is happening when you rename, the client then tells the collector that a PST is ready.

 

Try to select "Restart Search" and see if that helps without renamaning.

So in my environment I have

So in my environment I have just done the following :

1. Created a new PST file, on a client workstation.

2.  Added 2 mails to it

3.  Kept Outlook open.

4.  Do a registry scan from the EV server of the already discovered workstation.

 

The following is reported in DTRACE :

135 07:59:16.661  [1408] (PstLocatorTask) <968> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine
136 07:59:17.724  [1408] (PstLocatorTask) <LocateRegistryThread:968> EV-M {LocatorThread.CorrelatePstFile} Could not get Write access to \\C2\C$\Documents and Settings\m3\Local Settings\Application Data\Microsoft\Outlook\AlphaDongle.pst: The process cannot access the file '\\C2\C$\Documents and Settings\m3\Local Settings\Application Data\Microsoft\Outlook\AlphaDongle.pst' because it is being used by another process.
 

This is because, as we said, the file is locked open by Outlook.

If you look in the VAC under PST files, you'll see the file is set to DO NOT MIGRATE.  What you need to do is :-

 

1.  Close Outlook on the workstation.

2.  Set the PST to Ready to Copy

3.  Run now on the collector task.

 

You'll now see :

 

399 08:04:50.215  [3964] (PstCollectorTask) <CollectorThread:4300> EV-L {PstLogFile.LogMessage} Collected PST: \\C2\C$\Documents and Settings\m3\Local Settings\Application Data\Microsoft\Outlook\AlphaDongle.pst

 

And in the VAC, the PST will go to Ready to Migrate.

Working for Quadrotech-it.com

I'm a bit confused now. See

I'm a bit confused now. See the log below. The .pst was automatically set back to 'Ready to Copy' after the copy failure.

After I saw that, I closed Outlook and retried the Collector Task. Nothing.

Now today when I looked at the status of the file, it was Migration Failed with the Failure text: PersonalFoldersVI.pst is read only.

This is not exactly the behavior of  previous tests. Those other test files stayed as 'Ready to Copy' and would not be collected until I deleted the entry and re-located it with the Locator Task.

** 9/27/2010 10:12:37 AM Could not copy PST file: \\ITTSTK04\C$\Users\testp\AppData\Local\Microsoft\Outlook\PersonalFoldersVI.pst : The process cannot access the file because another process has locked a portion of the file. **

   9/27/2010 10:13:37 AM Migration Status of PST: \\ITTSTK04\C$\Users\testp\AppData\Local\Microsoft\Outlook\PersonalFoldersVI.pst has been reset to: Ready to Copy
   9/27/2010 11:08:36 AM PST Collector Task normal completion after a stop request or at end of schedule

I'll repeat the test

I'll repeat the test tomorrow, and see whether I get the line you're referring to above (the reset to: Ready to Copy line).

Working for Quadrotech-it.com

Okay I think you're going to

Okay I think you're going to have to be more specific with the testing steps, and the dtrace needs to be more complete (I can't tell if your trace is from locator or collector, without looking at the code)

I just located a new test pst file, with Outlook closed.  Are you doing the location with Outlook closed, or with Outlook open ?

In the VAC it is now listed as Do Not Migrate.

If I change that to Ready to Copy, and open Outlook on the client, and then run the collector I see the following logged :

1,348 08:45:15.171 [252] (PstCollectorTask) <CollectorThread:2392> EV-H {PstLogFile.LogError} Could not copy PST file: \\C2\C$\Docum
ents and Settings\m3\Local Settings\Application Data\Microsoft\Outlook\alpha1.pst : The process cannot access the file because anoth
er process has locked a portion of the file.

The status now in the VAC is "Copying".

We're getting a lot of differences, too many for me to try to guess what is happening, so I think you'll have to list each and every step along the way.

 

From here though, I'm not seeing anything go "wrong".  As you'd expect we can't/don't copy the file when it's locked open, but when it is not, the next collector run will pick up th file.

Working for Quadrotech-it.com