Exchange Integration does not work after upgrading to 7.2

Hello,

I upgraded the CRM 7.0 to CRM 7.2 and the system mostly work fine but the Exchange Integration. Here is the summary based on what I've found:

1. The synchronization of contacts works fine; the synchronization of tasks and appointments doesn't work (see logs below).

2. If the system is upgraded with out of the box database including demo data, the Exchange Integration works fine running 7.2; if the system is upgraded with client's database, the synchronization of tasks and appointments doesn't work.

3. I suspect there are issues with client's database so I changed the collation for Exchange related tables from SQL_Latin1_General_CP1_CI_AS to Latin1_General_CI_AS but the same issues remain; I then deleted EcngIntegration and EcngSyncDigestEntry table records, set up a new EWS connection successfully, but the same issues remain.

ExchangeSync log file:

ERROR [http-apr-10009-exec-2]: 09-Mar-2014 22:01:02.311 com.sage.scrm.model.error.SageSynchronizationException: com.sage.scrm.model.error.SageDataAccessException: Data access failure.
ERROR [http-apr-10009-exec-6]: 09-Mar-2014 22:01:03.544 url: http://<server name>/sdata/crmj/crmExchange/-/tasks/$syncTarget?trackingId=36c037b0-ddc6-4f0f-ae33-6484e62d87d1, error: com.sage.crm.httpconsumer.error.SageHttpConsumerException: POST on http://<server name>//sdata/crmj/crmExchange/-/tasks/$syncTarget?trackingId=36c037b0-ddc6-4f0f-ae33-6484e62d87d1 failed: 500, action: ESTABLISHING_CONNECTION_CRM_ENDPOINT
ERROR [http-apr-10009-exec-10]: 09-Mar-2014 22:03:07.235 com.sage.scrm.model.error.SageSynchronizationException: com.sage.scrm.model.error.SageDataAccessException: Data access failure.
ERROR [http-apr-10009-exec-4]: 09-Mar-2014 22:03:08.906 url: http://<server name>//sdata/crmj/crmExchange/-/tasks/$syncTarget?trackingId=e1d8cb9f-95ae-4e7f-a7f5-919be9abb41f, error: com.sage.crm.httpconsumer.error.SageHttpConsumerException: POST on http://<server name>//sdata/crmj/crmExchange/-/tasks/$syncTarget?trackingId=e1d8cb9f-95ae-4e7f-a7f5-919be9abb41f failed: 500, action: ESTABLISHING_CONNECTION_CRM_ENDPOINT
ERROR [http-apr-10009-exec-1]: 09-Mar-2014 22:05:27.687 com.sage.scrm.model.error.SageSynchronizationException: com.sage.scrm.model.error.SageDataAccessException: Data access failure.
ERROR [http-apr-10009-exec-9]: 09-Mar-2014 22:05:29.627 url: http://<server name>//sdata/crmj/crmExchange/-/tasks/$syncTarget?trackingId=ef770176-3db4-4aa7-acb1-d728399e66e6, error: com.sage.crm.httpconsumer.error.SageHttpConsumerException: POST on http://<server name>//sdata/crmj/crmExchange/-/tasks/$syncTarget?trackingId=ef770176-3db4-4aa7-acb1-d728399e66e6 failed: 500, action: ESTABLISHING_CONNECTION_CRM_ENDPOINT
ERROR [http-apr-10009-exec-5]: 09-Mar-2014 22:12:53.788 com.sage.scrm.model.error.SageSynchronizationException: com.sage.scrm.model.error.SageDataAccessException: Data access failure.
ERROR [http-apr-10009-exec-4]: 09-Mar-2014 22:12:55.410 url: http://<server name>//sdata/crmj/crmExchange/-/tasks/$syncTarget?trackingId=d7cf4d21-e516-4b24-bdf0-5c5dee45deee, error: com.sage.crm.httpconsumer.error.SageHttpConsumerException: POST on http://<server name>//sdata/crmj/crmExchange/-/tasks/$syncTarget?trackingId=d7cf4d21-e516-4b24-bdf0-5c5dee45deee failed: 500, action: ESTABLISHING_CONNECTION_CRM_ENDPOINT

ExchangeSynchronization log file:

