Upgrade to EV 9.0.1 - Problem trying to synchronize EV with Exchange Server

[nagyal]

I have recently upgraded EV 8.5 to EV 9.0.1. But now when i try to Manually synchronize EV Exchange Mailbox Archiving Task to update details of all mailboxes, i get the following error

'Failed to synchronize Enterprise Vault with details from Exchange Server XYZ

Reason: Access is Denied'

I am using Vault Service account to synchronize. Also when i try to synchronize only selected maiboxes the process completes successfully without any access denied errors.

I have gone through almost all the relevent threads, but none of them seem to work for me, i have checked the permission of Vault service account on Exchange server and they are OK.

Any help in this matter will be highly appreciated. Looking forward to some nice reply.

[JesusWept3]

Do you have any events in the event viewer when you try and do the synchronization that has other than access is denied? you may need to get a dtrace of agentclientbroker when synchronizing to see the full extent of the error

[csondermann]

- do you have 2008 AD? If so, check the NSPI on the DC... - does the svc account have a mbx? If not, create one and try again...

[nagyal]

@JesusWept2: When i try to do synchronization i dont see any errors occuring in the Event viewer. The only error i receive is in the 'Progress' Area. Although after observing Event viewer i can see another error

Event Type:    Error
Event Source:    Enterprise Vault
Event Category:    None
Event ID:    41285
Date:        24/03/2011
Time:        1:16:09 AM
User:        N/A
Computer:   XYZ
Description:
The EVStgOfflineOpns.exe process could not be started due to the following error:

The EVStgOfflineOpns.exe configuration file is malformed. Error: An error occurred loading a configuration file: The parameter 'exePath' is invalid.
Parameter name: exePath

For more information, see Help and Support Center at http://go.microsoft.com/fwlink/events.asp.

This error is followed by following event messages

Event Type:    Error
Event Source:    Enterprise Vault
Event Category:    None
Event ID:    40966
Date:        24/03/2011
Time:        1:16:10 AM
User:        N/A
Computer:    XYZ
Description:
A program fault has raised an exception.

Exception: An error occurred loading a configuration file: The parameter 'exePath' is invalid.
Parameter name: exePath
Diagnostic:
Type: KVS.EnterpriseVault.ProcessManagement.StartProcessFailedException
Reference:

Command Line: "D:\Program Files\Enterprise Vault\StorageServer.exe" -EntryID:12A286756A37482489BCF414CD66E8CF71e10000Archive
Application Domain: DefaultDomain
Process Id: 2356
Thread Id: 4520
Stack Trace:    at KVS.EnterpriseVault.ProcessManagement.ProcessManager.SpawnProcess(Boolean restart)
   at KVS.EnterpriseVault.ProcessManagement.ProcessManager.KVS.EnterpriseVault.ProcessManagement.IAdminControl.Start()
   at KVS.EnterpriseVault.ProcessManagement.ServerManager.KVS.EnterpriseVault.ProcessManagement.IAdminControl.Start()

For more information, see Help and Support Center at http://go.microsoft.com/fwlink/events.asp.

I will get a dtrace of the system and will share more information, meanwhile can i ask whether these executables have somthing to do with the synchronization problem?

@csondermann: I am not running 2008, its 2003 server. And svc account has a mbx and i can access the emails using outlook against vault service account as well as some other user account.

Looking forward to hear from you guyz....

[nagyal]

