Hi ,

I am currently working on MAD (multi domain active directory driver). Whenever i create a new user in AD .i can see in the trace that the remote loader is not generating any XML document for ADD . On the other had if i modify the same user it is creating a modify xml document. Please suggest wat could be the reason

below you can see the log from RL for ADD and modify.

ADD Logs

DirXML: [03/12/18 10:20:48.751]: TRACE: APTEST: ADDriver: Processing change from AD: isDeleted: NULL, whenCreated 20180312141949.0Z, name pranav johannan

DirXML: [03/12/18 10:20:48.751]: TRACE: APTEST: ADDriver: Publisher ADD

DirXML: [03/12/18 10:20:48.751]: TRACE: APTEST: ADDriver: Publisher-effectiveClassQuery dn=CN=pranav johannan,CN=Users,DC=ap,DC=corningtest,DC=net className=user
DirXML: [03/12/18 10:20:48.751]: TRACE: APTEST: ADDriver: cn
(naming value)

DirXML: [03/12/18 10:20:48.751]: TRACE: APTEST: ADDriver: displayName
appending addAttr attribute to input document...

DirXML: [03/12/18 10:20:48.751]: TRACE: APTEST: ADDriver: employeeID

DirXML: [03/12/18 10:20:48.751]: TRACE: APTEST: ADDriver: mail

DirXML: [03/12/18 10:20:48.751]: TRACE: APTEST: ADDriver: msRTCSIP-UserEnabled

DirXML: [03/12/18 10:20:48.751]: TRACE: APTEST: ADDriver: sAMAccountName
appending addAttr attribute to input document...

DirXML: [03/12/18 10:20:48.751]: TRACE: APTEST: ADDriver: sn
appending addAttr attribute to input document...

DirXML: [03/12/18 10:20:48.751]: TRACE: APTEST: ADDriver: telephoneNumber

DirXML: [03/12/18 10:20:48.751]: TRACE: APTEST: ADDriver: userAccountControl
appending addAttr attribute to input document...

DirXML: [03/12/18 10:20:48.751]: TRACE: APTEST: ADDriver: userPrincipalName
appending addAttr attribute to input document...

DirXML: [03/12/18 10:20:48.751]: TRACE: APTEST: Calling publisher.execute()
DirXML: [03/12/18 10:20:48.751]: TRACE: APTEST: sending publisher document ..
DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD] PasswordSync::getUserData()

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD] PasswordSync::getUserData().... checking that RPC Server is listening

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD] PasswordSync::getUserData().... checking that RPC Server is listening

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] PassSyncCache::GetPwdInfoByUser()

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] PassSyncCache::GetPwdInfoByUser() Looking for specific Username[pJohannan]

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] GetPwdInfoByUser() - open the cache. Key = SOFTWARE\Novell\PassSync\Data\AP.CORNINGTEST.NET

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] GetPwdInfoByUser() - acquire the mutex.

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] GetPwdInfoByUser() - mutex acquired.

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] GetPwdInfoByUser() - get number of registry keys.

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] GetPwdInfoByUser() - dwSubKeys[1] dwPrefMaxEntries[1] *lpdwResumeHandle[0] lpszUserName[pJohannan].

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] GetPwdInfoByUser() - allocate return buffer to hold 1 entries.

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] GetPwdInfoByUser() - get password and time for user pJohannan.

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] PassSyncCache::GetPasswordInformation()

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] GetPasswordInformation() - open the cache entry.

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] GetPasswordInformation() - Registry UserEnumIndex[0] Passed EnumIndex[0].

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] GetPasswordInformation() - read the cache data.

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] - PassSyncCache::QueryValue()

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] QueryValue() - allocate 140 byte buffer

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] QueryValue() - read the data.

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] PassSyncCache::QueryValue() returned 0x00000000

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] - PassSyncCache::QueryValue()

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] QueryValue() - allocate 514 byte buffer

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] QueryValue() - read the data.

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] PassSyncCache::QueryValue() returned 0x00000000

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD] PwdCrypt:ecryptObjectPassword()

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD] PwdCrypt::CreateKeyContainer()

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD] PwdCrypt::GetCspName()

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD] PwdCrypt::GetCspName() returned 0X00000000

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD] PwdCrypt::CreateKeyContainer() returned 0x00000000

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD] PwdCrypt:ecryptObjectPassword() obtained handle successfully

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD] PwdCrypt:ecryptObjectPassword() obtained session key successfully

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD] PwdCrypt:ecryptObjectPassword() returned 0x00000000

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] GetPasswordInformation() - close the cache entry.

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] PassSyncCache::GetPasswordInformation() returned 0x00000000

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] PassSyncCache::StoreCurrentTimeStamp()

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] PassSyncCache::StoreCurrentTimeStamp() returned 0x00000000

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] PassSyncCache::GetPwdInfoByUser() Read the following users from driver cache******

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756]PassSyncCache::GetPwdInfoByUser() userName[0] pJohannan

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] GetPwdInfoByUser() - release the mutex.

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] GetPwdInfoByUser() - mutex released.

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] GetPwdInfoByUser() - close the cache.

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD 756] PassSyncCache::GetPwdInfoByUser() returned 0x00000000