2014-03-09/22:01:02.324/MDT [SyncEngine thread] ERROR com.sage.scrm.syncengine.exchange.engine.SynchronisationThread.run com.sage.scrm.syncengine.core.engine.error.SageSyncEngineException: com.sage.scrm.syncengine.exchange.engine.model.error.SageSDataEndpointException: com.sage.crm.httpconsumer.error.SageHttpConsumerException: POST on http://<server name>/sdata/crmj/crmExchange/-/tasks/$syncTarget?trackingId=36c037b0-ddc6-4f0f-ae33-6484e62d87d1 failed: 500
2014-03-09/22:03:07.241/MDT [SyncEngine thread] ERROR com.sage.scrm.syncengine.exchange.engine.SynchronisationThread.run com.sage.scrm.syncengine.core.engine.error.SageSyncEngineException: com.sage.scrm.syncengine.exchange.engine.model.error.SageSDataEndpointException: com.sage.crm.httpconsumer.error.SageHttpConsumerException: POST on http://<server name>//sdata/crmj/crmExchange/-/tasks/$syncTarget?trackingId=e1d8cb9f-95ae-4e7f-a7f5-919be9abb41f failed: 500
2014-03-09/22:05:27.692/MDT [SyncEngine thread] ERROR com.sage.scrm.syncengine.exchange.engine.SynchronisationThread.run com.sage.scrm.syncengine.core.engine.error.SageSyncEngineException: com.sage.scrm.syncengine.exchange.engine.model.error.SageSDataEndpointException: com.sage.crm.httpconsumer.error.SageHttpConsumerException: POST on http://<server name>//sdata/crmj/crmExchange/-/tasks/$syncTarget?trackingId=ef770176-3db4-4aa7-acb1-d728399e66e6 failed: 500
2014-03-09/22:12:53.794/MDT [SyncEngine thread] ERROR com.sage.scrm.syncengine.exchange.engine.SynchronisationThread.run com.sage.scrm.syncengine.core.engine.error.SageSyncEngineException: com.sage.scrm.syncengine.exchange.engine.model.error.SageSDataEndpointException: com.sage.crm.httpconsumer.error.SageHttpConsumerException: POST on http://<server name>//sdata/crmj/crmExchange/-/tasks/$syncTarget?trackingId=d7cf4d21-e516-4b24-bdf0-5c5dee45deee failed: 500

ExchangeSyncEngineStackTrace log file:

