389-Directory/1.3.6.1 B2017.292.2010
	ldap13.bcgsc.ca:389 (/etc/dirsrv/slapd-ldap13)

[03/May/2018:18:10:25.116478658 -0700] - INFO - main - 389-Directory/1.3.6.1 B2017.292.2010 starting up
[03/May/2018:18:10:25.132262605 -0700] - INFO - ldbm_instance_config_cachememsize_set - force a minimal value 512000
[03/May/2018:18:10:25.153319434 -0700] - NOTICE - ldbm_back_start - found 1883880k physical memory
[03/May/2018:18:10:25.156601258 -0700] - NOTICE - ldbm_back_start - found 1518084k available
[03/May/2018:18:10:25.159434911 -0700] - NOTICE - ldbm_back_start - cache autosizing: db cache: 75355k
[03/May/2018:18:10:25.162585345 -0700] - NOTICE - ldbm_back_start - cache autosizing: userRoot entry cache (1 total): 131072k
[03/May/2018:18:10:25.169030318 -0700] - NOTICE - ldbm_back_start - total cache size: 212725923 B; 
[03/May/2018:18:10:25.477713067 -0700] - INFO - slapd_daemon - slapd started.  Listening on All Interfaces port 389 for LDAP requests
[03/May/2018:18:10:25.498714385 -0700] - INFO - ldbm_instance_config_cachememsize_set - force a minimal value 512000
[03/May/2018:18:12:23.115897237 -0700] - INFO - op_thread_cleanup - slapd shutting down - signaling operation threads - op stack size 1 max work q size 1 max work q stack size 1
[03/May/2018:18:12:23.123559732 -0700] - INFO - slapd_daemon - slapd shutting down - closing down internal subsystems and plugins
[03/May/2018:18:12:23.134471978 -0700] - INFO - dblayer_pre_close - Waiting for 4 database threads to stop
[03/May/2018:18:12:23.400757347 -0700] - INFO - dblayer_pre_close - All database threads now stopped
[03/May/2018:18:12:23.416370079 -0700] - INFO - ldbm_back_instance_set_destructor - Set of instances destroyed
[03/May/2018:18:12:23.420079169 -0700] - INFO - connection_post_shutdown_cleanup - slapd shutting down - freed 1 work q stack objects - freed 1 op stack objects
[03/May/2018:18:12:23.604803053 -0700] - INFO - main - slapd stopped.
[03/May/2018:18:12:23.905824777 -0700] - INFO - main - 389-Directory/1.3.6.1 B2017.292.2010 starting up
[03/May/2018:18:12:23.920183323 -0700] - INFO - ldbm_instance_config_cachememsize_set - force a minimal value 512000
[03/May/2018:18:12:23.929857986 -0700] - INFO - ldbm_instance_config_cachememsize_set - force a minimal value 512000
[03/May/2018:18:12:23.936492824 -0700] - NOTICE - ldbm_back_start - found 1883880k physical memory
[03/May/2018:18:12:23.939503627 -0700] - NOTICE - ldbm_back_start - found 1517820k available
[03/May/2018:18:12:23.942493105 -0700] - NOTICE - ldbm_back_start - cache autosizing: db cache: 75355k
[03/May/2018:18:12:23.945423636 -0700] - NOTICE - ldbm_back_start - cache autosizing: userRoot entry cache (2 total): 65536k
[03/May/2018:18:12:23.949297091 -0700] - NOTICE - ldbm_back_start - cache autosizing: NetscapeRoot entry cache (2 total): 65536k
[03/May/2018:18:12:23.953814250 -0700] - NOTICE - ldbm_back_start - total cache size: 229503139 B; 
[03/May/2018:18:12:24.057977572 -0700] - INFO - slapd_daemon - slapd started.  Listening on All Interfaces port 389 for LDAP requests
[03/May/2018:18:12:39.684427226 -0700] - INFO - op_thread_cleanup - slapd shutting down - signaling operation threads - op stack size 0 max work q size 0 max work q stack size 0
[03/May/2018:18:12:39.689510164 -0700] - INFO - slapd_daemon - slapd shutting down - closing down internal subsystems and plugins
[03/May/2018:18:12:39.719825478 -0700] - INFO - dblayer_pre_close - Waiting for 4 database threads to stop
[03/May/2018:18:12:39.994240304 -0700] - INFO - dblayer_pre_close - All database threads now stopped
[03/May/2018:18:12:40.004425442 -0700] - INFO - ldbm_back_instance_set_destructor - Set of instances destroyed
[03/May/2018:18:12:40.009016961 -0700] - INFO - connection_post_shutdown_cleanup - slapd shutting down - freed 0 work q stack objects - freed 0 op stack objects
[03/May/2018:18:12:40.075106289 -0700] - INFO - main - slapd stopped.
[03/May/2018:18:12:40.383603685 -0700] - INFO - main - 389-Directory/1.3.6.1 B2017.292.2010 starting up
[03/May/2018:18:12:40.395866527 -0700] - INFO - ldbm_instance_config_cachememsize_set - force a minimal value 512000
[03/May/2018:18:12:40.414966898 -0700] - INFO - ldbm_instance_config_cachememsize_set - force a minimal value 512000
[03/May/2018:18:12:40.422944647 -0700] - NOTICE - ldbm_back_start - found 1883880k physical memory
[03/May/2018:18:12:40.426037188 -0700] - NOTICE - ldbm_back_start - found 1519104k available
[03/May/2018:18:12:40.428770441 -0700] - NOTICE - ldbm_back_start - cache autosizing: db cache: 75355k
[03/May/2018:18:12:40.431449774 -0700] - NOTICE - ldbm_back_start - cache autosizing: userRoot entry cache (2 total): 65536k
[03/May/2018:18:12:40.435257777 -0700] - NOTICE - ldbm_back_start - cache autosizing: NetscapeRoot entry cache (2 total): 65536k
[03/May/2018:18:12:40.439002412 -0700] - NOTICE - ldbm_back_start - total cache size: 229503139 B; 
[03/May/2018:18:12:40.545483868 -0700] - INFO - slapd_daemon - slapd started.  Listening on All Interfaces port 389 for LDAP requests
[03/May/2018:18:13:22.076184850 -0700] - INFO - op_thread_cleanup - slapd shutting down - signaling operation threads - op stack size 0 max work q size 0 max work q stack size 0
[03/May/2018:18:13:22.082170388 -0700] - INFO - slapd_daemon - slapd shutting down - closing down internal subsystems and plugins
[03/May/2018:18:13:22.093378559 -0700] - INFO - dblayer_pre_close - Waiting for 4 database threads to stop
[03/May/2018:18:13:22.498319277 -0700] - INFO - dblayer_pre_close - All database threads now stopped
[03/May/2018:18:13:22.510405134 -0700] - INFO - ldbm_back_instance_set_destructor - Set of instances destroyed
[03/May/2018:18:13:22.514867236 -0700] - INFO - connection_post_shutdown_cleanup - slapd shutting down - freed 0 work q stack objects - freed 0 op stack objects
[03/May/2018:18:13:22.588130868 -0700] - INFO - main - slapd stopped.
[03/May/2018:18:13:47.703779960 -0700] - INFO - main - 389-Directory/1.3.6.1 B2017.292.2010 starting up
[03/May/2018:18:13:47.745051571 -0700] - INFO - ldbm_instance_config_cachememsize_set - force a minimal value 512000
[03/May/2018:18:13:47.774289461 -0700] - INFO - ldbm_instance_config_cachememsize_set - force a minimal value 512000
[03/May/2018:18:13:47.802459486 -0700] - NOTICE - ldbm_back_start - found 1883880k physical memory
[03/May/2018:18:13:47.809084752 -0700] - NOTICE - ldbm_back_start - found 1542916k available
[03/May/2018:18:13:47.813165868 -0700] - NOTICE - ldbm_back_start - cache autosizing: db cache: 75355k
[03/May/2018:18:13:47.817097268 -0700] - NOTICE - ldbm_back_start - cache autosizing: userRoot entry cache (2 total): 65536k
[03/May/2018:18:13:47.835200766 -0700] - NOTICE - ldbm_back_start - cache autosizing: NetscapeRoot entry cache (2 total): 65536k
[03/May/2018:18:13:47.840559165 -0700] - NOTICE - ldbm_back_start - total cache size: 229503139 B; 
[03/May/2018:18:13:48.228003187 -0700] - INFO - slapd_daemon - slapd started.  Listening on All Interfaces port 389 for LDAP requests
[03/May/2018:18:14:07.352703274 -0700] - INFO - op_thread_cleanup - slapd shutting down - signaling operation threads - op stack size 1 max work q size 1 max work q stack size 1
[03/May/2018:18:14:07.389993447 -0700] - INFO - slapd_daemon - slapd shutting down - closing down internal subsystems and plugins
[03/May/2018:18:14:07.400311963 -0700] - INFO - dblayer_pre_close - Waiting for 4 database threads to stop
[03/May/2018:18:14:07.997457517 -0700] - INFO - dblayer_pre_close - All database threads now stopped
[03/May/2018:18:14:08.019647581 -0700] - INFO - ldbm_back_instance_set_destructor - Set of instances destroyed
[03/May/2018:18:14:08.022051694 -0700] - INFO - connection_post_shutdown_cleanup - slapd shutting down - freed 1 work q stack objects - freed 1 op stack objects
[03/May/2018:18:14:08.248713648 -0700] - INFO - main - slapd stopped.
[03/May/2018:18:14:08.584838648 -0700] - INFO - main - 389-Directory/1.3.6.1 B2017.292.2010 starting up
[03/May/2018:18:14:08.595294557 -0700] - INFO - ldbm_instance_config_cachememsize_set - force a minimal value 512000
[03/May/2018:18:14:08.602413132 -0700] - INFO - ldbm_instance_config_cachememsize_set - force a minimal value 512000
[03/May/2018:18:14:08.609439298 -0700] - NOTICE - ldbm_back_start - found 1883880k physical memory
[03/May/2018:18:14:08.611140226 -0700] - NOTICE - ldbm_back_start - found 1516336k available
[03/May/2018:18:14:08.612678274 -0700] - NOTICE - ldbm_back_start - cache autosizing: db cache: 75355k
[03/May/2018:18:14:08.614169457 -0700] - NOTICE - ldbm_back_start - cache autosizing: userRoot entry cache (2 total): 65536k
[03/May/2018:18:14:08.616568084 -0700] - NOTICE - ldbm_back_start - cache autosizing: NetscapeRoot entry cache (2 total): 65536k
[03/May/2018:18:14:08.619046494 -0700] - NOTICE - ldbm_back_start - total cache size: 229503139 B; 
[03/May/2018:18:14:08.713558766 -0700] - INFO - slapd_daemon - slapd started.  Listening on All Interfaces port 389 for LDAP requests
[03/May/2018:18:16:29.314001381 -0700] - INFO - postop_modify_config_dse - The change of nsslapd-maxdescriptors will not take effect until the server is restarted
[03/May/2018:18:16:57.143500718 -0700] - INFO - op_thread_cleanup - slapd shutting down - signaling operation threads - op stack size 3 max work q size 3 max work q stack size 3
[03/May/2018:18:16:57.149576585 -0700] - INFO - slapd_daemon - slapd shutting down - closing down internal subsystems and plugins
[03/May/2018:18:16:57.169980300 -0700] - INFO - dblayer_pre_close - Waiting for 4 database threads to stop
[03/May/2018:18:16:57.545438985 -0700] - INFO - dblayer_pre_close - All database threads now stopped
[03/May/2018:18:16:57.560133942 -0700] - INFO - ldbm_back_instance_set_destructor - Set of instances destroyed
[03/May/2018:18:16:57.563752341 -0700] - INFO - connection_post_shutdown_cleanup - slapd shutting down - freed 3 work q stack objects - freed 3 op stack objects
[03/May/2018:18:16:58.511017065 -0700] - INFO - main - slapd stopped.
[03/May/2018:18:16:58.799961367 -0700] - INFO - main - 389-Directory/1.3.6.1 B2017.292.2010 starting up
[03/May/2018:18:16:58.811068823 -0700] - INFO - ldbm_instance_config_cachememsize_set - force a minimal value 512000
[03/May/2018:18:16:58.819506924 -0700] - INFO - ldbm_instance_config_cachememsize_set - force a minimal value 512000
[03/May/2018:18:16:58.826966416 -0700] - NOTICE - ldbm_back_start - found 1883880k physical memory
[03/May/2018:18:16:58.829560363 -0700] - NOTICE - ldbm_back_start - found 1521704k available
[03/May/2018:18:16:58.832228165 -0700] - NOTICE - ldbm_back_start - cache autosizing: db cache: 75355k
[03/May/2018:18:16:58.834788101 -0700] - NOTICE - ldbm_back_start - cache autosizing: userRoot entry cache (2 total): 65536k
[03/May/2018:18:16:58.838357260 -0700] - NOTICE - ldbm_back_start - cache autosizing: NetscapeRoot entry cache (2 total): 65536k
[03/May/2018:18:16:58.842278531 -0700] - NOTICE - ldbm_back_start - total cache size: 229503139 B; 
[03/May/2018:18:16:58.944928567 -0700] - INFO - slapd_daemon - slapd started.  Listening on All Interfaces port 389 for LDAP requests
[04/May/2018:10:47:04.983612544 -0700] - INFO - op_thread_cleanup - slapd shutting down - signaling operation threads - op stack size 3 max work q size 3 max work q stack size 3
[04/May/2018:10:47:04.992311988 -0700] - INFO - slapd_daemon - slapd shutting down - closing down internal subsystems and plugins
[04/May/2018:10:47:05.003530816 -0700] - INFO - dblayer_pre_close - Waiting for 4 database threads to stop
[04/May/2018:10:47:05.601788993 -0700] - INFO - dblayer_pre_close - All database threads now stopped
[04/May/2018:10:47:05.617644599 -0700] - INFO - ldbm_back_instance_set_destructor - Set of instances destroyed
[04/May/2018:10:47:05.623566787 -0700] - INFO - connection_post_shutdown_cleanup - slapd shutting down - freed 3 work q stack objects - freed 3 op stack objects
[04/May/2018:10:47:06.602909554 -0700] - INFO - main - slapd stopped.
[04/May/2018:10:47:06.909145478 -0700] - INFO - main - 389-Directory/1.3.6.1 B2017.292.2010 starting up
[04/May/2018:10:47:06.921049757 -0700] - INFO - ldbm_instance_config_cachememsize_set - force a minimal value 512000
[04/May/2018:10:47:06.929326336 -0700] - INFO - ldbm_instance_config_cachememsize_set - force a minimal value 512000
[04/May/2018:10:47:06.937563628 -0700] - NOTICE - ldbm_back_start - found 1883880k physical memory
[04/May/2018:10:47:06.940476812 -0700] - NOTICE - ldbm_back_start - found 1494512k available
[04/May/2018:10:47:06.943567748 -0700] - NOTICE - ldbm_back_start - cache autosizing: db cache: 75355k
[04/May/2018:10:47:06.946607121 -0700] - NOTICE - ldbm_back_start - cache autosizing: userRoot entry cache (2 total): 65536k
[04/May/2018:10:47:06.950694729 -0700] - NOTICE - ldbm_back_start - cache autosizing: NetscapeRoot entry cache (2 total): 65536k
[04/May/2018:10:47:06.954642645 -0700] - NOTICE - ldbm_back_start - total cache size: 229503139 B; 
[04/May/2018:10:47:07.063155924 -0700] - INFO - slapd_daemon - slapd started.  Listening on All Interfaces port 389 for LDAP requests
[07/Jun/2018:14:19:49.103569806 -0700] - INFO - main - 389-Directory/1.3.6.1 B2017.292.2010 starting up
[07/Jun/2018:14:19:49.132027909 -0700] - INFO - ldbm_instance_config_cachememsize_set - force a minimal value 512000
[07/Jun/2018:14:19:49.148452023 -0700] - INFO - ldbm_instance_config_cachememsize_set - force a minimal value 512000
[07/Jun/2018:14:19:49.163753811 -0700] - NOTICE - ldbm_back_start - found 1883880k physical memory
[07/Jun/2018:14:19:49.170647300 -0700] - NOTICE - ldbm_back_start - found 1545136k available
[07/Jun/2018:14:19:49.175485939 -0700] - NOTICE - ldbm_back_start - cache autosizing: db cache: 75355k
[07/Jun/2018:14:19:49.180026622 -0700] - NOTICE - ldbm_back_start - cache autosizing: userRoot entry cache (2 total): 65536k
[07/Jun/2018:14:19:49.203182199 -0700] - NOTICE - ldbm_back_start - cache autosizing: NetscapeRoot entry cache (2 total): 65536k
[07/Jun/2018:14:19:49.209283467 -0700] - NOTICE - ldbm_back_start - total cache size: 229503139 B; 
[07/Jun/2018:14:19:49.237094692 -0700] - NOTICE - dblayer_start - Detected Disorderly Shutdown last time Directory Server was running, recovering database.
[07/Jun/2018:14:19:50.289050682 -0700] - INFO - slapd_daemon - slapd started.  Listening on All Interfaces port 389 for LDAP requests
[07/Jun/2018:18:53:31.658754924 -0700] - ERR - attr_syntax_create - Error: the EQUALITY matching rule [caseIgnoreListMatch] is not compatible with the syntax [1.3.6.1.4.1.1466.115.121.1.15] for the attribute [registeredAddress]
[07/Jun/2018:18:53:31.664587648 -0700] - ERR - attr_syntax_create - Error: the SUBSTR matching rule [caseIgnoreListSubstringsMatch] is not compatible with the syntax [1.3.6.1.4.1.1466.115.121.1.15] for the attribute [registeredAddress]
[07/Jun/2018:18:53:31.670031893 -0700] - ERR - attr_syntax_create - Error: the EQUALITY matching rule [caseExactMatch] is not compatible with the syntax [1.3.6.1.4.1.1466.115.121.1.26] for the attribute [sabayonProfileURL]
[07/Jun/2018:18:53:31.674684493 -0700] - ERR - attr_syntax_create - Error: the EQUALITY matching rule [caseIgnoreIA5Match] is not compatible with the syntax [1.3.6.1.4.1.1466.115.121.1.15] for the attribute [dc]
[07/Jun/2018:18:53:31.677661555 -0700] - ERR - attr_syntax_create - Error: the SUBSTR matching rule [caseIgnoreIA5SubstringsMatch] is not compatible with the syntax [1.3.6.1.4.1.1466.115.121.1.15] for the attribute [dc]
[07/Jun/2018:18:53:31.694536130 -0700] - ERR - attr_syntax_create - Error: the EQUALITY matching rule [caseIgnoreIA5Match] is not compatible with the syntax [1.3.6.1.4.1.1466.115.121.1.15] for the attribute [dc]
[07/Jun/2018:18:53:31.697670773 -0700] - ERR - attr_syntax_create - Error: the SUBSTR matching rule [caseIgnoreIA5SubstringsMatch] is not compatible with the syntax [1.3.6.1.4.1.1466.115.121.1.15] for the attribute [dc]
[07/Jun/2018:18:53:31.701317802 -0700] - ERR - attr_syntax_create - Error: the EQUALITY matching rule [caseIgnoreListMatch] is not compatible with the syntax [1.3.6.1.4.1.1466.115.121.1.15] for the attribute [registeredAddress]
[07/Jun/2018:18:53:31.704178349 -0700] - ERR - attr_syntax_create - Error: the SUBSTR matching rule [caseIgnoreListSubstringsMatch] is not compatible with the syntax [1.3.6.1.4.1.1466.115.121.1.15] for the attribute [registeredAddress]
[07/Jun/2018:18:53:32.005097809 -0700] - ERR - modify_schema_dse - [C] Local objectClasses must not be overwritten (set replication log for additional info)
[07/Jun/2018:18:53:32.467941194 -0700] - ERR - attrlist_replace - attr_replace (nsslapd-referral, ldap://ldap-m1.bcgsc.bc.ca:389/dc%3Dbcgsc%2Cdc%3Dca) failed.
[07/Jun/2018:18:53:32.473109839 -0700] - NOTICE - NSMMReplicationPlugin - multimaster_be_state_change - Replica dc=bcgsc,dc=ca is going offline; disabling replication
[07/Jun/2018:18:53:32.481688139 -0700] - INFO - dblayer_instance_start - Import is running with nsslapd-db-private-import-mem on; No other process is allowed to access the database
[07/Jun/2018:18:53:36.859718050 -0700] - INFO - import_monitor_threads - import userRoot: Workers finished; cleaning up...
[07/Jun/2018:18:53:37.065450916 -0700] - INFO - import_monitor_threads - import userRoot: Workers cleaned up.
[07/Jun/2018:18:53:37.070476911 -0700] - INFO - import_main_offline - import userRoot: Indexing complete.  Post-processing...
[07/Jun/2018:18:53:37.073879493 -0700] - INFO - import_main_offline - import userRoot: Generating numsubordinates (this may take several minutes to complete)...
[07/Jun/2018:18:53:37.086864049 -0700] - INFO - import_main_offline - import userRoot: Generating numSubordinates complete.
[07/Jun/2018:18:53:37.090532659 -0700] - INFO - ldbm_get_nonleaf_ids - import userRoot: Gathering ancestorid non-leaf IDs...
[07/Jun/2018:18:53:37.093707638 -0700] - INFO - ldbm_get_nonleaf_ids - import userRoot: Finished gathering ancestorid non-leaf IDs.
[07/Jun/2018:18:53:37.101277389 -0700] - INFO - ldbm_ancestorid_new_idl_create_index - import userRoot: Creating ancestorid index (new idl)...
[07/Jun/2018:18:53:37.170190177 -0700] - INFO - ldbm_ancestorid_new_idl_create_index - import userRoot: Created ancestorid index (new idl).
[07/Jun/2018:18:53:37.173727025 -0700] - INFO - import_main_offline - import userRoot: Flushing caches...
[07/Jun/2018:18:53:37.176796913 -0700] - INFO - import_main_offline - import userRoot: Closing files...
[07/Jun/2018:18:53:37.517718798 -0700] - INFO - import_main_offline - import userRoot: Import complete.  Processed 6176 entries in 5 seconds. (1235.20 entries/sec)
[07/Jun/2018:18:53:37.531227237 -0700] - NOTICE - NSMMReplicationPlugin - multimaster_be_state_change - Replica dc=bcgsc,dc=ca is coming online; enabling replication
[07/Jun/2018:18:53:37.538954636 -0700] - ERR - NSACLPlugin - __aclp__init_targetattr - targetattr "passwordPolicySubentry" does not exist in schema. Please add attributeTypes "passwordPolicySubentry" to schema if necessary. 
[07/Jun/2018:18:53:37.546233939 -0700] - ERR - NSACLPlugin - acllist_insert_aci_needsLock_ext - ACL PARSE ERR(rv=-5): (targetattr  = "nsroledn
[07/Jun/2018:18:53:37.549784099 -0700] - ERR - NSACLPlugin - __aclinit_handler - This  ((targetattr != "nsroledn || aci || nsLookThroughLimit || nsSizeLimit || nsTimeLimit || nsIdleTimeout || passwordPolicySubentry || passwordExpirationTime || passwordExpWarned || passwordRetryCount || retryCountResetTime || accountUnlockTime || passwordHistory || passwordAllowChangeTime")(version 3.0; acl "Allow self entry modification except for nsroledn, aci, resource limit attributes, passwordPolicySubentry and password policy state attributes"; allow (write)userdn ="ldap:///self";)) ACL will not be considered for evaluation because of syntax errors.
[08/Jun/2018:17:58:39.845254250 -0700] - DEBUG - NSMMReplicationPlugin - consumer_connection_extension_acquire_exclusive_access - conn=21 op=3 Acquired consumer connection extension
[08/Jun/2018:17:58:39.860793910 -0700] - DEBUG - NSMMReplicationPlugin - multimaster_extop_StartNSDS50ReplicationRequest - conn=21 op=3 repl="dc=bcgsc,dc=ca": Begin incremental protocol
[08/Jun/2018:17:58:39.864544608 -0700] - DEBUG - csngen_adjust_time - gen state before 5b1b071a0002:1528497946:0:0
[08/Jun/2018:17:58:39.867720434 -0700] - DEBUG - _csngen_adjust_local_time - gen state before 5b1b071a0002:1528497946:0:0
[08/Jun/2018:17:58:39.870496815 -0700] - DEBUG - _csngen_adjust_local_time - gen state after 5b1b263f0000:1528505919:0:0
[08/Jun/2018:17:58:39.884803744 -0700] - DEBUG - csngen_adjust_time - gen state after 5b1b263f0008:1528505919:0:0
[08/Jun/2018:17:58:39.887824020 -0700] - DEBUG - NSMMReplicationPlugin - replica_get_exclusive_access - conn=21 op=3 repl="dc=bcgsc,dc=ca": Acquired replica
[08/Jun/2018:17:58:39.891925222 -0700] - DEBUG - NSMMReplicationPlugin - multimaster_extop_StartNSDS50ReplicationRequest - conn=21 op=3 repl="dc=bcgsc,dc=ca": StartNSDS50ReplicationRequest: response=0 rc=0
[08/Jun/2018:17:58:39.895089013 -0700] - DEBUG - NSMMReplicationPlugin - consumer_connection_extension_relinquish_exclusive_access - conn=21 op=3 Relinquishing consumer connection extension
[08/Jun/2018:17:58:39.909820826 -0700] - DEBUG - NSMMReplicationPlugin - ruv_add_csn_inprogress - Successfully inserted csn 5b1b263f000046aa0000 into pending list
[08/Jun/2018:17:58:39.913860750 -0700] - DEBUG - NSMMReplicationPlugin - purge_entry_state_information -  From entry uid=sbulut,ou=GSC,ou=Users,dc=bcgsc,dc=ca up to CSN 5b11cb6b000046aa0000
[08/Jun/2018:17:58:39.918202806 -0700] - DEBUG - NSMMReplicationPlugin - csnplCommitALL: committing all csns for csn 5b1b263f000046aa0000
[08/Jun/2018:17:58:39.921141971 -0700] - DEBUG - NSMMReplicationPlugin - csnplCommitALL: processing data csn 5b1b263f000046aa0000
[08/Jun/2018:17:58:39.924135206 -0700] - DEBUG - NSMMReplicationPlugin - ruv_update_ruv - Successfully committed csn 5b1b263f000046aa0000
[08/Jun/2018:17:58:39.927146511 -0700] - DEBUG - NSMMReplicationPlugin - ruv_update_ruv - Rolled up to csn 5b1b263f000046aa0000
[08/Jun/2018:17:58:39.930055525 -0700] - DEBUG - NSMMReplicationPlugin - csnplCommitALL: committing all csns for csn 5b1b263f000046aa0000
[08/Jun/2018:17:58:39.932864790 -0700] - DEBUG - NSMMReplicationPlugin - ruv_update_ruv - Successfully committed csn 5b1b263f000046aa0000
[08/Jun/2018:17:58:41.990524676 -0700] - DEBUG - NSMMReplicationPlugin - consumer_connection_extension_acquire_exclusive_access - conn=21 op=5 Acquired consumer connection extension
[08/Jun/2018:17:58:42.005987114 -0700] - DEBUG - NSMMReplicationPlugin - replica_relinquish_exclusive_access - conn=21 op=5 repl="dc=bcgsc,dc=ca": Released replica held by locking_purl=conn=21 id=3
[08/Jun/2018:17:58:42.009601615 -0700] - DEBUG - NSMMReplicationPlugin - consumer_connection_extension_relinquish_exclusive_access - conn=21 op=5 Relinquishing consumer connection extension