JeremyR3784

Q: LDAP failing to sync

so i recently setup a replica for my OD server...

 

here is a snippet of the log file from my OD Master...

Jun  4 09:07:35 batman.example.info slapd[228]: do_syncrep1[done]: si_ld(0x0) Can't contact LDAP server (-1)

Jun  4 09:07:35 batman.example.info slapd[228]: do_syncrepl: rid=002 rc -1 retrying

Jun  4 09:07:35 batman.example.info slapd[228]: slap_client_connect: URI=ldap://robin.example.info:389 ldap_sasl_interactive_bind_s failed (-2)

Jun  4 09:07:35 batman.example.info slapd[228]: do_syncrep1: client_connect failed (-1) - searchbase(dc=batman,dc=example,dc=info) URI(ldap://robin.example.info:389)

Jun  4 09:07:35 batman.example.info slapd[228]: do_syncrep1[done]: si_ld(0x0) Can't contact LDAP server (-1)

Jun  4 09:07:35 batman.example.info slapd[228]: do_syncrepl: rid=002 rc -1 retrying

Jun  4 09:08:36 batman.example.info slapd[228]: slap_client_connect: URI=ldap://robin.example.info:389 ldap_sasl_interactive_bind_s failed (-2)

Jun  4 09:08:36 batman.example.info slapd[228]: do_syncrep1: client_connect failed (-1) - searchbase(dc=batman,dc=example,dc=info) URI(ldap://robin.example.info:389)

Jun  4 09:08:36 batman.example.info slapd[228]: do_syncrep1[done]: si_ld(0x0) Can't contact LDAP server (-1)

Jun  4 09:08:36 batman.example.info slapd[228]: do_syncrepl: rid=002 rc -1 retrying

Jun  4 09:08:36 batman.example.info slapd[228]: slap_client_connect: URI=ldap://robin.example.info:389 ldap_sasl_interactive_bind_s failed (-2)

Jun  4 09:08:36 batman.example.info slapd[228]: do_syncrep1: client_connect failed (-1) - searchbase(cn=authdata) URI(ldap://robin.example.info:389)

Jun  4 09:08:36 batman.example.info slapd[228]: do_syncrep1[done]: si_ld(0x0) Can't contact LDAP server (-1)

Jun  4 09:08:36 batman.example.info slapd[228]: do_syncrepl: rid=002 rc -1 retrying

Jun  4 09:09:37 batman.example.info slapd[228]: slap_client_connect: URI=ldap://robin.example.info:389 ldap_sasl_interactive_bind_s failed (-2)

Jun  4 09:09:37 batman.example.info slapd[228]: do_syncrep1: client_connect failed (-1) - searchbase(dc=batman,dc=example,dc=info) URI(ldap://robin.example.info:389)

Jun  4 09:09:37 batman.example.info slapd[228]: do_syncrep1[done]: si_ld(0x0) Can't contact LDAP server (-1)

Jun  4 09:09:37 batman.example.info slapd[228]: do_syncrepl: rid=002 rc -1 retrying

Jun  4 09:09:37 batman.example.info slapd[228]: slap_client_connect: URI=ldap://robin.example.info:389 ldap_sasl_interactive_bind_s failed (-2)

Jun  4 09:09:37 batman.example.info slapd[228]: do_syncrep1: client_connect failed (-1) - searchbase(cn=authdata) URI(ldap://robin.example.info:389)

Jun  4 09:09:37 batman.example.info slapd[228]: do_syncrep1[done]: si_ld(0x0) Can't contact LDAP server (-1)

Jun  4 09:09:37 batman.example.info slapd[228]: do_syncrepl: rid=002 rc -1 retrying

 

here is a snippet from my OD Replica...

ay 26 19:56:01 robin.example.info slapd[220]: do_syncrep2: rid=001 (-1) Can't contact LDAP server

May 26 19:56:01 robin.example.info slapd[220]: do_syncrepl: rid=001 rc -1 retrying

May 26 19:57:02 robin.example.info slapd[220]: do_syncrep1: CONNECTED(0x7fa821458de0) searchbase(cn=authdata) URI(ldap://batman.example.info:389)

May 26 21:25:59 robin.example.info slapd[220]: => bdb_idl_insert_key: c_put id failed: DB_LOCK_DEADLOCK: Locker killed to resolve a deadlock (-30994)

May 26 21:25:59 robin.example.info slapd[220]: => bdb_idl_delete_key: c_del id failed: DB_LOCK_DEADLOCK: Locker killed to resolve a deadlock (-30994)

May 26 21:25:59 robin.example.info slapd[220]: conn=14442 op=2: attribute "entryCSN" index add failure

May 26 21:25:59 robin.example.info slapd[220]: conn=14442 op=4: attribute "entryCSN" index delete failure

May 26 23:02:09 robin.example.info slapd[220]: do_syncrep2: rid=001 (-1) Can't contact LDAP server

May 26 23:02:09 robin.example.info slapd[220]: do_syncrepl: rid=001 rc -1 retrying

May 26 23:03:10 robin.example.info slapd[220]: do_syncrep1: CONNECTED(0x7fa8217107d0) searchbase(cn=authdata) URI(ldap://batman.example.info:389)

May 26 23:13:21 robin.example.info slapd[220]: do_syncrep2: rid=001 (-1) Can't contact LDAP server

May 26 23:13:21 robin.example.info slapd[220]: do_syncrepl: rid=001 rc -1 retrying

May 26 23:14:22 robin.example.info slapd[220]: do_syncrep1: CONNECTED(0x7fa821456270) searchbase(cn=authdata) URI(ldap://batman.example.info:389)

May 27 01:19:26 robin.example.info slapd[220]: do_syncrep2: rid=001 (-1) Can't contact LDAP server

May 27 01:19:26 robin.example.info slapd[220]: do_syncrepl: rid=001 rc -1 retrying

May 27 01:20:26 robin.example.info slapd[220]: do_syncrep1: CONNECTED(0x7fa8217107d0) searchbase(cn=authdata) URI(ldap://batman.example.info:389)

May 27 03:35:23 robin.example.info slapd[220]: do_syncrep2: rid=001 (-1) Can't contact LDAP server

May 27 03:35:23 robin.example.info slapd[220]: do_syncrepl: rid=001 rc -1 retrying

May 27 03:36:24 robin.example.info slapd[220]: do_syncrep1: CONNECTED(0x7fa82147d480) searchbase(cn=authdata) URI(ldap://batman.example.info:389)

May 27 05:51:23 robin.example.info slapd[220]: do_syncrep2: rid=001 (-1) Can't contact LDAP server

May 27 05:51:23 robin.example.info slapd[220]: do_syncrepl: rid=001 rc -1 retrying

May 27 05:52:23 robin.example.info slapd[220]: do_syncrep1: CONNECTED(0x7fa82170c1c0) searchbase(cn=authdata) URI(ldap://batman.example.info:389)

May 27 08:07:52 robin.example.info slapd[220]: do_syncrep2: rid=001 (-1) Can't contact LDAP server

May 27 08:07:52 robin.example.info slapd[220]: do_syncrepl: rid=001 rc -1 retrying

May 27 08:08:53 robin.example.info slapd[220]: do_syncrep1: CONNECTED(0x7fa8216254f0) searchbase(cn=authdata) URI(ldap://batman.example.info:389)

May 27 10:19:24 robin.example.info slapd[220]: do_syncrep2: rid=001 (-1) Can't contact LDAP server

May 27 10:19:24 robin.example.info slapd[220]: do_syncrepl: rid=001 rc -1 retrying

May 27 10:20:25 robin.example.info slapd[220]: do_syncrep1: CONNECTED(0x7fa821711220) searchbase(cn=authdata) URI(ldap://batman.example.info:389)

May 27 10:36:53 robin.example.info slapd[220]: do_syncrep2: rid=001 (-1) Can't contact LDAP server

May 27 10:36:53 robin.example.info slapd[220]: do_syncrepl: rid=001 rc -1 retrying

May 27 10:37:54 robin.example.info slapd[220]: do_syncrep1: CONNECTED(0x7fa82159c440) searchbase(cn=authdata) URI(ldap://batman.example.info:389)

May 27 13:37:08 robin.example.info slapd[220]: do_syncrep2: rid=001 (-1) Can't contact LDAP server

May 27 13:37:08 robin.example.info slapd[220]: do_syncrepl: rid=001 rc -1 retrying

May 27 13:38:09 robin.example.info slapd[220]: do_syncrep1: CONNECTED(0x7fa8238224b0) searchbase(cn=authdata) URI(ldap://batman.example.info:389)

May 27 15:47:34 robin.example.info slapd[220]: do_syncrep2: rid=001 (-1) Can't contact LDAP server

May 27 15:47:34 robin.example.info slapd[220]: do_syncrepl: rid=001 rc -1 retrying

May 27 15:48:35 robin.example.info slapd[220]: do_syncrep1: CONNECTED(0x7fa821710710) searchbase(cn=authdata) URI(ldap://batman.example.info:389)

May 27 17:01:06 robin.example.info slapd[220]: do_syncrep2: rid=001 (-1) Can't contact LDAP server

May 27 17:01:06 robin.example.info slapd[220]: do_syncrepl: rid=001 rc -1 retrying

May 27 17:02:06 robin.example.info slapd[220]: do_syncrep1: CONNECTED(0x7fa821476660) searchbase(dc=batman,dc=example,dc=info) URI(ldap://batman.example.info:389)

May 27 18:09:31 robin.example.info slapd[220]: do_syncrep2: rid=001 (-1) Can't contact LDAP server

May 27 18:09:31 robin.example.info slapd[220]: do_syncrepl: rid=001 rc -1 retrying

May 27 18:10:32 robin.example.info slapd[220]: do_syncrep1: CONNECTED(0x7fa82146dfa0) searchbase(cn=authdata) URI(ldap://batman.example.info:389)

May 27 20:18:53 robin.example.info slapd[220]: do_syncrep2: rid=001 (-1) Can't contact LDAP server

May 27 20:18:53 robin.example.info slapd[220]: do_syncrepl: rid=001 rc -1 retrying

May 27 20:19:55 robin.example.info slapd[220]: do_syncrep1: CONNECTED(0x7fa82170c270) searchbase(cn=authdata) URI(ldap://batman.example.info:389)

May 27 20:32:05 robin.example.info slapd[220]: do_syncrep2: rid=001 (-1) Can't contact LDAP server

May 27 20:32:05: --- last message repeated 1 time ---

May 27 20:32:05 robin.example.info slapd[220]: do_syncrepl: rid=001 rc -1 retrying

May 27 20:32:35: --- last message repeated 1 time ---

May 27 20:33:39 robin.example.info slapd[220]: slap_client_connect: URI=ldap://batman.example.info:389 ldap_sasl_interactive_bind_s failed (-1)

May 27 20:33:39 robin.example.info slapd[220]: do_syncrep1: client_connect failed (-1) - searchbase(dc=batman,dc=example,dc=info) URI(ldap://batman.example.info:389)

May 27 20:33:39 robin.example.info slapd[220]: do_syncrep1[done]: si_ld(0x0) Can't contact LDAP server (-1)

May 27 20:33:39 robin.example.info slapd[220]: do_syncrepl: rid=001 rc -1 retrying

May 27 20:33:39 robin.example.info slapd[220]: slap_client_connect: URI=ldap://batman.example.info:389 ldap_sasl_interactive_bind_s failed (-1)

May 27 20:33:39 robin.example.info slapd[220]: do_syncrep1: client_connect failed (-1) - searchbase(cn=authdata) URI(ldap://batman.example.info:389)

May 27 20:33:39 robin.example.info slapd[220]: do_syncrep1[done]: si_ld(0x0) Can't contact LDAP server (-1)

May 27 20:33:39 robin.example.info slapd[220]: do_syncrepl: rid=001 rc -1 retrying

May 27 20:34:40 robin.example.info slapd[220]: do_syncrep1: CONNECTED(0x7fa8216346e0) searchbase(cn=authdata) URI(ldap://batman.example.info:389)

May 27 20:34:40 robin.example.info slapd[220]: do_syncrep1: CONNECTED(0x7fa82159c1b0) searchbase(dc=batman,dc=example,dc=info) URI(ldap://batman.example.info:389)

May 27 22:34:42 robin.example.info slapd[220]: => bdb_idl_delete_key: c_get failed: DB_LOCK_DEADLOCK: Locker killed to resolve a deadlock (-30994)

May 27 22:34:42 robin.example.info slapd[220]: conn=19904 op=4: attribute "entryCSN" index delete failure

May 28 07:13:00 robin.example.info slapd[220]: => bdb_idl_insert_key: c_get failed: DB_LOCK_DEADLOCK: Locker killed to resolve a deadlock (-30994)

May 28 07:13:00 robin.example.info slapd[220]: => bdb_idl_delete_key: c_get failed: DB_LOCK_DEADLOCK: Locker killed to resolve a deadlock (-30994)

May 28 07:13:00 robin.example.info slapd[220]: conn=22124 op=4: attribute "entryCSN" index add failure

May 28 07:13:00 robin.example.info slapd[220]: conn=22124 op=3: attribute "entryCSN" index delete failure

May 28 07:13:25 robin.example.info slapd[220]: => bdb_idl_insert_key: c_put id failed: DB_LOCK_DEADLOCK: Locker killed to resolve a deadlock (-30994)

May 28 07:13:25 robin.example.info slapd[220]: conn=22148 op=3: attribute "entryCSN" index add failure

May 28 07:13:25 robin.example.info slapd[220]: => bdb_idl_delete_key: c_get failed: DB_LOCK_DEADLOCK: Locker killed to resolve a deadlock (-30994)

May 28 07:13:25 robin.example.info slapd[220]: conn=22148 op=4: attribute "entryCSN" index delete failure

May 28 07:21:04 robin.example.info slapd[220]: => bdb_idl_insert_key: c_get failed: DB_LOCK_DEADLOCK: Locker killed to resolve a deadlock (-30994)

May 28 07:21:04 robin.example.info slapd[220]: => bdb_idl_delete_key: c_get failed: DB_LOCK_DEADLOCK: Locker killed to resolve a deadlock (-30994)

May 28 07:21:04 robin.example.info slapd[220]: conn=22191 op=4: attribute "entryCSN" index add failure

May 28 07:21:04 robin.example.info slapd[220]: conn=22191 op=3: attribute "entryCSN" index delete failure

May 28 07:21:44 robin.example.info slapd[220]: => bdb_idl_delete_key: c_get failed: DB_LOCK_DEADLOCK: Locker killed to resolve a deadlock (-30994)

May 28 07:21:44: --- last message repeated 1 time ---

May 28 07:21:44 robin.example.info slapd[220]: conn=22217 op=4: attribute "entryCSN" index delete failure

May 28 07:21:44 robin.example.info slapd[220]: conn=22217 op=3: attribute "entryCSN" index delete failure

May 31 20:49:52 robin.example.info slapd[220]: connection_read(49): no connection!

Jun  1 16:03:03 robin.example.info slapd[220]: connection_read(49): no connection!

 

when i create a test user on my OD Master it does sync to the OD Replica but i am getting all these errors and really can't tell if the OD Replica is actually working...here is a little insight on my network setup if it would help...

 

I have my OD Master also running the following services... Caching, Calendar, Contacts,File Sharing, Messages, Time Machine, DNS (Master), Websites, VPN, Profile Manager, Wiki, FTP...

I have my OD Replica also running the following services... Caching, File Sharing, Mail, Websites, Wiki, DNS (Secondary)...

 

Everything else seems to be working as of now except the OD...please help....

 

Also since my mail server is on my secondary server, how do i get all my clients to trust that server so i don't get a message asking if i want to trust it?

Posted on Jun 4, 2015 6:26 AM

Close

Q: LDAP failing to sync

  • All replies
  • Helpful answers

  • by adisor19,

    adisor19 adisor19 Dec 22, 2015 11:16 AM in response to JeremyR3784
    Level 1 (14 points)
    Dec 22, 2015 11:16 AM in response to JeremyR3784

    Hi,

     

    Did you ever manage to fix this ?

     

    I have this issue with only 1 of my 5 replicas and am currently looking for a solution short of wiping out the OS on the replica and starting from scratch..

     

    Thank you,

     

    Adrian

  • by adisor19,

    adisor19 adisor19 Jan 22, 2016 10:28 AM in response to adisor19
    Level 1 (14 points)
    Jan 22, 2016 10:28 AM in response to adisor19

    OK so I figured out what was causing my problem.

     

    Turns out that one of the OS X updates or upgrades removed the 127.0.0.1 entry on my network card DNS server on my OD master server.


    AS soon as I re added 127.0.0.1 aka localhost as DNS server, problem solved. The replication errors stopped right away.

     

    All my 5 replicas are 100% in sync and working now.