2014-03-09/22:01:02.325/MDT [SyncEngine thread] ERROR com.sage.scrm.syncengine.exchange.engine.SynchronisationThread.run com.sage.scrm.syncengine.core.engine.error.SageSyncEngineException: com.sage.scrm.syncengine.exchange.engine.model.error.SageSDataEndpointException: com.sage.crm.httpconsumer.error.SageHttpConsumerException: POST on http://<server name>/sdata/crmj/crmExchange/-/tasks/$syncTarget?trackingId=36c037b0-ddc6-4f0f-ae33-6484e62d87d1 failed: 500
com.sage.scrm.syncengine.core.engine.error.SageSyncEngineException: com.sage.scrm.syncengine.exchange.engine.model.error.SageSDataEndpointException: com.sage.crm.httpconsumer.error.SageHttpConsumerException: POST on http://<server name>//sdata/crmj/crmExchange/-/tasks/$syncTarget?trackingId=36c037b0-ddc6-4f0f-ae33-6484e62d87d1 failed: 500
at com.sage.scrm.syncengine.exchange.engine.SynchronisationProcess.execute(SynchronisationProcess.java:202)
at com.sage.scrm.syncengine.exchange.engine.SynchronisationThread.synchroniseResourceOneWay(SynchronisationThread.java:296)
at com.sage.scrm.syncengine.exchange.engine.SynchronisationThread.synchroniseResourcesOneWay(SynchronisationThread.java:281)
at com.sage.scrm.syncengine.exchange.engine.SynchronisationThread.run(SynchronisationThread.java:173)
at java.lang.Thread.run(Unknown Source)
Caused by: com.sage.scrm.syncengine.exchange.engine.model.error.SageSDataEndpointException: com.sage.crm.httpconsumer.error.SageHttpConsumerException: POST on http://<server name>//sdata/crmj/crmExchange/-/tasks/$syncTarget?trackingId=36c037b0-ddc6-4f0f-ae33-6484e62d87d1 failed: 500
at com.sage.scrm.syncengine.exchange.sdata.SCRMEndpoint.sendToSyncTarget(SCRMEndpoint.java:199)
at com.sage.scrm.syncengine.exchange.engine.SynchronisationProcess.execute(SynchronisationProcess.java:169)
... 4 more
Caused by: com.sage.crm.httpconsumer.error.SageHttpConsumerException: POST on http://<server name>//sdata/crmj/crmExchange/-/tasks/$syncTarget?trackingId=36c037b0-ddc6-4f0f-ae33-6484e62d87d1 failed: 500
at com.sage.crm.httpconsumer.HttpConsumer.doPostPut(HttpConsumer.java:981)
at com.sage.crm.httpconsumer.HttpConsumer.doPost(HttpConsumer.java:776)
at com.sage.crm.httpconsumer.HttpConsumer.doPost(HttpConsumer.java:748)
at com.sage.scrm.syncengine.exchange.sdata.SCRMEndpoint.sendToSyncTarget(SCRMEndpoint.java:191)
... 5 more
2014-03-09/22:03:07.242/MDT [SyncEngine thread] ERROR com.sage.scrm.syncengine.exchange.engine.SynchronisationThread.run com.sage.scrm.syncengine.core.engine.error.SageSyncEngineException: com.sage.scrm.syncengine.exchange.engine.model.error.SageSDataEndpointException: com.sage.crm.httpconsumer.error.SageHttpConsumerException: POST on http://<server name>//sdata/crmj/crmExchange/-/tasks/$syncTarget?trackingId=e1d8cb9f-95ae-4e7f-a7f5-919be9abb41f failed: 500
com.sage.scrm.syncengine.core.engine.error.SageSyncEngineException: com.sage.scrm.syncengine.exchange.engine.model.error.SageSDataEndpointException: com.sage.crm.httpconsumer.error.SageHttpConsumerException: POST on http://<server name>//sdata/crmj/crmExchange/-/tasks/$syncTarget?trackingId=e1d8cb9f-95ae-4e7f-a7f5-919be9abb41f failed: 500
at com.sage.scrm.syncengine.exchange.engine.SynchronisationProcess.execute(SynchronisationProcess.java:202)
at com.sage.scrm.syncengine.exchange.engine.SynchronisationThread.synchroniseResourceOneWay(SynchronisationThread.java:296)
at com.sage.scrm.syncengine.exchange.engine.SynchronisationThread.synchroniseResourcesOneWay(SynchronisationThread.java:281)
at com.sage.scrm.syncengine.exchange.engine.SynchronisationThread.run(SynchronisationThread.java:173)
at java.lang.Thread.run(Unknown Source)
Caused by: com.sage.scrm.syncengine.exchange.engine.model.error.SageSDataEndpointException: com.sage.crm.httpconsumer.error.SageHttpConsumerException: POST on http://<server name>//sdata/crmj/crmExchange/-/tasks/$syncTarget?trackingId=e1d8cb9f-95ae-4e7f-a7f5-919be9abb41f failed: 500
at com.sage.scrm.syncengine.exchange.sdata.SCRMEndpoint.sendToSyncTarget(SCRMEndpoint.java:199)
at com.sage.scrm.syncengine.exchange.engine.SynchronisationProcess.execute(SynchronisationProcess.java:169)
... 4 more
Caused by: com.sage.crm.httpconsumer.error.SageHttpConsumerException: POST on http://<server name>//sdata/crmj/crmExchange/-/tasks/$syncTarget?trackingId=e1d8cb9f-95ae-4e7f-a7f5-919be9abb41f failed: 500
at com.sage.crm.httpconsumer.HttpConsumer.doPostPut(HttpConsumer.java:981)
at com.sage.crm.httpconsumer.HttpConsumer.doPost(HttpConsumer.java:776)
at com.sage.crm.httpconsumer.HttpConsumer.doPost(HttpConsumer.java:748)
at com.sage.scrm.syncengine.exchange.sdata.SCRMEndpoint.sendToSyncTarget(SCRMEndpoint.java:191)
... 5 more
2014-03-09/22:05:27.692/MDT [SyncEngine thread] ERROR com.sage.scrm.syncengine.exchange.engine.SynchronisationThread.run com.sage.scrm.syncengine.core.engine.error.SageSyncEngineException: com.sage.scrm.syncengine.exchange.engine.model.error.SageSDataEndpointException: com.sage.crm.httpconsumer.error.SageHttpConsumerException: POST on http://<server name>//sdata/crmj/crmExchange/-/tasks/$syncTarget?trackingId=ef770176-3db4-4aa7-acb1-d728399e66e6 failed: 500
com.sage.scrm.syncengine.core.engine.error.SageSyncEngineException: com.sage.scrm.syncengine.exchange.engine.model.error.SageSDataEndpointException: com.sage.crm.httpconsumer.error.SageHttpConsumerException: POST on http://<server name>//sdata/crmj/crmExchange/-/tasks/$syncTarget?trackingId=ef770176-3db4-4aa7-acb1-d728399e66e6 failed: 500
at com.sage.scrm.syncengine.exchange.engine.SynchronisationProcess.execute(SynchronisationProcess.java:202)
at com.sage.scrm.syncengine.exchange.engine.SynchronisationThread.synchroniseResourceOneWay(SynchronisationThread.java:296)
at com.sage.scrm.syncengine.exchange.engine.SynchronisationThread.synchroniseResourcesOneWay(SynchronisationThread.java:281)
at com.sage.scrm.syncengine.exchange.engine.SynchronisationThread.run(SynchronisationThread.java:173)
at java.lang.Thread.run(Unknown Source)
Caused by: com.sage.scrm.syncengine.exchange.engine.model.error.SageSDataEndpointException: com.sage.crm.httpconsumer.error.SageHttpConsumerException: POST on http://<server name>//sdata/crmj/crmExchange/-/tasks/$syncTarget?trackingId=ef770176-3db4-4aa7-acb1-d728399e66e6 failed: 500
at com.sage.scrm.syncengine.exchange.sdata.SCRMEndpoint.sendToSyncTarget(SCRMEndpoint.java:199)
at com.sage.scrm.syncengine.exchange.engine.SynchronisationProcess.execute(SynchronisationProcess.java:169)
... 4 more
Caused by: com.sage.crm.httpconsumer.error.SageHttpConsumerException: POST on http://<server name>//sdata/crmj/crmExchange/-/tasks/$syncTarget?trackingId=ef770176-3db4-4aa7-acb1-d728399e66e6 failed: 500
at com.sage.crm.httpconsumer.HttpConsumer.doPostPut(HttpConsumer.java:981)
at com.sage.crm.httpconsumer.HttpConsumer.doPost(HttpConsumer.java:776)
at com.sage.crm.httpconsumer.HttpConsumer.doPost(HttpConsumer.java:748)
at com.sage.scrm.syncengine.exchange.sdata.SCRMEndpoint.sendToSyncTarget(SCRMEndpoint.java:191)
... 5 more

