]> git.sur5r.net Git - openldap/blobdiff - servers/slurpd/ldap_op.c
changes in bdb_psearch() - search scope check
[openldap] / servers / slurpd / ldap_op.c
index d02af7d1ce1d13064dfe9b0b1171c48a3cc52942..38882a1b42226351b564a2174a60d21276f683c3 100644 (file)
@@ -1,4 +1,8 @@
 /* $OpenLDAP$ */
+/*
+ * Copyright 1998-2002 The OpenLDAP Foundation, All Rights Reserved.
+ * COPYING RESTRICTIONS APPLY, see COPYRIGHT file
+ */
 /*
  * Copyright (c) 1996 Regents of the University of Michigan.
  * All rights reserved.
@@ -49,7 +53,7 @@ static int do_unbind LDAP_P(( Ri * ));
 /*
  * Determine the type of ldap operation being performed and call the
  * appropriate routine.
- * - If successful, returns ERR_DO_LDAP_OK
+ * - If successful, returns DO_LDAP_OK
  * - If a retryable error occurs, ERR_DO_LDAP_RETRYABLE is returned.
  *   The caller should wait a while and retry the operation.
  * - If a fatal error occurs, ERR_DO_LDAP_FATAL is returned.  The caller
@@ -58,88 +62,126 @@ static int do_unbind LDAP_P(( Ri * ));
  */
 int
 do_ldap(
-    Ri         *ri,
-    Re         *re,
-    char       **errmsg
+       Ri              *ri,
+       Re              *re,
+       char    **errmsg
 )
 {
-    int        rc = 0;
-    int        lderr = LDAP_SUCCESS;
-    int        retry = 2;
+       int     retry = 2;
+       *errmsg = NULL;
 
-    *errmsg = NULL;
+       do {
+               int lderr;
+               if ( ri->ri_ldp == NULL ) {
+                       lderr = do_bind( ri, &lderr );
 
-    while ( retry > 0 ) {
-       if ( ri->ri_ldp == NULL ) {
-           rc = do_bind( ri, &lderr );
+                       if ( lderr != BIND_OK ) {
+                               return DO_LDAP_ERR_RETRYABLE;
+                       }
+               }
 
-           if ( rc != BIND_OK ) {
-                       return DO_LDAP_ERR_RETRYABLE;
-           }
-       }
+               switch ( re->re_changetype ) {
+               case T_ADDCT:
+                       lderr = op_ldap_add( ri, re, errmsg );
+                       if ( lderr != LDAP_SUCCESS ) {
+#ifdef NEW_LOGGING
+                               LDAP_LOG ( OPERATION, ERR, "do_ldap: "
+                                       "Error: ldap_add_s failed adding \"%s\": %s\n",
+                                       *errmsg ? *errmsg : ldap_err2string( lderr ), 
+                                       re->re_dn, 0 );
+#else
+                               Debug( LDAP_DEBUG_ANY,
+                                       "Error: ldap_add_s failed adding \"%s\": %s\n",
+                                       *errmsg ? *errmsg : ldap_err2string( lderr ),
+                                       re->re_dn, 0 );
+#endif
+                       }
+                       break;
+
+               case T_MODIFYCT:
+                       lderr = op_ldap_modify( ri, re, errmsg );
+                       if ( lderr != LDAP_SUCCESS ) {
+#ifdef NEW_LOGGING
+                               LDAP_LOG ( OPERATION, ERR, "do_ldap: "
+                                       "Error: ldap_modify_s failed modifying \"%s\": %s\n",
+                                       *errmsg ? *errmsg : ldap_err2string( lderr ), 
+                                       re->re_dn, 0 );
+#else
+                               Debug( LDAP_DEBUG_ANY,
+                                       "Error: ldap_modify_s failed modifying \"%s\": %s\n",
+                                       *errmsg ? *errmsg : ldap_err2string( lderr ),
+                                       re->re_dn, 0 );
+#endif
+                       }
+                       break;
+
+               case T_DELETECT:
+                       lderr = op_ldap_delete( ri, re, errmsg );
+                       if ( lderr != LDAP_SUCCESS ) {
+#ifdef NEW_LOGGING
+                               LDAP_LOG ( OPERATION, ERR, "do_ldap: "
+                                       "Error: ldap_delete_s failed deleting \"%s\": %s\n",
+                                       *errmsg ? *errmsg : ldap_err2string( lderr ), 
+                                       re->re_dn, 0 );
+#else
+                               Debug( LDAP_DEBUG_ANY,
+                                       "Error: ldap_delete_s failed deleting \"%s\": %s\n",
+                                       *errmsg ? *errmsg : ldap_err2string( lderr ),
+                                       re->re_dn, 0 );
+#endif
+                       }
+                       break;
+
+               case T_MODRDNCT:
+                       lderr = op_ldap_modrdn( ri, re, errmsg );
+                       if ( lderr != LDAP_SUCCESS ) {
+#ifdef NEW_LOGGING
+                               LDAP_LOG ( OPERATION, ERR, "do_ldap: "
+                                       "Error: ldap_modrdn_s failed modifying %s: %s\n",
+                                       *errmsg ? *errmsg : ldap_err2string( lderr ), 
+                                       re->re_dn, 0 );
+#else
+                               Debug( LDAP_DEBUG_ANY,
+                                       "Error: ldap_modrdn_s failed modifying %s: %s\n",
+                                       *errmsg ? *errmsg : ldap_err2string( lderr ),
+                                       re->re_dn, 0 );
+#endif
+                       }
+                       break;
 
-       switch ( re->re_changetype ) {
-       case T_ADDCT:
-           lderr = op_ldap_add( ri, re, errmsg );
-           if ( lderr != LDAP_SUCCESS ) {
-               Debug( LDAP_DEBUG_ANY,
-                       "Error: ldap_add_s failed adding \"%s\": %s\n",
-                       *errmsg ? *errmsg : ldap_err2string( lderr ),
-                       re->re_dn, 0 );
-           }
-           break;
-       case T_MODIFYCT:
-           lderr = op_ldap_modify( ri, re, errmsg );
-           if ( lderr != LDAP_SUCCESS ) {
-               Debug( LDAP_DEBUG_ANY,
-                       "Error: ldap_modify_s failed modifying \"%s\": %s\n",
-                       *errmsg ? *errmsg : ldap_err2string( lderr ),
-                       re->re_dn, 0 );
-           }
-           break;
-       case T_DELETECT:
-           lderr = op_ldap_delete( ri, re, errmsg );
-           if ( lderr != LDAP_SUCCESS ) {
-               Debug( LDAP_DEBUG_ANY,
-                       "Error: ldap_delete_s failed deleting \"%s\": %s\n",
-                       *errmsg ? *errmsg : ldap_err2string( lderr ),
-                       re->re_dn, 0 );
-           }
-           break;
-       case T_MODRDNCT:
-           lderr = op_ldap_modrdn( ri, re, errmsg );
-           if ( lderr != LDAP_SUCCESS ) {
-               Debug( LDAP_DEBUG_ANY,
-                       "Error: ldap_modrdn_s failed modifying %s: %s\n",
-                       *errmsg ? *errmsg : ldap_err2string( lderr ),
-                       re->re_dn, 0 );
-           }
-           break;
-       default:
-           Debug( LDAP_DEBUG_ANY,
-                   "Error: do_ldap: bad op \"%d\", dn = \"%s\"\n",
-                   re->re_changetype, re->re_dn, 0 );
-           return DO_LDAP_ERR_FATAL;
-       }
+               default:
+#ifdef NEW_LOGGING
+                       LDAP_LOG ( OPERATION, ERR, "do_ldap: "
+                               "Error: bad op \"%d\", dn = \"%s\"\n",
+                               re->re_changetype, re->re_dn, 0 );
+#else
+                       Debug( LDAP_DEBUG_ANY,
+                               "Error: do_ldap: bad op \"%d\", dn = \"%s\"\n",
+                               re->re_changetype, re->re_dn, 0 );
+#endif
+                       return DO_LDAP_ERR_FATAL;
+               }
 
-       /*
-        * Analyze return code.  If ok, just return.  If LDAP_SERVER_DOWN,
-        * we may have been idle long enough that the remote slapd timed
-        * us out.  Rebind and try again.
-        */
-       if ( lderr == LDAP_SUCCESS ) {
-           return DO_LDAP_OK;
-       } else if ( lderr == LDAP_SERVER_DOWN ) {
-           /* The LDAP server may have timed us out - rebind and try again */
-           (void) do_unbind( ri );
-           retry--;
-       } else {
-           return DO_LDAP_ERR_FATAL;
-       }
-    }
-    return DO_LDAP_ERR_FATAL;
-}
+               /*
+                * Analyze return code. If ok, just return. If LDAP_SERVER_DOWN,
+                * we may have been idle long enough that the remote slapd timed
+                * us out. Rebind and try again.
+                */
+               switch( lderr ) {
+               case LDAP_SUCCESS:
+                       return DO_LDAP_OK;
+       
+               default:
+                       return DO_LDAP_ERR_FATAL;
+
+               case LDAP_SERVER_DOWN: /* server went down */
+                       (void) do_unbind( ri );
+                       retry--;
+               }
+       } while ( retry > 0 );
 