Here is the DTrace output on agentclientbroker

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    17:45:10.017     [6020]    (AgentClientBroker)    <6048>    EV:M    IsOutlookInstalledAsDefault - check registry for default mail client
2    17:45:10.017     [6020]    (AgentClientBroker)    <6048>    EV:M    IsOutlookInstalledAsDefault - found default mail client to be Microsoft Outlook
3    17:45:10.017     [6020]    (AgentClientBroker)    <6048>    EV:M    IsOutlookInstalledAsDefault - default mail client is outlook
4    17:45:10.080     [6020]    (AgentClientBroker)    <6048>    EV:M    EPC::EPC
5    17:45:10.080     [6020]    (AgentClientBroker)    <6048>    EV:M    EPC - new cache being created
6    17:45:10.080     [6020]    (AgentClientBroker)    <6048>    EV:M    EDPC::EDPC
7    17:45:10.080     [6020]    (AgentClientBroker)    <6048>    EV:M    EDPC - new cache being created
8    17:45:10.080     [6020]    (AgentClientBroker)    <6048>    EV:M    tracing level : 0, check vault read rights : true
9    17:45:10.101     [6020]    (AgentClientBroker)    <6048>    EV:L    CAAQ::SynchronizeSystemEx (Entry) |
10    17:45:10.101     [6020]    (AgentClientBroker)    <6048>    EV:M    CSecurityWrapper::CSecurityWrapper
11    17:45:10.101     [6020]    (AgentClientBroker)    <6048>    EV:M    CSecurityWrapper::HasServerClientGotPermission, Admin Operation: 48
12    17:45:10.101     [6020]    (AgentClientBroker)    <6048>    EV:M    CSecurityWrapper::IsServerClientTheVSA
13    17:45:10.101     [6020]    (AgentClientBroker)    <6048>    EV:M    CSecurityWrapper::IsServerClientTheVSA - hr=0 InClientCOMCall:T VSA:T
14    17:45:10.101     [6020]    (AgentClientBroker)    <6048>    EV:M    CSecurityWrapper::HasServerClientGotPermission: VSA: Allowed
15    17:45:10.101     [6020]    (AgentClientBroker)    <6048>    EV:M    CAAQ::SynchronizeSystemEx() - Failed to post message to queue, error = 0x80070005
16    17:45:10.101     [6020]    (AgentClientBroker)    <6048>    EV:L    CAAQ::SynchronizeSystemEx (Exit) |Access is denied.  [0x80070005] |
17    17:45:10.101     [6020]    (AgentClientBroker)    <6048>    EV:M    CMAPISession::ClearProfileCache()
18    17:45:10.101     [6020]    (AgentClientBroker)    <6048>    EV:M    CMAPISession::CloseMapiSession - Entry
19    17:45:10.101     [6020]    (AgentClientBroker)    <6048>    EV:M    CMAPISession::CloseMapiSession - [1]
20    17:45:10.101     [6020]    (AgentClientBroker)    <6048>    EV:M    CMAPISession::CloseMapiSession - [2]
21    17:45:10.101     [6020]    (AgentClientBroker)    <6048>    EV:M    CMAPISession::CloseMapiSession - [3]
22    17:45:16.793     [6020]    (AgentClientBroker)    <6024>    EV:M    _tWinMain (AgentClientBroker) shutdown
23    17:45:18.132     [6020]    (AgentClientBroker)    <6024>    EV:M    CEVAudit::Close Closing down the audit database.
24    17:45:18.132     [6020]    (AgentClientBroker)    <6024>    EV:M    DllMain (AgentsCommon.dll) shutdown
25    17:45:18.132     [6020]    (AgentClientBroker)    <6024>    EV:M    ~EDPC
26    17:45:18.132     [6020]    (AgentClientBroker)    <6024>    EV:M    ~EPC
27    17:45:20.558     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::CSecurityWrapper
28    17:45:20.558     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission, Admin Operation: 53
29    17:45:20.558     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA
30    17:45:20.558     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA - hr=0 InClientCOMCall:T VSA:T
31    17:45:20.558     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission: VSA: Allowed
32    17:45:47.326     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::CSecurityWrapper
33    17:45:47.326     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission, Admin Operation: 53
34    17:45:47.326     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA
35    17:45:47.326     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA - hr=0 InClientCOMCall:T VSA:T
36    17:45:47.326     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission: VSA: Allowed
37    17:46:14.095     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::CSecurityWrapper
38    17:46:14.095     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission, Admin Operation: 53
39    17:46:14.095     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA
40    17:46:14.095     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA - hr=0 InClientCOMCall:T VSA:T
41    17:46:14.095     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission: VSA: Allowed
42    17:46:40.863     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::CSecurityWrapper
43    17:46:40.863     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission, Admin Operation: 53
44    17:46:40.863     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA
45    17:46:40.863     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA - hr=0 InClientCOMCall:T VSA:T
46    17:46:40.863     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission: VSA: Allowed
58    17:47:03.804     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::CSecurityWrapper
59    17:47:03.804     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission, Admin Operation: 53
60    17:47:03.804     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA
61    17:47:03.804     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA - hr=0 InClientCOMCall:T VSA:T
62    17:47:03.804     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission: VSA: Allowed
63    17:47:26.241     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::CSecurityWrapper
64    17:47:26.241     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission, Admin Operation: 53
65    17:47:26.241     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA
66    17:47:26.241     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA - hr=0 InClientCOMCall:T VSA:T
67    17:47:26.241     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission: VSA: Allowed
68    17:47:48.678     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::CSecurityWrapper
69    17:47:48.678     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission, Admin Operation: 53
70    17:47:48.678     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA
71    17:47:48.678     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA - hr=0 InClientCOMCall:T VSA:T
72    17:47:48.678     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission: VSA: Allowed
74    17:48:11.115     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::CSecurityWrapper
75    17:48:11.115     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission, Admin Operation: 53
76    17:48:11.115     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA
77    17:48:11.115     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA - hr=0 InClientCOMCall:T VSA:T
78    17:48:11.115     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission: VSA: Allowed
79    17:48:33.551     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::CSecurityWrapper
80    17:48:33.551     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission, Admin Operation: 53
81    17:48:33.551     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA
82    17:48:33.551     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA - hr=0 InClientCOMCall:T VSA:T
83    17:48:33.551     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission: VSA: Allowed
84    17:48:55.988     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::CSecurityWrapper
85    17:48:55.988     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission, Admin Operation: 53
86    17:48:55.988     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA
87    17:48:55.988     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA - hr=0 InClientCOMCall:T VSA:T
88    17:48:55.988     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission: VSA: Allowed
89    17:49:18.425     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::CSecurityWrapper
90    17:49:18.425     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission, Admin Operation: 53
91    17:49:18.425     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA
92    17:49:18.425     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA - hr=0 InClientCOMCall:T VSA:T
93    17:49:18.425     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission: VSA: Allowed
94    17:49:40.862     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::CSecurityWrapper
95    17:49:40.862     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission, Admin Operation: 53
96    17:49:40.862     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA
97    17:49:40.862     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA - hr=0 InClientCOMCall:T VSA:T
98    17:49:40.862     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission: VSA: Allowed
99    17:50:03.298     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::CSecurityWrapper
100    17:50:03.298     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission, Admin Operation: 53
101    17:50:03.298     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA
102    17:50:03.298     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA - hr=0 InClientCOMCall:T VSA:T
103    17:50:03.298     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission: VSA: Allowed
104    17:50:25.735     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::CSecurityWrapper
105    17:50:25.735     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission, Admin Operation: 53
106    17:50:25.735     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA
107    17:50:25.735     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA - hr=0 InClientCOMCall:T VSA:T
108    17:50:25.735     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission: VSA: Allowed
109    17:50:48.172     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::CSecurityWrapper
110    17:50:48.172     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission, Admin Operation: 53
111    17:50:48.172     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA
112    17:50:48.172     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA - hr=0 InClientCOMCall:T VSA:T
113    17:50:48.172     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission: VSA: Allowed
114    17:51:10.609     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::CSecurityWrapper
115    17:51:10.609     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission, Admin Operation: 53
116    17:51:10.609     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA
117    17:51:10.609     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA - hr=0 InClientCOMCall:T VSA:T
118    17:51:10.609     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission: VSA: Allowed
119    17:51:33.045     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::CSecurityWrapper
120    17:51:33.045     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission, Admin Operation: 53
121    17:51:33.045     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA
122    17:51:33.045     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA - hr=0 InClientCOMCall:T VSA:T
123    17:51:33.045     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission: VSA: Allowed
124    17:51:55.482     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::CSecurityWrapper
125    17:51:55.482     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission, Admin Operation: 53
126    17:51:55.482     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA
127    17:51:55.482     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA - hr=0 InClientCOMCall:T VSA:T
128    17:51:55.482     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission: VSA: Allowed
130    17:52:17.919     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::CSecurityWrapper
131    17:52:17.919     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission, Admin Operation: 53
132    17:52:17.919     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA
133    17:52:17.919     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA - hr=0 InClientCOMCall:T VSA:T
134    17:52:17.919     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission: VSA: Allowed
135    17:52:38.977     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::CSecurityWrapper
136    17:52:38.977     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission, Admin Operation: 53
137    17:52:38.977     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA
138    17:52:38.977     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA - hr=0 InClientCOMCall:T VSA:T
139    17:52:38.977     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission: VSA: Allowed
140    17:52:59.855     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::CSecurityWrapper
141    17:52:59.855     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission, Admin Operation: 53
142    17:52:59.855     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA
143    17:52:59.855     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA - hr=0 InClientCOMCall:T VSA:T
144    17:52:59.855     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission: VSA: Allowed
145    17:53:20.748     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::CSecurityWrapper
146    17:53:20.748     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission, Admin Operation: 53
147    17:53:20.748     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA
148    17:53:20.748     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA - hr=0 InClientCOMCall:T VSA:T
149    17:53:20.748     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission: VSA: Allowed
150    17:53:41.625     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::CSecurityWrapper
151    17:53:41.625     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission, Admin Operation: 53
152    17:53:41.625     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA
153    17:53:41.625     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::IsServerClientTheVSA - hr=0 InClientCOMCall:T VSA:T
154    17:53:41.625     [4128]    (AgentClientBroker)    <4172>    EV:M    CSecurityWrapper::HasServerClientGotPermission: VSA: Allowed
155    17:53:43.566     [4164]    (AgentClientBroker)    <588>    EV:M    IsOutlookInstalledAsDefault - check registry for default mail client
156    17:53:43.566     [4164]    (AgentClientBroker)    <588>    EV:M    IsOutlookInstalledAsDefault - found default mail client to be Microsoft Outlook
157    17:53:43.566     [4164]    (AgentClientBroker)    <588>    EV:M    IsOutlookInstalledAsDefault - default mail client is outlook
158    17:53:43.615     [4164]    (AgentClientBroker)    <588>    EV:M    EPC::EPC
159    17:53:43.615     [4164]    (AgentClientBroker)    <588>    EV:M    EPC - new cache being created
160    17:53:43.615     [4164]    (AgentClientBroker)    <588>    EV:M    EDPC::EDPC
161    17:53:43.615     [4164]    (AgentClientBroker)    <588>    EV:M    EDPC - new cache being created
162    17:53:43.615     [4164]    (AgentClientBroker)    <588>    EV:M    tracing level : 0, check vault read rights : true
163    17:53:43.631     [4164]    (AgentClientBroker)    <588>    EV:L    CAAQ::SynchronizeSystemEx (Entry) |
164    17:53:43.631     [4164]    (AgentClientBroker)    <588>    EV:M    CSecurityWrapper::CSecurityWrapper
165    17:53:43.631     [4164]    (AgentClientBroker)    <588>    EV:M    CSecurityWrapper::HasServerClientGotPermission, Admin Operation: 48
166    17:53:43.631     [4164]    (AgentClientBroker)    <588>    EV:M    CSecurityWrapper::IsServerClientTheVSA
167    17:53:43.631     [4164]    (AgentClientBroker)    <588>    EV:M    CSecurityWrapper::IsServerClientTheVSA - hr=0 InClientCOMCall:T VSA:T
168    17:53:43.631     [4164]    (AgentClientBroker)    <588>    EV:M    CSecurityWrapper::HasServerClientGotPermission: VSA: Allowed
169    17:53:43.631     [4164]    (AgentClientBroker)    <588>    EV:M    CAAQ::SynchronizeSystemEx() - Failed to post message to queue, error = 0x80070005
170    17:53:43.631     [4164]    (AgentClientBroker)    <588>    EV:L    CAAQ::SynchronizeSystemEx (Exit) |Access is denied.  [0x80070005] |
171    17:53:43.631     [4164]    (AgentClientBroker)    <588>    EV:M    CMAPISession::ClearProfileCache()
172    17:53:43.631     [4164]    (AgentClientBroker)    <588>    EV:M    CMAPISession::CloseMapiSession - Entry
173    17:53:43.631     [4164]    (AgentClientBroker)    <588>    EV:M    CMAPISession::CloseMapiSession - [1]
174    17:53:43.631     [4164]    (AgentClientBroker)    <588>    EV:M    CMAPISession::CloseMapiSession - [2]
175    17:53:43.631     [4164]    (AgentClientBroker)    <588>    EV:M    CMAPISession::CloseMapiSession - [3]
176    17:53:48.851     [4164]    (AgentClientBroker)    <844>    EV:M    _tWinMain (AgentClientBroker) shutdown
177    17:53:49.895     [4164]    (AgentClientBroker)    <844>    EV:M    CEVAudit::Close Closing down the audit database.
178    17:53:49.895     [4164]    (AgentClientBroker)    <844>    EV:M    DllMain (AgentsCommon.dll) shutdown
179    17:53:49.895     [4164]    (AgentClientBroker)    <844>    EV:M    ~EDPC
180    17:53:49.895     [4164]    (AgentClientBroker)    <844>    EV:M    ~EPC

