git.sur5r.net Git - openldap/blob - servers/slapd/overlays/accesslog.c

   1 /* accesslog.c - log operations for audit/history purposes */
   2 /* $OpenLDAP$ */
   3 /* This work is part of OpenLDAP Software <http://www.openldap.org/>.
   4  *
   5  * Copyright 2005-2015 The OpenLDAP Foundation.
   6  * Portions copyright 2004-2005 Symas Corporation.
   7  * All rights reserved.
   8  *
   9  * Redistribution and use in source and binary forms, with or without
  10  * modification, are permitted only as authorized by the OpenLDAP
  11  * Public License.
  12  *
  13  * A copy of this license is available in the file LICENSE in the
  14  * top-level directory of the distribution or, alternatively, at
  15  * <http://www.OpenLDAP.org/license.html>.
  16  */
  17 /* ACKNOWLEDGEMENTS:
  18  * This work was initially developed by Howard Chu for inclusion in
  19  * OpenLDAP Software.
  20  */
  21
  22 #include "portable.h"
  23
  24 #ifdef SLAPD_OVER_ACCESSLOG
  25
  26 #include <stdio.h>
  27
  28 #include <ac/string.h>
  29 #include <ac/ctype.h>
  30
  31 #include "slap.h"
  32 #include "config.h"
  33 #include "lutil.h"
  34 #include "ldap_rq.h"
  35
  36 #define LOG_OP_ADD      0x001
  37 #define LOG_OP_DELETE   0x002
  38 #define LOG_OP_MODIFY   0x004
  39 #define LOG_OP_MODRDN   0x008
  40 #define LOG_OP_COMPARE  0x010
  41 #define LOG_OP_SEARCH   0x020
  42 #define LOG_OP_BIND     0x040
  43 #define LOG_OP_UNBIND   0x080
  44 #define LOG_OP_ABANDON  0x100
  45 #define LOG_OP_EXTENDED 0x200
  46 #define LOG_OP_UNKNOWN  0x400
  47
  48 #define LOG_OP_WRITES   (LOG_OP_ADD|LOG_OP_DELETE|LOG_OP_MODIFY|LOG_OP_MODRDN)
  49 #define LOG_OP_READS    (LOG_OP_COMPARE|LOG_OP_SEARCH)
  50 #define LOG_OP_SESSION  (LOG_OP_BIND|LOG_OP_UNBIND|LOG_OP_ABANDON)
  51 #define LOG_OP_ALL              (LOG_OP_READS|LOG_OP_WRITES|LOG_OP_SESSION| \
  52         LOG_OP_EXTENDED|LOG_OP_UNKNOWN)
  53
  54 typedef struct log_attr {
  55         struct log_attr *next;
  56         AttributeDescription *attr;
  57 } log_attr;
  58
  59 typedef struct log_base {
  60         struct log_base *lb_next;
  61         slap_mask_t lb_ops;
  62         struct berval lb_base;
  63         struct berval lb_line;
  64 } log_base;
  65
  66 typedef struct log_info {
  67         BackendDB *li_db;
  68         struct berval li_db_suffix;
  69         slap_mask_t li_ops;
  70         int li_age;
  71         int li_cycle;
  72         struct re_s *li_task;
  73         Filter *li_oldf;
  74         Entry *li_old;
  75         log_attr *li_oldattrs;
  76         struct berval li_uuid;
  77         int li_success;
  78         log_base *li_bases;
  79         ldap_pvt_thread_rmutex_t li_op_rmutex;
  80         ldap_pvt_thread_mutex_t li_log_mutex;
  81 } log_info;
  82
  83 static ConfigDriver log_cf_gen;
  84
  85 enum {
  86         LOG_DB = 1,
  87         LOG_OPS,
  88         LOG_PURGE,
  89         LOG_SUCCESS,
  90         LOG_OLD,
  91         LOG_OLDATTR,
  92         LOG_BASE
  93 };
  94
  95 static ConfigTable log_cfats[] = {
  96         { "logdb", "suffix", 2, 2, 0, ARG_DN|ARG_MAGIC|LOG_DB,
  97                 log_cf_gen, "( OLcfgOvAt:4.1 NAME 'olcAccessLogDB' "
  98                         "DESC 'Suffix of database for log content' "
  99                         "SUP distinguishedName SINGLE-VALUE )", NULL, NULL },
 100         { "logops", "op|writes|reads|session|all", 2, 0, 0,
 101                 ARG_MAGIC|LOG_OPS,
 102                 log_cf_gen, "( OLcfgOvAt:4.2 NAME 'olcAccessLogOps' "
 103                         "DESC 'Operation types to log' "
 104                         "EQUALITY caseIgnoreMatch "
 105                         "SYNTAX OMsDirectoryString )", NULL, NULL },
 106         { "logpurge", "age> <interval", 3, 3, 0, ARG_MAGIC|LOG_PURGE,
 107                 log_cf_gen, "( OLcfgOvAt:4.3 NAME 'olcAccessLogPurge' "
 108                         "DESC 'Log cleanup parameters' "
 109                         "SYNTAX OMsDirectoryString SINGLE-VALUE )", NULL, NULL },
 110         { "logsuccess", NULL, 2, 2, 0, ARG_MAGIC|ARG_ON_OFF|LOG_SUCCESS,
 111                 log_cf_gen, "( OLcfgOvAt:4.4 NAME 'olcAccessLogSuccess' "
 112                         "DESC 'Log successful ops only' "
 113                         "SYNTAX OMsBoolean SINGLE-VALUE )", NULL, NULL },
 114         { "logold", "filter", 2, 2, 0, ARG_MAGIC|LOG_OLD,
 115                 log_cf_gen, "( OLcfgOvAt:4.5 NAME 'olcAccessLogOld' "
 116                         "DESC 'Log old values when modifying entries matching the filter' "
 117                         "SYNTAX OMsDirectoryString SINGLE-VALUE )", NULL, NULL },
 118         { "logoldattr", "attrs", 2, 0, 0, ARG_MAGIC|LOG_OLDATTR,
 119                 log_cf_gen, "( OLcfgOvAt:4.6 NAME 'olcAccessLogOldAttr' "
 120                         "DESC 'Log old values of these attributes even if unmodified' "
 121                         "EQUALITY caseIgnoreMatch "
 122                         "SYNTAX OMsDirectoryString )", NULL, NULL },
 123         { "logbase", "op|writes|reads|session|all< <baseDN", 3, 3, 0,
 124                 ARG_MAGIC|LOG_BASE,
 125                 log_cf_gen, "( OLcfgOvAt:4.7 NAME 'olcAccessLogBase' "
 126                         "DESC 'Operation types to log under a specific branch' "
 127                         "EQUALITY caseIgnoreMatch "
 128                         "SYNTAX OMsDirectoryString )", NULL, NULL },
 129         { NULL }
 130 };
 131
 132 static ConfigOCs log_cfocs[] = {
 133         { "( OLcfgOvOc:4.1 "
 134                 "NAME 'olcAccessLogConfig' "
 135                 "DESC 'Access log configuration' "
 136                 "SUP olcOverlayConfig "
 137                 "MUST olcAccessLogDB "
 138                 "MAY ( olcAccessLogOps $ olcAccessLogPurge $ olcAccessLogSuccess $ "
 139                         "olcAccessLogOld $ olcAccessLogOldAttr $ olcAccessLogBase ) )",
 140                         Cft_Overlay, log_cfats },
 141         { NULL }
 142 };
 143
 144 static slap_verbmasks logops[] = {
 145         { BER_BVC("all"),               LOG_OP_ALL },
 146         { BER_BVC("writes"),    LOG_OP_WRITES },
 147         { BER_BVC("session"),   LOG_OP_SESSION },
 148         { BER_BVC("reads"),             LOG_OP_READS },
 149         { BER_BVC("add"),               LOG_OP_ADD },
 150         { BER_BVC("delete"),    LOG_OP_DELETE },
 151         { BER_BVC("modify"),    LOG_OP_MODIFY },
 152         { BER_BVC("modrdn"),    LOG_OP_MODRDN },
 153         { BER_BVC("compare"),   LOG_OP_COMPARE },
 154         { BER_BVC("search"),    LOG_OP_SEARCH },
 155         { BER_BVC("bind"),              LOG_OP_BIND },
 156         { BER_BVC("unbind"),    LOG_OP_UNBIND },
 157         { BER_BVC("abandon"),   LOG_OP_ABANDON },
 158         { BER_BVC("extended"),  LOG_OP_EXTENDED },
 159         { BER_BVC("unknown"),   LOG_OP_UNKNOWN },
 160         { BER_BVNULL, 0 }
 161 };
 162
 163 /* Start with "add" in logops */
 164 #define EN_OFFSET       4
 165
 166 enum {
 167         LOG_EN_ADD = 0,
 168         LOG_EN_DELETE,
 169         LOG_EN_MODIFY,
 170         LOG_EN_MODRDN,
 171         LOG_EN_COMPARE,
 172         LOG_EN_SEARCH,
 173         LOG_EN_BIND,
 174         LOG_EN_UNBIND,
 175         LOG_EN_ABANDON,
 176         LOG_EN_EXTENDED,
 177         LOG_EN_UNKNOWN,
 178         LOG_EN__COUNT
 179 };
 180
 181 static ObjectClass *log_ocs[LOG_EN__COUNT], *log_container,
 182         *log_oc_read, *log_oc_write;
 183
 184 #define LOG_SCHEMA_ROOT "1.3.6.1.4.1.4203.666.11.5"
 185
 186 #define LOG_SCHEMA_AT LOG_SCHEMA_ROOT ".1"
 187 #define LOG_SCHEMA_OC LOG_SCHEMA_ROOT ".2"
 188 #define LOG_SCHEMA_SYN LOG_SCHEMA_ROOT ".3"
 189
 190 static AttributeDescription *ad_reqDN, *ad_reqStart, *ad_reqEnd, *ad_reqType,
 191         *ad_reqSession, *ad_reqResult, *ad_reqAuthzID, *ad_reqControls,
 192         *ad_reqRespControls, *ad_reqMethod, *ad_reqAssertion, *ad_reqNewRDN,
 193         *ad_reqNewSuperior, *ad_reqDeleteOldRDN, *ad_reqMod,
 194         *ad_reqScope, *ad_reqFilter, *ad_reqAttr, *ad_reqEntries,
 195         *ad_reqSizeLimit, *ad_reqTimeLimit, *ad_reqAttrsOnly, *ad_reqData,
 196         *ad_reqId, *ad_reqMessage, *ad_reqVersion, *ad_reqDerefAliases,
 197         *ad_reqReferral, *ad_reqOld, *ad_auditContext, *ad_reqEntryUUID;
 198
 199 static int
 200 logSchemaControlValidate(
 201         Syntax          *syntax,
 202         struct berval   *val );
 203
 204 char    *mrControl[] = {
 205         "objectIdentifierFirstComponentMatch",
 206         NULL
 207 };
 208
 209 static struct {
 210         char                    *oid;
 211         slap_syntax_defs_rec    syn;
 212         char                    **mrs;
 213 } lsyntaxes[] = {
 214         { LOG_SCHEMA_SYN ".1" ,
 215                 { "( " LOG_SCHEMA_SYN ".1 DESC 'Control' )",
 216                         SLAP_SYNTAX_HIDE,
 217                         NULL,
 218                         logSchemaControlValidate,
 219                         NULL },
 220                 mrControl },
 221         { NULL }
 222 };
 223
 224 static struct {
 225         char *at;
 226         AttributeDescription **ad;
 227 } lattrs[] = {
 228         { "( " LOG_SCHEMA_AT ".1 NAME 'reqDN' "
 229                 "DESC 'Target DN of request' "
 230                 "EQUALITY distinguishedNameMatch "
 231                 "SYNTAX OMsDN "
 232                 "SINGLE-VALUE )", &ad_reqDN },
 233         { "( " LOG_SCHEMA_AT ".2 NAME 'reqStart' "
 234                 "DESC 'Start time of request' "
 235                 "EQUALITY generalizedTimeMatch "
 236                 "ORDERING generalizedTimeOrderingMatch "
 237                 "SYNTAX 1.3.6.1.4.1.1466.115.121.1.24 "
 238                 "SINGLE-VALUE )", &ad_reqStart },
 239         { "( " LOG_SCHEMA_AT ".3 NAME 'reqEnd' "
 240                 "DESC 'End time of request' "
 241                 "EQUALITY generalizedTimeMatch "
 242                 "ORDERING generalizedTimeOrderingMatch "
 243                 "SYNTAX 1.3.6.1.4.1.1466.115.121.1.24 "
 244                 "SINGLE-VALUE )", &ad_reqEnd },
 245         { "( " LOG_SCHEMA_AT ".4 NAME 'reqType' "
 246                 "DESC 'Type of request' "
 247                 "EQUALITY caseIgnoreMatch "
 248                 "SYNTAX OMsDirectoryString "
 249                 "SINGLE-VALUE )", &ad_reqType },
 250         { "( " LOG_SCHEMA_AT ".5 NAME 'reqSession' "
 251                 "DESC 'Session ID of request' "
 252                 "EQUALITY caseIgnoreMatch "
 253                 "SYNTAX OMsDirectoryString "
 254                 "SINGLE-VALUE )", &ad_reqSession },
 255         { "( " LOG_SCHEMA_AT ".6 NAME 'reqAuthzID' "
 256                 "DESC 'Authorization ID of requestor' "
 257                 "EQUALITY distinguishedNameMatch "
 258                 "SYNTAX OMsDN "
 259                 "SINGLE-VALUE )", &ad_reqAuthzID },
 260         { "( " LOG_SCHEMA_AT ".7 NAME 'reqResult' "
 261                 "DESC 'Result code of request' "
 262                 "EQUALITY integerMatch "
 263                 "ORDERING integerOrderingMatch "
 264                 "SYNTAX OMsInteger "
 265                 "SINGLE-VALUE )", &ad_reqResult },
 266         { "( " LOG_SCHEMA_AT ".8 NAME 'reqMessage' "
 267                 "DESC 'Error text of request' "
 268                 "EQUALITY caseIgnoreMatch "
 269                 "SUBSTR caseIgnoreSubstringsMatch "
 270                 "SYNTAX OMsDirectoryString "
 271                 "SINGLE-VALUE )", &ad_reqMessage },
 272         { "( " LOG_SCHEMA_AT ".9 NAME 'reqReferral' "
 273                 "DESC 'Referrals returned for request' "
 274                 "SUP labeledURI )", &ad_reqReferral },
 275         { "( " LOG_SCHEMA_AT ".10 NAME 'reqControls' "
 276                 "DESC 'Request controls' "
 277                 "EQUALITY objectIdentifierFirstComponentMatch "
 278                 "SYNTAX " LOG_SCHEMA_SYN ".1 "
 279                 "X-ORDERED 'VALUES' )", &ad_reqControls },
 280         { "( " LOG_SCHEMA_AT ".11 NAME 'reqRespControls' "
 281                 "DESC 'Response controls of request' "
 282                 "EQUALITY objectIdentifierFirstComponentMatch "
 283                 "SYNTAX " LOG_SCHEMA_SYN ".1 "
 284                 "X-ORDERED 'VALUES' )", &ad_reqRespControls },
 285         { "( " LOG_SCHEMA_AT ".12 NAME 'reqId' "
 286                 "DESC 'ID of Request to Abandon' "
 287                 "EQUALITY integerMatch "
 288                 "ORDERING integerOrderingMatch "
 289                 "SYNTAX OMsInteger "
 290                 "SINGLE-VALUE )", &ad_reqId },
 291         { "( " LOG_SCHEMA_AT ".13 NAME 'reqVersion' "
 292                 "DESC 'Protocol version of Bind request' "
 293                 "EQUALITY integerMatch "
 294                 "ORDERING integerOrderingMatch "
 295                 "SYNTAX OMsInteger "
 296                 "SINGLE-VALUE )", &ad_reqVersion },
 297         { "( " LOG_SCHEMA_AT ".14 NAME 'reqMethod' "
 298                 "DESC 'Bind method of request' "
 299                 "EQUALITY caseIgnoreMatch "
 300                 "SYNTAX OMsDirectoryString "
 301                 "SINGLE-VALUE )", &ad_reqMethod },
 302         { "( " LOG_SCHEMA_AT ".15 NAME 'reqAssertion' "
 303                 "DESC 'Compare Assertion of request' "
 304                 "SYNTAX OMsDirectoryString "
 305                 "SINGLE-VALUE )", &ad_reqAssertion },
 306         { "( " LOG_SCHEMA_AT ".16 NAME 'reqMod' "
 307                 "DESC 'Modifications of request' "
 308                 "EQUALITY octetStringMatch "
 309                 "SUBSTR octetStringSubstringsMatch "
 310                 "SYNTAX OMsOctetString )", &ad_reqMod },
 311         { "( " LOG_SCHEMA_AT ".17 NAME 'reqOld' "
 312                 "DESC 'Old values of entry before request completed' "
 313                 "EQUALITY octetStringMatch "
 314                 "SUBSTR octetStringSubstringsMatch "
 315                 "SYNTAX OMsOctetString )", &ad_reqOld },
 316         { "( " LOG_SCHEMA_AT ".18 NAME 'reqNewRDN' "
 317                 "DESC 'New RDN of request' "
 318                 "EQUALITY distinguishedNameMatch "
 319                 "SYNTAX OMsDN "
 320                 "SINGLE-VALUE )", &ad_reqNewRDN },
 321         { "( " LOG_SCHEMA_AT ".19 NAME 'reqDeleteOldRDN' "
 322                 "DESC 'Delete old RDN' "
 323                 "EQUALITY booleanMatch "
 324                 "SYNTAX OMsBoolean "
 325                 "SINGLE-VALUE )", &ad_reqDeleteOldRDN },
 326         { "( " LOG_SCHEMA_AT ".20 NAME 'reqNewSuperior' "
 327                 "DESC 'New superior DN of request' "
 328                 "EQUALITY distinguishedNameMatch "
 329                 "SYNTAX OMsDN "
 330                 "SINGLE-VALUE )", &ad_reqNewSuperior },
 331         { "( " LOG_SCHEMA_AT ".21 NAME 'reqScope' "
 332                 "DESC 'Scope of request' "
 333                 "EQUALITY caseIgnoreMatch "
 334                 "SYNTAX OMsDirectoryString "
 335                 "SINGLE-VALUE )", &ad_reqScope },
 336         { "( " LOG_SCHEMA_AT ".22 NAME 'reqDerefAliases' "
 337                 "DESC 'Disposition of Aliases in request' "
 338                 "EQUALITY caseIgnoreMatch "
 339                 "SYNTAX OMsDirectoryString "
 340                 "SINGLE-VALUE )", &ad_reqDerefAliases },
 341         { "( " LOG_SCHEMA_AT ".23 NAME 'reqAttrsOnly' "
 342                 "DESC 'Attributes and values of request' "
 343                 "EQUALITY booleanMatch "
 344                 "SYNTAX OMsBoolean "
 345                 "SINGLE-VALUE )", &ad_reqAttrsOnly },
 346         { "( " LOG_SCHEMA_AT ".24 NAME 'reqFilter' "
 347                 "DESC 'Filter of request' "
 348                 "EQUALITY caseIgnoreMatch "
 349                 "SUBSTR caseIgnoreSubstringsMatch "
 350                 "SYNTAX OMsDirectoryString "
 351                 "SINGLE-VALUE )", &ad_reqFilter },
 352         { "( " LOG_SCHEMA_AT ".25 NAME 'reqAttr' "
 353                 "DESC 'Attributes of request' "
 354                 "EQUALITY caseIgnoreMatch "
 355                 "SYNTAX OMsDirectoryString )", &ad_reqAttr },
 356         { "( " LOG_SCHEMA_AT ".26 NAME 'reqSizeLimit' "
 357                 "DESC 'Size limit of request' "
 358                 "EQUALITY integerMatch "
 359                 "ORDERING integerOrderingMatch "
 360                 "SYNTAX OMsInteger "
 361                 "SINGLE-VALUE )", &ad_reqSizeLimit },
 362         { "( " LOG_SCHEMA_AT ".27 NAME 'reqTimeLimit' "
 363                 "DESC 'Time limit of request' "
 364                 "EQUALITY integerMatch "
 365                 "ORDERING integerOrderingMatch "
 366                 "SYNTAX OMsInteger "
 367                 "SINGLE-VALUE )", &ad_reqTimeLimit },
 368         { "( " LOG_SCHEMA_AT ".28 NAME 'reqEntries' "
 369                 "DESC 'Number of entries returned' "
 370                 "EQUALITY integerMatch "
 371                 "ORDERING integerOrderingMatch "
 372                 "SYNTAX OMsInteger "
 373                 "SINGLE-VALUE )", &ad_reqEntries },
 374         { "( " LOG_SCHEMA_AT ".29 NAME 'reqData' "
 375                 "DESC 'Data of extended request' "
 376                 "EQUALITY octetStringMatch "
 377                 "SUBSTR octetStringSubstringsMatch "
 378                 "SYNTAX OMsOctetString "
 379                 "SINGLE-VALUE )", &ad_reqData },
 380
 381         /*
 382          * from <draft-chu-ldap-logschema-01.txt>:
 383          *
 384
 385    ( LOG_SCHEMA_AT .30 NAME 'auditContext'
 386    DESC 'DN of auditContainer'
 387    EQUALITY distinguishedNameMatch
 388    SYNTAX 1.3.6.1.4.1.1466.115.121.1.12
 389    SINGLE-VALUE NO-USER-MODIFICATION USAGE directoryOperation )
 390
 391          * - removed EQUALITY matchingRule
 392          * - changed directoryOperation in dSAOperation
 393          */
 394         { "( " LOG_SCHEMA_AT ".30 NAME 'auditContext' "
 395                 "DESC 'DN of auditContainer' "
 396                 "SYNTAX 1.3.6.1.4.1.1466.115.121.1.12 "
 397                 "SINGLE-VALUE "
 398                 "NO-USER-MODIFICATION "
 399                 "USAGE dSAOperation )", &ad_auditContext },
 400
 401         /*
 402          * ITS#6656
 403          */
 404         { "( " LOG_SCHEMA_AT ".31 NAME 'reqEntryUUID' "
 405                 "DESC 'UUID of entry' "
 406                 "EQUALITY UUIDMatch "
 407                 "ORDERING UUIDOrderingMatch "
 408                 "SYNTAX 1.3.6.1.1.16.1 "
 409                 "SINGLE-VALUE )", &ad_reqEntryUUID },
 410         { NULL, NULL }
 411 };
 412
 413 static struct {
 414         char *ot;
 415         ObjectClass **oc;
 416 } locs[] = {
 417         { "( " LOG_SCHEMA_OC ".0 NAME 'auditContainer' "
 418                 "DESC 'AuditLog container' "
 419                 "SUP top STRUCTURAL "
 420                 "MAY ( cn $ reqStart $ reqEnd ) )", &log_container },
 421         { "( " LOG_SCHEMA_OC ".1 NAME 'auditObject' "
 422                 "DESC 'OpenLDAP request auditing' "
 423                 "SUP top STRUCTURAL "
 424                 "MUST ( reqStart $ reqType $ reqSession ) "
 425                 "MAY ( reqDN $ reqAuthzID $ reqControls $ reqRespControls $ reqEnd $ "
 426                         "reqResult $ reqMessage $ reqReferral $ reqEntryUUID ) )",
 427                                 &log_ocs[LOG_EN_UNBIND] },
 428         { "( " LOG_SCHEMA_OC ".2 NAME 'auditReadObject' "
 429                 "DESC 'OpenLDAP read request record' "
 430                 "SUP auditObject STRUCTURAL )", &log_oc_read },
 431         { "( " LOG_SCHEMA_OC ".3 NAME 'auditWriteObject' "
 432                 "DESC 'OpenLDAP write request record' "
 433                 "SUP auditObject STRUCTURAL )", &log_oc_write },
 434         { "( " LOG_SCHEMA_OC ".4 NAME 'auditAbandon' "
 435                 "DESC 'Abandon operation' "
 436                 "SUP auditObject STRUCTURAL "
 437                 "MUST reqId )", &log_ocs[LOG_EN_ABANDON] },
 438         { "( " LOG_SCHEMA_OC ".5 NAME 'auditAdd' "
 439                 "DESC 'Add operation' "
 440                 "SUP auditWriteObject STRUCTURAL "
 441                 "MUST reqMod )", &log_ocs[LOG_EN_ADD] },
 442         { "( " LOG_SCHEMA_OC ".6 NAME 'auditBind' "
 443                 "DESC 'Bind operation' "
 444                 "SUP auditObject STRUCTURAL "
 445                 "MUST ( reqVersion $ reqMethod ) )", &log_ocs[LOG_EN_BIND] },
 446         { "( " LOG_SCHEMA_OC ".7 NAME 'auditCompare' "
 447                 "DESC 'Compare operation' "
 448                 "SUP auditReadObject STRUCTURAL "
 449                 "MUST reqAssertion )", &log_ocs[LOG_EN_COMPARE] },
 450         { "( " LOG_SCHEMA_OC ".8 NAME 'auditDelete' "
 451                 "DESC 'Delete operation' "
 452                 "SUP auditWriteObject STRUCTURAL "
 453                 "MAY reqOld )", &log_ocs[LOG_EN_DELETE] },
 454         { "( " LOG_SCHEMA_OC ".9 NAME 'auditModify' "
 455                 "DESC 'Modify operation' "
 456                 "SUP auditWriteObject STRUCTURAL "
 457                 "MAY reqOld MUST reqMod )", &log_ocs[LOG_EN_MODIFY] },
 458         { "( " LOG_SCHEMA_OC ".10 NAME 'auditModRDN' "
 459                 "DESC 'ModRDN operation' "
 460                 "SUP auditWriteObject STRUCTURAL "
 461                 "MUST ( reqNewRDN $ reqDeleteOldRDN ) "
 462                 "MAY ( reqNewSuperior $ reqMod $ reqOld ) )", &log_ocs[LOG_EN_MODRDN] },
 463         { "( " LOG_SCHEMA_OC ".11 NAME 'auditSearch' "
 464                 "DESC 'Search operation' "
 465                 "SUP auditReadObject STRUCTURAL "
 466                 "MUST ( reqScope $ reqDerefAliases $ reqAttrsonly ) "
 467                 "MAY ( reqFilter $ reqAttr $ reqEntries $ reqSizeLimit $ "
 468                         "reqTimeLimit ) )", &log_ocs[LOG_EN_SEARCH] },
 469         { "( " LOG_SCHEMA_OC ".12 NAME 'auditExtended' "
 470                 "DESC 'Extended operation' "
 471                 "SUP auditObject STRUCTURAL "
 472                 "MAY reqData )", &log_ocs[LOG_EN_EXTENDED] },
 473         { NULL, NULL }
 474 };
 475
 476 #define RDNEQ   "reqStart="
 477
 478 /* Our time intervals are of the form [ddd+]hh:mm[:ss]
 479  * If a field is present, it must be two digits. (Except for
 480  * days, which can be arbitrary width.)
 481  */
 482 static int
 483 log_age_parse(char *agestr)
 484 {
 485         int t1, t2;
 486         int gotdays = 0;
 487         char *endptr;
 488
 489         t1 = strtol( agestr, &endptr, 10 );
 490         /* Is there a days delimiter? */
 491         if ( *endptr == '+' ) {
 492                 /* 32 bit time only covers about 68 years */
 493                 if ( t1 < 0 || t1 > 25000 )
 494                         return -1;
 495                 t1 *= 24;
 496                 gotdays = 1;
 497                 agestr = endptr + 1;
 498         } else {
 499                 if ( agestr[2] != ':' ) {
 500                         /* No valid delimiter found, fail */
 501                         return -1;
 502                 }
 503                 t1 *= 60;
 504                 agestr += 3;
 505         }
 506
 507         t2 = atoi( agestr );
 508         t1 += t2;
 509
 510         if ( agestr[2] ) {
 511                 /* if there's a delimiter, it can only be a colon */
 512                 if ( agestr[2] != ':' )
 513                         return -1;
 514         } else {
 515                 /* If we're at the end of the string, and we started with days,
 516                  * fail because we expected to find minutes too.
 517                  */
 518                 return gotdays ? -1 : t1 * 60;
 519         }
 520
 521         agestr += 3;
 522         t2 = atoi( agestr );
 523
 524         /* last field can only be seconds */
 525         if ( agestr[2] && ( agestr[2] != ':' || !gotdays ))
 526                 return -1;
 527         t1 *= 60;
 528         t1 += t2;
 529
 530         if ( agestr[2] ) {
 531                 agestr += 3;
 532                 if ( agestr[2] )
 533                         return -1;
 534                 t1 *= 60;
 535                 t1 += atoi( agestr );
 536         } else if ( gotdays ) {
 537                 /* only got days+hh:mm */
 538                 t1 *= 60;
 539         }
 540         return t1;
 541 }
 542
 543 static void
 544 log_age_unparse( int age, struct berval *agebv, size_t size )
 545 {
 546         int dd, hh, mm, ss, len;
 547         char *ptr;
 548
 549         assert( size > 0 );
 550
 551         ss = age % 60;
 552         age /= 60;
 553         mm = age % 60;
 554         age /= 60;
 555         hh = age % 24;
 556         age /= 24;
 557         dd = age;
 558
 559         ptr = agebv->bv_val;
 560
 561         if ( dd ) {
 562                 len = snprintf( ptr, size, "%d+", dd );
 563                 assert( len >= 0 && (unsigned) len < size );
 564                 size -= len;
 565                 ptr += len;
 566         }
 567         len = snprintf( ptr, size, "%02d:%02d", hh, mm );
 568         assert( len >= 0 && (unsigned) len < size );
 569         size -= len;
 570         ptr += len;
 571         if ( ss ) {
 572                 len = snprintf( ptr, size, ":%02d", ss );
 573                 assert( len >= 0 && (unsigned) len < size );
 574                 size -= len;
 575                 ptr += len;
 576         }
 577
 578         agebv->bv_len = ptr - agebv->bv_val;
 579 }
 580
 581 static slap_callback nullsc = { NULL, NULL, NULL, NULL };
 582
 583 #define PURGE_INCREMENT 100
 584
 585 typedef struct purge_data {
 586         int slots;
 587         int used;
 588         BerVarray dn;
 589         BerVarray ndn;
 590         struct berval csn;      /* an arbitrary old CSN */
 591 } purge_data;
 592
 593 static int
 594 log_old_lookup( Operation *op, SlapReply *rs )
 595 {
 596         purge_data *pd = op->o_callback->sc_private;
 597         Attribute *a;
 598
 599         if ( rs->sr_type != REP_SEARCH) return 0;
 600
 601         if ( slapd_shutdown ) return 0;
 602
 603         /* Remember max CSN: should always be the last entry
 604          * seen, since log entries are ordered chronologically...
 605          */
 606         a = attr_find( rs->sr_entry->e_attrs,
 607                 slap_schema.si_ad_entryCSN );
 608         if ( a ) {
 609                 ber_len_t len = a->a_nvals[0].bv_len;
 610                 /* Paranoid len check, normalized CSNs are always the same length */
 611                 if ( len > LDAP_PVT_CSNSTR_BUFSIZE )
 612                         len = LDAP_PVT_CSNSTR_BUFSIZE;
 613                 if ( memcmp( a->a_nvals[0].bv_val, pd->csn.bv_val, len ) > 0 ) {
 614                         AC_MEMCPY( pd->csn.bv_val, a->a_nvals[0].bv_val, len );
 615                         pd->csn.bv_len = len;
 616                 }
 617         }
 618         if ( pd->used >= pd->slots ) {
 619                 pd->slots += PURGE_INCREMENT;
 620                 pd->dn = ch_realloc( pd->dn, pd->slots * sizeof( struct berval ));
 621                 pd->ndn = ch_realloc( pd->ndn, pd->slots * sizeof( struct berval ));
 622         }
 623         ber_dupbv( &pd->dn[pd->used], &rs->sr_entry->e_name );
 624         ber_dupbv( &pd->ndn[pd->used], &rs->sr_entry->e_nname );
 625         pd->used++;
 626         return 0;
 627 }
 628
 629 /* Periodically search for old entries in the log database and delete them */
 630 static void *
 631 accesslog_purge( void *ctx, void *arg )
 632 {
 633         struct re_s *rtask = arg;
 634         struct log_info *li = rtask->arg;
 635
 636         Connection conn = {0};
 637         OperationBuffer opbuf;
 638         Operation *op;
 639         SlapReply rs = {REP_RESULT};
 640         slap_callback cb = { NULL, log_old_lookup, NULL, NULL };
 641         Filter f;
 642         AttributeAssertion ava = ATTRIBUTEASSERTION_INIT;
 643         purge_data pd = {0};
 644         char timebuf[LDAP_LUTIL_GENTIME_BUFSIZE];
 645         char csnbuf[LDAP_PVT_CSNSTR_BUFSIZE];
 646         time_t old = slap_get_time();
 647
 648         connection_fake_init( &conn, &opbuf, ctx );
 649         op = &opbuf.ob_op;
 650
 651         f.f_choice = LDAP_FILTER_LE;
 652         f.f_ava = &ava;
 653         f.f_next = NULL;
 654
 655         ava.aa_desc = ad_reqStart;
 656         ava.aa_value.bv_val = timebuf;
 657         ava.aa_value.bv_len = sizeof(timebuf);
 658
 659         old -= li->li_age;
 660         slap_timestamp( &old, &ava.aa_value );
 661
 662         op->o_tag = LDAP_REQ_SEARCH;
 663         op->o_bd = li->li_db;
 664         op->o_dn = li->li_db->be_rootdn;
 665         op->o_ndn = li->li_db->be_rootndn;
 666         op->o_req_dn = li->li_db->be_suffix[0];
 667         op->o_req_ndn = li->li_db->be_nsuffix[0];
 668         op->o_callback = &cb;
 669         op->ors_scope = LDAP_SCOPE_ONELEVEL;
 670         op->ors_deref = LDAP_DEREF_NEVER;
 671         op->ors_tlimit = SLAP_NO_LIMIT;
 672         op->ors_slimit = SLAP_NO_LIMIT;
 673         op->ors_filter = &f;
 674         filter2bv_x( op, &f, &op->ors_filterstr );
 675         op->ors_attrs = slap_anlist_no_attrs;
 676         op->ors_attrsonly = 1;
 677
 678         pd.csn.bv_len = sizeof( csnbuf );
 679         pd.csn.bv_val = csnbuf;
 680         csnbuf[0] = '\0';
 681         cb.sc_private = &pd;
 682
 683         op->o_bd->be_search( op, &rs );
 684         op->o_tmpfree( op->ors_filterstr.bv_val, op->o_tmpmemctx );
 685
 686         if ( pd.used ) {
 687                 int i;
 688
 689                 /* delete the expired entries */
 690                 op->o_tag = LDAP_REQ_DELETE;
 691                 op->o_callback = &nullsc;
 692                 op->o_csn = pd.csn;
 693                 op->o_dont_replicate = 1;
 694
 695                 for (i=0; i<pd.used; i++) {
 696                         op->o_req_dn = pd.dn[i];
 697                         op->o_req_ndn = pd.ndn[i];
 698                         if ( !slapd_shutdown ) {
 699                                 rs_reinit( &rs, REP_RESULT );
 700                                 op->o_bd->be_delete( op, &rs );
 701                         }
 702                         ch_free( pd.ndn[i].bv_val );
 703                         ch_free( pd.dn[i].bv_val );
 704                 }
 705                 ch_free( pd.ndn );
 706                 ch_free( pd.dn );
 707
 708                 {
 709                         Modifications mod;
 710                         struct berval bv[2];
 711                         rs_reinit( &rs, REP_RESULT );
 712                         /* update context's entryCSN to reflect oldest CSN */
 713                         mod.sml_numvals = 1;
 714                         mod.sml_values = bv;
 715                         bv[0] = pd.csn;
 716                         BER_BVZERO(&bv[1]);
 717                         mod.sml_nvalues = NULL;
 718                         mod.sml_desc = slap_schema.si_ad_entryCSN;
 719                         mod.sml_op = LDAP_MOD_REPLACE;
 720                         mod.sml_flags = SLAP_MOD_INTERNAL;
 721                         mod.sml_next = NULL;
 722
 723                         op->o_tag = LDAP_REQ_MODIFY;
 724                         op->orm_modlist = &mod;
 725                         op->orm_no_opattrs = 1;
 726                         op->o_req_dn = li->li_db->be_suffix[0];
 727                         op->o_req_ndn = li->li_db->be_nsuffix[0];
 728                         op->o_no_schema_check = 1;
 729                         op->o_managedsait = SLAP_CONTROL_NONCRITICAL;
 730                         op->o_bd->be_modify( op, &rs );
 731                         if ( mod.sml_next ) {
 732                                 slap_mods_free( mod.sml_next, 1 );
 733                         }
 734                 }
 735         }
 736
 737         ldap_pvt_thread_mutex_lock( &slapd_rq.rq_mutex );
 738         ldap_pvt_runqueue_stoptask( &slapd_rq, rtask );
 739         ldap_pvt_thread_mutex_unlock( &slapd_rq.rq_mutex );
 740
 741         return NULL;
 742 }
 743
 744 static int
 745 log_cf_gen(ConfigArgs *c)
 746 {
 747         slap_overinst *on = (slap_overinst *)c->bi;
 748         struct log_info *li = on->on_bi.bi_private;
 749         int rc = 0;
 750         slap_mask_t tmask = 0;
 751         char agebuf[2*STRLENOF("ddddd+hh:mm:ss  ")];
 752         struct berval agebv, cyclebv;
 753
 754         switch( c->op ) {
 755         case SLAP_CONFIG_EMIT:
 756                 switch( c->type ) {
 757                 case LOG_DB:
 758                         if ( !BER_BVISEMPTY( &li->li_db_suffix )) {
 759                                 value_add_one( &c->rvalue_vals, &li->li_db_suffix );
 760                                 value_add_one( &c->rvalue_nvals, &li->li_db_suffix );
 761                         } else if ( li->li_db ) {
 762                                 value_add_one( &c->rvalue_vals, li->li_db->be_suffix );
 763                                 value_add_one( &c->rvalue_nvals, li->li_db->be_nsuffix );
 764                         } else {
 765                                 snprintf( c->cr_msg, sizeof( c->cr_msg ),
 766                                         "accesslog: \"logdb <suffix>\" must be specified" );
 767                                 Debug( LDAP_DEBUG_ANY, "%s: %s \"%s\"\n",
 768                                         c->log, c->cr_msg, c->value_dn.bv_val );
 769                                 rc = 1;
 770                                 break;
 771                         }
 772                         break;
 773                 case LOG_OPS:
 774                         rc = mask_to_verbs( logops, li->li_ops, &c->rvalue_vals );
 775                         break;
 776                 case LOG_PURGE:
 777                         if ( !li->li_age ) {
 778                                 rc = 1;
 779                                 break;
 780                         }
 781                         agebv.bv_val = agebuf;
 782                         log_age_unparse( li->li_age, &agebv, sizeof( agebuf ) );
 783                         agebv.bv_val[agebv.bv_len] = ' ';
 784                         agebv.bv_len++;
 785                         cyclebv.bv_val = agebv.bv_val + agebv.bv_len;
 786                         log_age_unparse( li->li_cycle, &cyclebv, sizeof( agebuf ) - agebv.bv_len );
 787                         agebv.bv_len += cyclebv.bv_len;
 788                         value_add_one( &c->rvalue_vals, &agebv );
 789                         break;
 790                 case LOG_SUCCESS:
 791                         if ( li->li_success )
 792                                 c->value_int = li->li_success;
 793                         else
 794                                 rc = 1;
 795                         break;
 796                 case LOG_OLD:
 797                         if ( li->li_oldf ) {
 798                                 filter2bv( li->li_oldf, &agebv );
 799                                 ber_bvarray_add( &c->rvalue_vals, &agebv );
 800                         }
 801                         else
 802                                 rc = 1;
 803                         break;
 804                 case LOG_OLDATTR:
 805                         if ( li->li_oldattrs ) {
 806                                 log_attr *la;
 807
 808                                 for ( la = li->li_oldattrs; la; la=la->next )
 809                                         value_add_one( &c->rvalue_vals, &la->attr->ad_cname );
 810                         }
 811                         else
 812                                 rc = 1;
 813                         break;
 814                 case LOG_BASE:
 815                         if ( li->li_bases ) {
 816                                 log_base *lb;
 817
 818                                 for ( lb = li->li_bases; lb; lb=lb->lb_next )
 819                                         value_add_one( &c->rvalue_vals, &lb->lb_line );
 820                         }
 821                         else
 822                                 rc = 1;
 823                         break;
 824                 }
 825                 break;
 826         case LDAP_MOD_DELETE:
 827                 switch( c->type ) {
 828                 case LOG_DB:
 829                         /* noop. this should always be a valid backend. */
 830                         break;
 831                 case LOG_OPS:
 832                         if ( c->valx < 0 ) {
 833                                 li->li_ops = 0;
 834                         } else {
 835                                 rc = verbs_to_mask( 1, &c->line, logops, &tmask );
 836                                 if ( rc == 0 )
 837                                         li->li_ops &= ~tmask;
 838                         }
 839                         break;
 840                 case LOG_PURGE:
 841                         if ( li->li_task ) {
 842                                 struct re_s *re = li->li_task;
 843                                 li->li_task = NULL;
 844                                 ldap_pvt_thread_mutex_lock( &slapd_rq.rq_mutex );
 845                                 if ( ldap_pvt_runqueue_isrunning( &slapd_rq, re ))
 846                                         ldap_pvt_runqueue_stoptask( &slapd_rq, re );
 847                                 ldap_pvt_runqueue_remove( &slapd_rq, re );
 848                                 ldap_pvt_thread_mutex_unlock( &slapd_rq.rq_mutex );
 849                         }
 850                         li->li_age = 0;
 851                         li->li_cycle = 0;
 852                         break;
 853                 case LOG_SUCCESS:
 854                         li->li_success = 0;
 855                         break;
 856                 case LOG_OLD:
 857                         if ( li->li_oldf ) {
 858                                 filter_free( li->li_oldf );
 859                                 li->li_oldf = NULL;
 860                         }
 861                         break;
 862                 case LOG_OLDATTR:
 863                         if ( c->valx < 0 ) {
 864                                 log_attr *la, *ln;
 865
 866                                 for ( la = li->li_oldattrs; la; la = ln ) {
 867                                         ln = la->next;
 868                                         ch_free( la );
 869                                 }
 870                         } else {
 871                                 log_attr *la = NULL, **lp;
 872                                 int i;
 873
 874                                 for ( lp = &li->li_oldattrs, i=0; i < c->valx; i++ ) {
 875                                         la = *lp;
 876                                         lp = &la->next;
 877                                 }
 878                                 *lp = la->next;
 879                                 ch_free( la );
 880                         }
 881                         break;
 882                 case LOG_BASE:
 883                         if ( c->valx < 0 ) {
 884                                 log_base *lb, *ln;
 885
 886                                 for ( lb = li->li_bases; lb; lb = ln ) {
 887                                         ln = lb->lb_next;
 888                                         ch_free( lb );
 889                                 }
 890                         } else {
 891                                 log_base *lb = NULL, **lp;
 892                                 int i;
 893
 894                                 for ( lp = &li->li_bases, i=0; i < c->valx; i++ ) {
 895                                         lb = *lp;
 896                                         lp = &lb->lb_next;
 897                                 }
 898                                 *lp = lb->lb_next;
 899                                 ch_free( lb );
 900                         }
 901                         break;
 902                 }
 903                 break;
 904         default:
 905                 switch( c->type ) {
 906                 case LOG_DB:
 907                         if ( CONFIG_ONLINE_ADD( c )) {
 908                                 li->li_db = select_backend( &c->value_ndn, 0 );
 909                                 if ( !li->li_db ) {
 910                                         snprintf( c->cr_msg, sizeof( c->cr_msg ),
 911                                                 "<%s> no matching backend found for suffix",
 912                                                 c->argv[0] );
 913                                         Debug( LDAP_DEBUG_ANY, "%s: %s \"%s\"\n",
 914                                                 c->log, c->cr_msg, c->value_dn.bv_val );
 915                                         rc = 1;
 916                                 }
 917                                 ch_free( c->value_ndn.bv_val );
 918                         } else {
 919                                 li->li_db_suffix = c->value_ndn;
 920                         }
 921                         ch_free( c->value_dn.bv_val );
 922                         break;
 923                 case LOG_OPS:
 924                         rc = verbs_to_mask( c->argc, c->argv, logops, &tmask );
 925                         if ( rc == 0 )
 926                                 li->li_ops |= tmask;
 927                         break;
 928                 case LOG_PURGE:
 929                         li->li_age = log_age_parse( c->argv[1] );
 930                         if ( li->li_age < 1 ) {
 931                                 rc = 1;
 932                         } else {
 933                                 li->li_cycle = log_age_parse( c->argv[2] );
 934                                 if ( li->li_cycle < 1 ) {
 935                                         rc = 1;
 936                                 } else if ( slapMode & SLAP_SERVER_MODE ) {
 937                                         struct re_s *re = li->li_task;
 938                                         if ( re )
 939                                                 re->interval.tv_sec = li->li_cycle;
 940                                         else {
 941                                                 ldap_pvt_thread_mutex_lock( &slapd_rq.rq_mutex );
 942                                                 li->li_task = ldap_pvt_runqueue_insert( &slapd_rq,
 943                                                         li->li_cycle, accesslog_purge, li,
 944                                                         "accesslog_purge", li->li_db ?
 945                                                                 li->li_db->be_suffix[0].bv_val :
 946                                                                 c->be->be_suffix[0].bv_val );
 947                                                 ldap_pvt_thread_mutex_unlock( &slapd_rq.rq_mutex );
 948                                         }
 949                                 }
 950                         }
 951                         break;
 952                 case LOG_SUCCESS:
 953                         li->li_success = c->value_int;
 954                         break;
 955                 case LOG_OLD:
 956                         li->li_oldf = str2filter( c->argv[1] );
 957                         if ( !li->li_oldf ) {
 958                                 snprintf( c->cr_msg, sizeof( c->cr_msg ), "bad filter!" );
 959                                 rc = 1;
 960                         }
 961                         break;
 962                 case LOG_OLDATTR: {
 963                         int i;
 964                         AttributeDescription *ad;
 965                         const char *text;
 966
 967                         for ( i=1; i< c->argc; i++ ) {
 968                                 ad = NULL;
 969                                 if ( slap_str2ad( c->argv[i], &ad, &text ) == LDAP_SUCCESS ) {
 970                                         log_attr *la = ch_malloc( sizeof( log_attr ));
 971                                         la->attr = ad;
 972                                         la->next = li->li_oldattrs;
 973                                         li->li_oldattrs = la;
 974                                 } else {
 975                                         snprintf( c->cr_msg, sizeof( c->cr_msg ), "%s <%s>: %s",
 976                                                 c->argv[0], c->argv[i], text );
 977                                         Debug( LDAP_DEBUG_CONFIG|LDAP_DEBUG_NONE,
 978                                                 "%s: %s\n", c->log, c->cr_msg, 0 );
 979                                         rc = ARG_BAD_CONF;
 980                                         break;
 981                                 }
 982                         }
 983                         }
 984                         break;
 985                 case LOG_BASE: {
 986                         slap_mask_t m = 0;
 987                         rc = verbstring_to_mask( logops, c->argv[1], '|', &m );
 988                         if ( rc == 0 ) {
 989                                 struct berval dn, ndn;
 990                                 ber_str2bv( c->argv[2], 0, 0, &dn );
 991                                 rc = dnNormalize( 0, NULL, NULL, &dn, &ndn, NULL );
 992                                 if ( rc == 0 ) {
 993                                         log_base *lb;
 994                                         struct berval mbv;
 995                                         char *ptr;
 996                                         mask_to_verbstring( logops, m, '|', &mbv );
 997                                         lb = ch_malloc( sizeof( log_base ) + mbv.bv_len + ndn.bv_len + 3 + 1 );
 998                                         lb->lb_line.bv_val = (char *)(lb + 1);
 999                                         lb->lb_line.bv_len = mbv.bv_len + ndn.bv_len + 3;
1000                                         ptr = lutil_strcopy( lb->lb_line.bv_val, mbv.bv_val );
1001                                         *ptr++ = ' ';
1002                                         *ptr++ = '"';
1003                                         lb->lb_base.bv_val = ptr;
1004                                         lb->lb_base.bv_len = ndn.bv_len;
1005                                         ptr = lutil_strcopy( ptr, ndn.bv_val );
1006                                         *ptr++ = '"';
1007                                         lb->lb_ops = m;
1008                                         lb->lb_next = li->li_bases;
1009                                         li->li_bases = lb;
1010                                 } else {
1011                                         snprintf( c->cr_msg, sizeof( c->cr_msg ), "%s invalid DN: %s",
1012                                                 c->argv[0], c->argv[2] );
1013                                         Debug( LDAP_DEBUG_CONFIG|LDAP_DEBUG_NONE,
1014                                                 "%s: %s\n", c->log, c->cr_msg, 0 );
1015                                         rc = ARG_BAD_CONF;
1016                                 }
1017                         } else {
1018                                 snprintf( c->cr_msg, sizeof( c->cr_msg ), "%s invalid ops: %s",
1019                                         c->argv[0], c->argv[1] );
1020                                 Debug( LDAP_DEBUG_CONFIG|LDAP_DEBUG_NONE,
1021                                         "%s: %s\n", c->log, c->cr_msg, 0 );
1022                                 rc = ARG_BAD_CONF;
1023                         }
1024                         }
1025                         break;
1026                 }
1027                 break;
1028         }
1029         return rc;
1030 }
1031
1032 static int
1033 logSchemaControlValidate(
1034         Syntax          *syntax,
1035         struct berval   *valp )
1036 {
1037         struct berval   val, bv;
1038         ber_len_t               i;
1039         int             rc = LDAP_SUCCESS;
1040
1041         assert( valp != NULL );
1042
1043         val = *valp;
1044
1045         /* check minimal size */
1046         if ( val.bv_len < STRLENOF( "{*}" ) ) {
1047                 return LDAP_INVALID_SYNTAX;
1048         }
1049
1050         val.bv_len--;
1051
1052         /* check SEQUENCE boundaries */
1053         if ( val.bv_val[ 0 ] != '{' /*}*/ ||
1054                 val.bv_val[ val.bv_len ] != /*{*/ '}' )
1055         {
1056                 return LDAP_INVALID_SYNTAX;
1057         }
1058
1059         /* extract and check OID */
1060         for ( i = 1; i < val.bv_len; i++ ) {
1061                 if ( !ASCII_SPACE( val.bv_val[ i ] ) ) {
1062                         break;
1063                 }
1064         }
1065
1066         bv.bv_val = &val.bv_val[ i ];
1067
1068         for ( i++; i < val.bv_len; i++ ) {
1069                 if ( ASCII_SPACE( val.bv_val[ i ] ) )
1070                 {
1071                         break;
1072                 }
1073         }
1074
1075         bv.bv_len = &val.bv_val[ i ] - bv.bv_val;
1076
1077         rc = numericoidValidate( NULL, &bv );
1078         if ( rc != LDAP_SUCCESS ) {
1079                 return rc;
1080         }
1081
1082         if ( i == val.bv_len ) {
1083                 return LDAP_SUCCESS;
1084         }
1085
1086         if ( val.bv_val[ i ] != ' ' ) {
1087                 return LDAP_INVALID_SYNTAX;
1088         }
1089
1090         for ( i++; i < val.bv_len; i++ ) {
1091                 if ( !ASCII_SPACE( val.bv_val[ i ] ) ) {
1092                         break;
1093                 }
1094         }
1095
1096         if ( i == val.bv_len ) {
1097                 return LDAP_SUCCESS;
1098         }
1099
1100         /* extract and check criticality */
1101         if ( strncasecmp( &val.bv_val[ i ], "criticality ", STRLENOF( "criticality " ) ) == 0 )
1102         {
1103                 i += STRLENOF( "criticality " );
1104                 for ( ; i < val.bv_len; i++ ) {
1105                         if ( !ASCII_SPACE( val.bv_val[ i ] ) ) {
1106                                 break;
1107                         }
1108                 }
1109
1110                 if ( i == val.bv_len ) {
1111                         return LDAP_INVALID_SYNTAX;
1112                 }
1113
1114                 bv.bv_val = &val.bv_val[ i ];
1115
1116                 for ( ; i < val.bv_len; i++ ) {
1117                         if ( ASCII_SPACE( val.bv_val[ i ] ) ) {
1118                                 break;
1119                         }
1120                 }
1121
1122                 bv.bv_len = &val.bv_val[ i ] - bv.bv_val;
1123
1124                 if ( !bvmatch( &bv, &slap_true_bv ) && !bvmatch( &bv, &slap_false_bv ) )
1125                 {
1126                         return LDAP_INVALID_SYNTAX;
1127                 }
1128
1129                 if ( i == val.bv_len ) {
1130                         return LDAP_SUCCESS;
1131                 }
1132
1133                 if ( val.bv_val[ i ] != ' ' ) {
1134                         return LDAP_INVALID_SYNTAX;
1135                 }
1136
1137                 for ( i++; i < val.bv_len; i++ ) {
1138                         if ( !ASCII_SPACE( val.bv_val[ i ] ) ) {
1139                                 break;
1140                         }
1141                 }
1142
1143                 if ( i == val.bv_len ) {
1144                         return LDAP_SUCCESS;
1145                 }
1146         }
1147
1148         /* extract and check controlValue */
1149         if ( strncasecmp( &val.bv_val[ i ], "controlValue ", STRLENOF( "controlValue " ) ) == 0 )
1150         {
1151                 ber_len_t valueStart, valueLen;
1152
1153                 i += STRLENOF( "controlValue " );
1154                 for ( ; i < val.bv_len; i++ ) {
1155                         if ( !ASCII_SPACE( val.bv_val[ i ] ) ) {
1156                                 break;
1157                         }
1158                 }
1159
1160                 if ( i == val.bv_len ) {
1161                         return LDAP_INVALID_SYNTAX;
1162                 }
1163
1164                 if ( val.bv_val[ i ] != '"' ) {
1165                         return LDAP_INVALID_SYNTAX;
1166                 }
1167
1168                 i++;
1169                 valueStart = i;
1170
1171                 for ( ; i < val.bv_len; i++ ) {
1172                         if ( val.bv_val[ i ] == '"' ) {
1173                                 break;
1174                         }
1175
1176                         if ( !ASCII_HEX( val.bv_val[ i ] ) ) {
1177                                 return LDAP_INVALID_SYNTAX;
1178                         }
1179                 }
1180
1181                 if ( val.bv_val[ i ] != '"' ) {
1182                         return LDAP_INVALID_SYNTAX;
1183                 }
1184
1185                 valueLen = i - valueStart;
1186                 if ( (valueLen/2)*2 != valueLen ) {
1187                         return LDAP_INVALID_SYNTAX;
1188                 }
1189
1190                 for ( i++; i < val.bv_len; i++ ) {
1191                         if ( !ASCII_SPACE( val.bv_val[ i ] ) ) {
1192                                 break;
1193                         }
1194                 }
1195
1196                 if ( i == val.bv_len ) {
1197                         return LDAP_SUCCESS;
1198                 }
1199         }
1200
1201         return LDAP_INVALID_SYNTAX;
1202 }
1203
1204 static int
1205 accesslog_ctrls(
1206         LDAPControl **ctrls,
1207         BerVarray *valsp,
1208         BerVarray *nvalsp,
1209         void *memctx )
1210 {
1211         long            i, rc = 0;
1212
1213         assert( valsp != NULL );
1214         assert( ctrls != NULL );
1215
1216         *valsp = NULL;
1217         *nvalsp = NULL;
1218
1219         for ( i = 0; ctrls[ i ] != NULL; i++ ) {
1220                 struct berval   idx,
1221                                 oid,
1222                                 noid,
1223                                 bv;
1224                 char            *ptr,
1225                                 buf[ 32 ];
1226
1227                 if ( ctrls[ i ]->ldctl_oid == NULL ) {
1228                         return LDAP_PROTOCOL_ERROR;
1229                 }
1230
1231                 idx.bv_len = snprintf( buf, sizeof( buf ), "{%ld}", i );
1232                 idx.bv_val = buf;
1233
1234                 ber_str2bv( ctrls[ i ]->ldctl_oid, 0, 0, &oid );
1235                 noid.bv_len = idx.bv_len + oid.bv_len;
1236                 ptr = noid.bv_val = ber_memalloc_x( noid.bv_len + 1, memctx );
1237                 ptr = lutil_strcopy( ptr, idx.bv_val );
1238                 ptr = lutil_strcopy( ptr, oid.bv_val );
1239
1240                 bv.bv_len = idx.bv_len + STRLENOF( "{}" ) + oid.bv_len;
1241
1242                 if ( ctrls[ i ]->ldctl_iscritical ) {
1243                         bv.bv_len += STRLENOF( " criticality TRUE" );
1244                 }
1245
1246                 if ( !BER_BVISNULL( &ctrls[ i ]->ldctl_value ) ) {
1247                         bv.bv_len += STRLENOF( " controlValue \"\"" )
1248                                 + 2 * ctrls[ i ]->ldctl_value.bv_len;
1249                 }
1250
1251                 ptr = bv.bv_val = ber_memalloc_x( bv.bv_len + 1, memctx );
1252                 if ( ptr == NULL ) {
1253                         ber_bvarray_free( *valsp );
1254                         *valsp = NULL;
1255                         ber_bvarray_free( *nvalsp );
1256                         *nvalsp = NULL;
1257                         return LDAP_OTHER;
1258                 }
1259
1260                 ptr = lutil_strcopy( ptr, idx.bv_val );
1261
1262                 *ptr++ = '{' /*}*/ ;
1263                 ptr = lutil_strcopy( ptr, oid.bv_val );
1264
1265                 if ( ctrls[ i ]->ldctl_iscritical ) {
1266                         ptr = lutil_strcopy( ptr, " criticality TRUE" );
1267                 }
1268
1269                 if ( !BER_BVISNULL( &ctrls[ i ]->ldctl_value ) ) {
1270                         ber_len_t       j;
1271
1272                         ptr = lutil_strcopy( ptr, " controlValue \"" );
1273                         for ( j = 0; j < ctrls[ i ]->ldctl_value.bv_len; j++ ) {
1274                                 *ptr++ = SLAP_ESCAPE_HI(ctrls[ i ]->ldctl_value.bv_val[ j ]);
1275                                 *ptr++ = SLAP_ESCAPE_LO(ctrls[ i ]->ldctl_value.bv_val[ j ]);
1276                         }
1277
1278                         *ptr++ = '"';
1279                 }
1280
1281                 *ptr++ = '}';
1282                 *ptr = '\0';
1283
1284                 ber_bvarray_add_x( valsp, &bv, memctx );
1285                 ber_bvarray_add_x( nvalsp, &noid, memctx );
1286         }
1287
1288         return rc;
1289
1290 }
1291
1292 static Entry *accesslog_entry( Operation *op, SlapReply *rs, int logop,
1293         Operation *op2 ) {
1294         slap_overinst *on = (slap_overinst *)op->o_bd->bd_info;
1295         log_info *li = on->on_bi.bi_private;
1296
1297         char rdnbuf[STRLENOF(RDNEQ)+LDAP_LUTIL_GENTIME_BUFSIZE+8];
1298         char nrdnbuf[STRLENOF(RDNEQ)+LDAP_LUTIL_GENTIME_BUFSIZE+8];
1299
1300         struct berval rdn, nrdn, timestamp, ntimestamp, bv;
1301         slap_verbmasks *lo = logops+logop+EN_OFFSET;
1302
1303         Entry *e = entry_alloc();
1304
1305         strcpy( rdnbuf, RDNEQ );
1306         rdn.bv_val = rdnbuf;
1307         strcpy( nrdnbuf, RDNEQ );
1308         nrdn.bv_val = nrdnbuf;
1309
1310         timestamp.bv_val = rdnbuf+STRLENOF(RDNEQ);
1311         timestamp.bv_len = sizeof(rdnbuf) - STRLENOF(RDNEQ);
1312         slap_timestamp( &op->o_time, &timestamp );
1313         snprintf( timestamp.bv_val + timestamp.bv_len-1, sizeof(".123456Z"), ".%06dZ", op->o_tincr );
1314         timestamp.bv_len += STRLENOF(".123456");
1315
1316         rdn.bv_len = STRLENOF(RDNEQ)+timestamp.bv_len;
1317         ad_reqStart->ad_type->sat_equality->smr_normalize(
1318                 SLAP_MR_VALUE_OF_ASSERTION_SYNTAX, ad_reqStart->ad_type->sat_syntax,
1319                 ad_reqStart->ad_type->sat_equality, &timestamp, &ntimestamp,
1320                 op->o_tmpmemctx );
1321
1322         strcpy( nrdn.bv_val + STRLENOF(RDNEQ), ntimestamp.bv_val );
1323         nrdn.bv_len = STRLENOF(RDNEQ)+ntimestamp.bv_len;
1324         build_new_dn( &e->e_name, li->li_db->be_suffix, &rdn, NULL );
1325         build_new_dn( &e->e_nname, li->li_db->be_nsuffix, &nrdn, NULL );
1326
1327         attr_merge_one( e, slap_schema.si_ad_objectClass,
1328                 &log_ocs[logop]->soc_cname, NULL );
1329         attr_merge_one( e, slap_schema.si_ad_structuralObjectClass,
1330                 &log_ocs[logop]->soc_cname, NULL );
1331         attr_merge_one( e, ad_reqStart, &timestamp, &ntimestamp );
1332         op->o_tmpfree( ntimestamp.bv_val, op->o_tmpmemctx );
1333
1334         slap_op_time( &op2->o_time, &op2->o_tincr );
1335
1336         timestamp.bv_len = sizeof(rdnbuf) - STRLENOF(RDNEQ);
1337         slap_timestamp( &op2->o_time, &timestamp );
1338         snprintf( timestamp.bv_val + timestamp.bv_len-1, sizeof(".123456Z"), ".%06dZ", op2->o_tincr );
1339         timestamp.bv_len += STRLENOF(".123456");
1340
1341         attr_merge_normalize_one( e, ad_reqEnd, &timestamp, op->o_tmpmemctx );
1342
1343         /* Exops have OID appended */
1344         if ( logop == LOG_EN_EXTENDED ) {
1345                 bv.bv_len = lo->word.bv_len + op->ore_reqoid.bv_len + 2;
1346                 bv.bv_val = ch_malloc( bv.bv_len + 1 );
1347                 AC_MEMCPY( bv.bv_val, lo->word.bv_val, lo->word.bv_len );
1348                 bv.bv_val[lo->word.bv_len] = '{';
1349                 AC_MEMCPY( bv.bv_val+lo->word.bv_len+1, op->ore_reqoid.bv_val,
1350                         op->ore_reqoid.bv_len );
1351                 bv.bv_val[bv.bv_len-1] = '}';
1352                 bv.bv_val[bv.bv_len] = '\0';
1353                 attr_merge_one( e, ad_reqType, &bv, NULL );
1354         } else {
1355                 attr_merge_one( e, ad_reqType, &lo->word, NULL );
1356         }
1357
1358         rdn.bv_len = snprintf( rdn.bv_val, sizeof( rdnbuf ), "%lu", op->o_connid );
1359         if ( rdn.bv_len < sizeof( rdnbuf ) ) {
1360                 attr_merge_one( e, ad_reqSession, &rdn, NULL );
1361         } /* else? */
1362
1363         if ( BER_BVISNULL( &op->o_dn ) ) {
1364                 attr_merge_one( e, ad_reqAuthzID, (struct berval *)&slap_empty_bv,
1365                         (struct berval *)&slap_empty_bv );
1366         } else {
1367                 attr_merge_one( e, ad_reqAuthzID, &op->o_dn, &op->o_ndn );
1368         }
1369
1370         /* FIXME: need to add reqControls and reqRespControls */
1371         if ( op->o_ctrls ) {
1372                 BerVarray       vals = NULL,
1373                                 nvals = NULL;
1374
1375                 if ( accesslog_ctrls( op->o_ctrls, &vals, &nvals,
1376                         op->o_tmpmemctx ) == LDAP_SUCCESS && vals )
1377                 {
1378                         attr_merge( e, ad_reqControls, vals, nvals );
1379                         ber_bvarray_free_x( vals, op->o_tmpmemctx );
1380                         ber_bvarray_free_x( nvals, op->o_tmpmemctx );
1381                 }
1382         }
1383
1384         if ( rs->sr_ctrls ) {
1385                 BerVarray       vals = NULL,
1386                                 nvals = NULL;
1387
1388                 if ( accesslog_ctrls( rs->sr_ctrls, &vals, &nvals,
1389                         op->o_tmpmemctx ) == LDAP_SUCCESS && vals )
1390                 {
1391                         attr_merge( e, ad_reqRespControls, vals, nvals );
1392                         ber_bvarray_free_x( vals, op->o_tmpmemctx );
1393                         ber_bvarray_free_x( nvals, op->o_tmpmemctx );
1394                 }
1395
1396         }
1397
1398         return e;
1399 }
1400
1401 static struct berval scopes[] = {
1402         BER_BVC("base"),
1403         BER_BVC("one"),
1404         BER_BVC("sub"),
1405         BER_BVC("subord")
1406 };
1407
1408 static struct berval derefs[] = {
1409         BER_BVC("never"),
1410         BER_BVC("searching"),
1411         BER_BVC("finding"),
1412         BER_BVC("always")
1413 };
1414
1415 static struct berval simple = BER_BVC("SIMPLE");
1416
1417 static void accesslog_val2val(AttributeDescription *ad, struct berval *val,
1418         char c_op, struct berval *dst) {
1419         char *ptr;
1420
1421         dst->bv_len = ad->ad_cname.bv_len + val->bv_len + 2;
1422         if ( c_op ) dst->bv_len++;
1423
1424         dst->bv_val = ch_malloc( dst->bv_len+1 );
1425
1426         ptr = lutil_strcopy( dst->bv_val, ad->ad_cname.bv_val );
1427         *ptr++ = ':';
1428         if ( c_op )
1429                 *ptr++ = c_op;
1430         *ptr++ = ' ';
1431         AC_MEMCPY( ptr, val->bv_val, val->bv_len );
1432         dst->bv_val[dst->bv_len] = '\0';
1433 }
1434
1435 static int
1436 accesslog_op2logop( Operation *op )
1437 {
1438         switch ( op->o_tag ) {
1439         case LDAP_REQ_ADD:              return LOG_EN_ADD;
1440         case LDAP_REQ_DELETE:   return LOG_EN_DELETE;
1441         case LDAP_REQ_MODIFY:   return LOG_EN_MODIFY;
1442         case LDAP_REQ_MODRDN:   return LOG_EN_MODRDN;
1443         case LDAP_REQ_COMPARE:  return LOG_EN_COMPARE;
1444         case LDAP_REQ_SEARCH:   return LOG_EN_SEARCH;
1445         case LDAP_REQ_BIND:             return LOG_EN_BIND;
1446         case LDAP_REQ_EXTENDED: return LOG_EN_EXTENDED;
1447         default:        /* unknown operation type */
1448                 break;
1449         }       /* Unbind and Abandon never reach here */
1450         return LOG_EN_UNKNOWN;
1451 }
1452
1453 static int accesslog_response(Operation *op, SlapReply *rs) {
1454         slap_overinst *on = (slap_overinst *)op->o_bd->bd_info;
1455         log_info *li = on->on_bi.bi_private;
1456         Attribute *a, *last_attr;
1457         Modifications *m;
1458         struct berval *b, uuid = BER_BVNULL;
1459         int i;
1460         int logop, do_graduate = 0;
1461         slap_verbmasks *lo;
1462         Entry *e = NULL, *old = NULL, *e_uuid = NULL;
1463         char timebuf[LDAP_LUTIL_GENTIME_BUFSIZE+8];
1464         struct berval bv;
1465         char *ptr;
1466         BerVarray vals;
1467         Operation op2 = {0};
1468         SlapReply rs2 = {REP_RESULT};
1469
1470         if ( rs->sr_type != REP_RESULT && rs->sr_type != REP_EXTENDED )
1471                 return SLAP_CB_CONTINUE;
1472
1473         logop = accesslog_op2logop( op );
1474         lo = logops+logop+EN_OFFSET;
1475         if ( !( li->li_ops & lo->mask )) {
1476                 log_base *lb;
1477
1478                 i = 0;
1479                 for ( lb = li->li_bases; lb; lb=lb->lb_next )
1480                         if (( lb->lb_ops & lo->mask ) && dnIsSuffix( &op->o_req_ndn, &lb->lb_base )) {
1481                                 i = 1;
1482                                 break;
1483                         }
1484                 if ( !i )
1485                         return SLAP_CB_CONTINUE;
1486         }
1487
1488         /* mutex and so were only set for write operations;
1489          * if we got here, the operation must be logged */
1490         if ( lo->mask & LOG_OP_WRITES ) {
1491                 slap_callback *cb;
1492
1493                 /* These internal ops are not logged */
1494                 if ( op->o_dont_replicate && op->orm_no_opattrs )
1495                         return SLAP_CB_CONTINUE;
1496
1497                 ldap_pvt_thread_mutex_lock( &li->li_log_mutex );
1498                 old = li->li_old;
1499                 uuid = li->li_uuid;
1500                 li->li_old = NULL;
1501                 BER_BVZERO( &li->li_uuid );
1502                 /* Disarm mod_cleanup */
1503                 for ( cb = op->o_callback; cb; cb = cb->sc_next ) {
1504                         if ( cb->sc_private == (void *)on ) {
1505                                 cb->sc_private = NULL;
1506                                 break;
1507                         }
1508                 }
1509                 ldap_pvt_thread_rmutex_unlock( &li->li_op_rmutex, op->o_tid );
1510         }
1511
1512         /* ignore these internal reads */
1513         if (( lo->mask & LOG_OP_READS ) && op->o_do_not_cache ) {
1514                 return SLAP_CB_CONTINUE;
1515         }
1516
1517         if ( li->li_success && rs->sr_err != LDAP_SUCCESS )
1518                 goto done;
1519
1520         e = accesslog_entry( op, rs, logop, &op2 );
1521
1522         attr_merge_one( e, ad_reqDN, &op->o_req_dn, &op->o_req_ndn );
1523
1524         if ( rs->sr_text ) {
1525                 ber_str2bv( rs->sr_text, 0, 0, &bv );
1526                 attr_merge_normalize_one( e, ad_reqMessage, &bv, op->o_tmpmemctx );
1527         }
1528         bv.bv_len = snprintf( timebuf, sizeof( timebuf ), "%d", rs->sr_err );
1529         if ( bv.bv_len < sizeof( timebuf ) ) {
1530                 bv.bv_val = timebuf;
1531                 attr_merge_one( e, ad_reqResult, &bv, NULL );
1532         }
1533
1534         last_attr = attr_find( e->e_attrs, ad_reqResult );
1535
1536         e_uuid = old;
1537         switch( logop ) {
1538         case LOG_EN_ADD:
1539         case LOG_EN_DELETE: {
1540                 char c_op;
1541                 Entry *e2;
1542
1543                 if ( logop == LOG_EN_ADD ) {
1544                         e2 = op->ora_e;
1545                         e_uuid = op->ora_e;
1546                         c_op = '+';
1547
1548                 } else {
1549                         if ( !old )
1550                                 break;
1551                         e2 = old;
1552                         c_op = 0;
1553                 }
1554                 /* count all the vals */
1555                 i = 0;
1556                 for ( a=e2->e_attrs; a; a=a->a_next ) {
1557                         i += a->a_numvals;
1558                 }
1559                 vals = ch_malloc( (i+1) * sizeof( struct berval ));
1560                 i = 0;
1561                 for ( a=e2->e_attrs; a; a=a->a_next ) {
1562                         if ( a->a_vals ) {
1563                                 for (b=a->a_vals; !BER_BVISNULL( b ); b++,i++) {
1564                                         accesslog_val2val( a->a_desc, b, c_op, &vals[i] );
1565                                 }
1566                         }
1567                 }
1568                 vals[i].bv_val = NULL;
1569                 vals[i].bv_len = 0;
1570                 a = attr_alloc( logop == LOG_EN_ADD ? ad_reqMod : ad_reqOld );
1571                 a->a_numvals = i;
1572                 a->a_vals = vals;
1573                 a->a_nvals = vals;
1574                 last_attr->a_next = a;
1575                 break;
1576         }
1577
1578         case LOG_EN_MODRDN:
1579         case LOG_EN_MODIFY:
1580                 /* count all the mods */
1581                 i = 0;
1582                 for ( m = op->orm_modlist; m; m = m->sml_next ) {
1583                         if ( m->sml_values ) {
1584                                 i += m->sml_numvals;
1585                         } else if ( m->sml_op == LDAP_MOD_DELETE ||
1586                                 m->sml_op == LDAP_MOD_REPLACE )
1587                         {
1588                                 i++;
1589                         }
1590                 }
1591                 vals = ch_malloc( (i+1) * sizeof( struct berval ));
1592                 i = 0;
1593
1594                 /* init flags on old entry */
1595                 if ( old ) {
1596                         for ( a = old->e_attrs; a; a = a->a_next ) {
1597                                 log_attr *la;
1598                                 a->a_flags = 0;
1599
1600                                 /* look for attrs that are always logged */
1601                                 for ( la = li->li_oldattrs; la; la = la->next ) {
1602                                         if ( a->a_desc == la->attr ) {
1603                                                 a->a_flags = 1;
1604                                         }
1605                                 }
1606                         }
1607                 }
1608
1609                 for ( m = op->orm_modlist; m; m = m->sml_next ) {
1610                         /* Mark this attribute as modified */
1611                         if ( old ) {
1612                                 a = attr_find( old->e_attrs, m->sml_desc );
1613                                 if ( a ) {
1614                                         a->a_flags = 1;
1615                                 }
1616                         }
1617
1618                         /* don't log the RDN mods; they're explicitly logged later */
1619                         if ( logop == LOG_EN_MODRDN &&
1620                                 ( m->sml_op == SLAP_MOD_SOFTADD ||
1621                                   m->sml_op == LDAP_MOD_DELETE ) )
1622                         {
1623                                 continue;
1624                         }
1625
1626                         if ( m->sml_values ) {
1627                                 for ( b = m->sml_values; !BER_BVISNULL( b ); b++, i++ ) {
1628                                         char c_op;
1629
1630                                         switch ( m->sml_op ) {
1631                                         case LDAP_MOD_ADD: c_op = '+'; break;
1632                                         case LDAP_MOD_DELETE:   c_op = '-'; break;
1633                                         case LDAP_MOD_REPLACE:  c_op = '='; break;
1634                                         case LDAP_MOD_INCREMENT:        c_op = '#'; break;
1635
1636                                         /* unknown op. there shouldn't be any of these. we
1637                                          * don't know what to do with it, but we shouldn't just
1638                                          * ignore it.
1639                                          */
1640                                         default: c_op = '?'; break;
1641                                         }
1642                                         accesslog_val2val( m->sml_desc, b, c_op, &vals[i] );
1643                                 }
1644                         } else if ( m->sml_op == LDAP_MOD_DELETE ||
1645                                 m->sml_op == LDAP_MOD_REPLACE )
1646                         {
1647                                 vals[i].bv_len = m->sml_desc->ad_cname.bv_len + 2;
1648                                 vals[i].bv_val = ch_malloc( vals[i].bv_len + 1 );
1649                                 ptr = lutil_strcopy( vals[i].bv_val,
1650                                         m->sml_desc->ad_cname.bv_val );
1651                                 *ptr++ = ':';
1652                                 if ( m->sml_op == LDAP_MOD_DELETE ) {
1653                                         *ptr++ = '-';
1654                                 } else {
1655                                         *ptr++ = '=';
1656                                 }
1657                                 *ptr = '\0';
1658                                 i++;
1659                         }
1660                 }
1661
1662                 if ( i > 0 ) {
1663                         BER_BVZERO( &vals[i] );
1664                         a = attr_alloc( ad_reqMod );
1665                         a->a_numvals = i;
1666                         a->a_vals = vals;
1667                         a->a_nvals = vals;
1668                         last_attr->a_next = a;
1669                         last_attr = a;
1670
1671                 } else {
1672                         ch_free( vals );
1673                 }
1674
1675                 if ( old ) {
1676                         /* count all the vals */
1677                         i = 0;
1678                         for ( a = old->e_attrs; a != NULL; a = a->a_next ) {
1679                                 if ( a->a_vals && a->a_flags ) {
1680                                         i += a->a_numvals;
1681                                 }
1682                         }
1683                         if ( i ) {
1684                                 vals = ch_malloc( (i + 1) * sizeof( struct berval ) );
1685                                 i = 0;
1686                                 for ( a=old->e_attrs; a; a=a->a_next ) {
1687                                         if ( a->a_vals && a->a_flags ) {
1688                                                 for (b=a->a_vals; !BER_BVISNULL( b ); b++,i++) {
1689                                                         accesslog_val2val( a->a_desc, b, 0, &vals[i] );
1690                                                 }
1691                                         }
1692                                 }
1693                                 vals[i].bv_val = NULL;
1694                                 vals[i].bv_len = 0;
1695                                 a = attr_alloc( ad_reqOld );
1696                                 a->a_numvals = i;
1697                                 a->a_vals = vals;
1698                                 a->a_nvals = vals;
1699                                 last_attr->a_next = a;
1700                         }
1701                 }
1702                 if ( logop == LOG_EN_MODIFY ) {
1703                         break;
1704                 }
1705
1706                 /* Now log the actual modRDN info */
1707                 attr_merge_one( e, ad_reqNewRDN, &op->orr_newrdn, &op->orr_nnewrdn );
1708                 attr_merge_one( e, ad_reqDeleteOldRDN, op->orr_deleteoldrdn ?
1709                         (struct berval *)&slap_true_bv : (struct berval *)&slap_false_bv,
1710                         NULL );
1711                 if ( op->orr_newSup ) {
1712                         attr_merge_one( e, ad_reqNewSuperior, op->orr_newSup, op->orr_nnewSup );
1713                 }
1714                 break;
1715
1716         case LOG_EN_COMPARE:
1717                 bv.bv_len = op->orc_ava->aa_desc->ad_cname.bv_len + 1 +
1718                         op->orc_ava->aa_value.bv_len;
1719                 bv.bv_val = op->o_tmpalloc( bv.bv_len+1, op->o_tmpmemctx );
1720                 ptr = lutil_strcopy( bv.bv_val, op->orc_ava->aa_desc->ad_cname.bv_val );
1721                 *ptr++ = '=';
1722                 AC_MEMCPY( ptr, op->orc_ava->aa_value.bv_val, op->orc_ava->aa_value.bv_len );
1723                 bv.bv_val[bv.bv_len] = '\0';
1724                 attr_merge_one( e, ad_reqAssertion, &bv, NULL );
1725                 op->o_tmpfree( bv.bv_val, op->o_tmpmemctx );
1726                 break;
1727
1728         case LOG_EN_SEARCH:
1729                 attr_merge_one( e, ad_reqScope, &scopes[op->ors_scope], NULL );
1730                 attr_merge_one( e, ad_reqDerefAliases, &derefs[op->ors_deref], NULL );
1731                 attr_merge_one( e, ad_reqAttrsOnly, op->ors_attrsonly ?
1732                         (struct berval *)&slap_true_bv : (struct berval *)&slap_false_bv,
1733                         NULL );
1734                 if ( !BER_BVISEMPTY( &op->ors_filterstr ))
1735                         attr_merge_normalize_one( e, ad_reqFilter, &op->ors_filterstr, op->o_tmpmemctx );
1736                 if ( op->ors_attrs ) {
1737                         int j;
1738                         /* count them */
1739                         for (i=0; !BER_BVISNULL(&op->ors_attrs[i].an_name );i++)
1740                                 ;
1741                         vals = op->o_tmpalloc( (i+1) * sizeof(struct berval),
1742                                 op->o_tmpmemctx );
1743                         for (i=0, j=0; !BER_BVISNULL(&op->ors_attrs[i].an_name );i++) {
1744                                 if (!BER_BVISEMPTY(&op->ors_attrs[i].an_name)) {
1745                                         vals[j] = op->ors_attrs[i].an_name;
1746                                         j++;
1747                                 }
1748                         }
1749                         BER_BVZERO(&vals[j]);
1750                         attr_merge_normalize( e, ad_reqAttr, vals, op->o_tmpmemctx );
1751                         op->o_tmpfree( vals, op->o_tmpmemctx );
1752                 }
1753                 bv.bv_val = timebuf;
1754                 bv.bv_len = snprintf( bv.bv_val, sizeof( timebuf ), "%d", rs->sr_nentries );
1755                 if ( bv.bv_len < sizeof( timebuf ) ) {
1756                         attr_merge_one( e, ad_reqEntries, &bv, NULL );
1757                 } /* else? */
1758
1759                 bv.bv_len = snprintf( bv.bv_val, sizeof( timebuf ), "%d", op->ors_tlimit );
1760                 if ( bv.bv_len < sizeof( timebuf ) ) {
1761                         attr_merge_one( e, ad_reqTimeLimit, &bv, NULL );
1762                 } /* else? */
1763
1764                 bv.bv_len = snprintf( bv.bv_val, sizeof( timebuf ), "%d", op->ors_slimit );
1765                 if ( bv.bv_len < sizeof( timebuf ) ) {
1766                         attr_merge_one( e, ad_reqSizeLimit, &bv, NULL );
1767                 } /* else? */
1768                 break;
1769
1770         case LOG_EN_BIND:
1771                 bv.bv_val = timebuf;
1772                 bv.bv_len = snprintf( bv.bv_val, sizeof( timebuf ), "%d", op->o_protocol );
1773                 if ( bv.bv_len < sizeof( timebuf ) ) {
1774                         attr_merge_one( e, ad_reqVersion, &bv, NULL );
1775                 } /* else? */
1776                 if ( op->orb_method == LDAP_AUTH_SIMPLE ) {
1777                         attr_merge_normalize_one( e, ad_reqMethod, &simple, op->o_tmpmemctx );
1778                 } else {
1779                         bv.bv_len = STRLENOF("SASL()") + op->orb_mech.bv_len;
1780                         bv.bv_val = op->o_tmpalloc( bv.bv_len + 1, op->o_tmpmemctx );
1781                         ptr = lutil_strcopy( bv.bv_val, "SASL(" );
1782                         ptr = lutil_strcopy( ptr, op->orb_mech.bv_val );
1783                         *ptr++ = ')';
1784                         *ptr = '\0';
1785                         attr_merge_normalize_one( e, ad_reqMethod, &bv, op->o_tmpmemctx );
1786                         op->o_tmpfree( bv.bv_val, op->o_tmpmemctx );
1787                 }
1788
1789                 break;
1790
1791         case LOG_EN_EXTENDED:
1792                 if ( op->ore_reqdata ) {
1793                         attr_merge_one( e, ad_reqData, op->ore_reqdata, NULL );
1794                 }
1795                 break;
1796
1797         case LOG_EN_UNKNOWN:
1798                 /* we don't know its parameters, don't add any */
1799                 break;
1800         }
1801
1802         if ( e_uuid || !BER_BVISNULL( &uuid ) ) {
1803                 struct berval *pbv = NULL;
1804
1805                 if ( !BER_BVISNULL( &uuid ) ) {
1806                         pbv = &uuid;
1807
1808                 } else {
1809                         a = attr_find( e_uuid->e_attrs, slap_schema.si_ad_entryUUID );
1810                         if ( a ) {
1811                                 pbv = &a->a_vals[0];
1812                         }
1813                 }
1814
1815                 if ( pbv ) {
1816                         attr_merge_normalize_one( e, ad_reqEntryUUID, pbv, op->o_tmpmemctx );
1817                 }
1818
1819                 if ( !BER_BVISNULL( &uuid ) ) {
1820                         ber_memfree( uuid.bv_val );
1821                         BER_BVZERO( &uuid );
1822                 }
1823         }
1824
1825         op2.o_hdr = op->o_hdr;
1826         op2.o_tag = LDAP_REQ_ADD;
1827         op2.o_bd = li->li_db;
1828         op2.o_dn = li->li_db->be_rootdn;
1829         op2.o_ndn = li->li_db->be_rootndn;
1830         op2.o_req_dn = e->e_name;
1831         op2.o_req_ndn = e->e_nname;
1832         op2.ora_e = e;
1833         op2.o_callback = &nullsc;
1834
1835         if (( lo->mask & LOG_OP_WRITES ) && !BER_BVISEMPTY( &op->o_csn )) {
1836                 slap_queue_csn( &op2, &op->o_csn );
1837                 do_graduate = 1;
1838         }
1839
1840         op2.o_bd->be_add( &op2, &rs2 );
1841         if ( e == op2.ora_e ) entry_free( e );
1842         e = NULL;
1843         if ( do_graduate ) {
1844                 slap_graduate_commit_csn( &op2 );
1845                 if ( op2.o_csn.bv_val )
1846                         op->o_tmpfree( op2.o_csn.bv_val, op->o_tmpmemctx );
1847         }
1848
1849 done:
1850         if ( lo->mask & LOG_OP_WRITES )
1851                 ldap_pvt_thread_mutex_unlock( &li->li_log_mutex );
1852         if ( old ) entry_free( old );
1853         return SLAP_CB_CONTINUE;
1854 }
1855
1856 /* Since Bind success is sent by the frontend, it won't normally enter
1857  * the overlay response callback. Add another callback to make sure it
1858  * gets here.
1859  */
1860 static int
1861 accesslog_bind_resp( Operation *op, SlapReply *rs )
1862 {
1863         BackendDB *be, db;
1864         int rc;
1865         slap_callback *sc;
1866
1867         be = op->o_bd;
1868         db = *be;
1869         op->o_bd = &db;
1870         db.bd_info = op->o_callback->sc_private;
1871         rc = accesslog_response( op, rs );
1872         op->o_bd = be;
1873         sc = op->o_callback;
1874         op->o_callback = sc->sc_next;
1875         op->o_tmpfree( sc, op->o_tmpmemctx );
1876         return rc;
1877 }
1878
1879 static int
1880 accesslog_op_bind( Operation *op, SlapReply *rs )
1881 {
1882         slap_callback *sc;
1883
1884         sc = op->o_tmpcalloc( 1, sizeof(slap_callback), op->o_tmpmemctx );
1885         sc->sc_response = accesslog_bind_resp;
1886         sc->sc_private = op->o_bd->bd_info;
1887
1888         if ( op->o_callback ) {
1889                 sc->sc_next = op->o_callback->sc_next;
1890                 op->o_callback->sc_next = sc;
1891         } else {
1892                 op->o_callback = sc;
1893         }
1894         return SLAP_CB_CONTINUE;
1895 }
1896
1897 static int
1898 accesslog_mod_cleanup( Operation *op, SlapReply *rs )
1899 {
1900         slap_callback *sc = op->o_callback;
1901         slap_overinst *on = sc->sc_private;
1902         op->o_callback = sc->sc_next;
1903
1904         op->o_tmpfree( sc, op->o_tmpmemctx );
1905
1906         if ( on ) {
1907                 BackendInfo *bi = op->o_bd->bd_info;
1908                 op->o_bd->bd_info = (BackendInfo *)on;
1909                 accesslog_response( op, rs );
1910                 op->o_bd->bd_info = bi;
1911         }
1912         return 0;
1913 }
1914
1915 static int
1916 accesslog_op_mod( Operation *op, SlapReply *rs )
1917 {
1918         slap_overinst *on = (slap_overinst *)op->o_bd->bd_info;
1919         log_info *li = on->on_bi.bi_private;
1920         slap_verbmasks *lo;
1921         int logop;
1922         int doit = 0;
1923
1924         /* These internal ops are not logged */
1925         if ( op->o_dont_replicate && op->orm_no_opattrs )
1926                 return SLAP_CB_CONTINUE;
1927
1928         logop = accesslog_op2logop( op );
1929         lo = logops+logop+EN_OFFSET;
1930
1931         if ( li->li_ops & lo->mask ) {
1932                 doit = 1;
1933         } else {
1934                 log_base *lb;
1935                 for ( lb = li->li_bases; lb; lb = lb->lb_next )
1936                         if (( lb->lb_ops & lo->mask ) && dnIsSuffix( &op->o_req_ndn, &lb->lb_base )) {
1937                                 doit = 1;
1938                                 break;
1939                         }
1940         }
1941
1942         if ( doit ) {
1943                 slap_callback *cb = op->o_tmpalloc( sizeof( slap_callback ), op->o_tmpmemctx ), *cb2;
1944                 cb->sc_cleanup = accesslog_mod_cleanup;
1945                 cb->sc_response = NULL;
1946                 cb->sc_private = on;
1947                 cb->sc_next = NULL;
1948                 for ( cb2 = op->o_callback; cb2->sc_next; cb2 = cb2->sc_next );
1949                 cb2->sc_next = cb;
1950
1951                 ldap_pvt_thread_rmutex_lock( &li->li_op_rmutex, op->o_tid );
1952                 if ( li->li_oldf && ( op->o_tag == LDAP_REQ_DELETE ||
1953                         op->o_tag == LDAP_REQ_MODIFY ||
1954                         ( op->o_tag == LDAP_REQ_MODRDN && li->li_oldattrs )))
1955                 {
1956                         int rc;
1957                         Entry *e;
1958
1959                         op->o_bd->bd_info = (BackendInfo *)on->on_info;
1960                         rc = be_entry_get_rw( op, &op->o_req_ndn, NULL, NULL, 0, &e );
1961                         if ( e ) {
1962                                 if ( test_filter( op, e, li->li_oldf ) == LDAP_COMPARE_TRUE )
1963                                         li->li_old = entry_dup( e );
1964                                 be_entry_release_rw( op, e, 0 );
1965                         }
1966                         op->o_bd->bd_info = (BackendInfo *)on;
1967
1968                 } else {
1969                         int rc;
1970                         Entry *e;
1971
1972                         op->o_bd->bd_info = (BackendInfo *)on->on_info;
1973                         rc = be_entry_get_rw( op, &op->o_req_ndn, NULL, NULL, 0, &e );
1974                         if ( e ) {
1975                                 Attribute *a = attr_find( e->e_attrs, slap_schema.si_ad_entryUUID );
1976                                 if ( a ) {
1977                                         ber_dupbv( &li->li_uuid, &a->a_vals[0] );
1978                                 }
1979                                 be_entry_release_rw( op, e, 0 );
1980                         }
1981                         op->o_bd->bd_info = (BackendInfo *)on;
1982                 }
1983         }
1984         return SLAP_CB_CONTINUE;
1985 }
1986
1987 /* unbinds are broadcast to all backends; we only log it if this
1988  * backend was used for the original bind.
1989  */
1990 static int
1991 accesslog_unbind( Operation *op, SlapReply *rs )
1992 {
1993         slap_overinst *on = (slap_overinst *)op->o_bd->bd_info;
1994         if ( op->o_conn->c_authz_backend == on->on_info->oi_origdb ) {
1995                 log_info *li = on->on_bi.bi_private;
1996                 Operation op2 = {0};
1997                 void *cids[SLAP_MAX_CIDS];
1998                 SlapReply rs2 = {REP_RESULT};
1999                 Entry *e;
2000
2001                 if ( !( li->li_ops & LOG_OP_UNBIND )) {
2002                         log_base *lb;
2003                         int i = 0;
2004
2005                         for ( lb = li->li_bases; lb; lb=lb->lb_next )
2006                                 if (( lb->lb_ops & LOG_OP_UNBIND ) && dnIsSuffix( &op->o_ndn, &lb->lb_base )) {
2007                                         i = 1;
2008                                         break;
2009                                 }
2010                         if ( !i )
2011                                 return SLAP_CB_CONTINUE;
2012                 }
2013
2014                 e = accesslog_entry( op, rs, LOG_EN_UNBIND, &op2 );
2015                 op2.o_hdr = op->o_hdr;
2016                 op2.o_tag = LDAP_REQ_ADD;
2017                 op2.o_bd = li->li_db;
2018                 op2.o_dn = li->li_db->be_rootdn;
2019                 op2.o_ndn = li->li_db->be_rootndn;
2020                 op2.o_req_dn = e->e_name;
2021                 op2.o_req_ndn = e->e_nname;
2022                 op2.ora_e = e;
2023                 op2.o_callback = &nullsc;
2024                 op2.o_controls = cids;
2025                 memset(cids, 0, sizeof( cids ));
2026
2027                 op2.o_bd->be_add( &op2, &rs2 );
2028                 if ( e == op2.ora_e )
2029                         entry_free( e );
2030         }
2031         return SLAP_CB_CONTINUE;
2032 }
2033
2034 static int
2035 accesslog_abandon( Operation *op, SlapReply *rs )
2036 {
2037         slap_overinst *on = (slap_overinst *)op->o_bd->bd_info;
2038         log_info *li = on->on_bi.bi_private;
2039         Operation op2 = {0};
2040         void *cids[SLAP_MAX_CIDS];
2041         SlapReply rs2 = {REP_RESULT};
2042         Entry *e;
2043         char buf[64];
2044         struct berval bv;
2045
2046         if ( !op->o_time )
2047                 return SLAP_CB_CONTINUE;
2048
2049         if ( !( li->li_ops & LOG_OP_ABANDON )) {
2050                 log_base *lb;
2051                 int i = 0;
2052
2053                 for ( lb = li->li_bases; lb; lb=lb->lb_next )
2054                         if (( lb->lb_ops & LOG_OP_ABANDON ) && dnIsSuffix( &op->o_ndn, &lb->lb_base )) {
2055                                 i = 1;
2056                                 break;
2057                         }
2058                 if ( !i )
2059                         return SLAP_CB_CONTINUE;
2060         }
2061
2062         e = accesslog_entry( op, rs, LOG_EN_ABANDON, &op2 );
2063         bv.bv_val = buf;
2064         bv.bv_len = snprintf( buf, sizeof( buf ), "%d", op->orn_msgid );
2065         if ( bv.bv_len < sizeof( buf ) ) {
2066                 attr_merge_one( e, ad_reqId, &bv, NULL );
2067         } /* else? */
2068
2069         op2.o_hdr = op->o_hdr;
2070         op2.o_tag = LDAP_REQ_ADD;
2071         op2.o_bd = li->li_db;
2072         op2.o_dn = li->li_db->be_rootdn;
2073         op2.o_ndn = li->li_db->be_rootndn;
2074         op2.o_req_dn = e->e_name;
2075         op2.o_req_ndn = e->e_nname;
2076         op2.ora_e = e;
2077         op2.o_callback = &nullsc;
2078         op2.o_controls = cids;
2079         memset(cids, 0, sizeof( cids ));
2080
2081         op2.o_bd->be_add( &op2, &rs2 );
2082         if ( e == op2.ora_e )
2083                 entry_free( e );
2084
2085         return SLAP_CB_CONTINUE;
2086 }
2087
2088 static int
2089 accesslog_operational( Operation *op, SlapReply *rs )
2090 {
2091         slap_overinst *on = (slap_overinst *)op->o_bd->bd_info;
2092         log_info *li = on->on_bi.bi_private;
2093
2094         if ( op->o_sync != SLAP_CONTROL_NONE )
2095                 return SLAP_CB_CONTINUE;
2096
2097         if ( rs->sr_entry != NULL
2098                 && dn_match( &op->o_bd->be_nsuffix[0], &rs->sr_entry->e_nname ) )
2099         {
2100                 Attribute       **ap;
2101
2102                 for ( ap = &rs->sr_operational_attrs; *ap; ap = &(*ap)->a_next )
2103                         /* just count */ ;
2104
2105                 if ( SLAP_OPATTRS( rs->sr_attr_flags ) ||
2106                                 ad_inlist( ad_auditContext, rs->sr_attrs ) )
2107                 {
2108                         *ap = attr_alloc( ad_auditContext );
2109                         attr_valadd( *ap,
2110                                 &li->li_db->be_suffix[0],
2111                                 &li->li_db->be_nsuffix[0], 1 );
2112                 }
2113         }
2114
2115         return SLAP_CB_CONTINUE;
2116 }
2117
2118 static slap_overinst accesslog;
2119
2120 static int
2121 accesslog_db_init(
2122         BackendDB *be,
2123         ConfigReply *cr
2124 )
2125 {
2126         slap_overinst *on = (slap_overinst *)be->bd_info;
2127         log_info *li = ch_calloc(1, sizeof(log_info));
2128
2129         on->on_bi.bi_private = li;
2130         ldap_pvt_thread_rmutex_init( &li->li_op_rmutex );
2131         ldap_pvt_thread_mutex_init( &li->li_log_mutex );
2132         return 0;
2133 }
2134
2135 static int
2136 accesslog_db_destroy(
2137         BackendDB *be,
2138         ConfigReply *cr
2139 )
2140 {
2141         slap_overinst *on = (slap_overinst *)be->bd_info;
2142         log_info *li = on->on_bi.bi_private;
2143         log_attr *la;
2144
2145         if ( li->li_oldf )
2146                 filter_free( li->li_oldf );
2147         for ( la=li->li_oldattrs; la; la=li->li_oldattrs ) {
2148                 li->li_oldattrs = la->next;
2149                 ch_free( la );
2150         }
2151         ldap_pvt_thread_mutex_destroy( &li->li_log_mutex );
2152         ldap_pvt_thread_rmutex_destroy( &li->li_op_rmutex );
2153         free( li );
2154         return LDAP_SUCCESS;
2155 }
2156
2157 /* Create the logdb's root entry if it's missing */
2158 static void *
2159 accesslog_db_root(
2160         void *ctx,
2161         void *arg )
2162 {
2163         struct re_s *rtask = arg;
2164         slap_overinst *on = rtask->arg;
2165         log_info *li = on->on_bi.bi_private;
2166
2167         Connection conn = {0};
2168         OperationBuffer opbuf;
2169         Operation *op;
2170
2171         Entry *e;
2172         int rc;
2173
2174         connection_fake_init( &conn, &opbuf, ctx );
2175         op = &opbuf.ob_op;
2176         op->o_bd = li->li_db;
2177         op->o_dn = li->li_db->be_rootdn;
2178         op->o_ndn = li->li_db->be_rootndn;
2179         rc = be_entry_get_rw( op, li->li_db->be_nsuffix, NULL, NULL, 0, &e );
2180
2181         if ( e ) {
2182                 be_entry_release_rw( op, e, 0 );
2183
2184         } else {
2185                 SlapReply rs = {REP_RESULT};
2186                 struct berval rdn, nrdn, attr;
2187                 char *ptr;
2188                 AttributeDescription *ad = NULL;
2189                 const char *text = NULL;
2190                 Entry *e_ctx;
2191                 BackendDB db;
2192
2193                 e = entry_alloc();
2194                 ber_dupbv( &e->e_name, li->li_db->be_suffix );
2195                 ber_dupbv( &e->e_nname, li->li_db->be_nsuffix );
2196
2197                 attr_merge_one( e, slap_schema.si_ad_objectClass,
2198                         &log_container->soc_cname, NULL );
2199
2200                 dnRdn( &e->e_name, &rdn );
2201                 dnRdn( &e->e_nname, &nrdn );
2202                 ptr = ber_bvchr( &rdn, '=' );
2203
2204                 assert( ptr != NULL );
2205
2206                 attr.bv_val = rdn.bv_val;
2207                 attr.bv_len = ptr - rdn.bv_val;
2208
2209                 slap_bv2ad( &attr, &ad, &text );
2210
2211                 rdn.bv_val = ptr+1;
2212                 rdn.bv_len -= attr.bv_len + 1;
2213                 ptr = ber_bvchr( &nrdn, '=' );
2214                 nrdn.bv_len -= ptr - nrdn.bv_val + 1;
2215                 nrdn.bv_val = ptr+1;
2216                 attr_merge_one( e, ad, &rdn, &nrdn );
2217
2218                 /* Get contextCSN from main DB */
2219                 op->o_bd = on->on_info->oi_origdb;
2220                 rc = be_entry_get_rw( op, op->o_bd->be_nsuffix, NULL,
2221                         slap_schema.si_ad_contextCSN, 0, &e_ctx );
2222
2223                 if ( e_ctx ) {
2224                         Attribute *a;
2225
2226                         a = attr_find( e_ctx->e_attrs, slap_schema.si_ad_contextCSN );
2227                         if ( a ) {
2228                                 /* FIXME: contextCSN could have multiple values!
2229                                  * should select the one with the server's SID */
2230                                 attr_merge_one( e, slap_schema.si_ad_entryCSN,
2231                                         &a->a_vals[0], &a->a_nvals[0] );
2232                                 attr_merge( e, a->a_desc, a->a_vals, a->a_nvals );
2233                         }
2234                         be_entry_release_rw( op, e_ctx, 0 );
2235                 }
2236                 db = *li->li_db;
2237                 op->o_bd = &db;
2238
2239                 op->ora_e = e;
2240                 op->o_req_dn = e->e_name;
2241                 op->o_req_ndn = e->e_nname;
2242                 op->o_callback = &nullsc;
2243                 SLAP_DBFLAGS( op->o_bd ) |= SLAP_DBFLAG_NOLASTMOD;
2244                 rc = op->o_bd->be_add( op, &rs );
2245                 if ( e == op->ora_e )
2246                         entry_free( e );
2247         }
2248         ldap_pvt_thread_mutex_lock( &slapd_rq.rq_mutex );
2249         ldap_pvt_runqueue_stoptask( &slapd_rq, rtask );
2250         ldap_pvt_runqueue_remove( &slapd_rq, rtask );
2251         ldap_pvt_thread_mutex_unlock( &slapd_rq.rq_mutex );
2252
2253         return NULL;
2254 }
2255
2256 static int
2257 accesslog_db_open(
2258         BackendDB *be,
2259         ConfigReply *cr
2260 )
2261 {
2262         slap_overinst *on = (slap_overinst *)be->bd_info;
2263         log_info *li = on->on_bi.bi_private;
2264
2265
2266         if ( !BER_BVISEMPTY( &li->li_db_suffix )) {
2267                 li->li_db = select_backend( &li->li_db_suffix, 0 );
2268                 ch_free( li->li_db_suffix.bv_val );
2269                 BER_BVZERO( &li->li_db_suffix );
2270         }
2271         if ( li->li_db == NULL ) {
2272                 Debug( LDAP_DEBUG_ANY,
2273                         "accesslog: \"logdb <suffix>\" missing or invalid.\n",
2274                         0, 0, 0 );
2275                 return 1;
2276         }
2277
2278         if ( slapMode & SLAP_TOOL_MODE )
2279                 return 0;
2280
2281         if ( BER_BVISEMPTY( &li->li_db->be_rootndn )) {
2282                 ber_dupbv( &li->li_db->be_rootdn, li->li_db->be_suffix );
2283                 ber_dupbv( &li->li_db->be_rootndn, li->li_db->be_nsuffix );
2284         }
2285
2286         ldap_pvt_thread_mutex_lock( &slapd_rq.rq_mutex );
2287         ldap_pvt_runqueue_insert( &slapd_rq, 3600, accesslog_db_root, on,
2288                 "accesslog_db_root", li->li_db->be_suffix[0].bv_val );
2289         ldap_pvt_thread_mutex_unlock( &slapd_rq.rq_mutex );
2290
2291         return 0;
2292 }
2293
2294 int accesslog_initialize()
2295 {
2296         int i, rc;
2297
2298         accesslog.on_bi.bi_type = "accesslog";
2299         accesslog.on_bi.bi_db_init = accesslog_db_init;
2300         accesslog.on_bi.bi_db_destroy = accesslog_db_destroy;
2301         accesslog.on_bi.bi_db_open = accesslog_db_open;
2302
2303         accesslog.on_bi.bi_op_add = accesslog_op_mod;
2304         accesslog.on_bi.bi_op_bind = accesslog_op_bind;
2305         accesslog.on_bi.bi_op_delete = accesslog_op_mod;
2306         accesslog.on_bi.bi_op_modify = accesslog_op_mod;
2307         accesslog.on_bi.bi_op_modrdn = accesslog_op_mod;
2308         accesslog.on_bi.bi_op_unbind = accesslog_unbind;
2309         accesslog.on_bi.bi_op_abandon = accesslog_abandon;
2310         accesslog.on_bi.bi_operational = accesslog_operational;
2311         accesslog.on_response = accesslog_response;
2312
2313         accesslog.on_bi.bi_cf_ocs = log_cfocs;
2314
2315         nullsc.sc_response = slap_null_cb;
2316
2317         rc = config_register_schema( log_cfats, log_cfocs );
2318         if ( rc ) return rc;
2319
2320         /* log schema integration */
2321         for ( i=0; lsyntaxes[i].oid; i++ ) {
2322                 int code;
2323
2324                 code = register_syntax( &lsyntaxes[ i ].syn );
2325                 if ( code != 0 ) {
2326                         Debug( LDAP_DEBUG_ANY,
2327                                 "accesslog_init: register_syntax failed\n",
2328                                 0, 0, 0 );
2329                         return code;
2330                 }
2331
2332                 if ( lsyntaxes[i].mrs != NULL ) {
2333                         code = mr_make_syntax_compat_with_mrs(
2334                                 lsyntaxes[i].oid, lsyntaxes[i].mrs );
2335                         if ( code < 0 ) {
2336                                 Debug( LDAP_DEBUG_ANY,
2337                                         "accesslog_init: "
2338                                         "mr_make_syntax_compat_with_mrs "
2339                                         "failed\n",
2340                                         0, 0, 0 );
2341                                 return code;
2342                         }
2343                 }
2344         }
2345
2346         for ( i=0; lattrs[i].at; i++ ) {
2347                 int code;
2348
2349                 code = register_at( lattrs[i].at, lattrs[i].ad, 0 );
2350                 if ( code ) {
2351                         Debug( LDAP_DEBUG_ANY,
2352                                 "accesslog_init: register_at failed\n",
2353                                 0, 0, 0 );
2354                         return -1;
2355                 }
2356         }
2357
2358         for ( i=0; locs[i].ot; i++ ) {
2359                 int code;
2360
2361                 code = register_oc( locs[i].ot, locs[i].oc, 0 );
2362                 if ( code ) {
2363                         Debug( LDAP_DEBUG_ANY,
2364                                 "accesslog_init: register_oc failed\n",
2365                                 0, 0, 0 );
2366                         return -1;
2367                 }
2368         }
2369
2370         return overlay_register(&accesslog);
2371 }
2372
2373 #if SLAPD_OVER_ACCESSLOG == SLAPD_MOD_DYNAMIC
2374 int
2375 init_module( int argc, char *argv[] )
2376 {
2377         return accesslog_initialize();
2378 }
2379 #endif
2380
2381 #endif /* SLAPD_OVER_ACCESSLOG */