+       return DO_LDAP_ERR_RETRYABLE;
+}
 
 
 
@@ -182,16 +224,27 @@ op_ldap_add(
        ldmarr[ nattrs ] = NULL;
 
        /* Perform the operation */
+#ifdef NEW_LOGGING
+       LDAP_LOG ( OPERATION, ARGS, 
+               "op_ldap_add: replica %s:%d - add dn \"%s\"\n",
+               ri->ri_hostname, ri->ri_port, re->re_dn );
+#else
        Debug( LDAP_DEBUG_ARGS, "replica %s:%d - add dn \"%s\"\n",
                ri->ri_hostname, ri->ri_port, re->re_dn );
+#endif
        rc = ldap_add_s( ri->ri_ldp, re->re_dn, ldmarr );
 
        ldap_get_option( ri->ri_ldp, LDAP_OPT_ERROR_NUMBER, &lderr);
 
     } else {
        *errmsg = "No modifications to do";
+#ifdef NEW_LOGGING
+       LDAP_LOG ( OPERATION, ERR, 
+               "op_ldap_add: Error: no mods to do (%s)!\n", re->re_dn, 0, 0 );
+#else
        Debug( LDAP_DEBUG_ANY,
               "Error: op_ldap_add: no mods to do (%s)!\n", re->re_dn, 0, 0 );
+#endif
     }
     free_ldmarr( ldmarr );
     return( lderr ); 