DirXML: [03/12/18 10:20:48.813]: TRACE: NATEST: ADDriver: [PWD] PasswordSync::getUserData() returned 0x00000000

DirXML: [03/12/18 10:20:48.813]: TRACE: APTEST: Calling publisher.execute()
DirXML: [03/12/18 10:20:48.813]: TRACE: APTEST: sending publisher document ..


Modify Logs

DirXML: [03/12/18 02:23:34.184]: TRACE: APTEST: ADDriver: Publisher MODIFY

DirXML: [03/12/18 02:23:34.184]: TRACE: APTEST: ADDriver: Publisher Modify- effectiveClassQuery dn=CN=Contact3,OU=Contact,OU=IDM-AADSync,DC=ap,DC=corningtest,DC=net className=contact
DirXML: [03/12/18 02:23:34.184]: TRACE: APTEST: ADDriver: cn

DirXML: [03/12/18 02:23:34.184]: TRACE: APTEST: ADDriver: mail

DirXML: [03/12/18 02:23:34.184]: TRACE: APTEST: Calling publisher.execute()
DirXML: [03/12/18 02:23:34.184]: TRACE: APTEST: sending publisher document ..
DirXML: [03/12/18 02:23:34.246]: TRACE: APTEST: publisher response
DirXML: [03/12/18 02:23:34.246]: TRACE: APTEST: Calling publisher.execute()
DirXML: [03/12/18 02:23:34.246]: TRACE: APTEST: sending publisher document ..
DirXML: [03/12/18 02:23:34.246]: TRACE: APTEST: Fetching state document ..
DirXML: [03/12/18 02:23:34.277]: TRACE: APTEST: publisher response
DirXML: [03/12/18 02:23:34.277]: TRACE: APTEST: ADDriver: object changes complete
DirXML: [03/12/18 02:23:55.965]: TRACE: Remote Loader: Received.
DirXML: [03/12/18 02:23:55.965]: TRACE:
<nds dtdversion="4.0" ndsversion="8.x">
<source>
<product edition="Advanced" version="4.6.1.0">DirXML</product>
<contact>NetIQ Corporation</contact>
</source>
<output>
<status event-id="0" level="success"></status>
</output>
</nds>
DirXML: [03/12/18 02:23:55.965]: TRACE: Remote Loader: Received document for publisher channel
DirXML: [03/12/18 02:23:55.965]: TRACE: Remote Loader: Waiting for receive...
DirXML: [03/12/18 02:23:55.965]: TRACE: Remote Loader: DirXML returned:
DirXML: [03/12/18 02:23:55.965]: TRACE:
<nds dtdversion="4.0" ndsversion="8.x">
<source>
<product edition="Advanced" version="4.6.1.0">DirXML</product>
<contact>NetIQ Corporation</contact>
</source>
<output>
<status event-id="0" level="success"></status>
</output>
</nds>
DirXML: [03/12/18 02:23:55.965]:
DirXML Log Event -------------------
Driver = \CORNING-IDV-STG\system\IDM-DriverSet\MDAD Driver
Level = success
DirXML: [03/12/18 02:23:55.997]: TRACE: Remote Loader: Received document from publicationShim
DirXML: [03/12/18 02:23:55.997]: TRACE:
<nds dtdversion="3.5">
<source>
<product instance="MDAD Driver" version="1.0.0.1C" build="201611160300">Multi Domain Active Directory Driver</product>
<contact>NetIQ, Corporation.</contact>
</source>
<input>
<modify class-name="contact" event-id="MDAD Driver##16218e0e328##0" src-dn="CN=Contact3,OU=Contact,OU=IDM-AADSync,DC=ap,DC=corningtest,DC=net">
<association>5a8b90f42ca8f64a9863d91f8c382c8d</association>
<modify-attr attr-name="mail">
<remove-all-values />
<add-value>
<value type="string" naming="false">AADContact3@abc.com</value>
</add-value>
</modify-attr>
</modify>
</input>
</nds>