Thanks,

  • 0

    Hi Ichung,

    You're getting an error 500 when the synch engine does a POST to the CRMJ webapp. As such, the error isn't really in the Exhcange integration; the error is happening in the CRMJ webapp. Is there anything being logged in the ..\CRM\tomcat\logs directory, or in the scrm.log in the main logs directory?

    You might want to clear down your logs prior to testing again, in case something in being written to the Tomcat logs directory when the service starts up.

    Thanks,

    Rob

  • 0

    Thanks Rob.

    I've attached the log files to this post. scrm.log is empty. The log files under SCRM are saved in 02/2014, I am not sure if they can provide any helpful information at all. My impression on the issue could be database-related is that when I upgraded Sage CRM from 7.0 to 7.2 with default database, there is no issue at all, whereas I ran into the issue when restore the client's database to the same 7.2 environment. There could be multiple causes besides the database issue though. Thanks again!

  • 0

    Hi,

    Thanks for those. It looks like the CRMJ webapp can't connect to the database when the Tomcat service starts. Oddly, we're getting a socket write error - this would be more the sort of thing you'd expect if there's a firewall blocking the connection, but since the synch engine webapp can connect, I don't think it's that.

    Are those XML logs current, or are they from the v7.1 install? I'd check out the db.properties in ..\CRM\tomcat\webapps\crm72j\WEB-INF\. It could be somethign as simple as the port number being incorrect. Once you've confirmed that the connection string is connect, try clearing down the logs, start Tomcat again, and see what gets generated.

    Thanks,

    Rob