@@ -215,7 +268,7 @@ op_ldap_modify(
     int                state;  /* This code is a simple-minded state machine */
     int                nvals;  /* Number of values we're modifying */
     int                nops;   /* Number of LDAPMod structs in ldmarr */
-    LDAPMod    *ldm, **ldmarr;
+    LDAPMod    *ldm = NULL, **ldmarr;
     int                i, len;
     char       *type, *value;
     int                rc = 0;
@@ -227,8 +280,13 @@ op_ldap_modify(
 
     if ( re->re_mods == NULL ) {
        *errmsg = "No arguments given";
+#ifdef NEW_LOGGING
+       LDAP_LOG ( OPERATION, ERR, 
+               "op_ldap_modify: Error: no arguments\n" , 0, 0, 0 );
+#else
        Debug( LDAP_DEBUG_ANY, "Error: op_ldap_modify: no arguments\n",
                0, 0, 0 );
+#endif
            return -1;
     }
 
@@ -275,20 +333,34 @@ op_ldap_modify(
            break;
        default:
            if ( state == AWAITING_OP ) {
+#ifdef NEW_LOGGING
+               LDAP_LOG ( OPERATION, ERR, 
+                       "op_ldap_modify: Error: unknown mod type \"%s\"\n", type, 0, 0 );
+#else
                Debug( LDAP_DEBUG_ANY,
                        "Error: op_ldap_modify: unknown mod type \"%s\"\n",
                        type, 0, 0 );
+#endif
                continue;
            }
 
+           assert( ldm );
+
            /*
             * We should have an attribute: value pair here.
             * Construct the mod_bvalues part of the ldapmod struct.
             */
            if ( strcasecmp( type, ldm->mod_type )) {
+#ifdef NEW_LOGGING
+               LDAP_LOG ( OPERATION, ERR, 
+                       "op_ldap_modify: Error: "
+                       "malformed modify op, %s: %s (expecting \"%s\")\n", 
+                       type, value, ldm->mod_type );
+#else
                Debug( LDAP_DEBUG_ANY,
                        "Error: malformed modify op, %s: %s (expecting %s:)\n",
                        type, value, ldm->mod_type );
+#endif
                continue;
            }
            ldm->mod_bvalues = ( struct berval ** )
@@ -306,8 +378,14 @@ op_ldap_modify(
 
     if ( nops > 0 ) {
        /* Actually perform the LDAP operation */
+#ifdef NEW_LOGGING
+       LDAP_LOG ( OPERATION, DETAIL1, 
+               "op_ldap_modify: replica %s:%d - modify dn \"%s\"\n", 
+               ri->ri_hostname, ri->ri_port, re->re_dn );
+#else
        Debug( LDAP_DEBUG_ARGS, "replica %s:%d - modify dn \"%s\"\n",
                ri->ri_hostname, ri->ri_port, re->re_dn );
+#endif
        rc = ldap_modify_s( ri->ri_ldp, re->re_dn, ldmarr );
     }
     free_ldmarr( ldmarr );
@@ -329,8 +407,14 @@ op_ldap_delete(
 {
     int                rc;
 
+#ifdef NEW_LOGGING
+       LDAP_LOG ( OPERATION, ARGS, 
+               "op_ldap_delete: replica %s:%d - delete dn \"%s\"\n",
+           ri->ri_hostname, ri->ri_port, re->re_dn );
+#else
     Debug( LDAP_DEBUG_ARGS, "replica %s:%d - delete dn \"%s\"\n",
            ri->ri_hostname, ri->ri_port, re->re_dn );
+#endif
     rc = ldap_delete_s( ri->ri_ldp, re->re_dn );
 
     return( rc );
@@ -361,13 +445,18 @@ op_ldap_modrdn(
        int             lderr = 0;
     int                state = 0;
     int                drdnflag = -1;
-    char       *newrdn;
+    char       *newrdn = NULL;
        char    *newsup = NULL;
 
     if ( re->re_mods == NULL ) {
        *errmsg = "No arguments given";
+#ifdef NEW_LOGGING
+       LDAP_LOG ( OPERATION, ERR, 
+               "op_ldap_modrdn: Error: no arguments\n" , 0, 0, 0 );
+#else
        Debug( LDAP_DEBUG_ANY, "Error: op_ldap_modrdn: no arguments\n",
                0, 0, 0 );
+#endif
            return -1;
     }
 
@@ -377,9 +466,15 @@ op_ldap_modrdn(
     for ( mi = re->re_mods, i = 0; mi[ i ].mi_type != NULL; i++ ) {
        if ( !strcmp( mi[ i ].mi_type, T_NEWRDNSTR )) {
                if( state & GOT_NEWRDN ) {
+#ifdef NEW_LOGGING
+               LDAP_LOG ( OPERATION, ERR, 
+                       "op_ldap_modrdn: Error: multiple newrdn arg \"%s\"\n",
+                       mi[ i ].mi_val, 0, 0 );
+#else
                Debug( LDAP_DEBUG_ANY,
                        "Error: op_ldap_modrdn: multiple newrdn arg \"%s\"\n",
                        mi[ i ].mi_val, 0, 0 );
+#endif
                *errmsg = "Multiple newrdn argument";
                return -1;
                }
@@ -389,9 +484,15 @@ op_ldap_modrdn(
 
        } else if ( !strcmp( mi[ i ].mi_type, T_DELOLDRDNSTR )) {
                if( state & GOT_DELOLDRDN ) {
+#ifdef NEW_LOGGING
+               LDAP_LOG ( OPERATION, ERR, 
+                       "op_ldap_modrdn: Error: multiple deleteoldrdn arg \"%s\"\n",
+                       mi[ i ].mi_val, 0, 0 );
+#else
                Debug( LDAP_DEBUG_ANY,
                        "Error: op_ldap_modrdn: multiple deleteoldrdn arg \"%s\"\n",
                        mi[ i ].mi_val, 0, 0 );
+#endif
                *errmsg = "Multiple newrdn argument";
                return -1;
                }
@@ -402,28 +503,46 @@ op_ldap_modrdn(
            } else if ( !strcmp( mi[ i ].mi_val, "1" )) {
                drdnflag = 1;
            } else {
+#ifdef NEW_LOGGING
+               LDAP_LOG ( OPERATION, ERR, 
+                       "op_ldap_modrdn: Error: bad deleteoldrdn arg \"%s\"\n",
+                       mi[ i ].mi_val, 0, 0 );
+#else
                Debug( LDAP_DEBUG_ANY,
                        "Error: op_ldap_modrdn: bad deleteoldrdn arg \"%s\"\n",
                        mi[ i ].mi_val, 0, 0 );
+#endif
                *errmsg = "Incorrect argument to deleteoldrdn";
                return -1;
            }
 
        } else if ( !strcmp( mi[ i ].mi_type, T_NEWSUPSTR )) {
                if( state & GOT_NEWSUP ) {
+#ifdef NEW_LOGGING
+               LDAP_LOG ( OPERATION, ERR, 
+                       "op_ldap_modrdn: Error: multiple newsuperior arg \"%s\"\n",
+                       mi[ i ].mi_val, 0, 0 );
+#else
                Debug( LDAP_DEBUG_ANY,
                        "Error: op_ldap_modrdn: multiple newsuperior arg \"%s\"\n",
                        mi[ i ].mi_val, 0, 0 );
+#endif
                *errmsg = "Multiple newsuperior argument";
                return -1;
                }
 
-               newrdn = mi[ i ].mi_val;
+               newsup = mi[ i ].mi_val;
            state |= GOT_NEWSUP;
 
        } else {
+#ifdef NEW_LOGGING
+               LDAP_LOG ( OPERATION, ERR, 
+                       "op_ldap_modrdn: Error: bad type \"%s\"\n",
+                       mi[ i ].mi_type, 0, 0 );
+#else
            Debug( LDAP_DEBUG_ANY, "Error: op_ldap_modrdn: bad type \"%s\"\n",
                    mi[ i ].mi_type, 0, 0 );
+#endif
            *errmsg = "Bad value in replication log entry";
            return -1;
        }
@@ -433,8 +552,13 @@ op_ldap_modrdn(
      * Punt if we don't have all the args.
      */
     if ( !GOT_ALL_MODDN(state) ) {
+#ifdef NEW_LOGGING
+               LDAP_LOG ( OPERATION, ERR, 
+                       "op_ldap_modrdn: Error: missing arguments\n" , 0, 0, 0 );
+#else
        Debug( LDAP_DEBUG_ANY, "Error: op_ldap_modrdn: missing arguments\n",
                0, 0, 0 );
+#endif
        *errmsg = "Missing argument: requires \"newrdn\" and \"deleteoldrdn\"";
        return -1;
     }
@@ -443,19 +567,30 @@ op_ldap_modrdn(
     if ( ldap_debug & LDAP_DEBUG_ARGS ) {
        char buf[ 256 ];
        char *buf2;
-       sprintf( buf, "%s:%d", ri->ri_hostname, ri->ri_port );
-       buf2 = (char *) ch_malloc( strlen( re->re_dn ) + strlen( mi->mi_val )
-               + 10 );
-       sprintf( buf2, "(\"%s\" -> \"%s\")", re->re_dn, mi->mi_val );
+       int buf2len = strlen( re->re_dn ) + strlen( mi->mi_val ) + 11;
+
+       snprintf( buf, sizeof(buf), "%s:%d", ri->ri_hostname, ri->ri_port );
+
+       buf2 = (char *) ch_malloc( buf2len );
+       snprintf( buf2, buf2len, "(\"%s\" -> \"%s\")", re->re_dn, mi->mi_val );
+
+#ifdef NEW_LOGGING
+       LDAP_LOG ( OPERATION, ARGS, 
+               "op_ldap_modrdn: replica %s - modify rdn %s (flag: %d)\n",
+               buf, buf2, drdnflag );
+#else
        Debug( LDAP_DEBUG_ARGS,
                "replica %s - modify rdn %s (flag: %d)\n",
                buf, buf2, drdnflag );
+#endif
        free( buf2 );
     }
 #endif /* LDAP_DEBUG */
 
+    assert( newrdn );
+
     /* Do the modrdn */
-    rc = ldap_rename2_s( ri->ri_ldp, re->re_dn, mi->mi_val, newsup, drdnflag );
+    rc = ldap_rename2_s( ri->ri_ldp, re->re_dn, newrdn, newsup, drdnflag );
 
        ldap_get_option( ri->ri_ldp, LDAP_OPT_ERROR_NUMBER, &lderr);
     return( lderr );
@@ -580,9 +715,15 @@ do_unbind(
     if (( ri != NULL ) && ( ri->ri_ldp != NULL )) {
        rc = ldap_unbind( ri->ri_ldp );
        if ( rc != LDAP_SUCCESS ) {
+#ifdef NEW_LOGGING
+               LDAP_LOG ( OPERATION, ERR, 
+                       "do_unbind: ldap_unbind failed for %s:%d: %s\n",
+                   ri->ri_hostname, ri->ri_port, ldap_err2string( rc ) );
+#else
            Debug( LDAP_DEBUG_ANY,
                    "Error: do_unbind: ldap_unbind failed for %s:%d: %s\n",
                    ri->ri_hostname, ri->ri_port, ldap_err2string( rc ) );
+#endif
        }
        ri->ri_ldp = NULL;
     }
@@ -609,35 +750,52 @@ do_bind(
 )
 {
     int                ldrc;
-#ifdef HAVE_CYRUS_SASL
-       void *defaults;
-#endif
-
 
     *lderr = 0;
 
     if ( ri == NULL ) {
+#ifdef NEW_LOGGING
+       LDAP_LOG ( OPERATION, ERR, "do_bind: null ri ptr\n" , 0, 0, 0 );
+#else
        Debug( LDAP_DEBUG_ANY, "Error: do_bind: null ri ptr\n", 0, 0, 0 );
+#endif
        return( BIND_ERR_BADRI );
     }
 
     if ( ri->ri_ldp != NULL ) {
        ldrc = ldap_unbind( ri->ri_ldp );
        if ( ldrc != LDAP_SUCCESS ) {
+#ifdef NEW_LOGGING
+               LDAP_LOG ( OPERATION, ERR, 
+                       "do_bind: ldap_unbind failed: %s\n", ldap_err2string( ldrc ), 0, 0 );
+#else
            Debug( LDAP_DEBUG_ANY,
                    "Error: do_bind: ldap_unbind failed: %s\n",
                    ldap_err2string( ldrc ), 0, 0 );
+#endif
        }
        ri->ri_ldp = NULL;
     }
 
+#ifdef NEW_LOGGING
+       LDAP_LOG ( OPERATION, ARGS, 
+               "do_bind: Initializing session to %s:%d\n", 
+           ri->ri_hostname, ri->ri_port, 0 );
+#else
     Debug( LDAP_DEBUG_ARGS, "Initializing session to %s:%d\n",
            ri->ri_hostname, ri->ri_port, 0 );
+#endif
 
     ri->ri_ldp = ldap_init( ri->ri_hostname, ri->ri_port );
     if ( ri->ri_ldp == NULL ) {
+#ifdef NEW_LOGGING
+               LDAP_LOG ( OPERATION, ERR, 
+                       "do_bind: ldap_init (%s, %d) failed: %s\n",
+                       ri->ri_hostname, ri->ri_port, sys_errlist[ errno ] );
+#else
                Debug( LDAP_DEBUG_ANY, "Error: ldap_init(%s, %d) failed: %s\n",
                        ri->ri_hostname, ri->ri_port, sys_errlist[ errno ] );
+#endif
                return( BIND_ERR_OPEN );
     }
 
@@ -647,9 +805,15 @@ do_bind(
                        LDAP_OPT_PROTOCOL_VERSION, &version);
 
                if( err != LDAP_OPT_SUCCESS ) {
+#ifdef NEW_LOGGING
+                       LDAP_LOG ( OPERATION, ERR, "do_bind: "
+                               "Error: ldap_set_option(%s, LDAP_OPT_VERSION, 3) failed!\n",
+                               ri->ri_hostname, 0, 0 );
+#else
                        Debug( LDAP_DEBUG_ANY,
                                "Error: ldap_set_option(%s, LDAP_OPT_VERSION, 3) failed!\n",
                                ri->ri_hostname, NULL, NULL );
+#endif
 
                        ldap_unbind( ri->ri_ldp );
                        ri->ri_ldp = NULL;
@@ -666,9 +830,15 @@ do_bind(
                err = ldap_set_option(ri->ri_ldp, LDAP_OPT_REFERRALS, LDAP_OPT_OFF);
 
                if( err != LDAP_OPT_SUCCESS ) {
+#ifdef NEW_LOGGING
+                       LDAP_LOG ( OPERATION, ERR, "do_bind: "
+                               "Error: ldap_set_option(%s, REFERRALS, OFF) failed!\n",
+                               ri->ri_hostname, 0, 0 );
+#else
                        Debug( LDAP_DEBUG_ANY,
                                "Error: ldap_set_option(%s,REFERRALS, OFF) failed!\n",
                                ri->ri_hostname, NULL, NULL );
+#endif
                        ldap_unbind( ri->ri_ldp );
                        ri->ri_ldp = NULL;
                        return BIND_ERR_REFERRALS;
@@ -681,12 +851,19 @@ do_bind(
                err = ldap_start_tls_s(ri->ri_ldp, NULL, NULL);
 
                if( err != LDAP_SUCCESS ) {
+#ifdef NEW_LOGGING
+                       LDAP_LOG ( OPERATION, ERR, "do_bind: "
+                               "%s: ldap_start_tls failed: %s (%d)\n",
+                               ri->ri_tls == TLS_CRITICAL ? "Error" : "Warning",
+                               ldap_err2string( err ), err );
+#else
                        Debug( LDAP_DEBUG_ANY,
                                "%s: ldap_start_tls failed: %s (%d)\n",
-                               ri->ri_tls != TLS_CRITICAL ? "Warning" : "Error",
+                               ri->ri_tls == TLS_CRITICAL ? "Error" : "Warning",
                                ldap_err2string( err ), err );
+#endif
 
-                       if( ri->ri_tls != TLS_CRITICAL ) {
+                       if( ri->ri_tls == TLS_CRITICAL ) {
                                ldap_unbind( ri->ri_ldp );
                                ri->ri_ldp = NULL;
                                return BIND_ERR_TLS_FAILED;
@@ -699,14 +876,26 @@ do_bind(
        /*
         * Bind with a plaintext password.
         */
+#ifdef NEW_LOGGING
+       LDAP_LOG ( OPERATION, ARGS, 
+               "do_bind: bind to %s:%d as %s (simple)\n", 
+               ri->ri_hostname, ri->ri_port, ri->ri_bind_dn );
+#else
        Debug( LDAP_DEBUG_ARGS, "bind to %s:%d as %s (simple)\n",
                ri->ri_hostname, ri->ri_port, ri->ri_bind_dn );
+#endif
        ldrc = ldap_simple_bind_s( ri->ri_ldp, ri->ri_bind_dn,
                ri->ri_password );
        if ( ldrc != LDAP_SUCCESS ) {
+#ifdef NEW_LOGGING
+               LDAP_LOG ( OPERATION, ERR, "do_bind: "
+                   "Error: ldap_simple_bind_s for %s:%d failed: %s\n",
+                   ri->ri_hostname, ri->ri_port, ldap_err2string( ldrc ) );
+#else
            Debug( LDAP_DEBUG_ANY,
                    "Error: ldap_simple_bind_s for %s:%d failed: %s\n",
                    ri->ri_hostname, ri->ri_port, ldap_err2string( ldrc ));
+#endif
            *lderr = ldrc;
                ldap_unbind( ri->ri_ldp );
                ri->ri_ldp = NULL;
@@ -715,8 +904,18 @@ do_bind(
        break;
 
        case AUTH_SASL:
+#ifdef NEW_LOGGING
+       LDAP_LOG ( OPERATION, ARGS, 
+               "do_bind: bind to %s as %s via %s (SASL)\n", 
+               ri->ri_hostname,
+               ri->ri_authcId ? ri->ri_authcId : "-",
+               ri->ri_saslmech );
+#else
        Debug( LDAP_DEBUG_ARGS, "bind to %s as %s via %s (SASL)\n",
-               ri->ri_hostname, ri->ri_authcId, ri->ri_saslmech );
+               ri->ri_hostname,
+               ri->ri_authcId ? ri->ri_authcId : "-",
+               ri->ri_saslmech );
+#endif
 
 #ifdef HAVE_CYRUS_SASL
        if( ri->ri_secprops != NULL ) {
@@ -725,42 +924,73 @@ do_bind(
                        ri->ri_secprops);
 
                if( err != LDAP_OPT_SUCCESS ) {
+#ifdef NEW_LOGGING
+                       LDAP_LOG ( OPERATION, ERR, "do_bind: "
+                               "Error: ldap_set_option(%s,SECPROPS,\"%s\") failed!\n",
+                               ri->ri_hostname, ri->ri_secprops, 0 );
+#else
                        Debug( LDAP_DEBUG_ANY,
                                "Error: ldap_set_option(%s,SECPROPS,\"%s\") failed!\n",
                                ri->ri_hostname, ri->ri_secprops, NULL );
+#endif
                        ldap_unbind( ri->ri_ldp );
                        ri->ri_ldp = NULL;
                        return BIND_ERR_SASL_FAILED;
                }
        }
 
-       defaults = lutil_sasl_defaults( ri->ri_ldp, ri->ri_saslmech,
-           ri->ri_realm, ri->ri_authcId, ri->ri_password, ri->ri_authzId );
-       ldrc = ldap_sasl_interactive_bind_s( ri->ri_ldp, ri->ri_bind_dn,
-           ri->ri_saslmech, NULL, NULL,
-           LDAP_SASL_QUIET, lutil_sasl_interact, defaults );
-       if ( ldrc != LDAP_SUCCESS ) {
-               Debug( LDAP_DEBUG_ANY, "Error: LDAP SASL for %s:%d failed: %s\n",
-                   ri->ri_hostname, ri->ri_port, ldap_err2string( ldrc ));
-               *lderr = ldrc;
-               ldap_unbind( ri->ri_ldp );
-               ri->ri_ldp = NULL;
-               return( BIND_ERR_SASL_FAILED );
+       {
+               char *passwd = ri->ri_password ? ber_strdup( ri->ri_password ) : NULL;
+               void *defaults = lutil_sasl_defaults( ri->ri_ldp, ri->ri_saslmech,
+                   ri->ri_realm, ri->ri_authcId, passwd, ri->ri_authzId );
+
+               ldrc = ldap_sasl_interactive_bind_s( ri->ri_ldp, ri->ri_bind_dn,
+                   ri->ri_saslmech, NULL, NULL,
+                   LDAP_SASL_QUIET, lutil_sasl_interact, defaults );
+               if ( ldrc != LDAP_SUCCESS ) {
+#ifdef NEW_LOGGING
+                       LDAP_LOG ( OPERATION, ERR, "do_bind: "
+                               "Error: LDAP SASL for %s:%d failed: %s\n",
+                           ri->ri_hostname, ri->ri_port, ldap_err2string( ldrc ) );
+#else
+                       Debug( LDAP_DEBUG_ANY, "Error: LDAP SASL for %s:%d failed: %s\n",
+                           ri->ri_hostname, ri->ri_port, ldap_err2string( ldrc ));
+#endif
+                       *lderr = ldrc;
+                       ldap_unbind( ri->ri_ldp );
+                       ri->ri_ldp = NULL;
+                       return( BIND_ERR_SASL_FAILED );
+               }
+
+               ber_memfree( passwd );
+               ber_memfree( defaults );
        }
        break;
+#else
+#ifdef NEW_LOGGING
+       LDAP_LOG ( OPERATION, ERR, "do_bind: "
+               "Error: do_bind: SASL not supported %s:%d\n",
+               ri->ri_hostname, ri->ri_port, 0 );
 #else
        Debug( LDAP_DEBUG_ANY,
                "Error: do_bind: SASL not supported %s:%d\n",
                 ri->ri_hostname, ri->ri_port, NULL );
+#endif
        ldap_unbind( ri->ri_ldp );
        ri->ri_ldp = NULL;
        return( BIND_ERR_BAD_ATYPE );
 #endif
 
     default:
+#ifdef NEW_LOGGING
+       LDAP_LOG ( OPERATION, ERR, "do_bind: "
+               "Error: do_bind: unknown auth type \"%d\" for %s:%d\n",
+               ri->ri_bind_method, ri->ri_hostname, ri->ri_port );
+#else
        Debug(  LDAP_DEBUG_ANY,
                "Error: do_bind: unknown auth type \"%d\" for %s:%d\n",
                ri->ri_bind_method, ri->ri_hostname, ri->ri_port );
+#endif
        ldap_unbind( ri->ri_ldp );
        ri->ri_ldp = NULL;
        return( BIND_ERR_BAD_ATYPE );
@@ -776,14 +1006,20 @@ do_bind(
                c.ldctl_oid = LDAP_CONTROL_MANAGEDSAIT;
                c.ldctl_value.bv_val = NULL;
                c.ldctl_value.bv_len = 0;
-               c.ldctl_iscritical = 1;
+               c.ldctl_iscritical = 0;
 
                err = ldap_set_option(ri->ri_ldp, LDAP_OPT_SERVER_CONTROLS, &ctrls);
 
                if( err != LDAP_OPT_SUCCESS ) {
-                       Debug( LDAP_DEBUG_ANY,
-                               "Error: ldap_set_option(%s, SERVER_CONTROLS, ManageDSAit) failed!\n",
+#ifdef NEW_LOGGING
+                       LDAP_LOG ( OPERATION, ERR, "do_bind: "
+                               "ldap_set_option(%s, SERVER_CONTROLS, ManageDSAit) failed!\n",
+                               ri->ri_hostname, 0, 0 );
+#else
+                       Debug( LDAP_DEBUG_ANY, "Error: "
+                               "ldap_set_option(%s, SERVER_CONTROLS, ManageDSAit) failed!\n",
                                ri->ri_hostname, NULL, NULL );
+#endif
                        ldap_unbind( ri->ri_ldp );
                        ri->ri_ldp = NULL;
                        return BIND_ERR_MANAGEDSAIT;
@@ -812,6 +1048,17 @@ dump_ldm_array(
 
     for ( i = 0; ldmarr[ i ] != NULL; i++ ) {
        ldm = ldmarr[ i ];
+#ifdef NEW_LOGGING
+       LDAP_LOG ( OPERATION, INFO, "dump_ldm_array: "
+               "Trace (%ld): *** ldmarr[ %d ] contents:\n",
+               (long) getpid(), i, 0 );
+       LDAP_LOG ( OPERATION, INFO, "dump_ldm_array: "
+               "Trace (%ld): *** ldm->mod_op: %d\n",
+               (long) getpid(), ldm->mod_op, 0 );
+       LDAP_LOG ( OPERATION, INFO, "dump_ldm_array: "
+               "Trace (%ld): *** ldm->mod_type: %s\n",
+               (long) getpid(), ldm->mod_type, 0 );
+#else
        Debug( LDAP_DEBUG_TRACE,
                "Trace (%ld): *** ldmarr[ %d ] contents:\n",
                (long) getpid(), i, 0 );
@@ -821,13 +1068,19 @@ dump_ldm_array(
        Debug( LDAP_DEBUG_TRACE,
                "Trace (%ld): *** ldm->mod_type: %s\n",
                (long) getpid(), ldm->mod_type, 0 );
+#endif
        if ( ldm->mod_bvalues != NULL ) {
            for ( j = 0; ( b = ldm->mod_bvalues[ j ] ) != NULL; j++ ) {
                msgbuf = ch_malloc( b->bv_len + 512 );
                sprintf( msgbuf, "***** bv[ %d ] len = %ld, val = <%s>",
                        j, b->bv_len, b->bv_val );
+#ifdef NEW_LOGGING
+               LDAP_LOG ( OPERATION, INFO, "dump_ldm_array: "
+                       "Trace (%ld):%s\n", (long) getpid(), msgbuf, 0 );
+#else
                Debug( LDAP_DEBUG_TRACE,
                        "Trace (%ld):%s\n", (long) getpid(), msgbuf, 0 );
+#endif
                free( msgbuf );
            }
        }