[KarlW]

It's failing to post messages to MSMQ:

15    17:45:10.101     [6020]    (AgentClientBroker)    <6048>    EV:M    CAAQ::SynchronizeSystemEx() - Failed to post message to queue, error = 0x80070005
16    17:45:10.101     [6020]    (AgentClientBroker)    <6048>    EV:L    CAAQ::SynchronizeSystemEx (Exit) |Access is denied.  [0x80070005] |

Does the VSA have the correct permissions on MSMQ?

-Karl

[AMICD]

Our DC's are 2008 R2, we did the NSPI settings as recommended.  the SVC account has a mailbox.  We are starting our transition to Exchange 2010 from Exchange 2003.  Exchnage 2003 Journaling works fine, just not Exchange 2010.  the pertinent error in the trce log (I've changed the name info) is:

331 13:45:38.076  [5568] (AgentClientBroker) <5852> EV:M ConfigureMsgServiceAttempt - Trying ConfigureMsgService using PR_PROFILE_UNRESOLVED_SERVER=[mailserver02], Attempt=[1]
332 13:45:38.108  [5568] (AgentClientBroker) <5852> EV:M ConfigureMsgServiceAttempt - ConfigureMsgService failed with error [0x8007000E]
333 13:45:38.608  [5568] (AgentClientBroker) <5852> EV:M ConfigureMsgServiceAttempt - Using Provided Global Catalog Server=[DomainController02.domain.pri]
334 13:45:38.608  [5568] (AgentClientBroker) <5852> EV:M ConfigureMsgServiceAttempt - Trying ConfigureMsgService using PR_PROFILE_UNRESOLVED_SERVER=[DomainController02.domain.pri], Attempt=[2]
335 13:45:38.639  [5568] (AgentClientBroker) <5852> EV:M ConfigureMsgServiceAttempt - ConfigureMsgService failed with error [0x8007000E]
336 13:45:39.139  [5568] (AgentClientBroker) <5852> EV:M ConfigureMsgServiceAttempt - Trying ConfigureMsgService using PR_PROFILE_UNRESOLVED_SERVER=[mailserver02], Attempt=[3]
337 13:45:39.170  [5568] (AgentClientBroker) <5852> EV:M ConfigureMsgServiceAttempt - ConfigureMsgService failed with error [0x8007000E]
338 13:45:39.670  [5568] (AgentClientBroker) <5852> EV:M ConfigureMsgServiceAttempt - Trying ConfigureMsgService using PR_PROFILE_UNRESOLVED_SERVER=[DomainController02.domain.pri], Attempt=[4]
339 13:45:39.701  [5568] (AgentClientBroker) <5852> EV:M ConfigureMsgServiceAttempt - ConfigureMsgService failed with error [0x8007000E]
340 13:45:40.201  [5568] (AgentClientBroker) <5852> EV:M ConfigureMsgServiceAttempt - Trying ConfigureMsgService using PR_PROFILE_UNRESOLVED_SERVER=[mailserver02], Attempt=[5]
341 13:45:40.233  [5568] (AgentClientBroker) <5852> EV:M ConfigureMsgServiceAttempt - ConfigureMsgService failed with error [0x8007000E]
342 13:45:40.233  [5568] (AgentClientBroker) <5852> EV:M ConfigureMsgServiceAttempt - Exiting [0x8007000E]
343 13:45:40.233  [5568] (AgentClientBroker) <5852> EV:M CMailboxHelper::CreateProfileAndSession - Call to ConfigureMsgService Failed [0x8007000E]
344 13:45:40.233  [5568] (AgentClientBroker) <5852> EV~E Event ID: 3411 An error has been reported by ConfigureMsgService.  It may be due to a problem contacting a Global Catalogue Server. |Exchange Server: mailserver02 |Mailbox: SMTP:s4@domain.pri |Error: 0x8007000e   |
345 13:45:40.233  [5568] (AgentClientBroker) <5852> EV:M CMailboxHelper::CreateProfileAndSession(VaultMbxAgent-mailserver02-5852-1301075138-0-30-0) - Profile failed (0x8007000e)
346 13:45:40.248  [5568] (AgentClientBroker) <5852> EV:M CMailboxHelper::CreateProfileAndSession - Delete Profile (0x0)

It really appears to be a GC issue, but I'm not real sure what I shoudl be lookign for.

Thanks

[KarlW]

Looks like you need the Outlook hot fix

See: https://www-secure.symantec.com/connect/blogs/outlook-2007-update-resolve-issues-ev-server

Cheers

Karl

[AMICD]

That link applys to 2007 :(

[KarlW]

Outlook 2010 is not supported on the EV server.  You'll need to remove it and install Outlook 2007 plus the update as per the link.

-Karl

[AMICD]

Ok, we rolled back to Outlook 2007 and applied all patches and the hotfix in this thread, now we're getting a differetnt error.

We have verified the client isn't hidden (in fact the tasks against the Exchange 2003 server continue to run).  We have also verified the service accounts right by using Send as to send as the Journal mailbox (NOT send on behalf of).

the trace now looks like this:

329 14:38:00.029  [10164] (JournalTask) <8436> EV:M CAgentTask::Initialise - Failed to open privileged MAPI session - aborting agent startup, error [8004011d]
330 14:38:00.029  [10164] (JournalTask) <8436> EV:M IsCurrentUserADomainAdmin - result = [0]
331 14:38:00.029  [10164] (JournalTask) <8436> EV~E Event ID: 3305 The Task 'Exchange Journaling Task for xxxxxxxxxx' failed to log on to Exchange server 'xxxxxxxxx' using mailbox 'SMTP:yyyyy@xxxxx.com'. Please ensure the mailbox has not been hidden, that the server is running and that the Vault account has sufficient permissions on the server. |
332 14:38:00.029  [10164] (JournalTask) <8436> EV:H CAgentTask::Initialise - HRXEX fn trace : Error 0x80004005, ..\ArchiveService\AgentTask.cpp [lines  

[nagyal]

Thanks for all who helped,

What turned out for me to be is that .Net Framework 3.5 was corrupt and also the VSA does not have proper permissions on the Registery.

While repairing .Net 3.5 system WMI got corrupted, and this linked helped me repair WMI

http://windowsxp.mvps.org/repairwmi.htm

Next using the following link i was able to set proper permissions to VSA

http://blogs.msdn.com/b/astebner/archive/2006/09/04/739820.aspx

Now my synchronization process is working fine, but i am having problems with MAilbox provisioning task. It is showing Error in its status.

I can find following errors in my Event viewer when i start my Task Controller service

Event Type:    Error
Event Source:    Enterprise Vault
Event Category:    (105)
Event ID:    41285
Date:        29/03/2011
Time:        4:57:43 PM
User:        N/A
Computer:    XXXXXXXXXXX
Description:
The EVTaskGuardian.exe process could not be started due to the following error:

The EVTaskGuardian.exe configuration file is malformed. Error: An error occurred loading a configuration file: The parameter 'exePath' is invalid.
Parameter name: exePath

For more information, see Help and Support Center at http://go.microsoft.com/fwlink/events.asp.

and the second error i receive is as under

Event Type:    Error
Event Source:    Enterprise Vault
Event Category:    (105)
Event ID:    40966
Date:        29/03/2011
Time:        4:57:43 PM
User:        N/A
Computer:    XXXXXXXXXXXXXXX
Description:
A program fault has raised an exception.

Exception: An error occurred loading a configuration file: The parameter 'exePath' is invalid.
Parameter name: exePath
Diagnostic:
Type: KVS.EnterpriseVault.ProcessManagement.StartProcessFailedException
Reference:

Command Line: "D:\Program Files\Enterprise Vault\TaskController.exe" -EntryID:13BCF241D97638045858CD775A5918F6D1011v00Archive
Application Domain: DefaultDomain
Process Id: 6084
Thread Id: 1340
Stack Trace:    at KVS.EnterpriseVault.ProcessManagement.ProcessManager.SpawnProcess(Boolean restart)
   at KVS.EnterpriseVault.ProcessManagement.ProcessManager.KVS.EnterpriseVault.ProcessManagement.IAdminControl.Start()
   at KVS.EnterpriseVault.ProcessManagement.ServerManager.KVS.EnterpriseVault.ProcessManagement.IAdminControl.Start()

For more information, see Help and Support Center at http://go.microsoft.com/fwlink/events.asp.

Any suggestions on why this problem is arrising???????

[KarlW · Accepted solution]

It could be linked to the .Net framework issue you had to resolve.  I'd suggest re-installing the EV binaries again so that everything gets re-registered.

-Karl