[Date Prev][Date Next]
[Chronological]
[Thread]
[Top]
(ITS#4317) refreshAndPersist vs. refreshOnly and the ...4302.. control
Full_Name: Uwe Meding
Version: 2.3.15
OS: Linux 2.6.11/FC4/SMP x86_64
URL: ftp://ftp.openldap.org/incoming/
Submission from: (NULL) (64.81.114.223)
I am trying to run a syncrepl, using the refreshAndPersist option, but the
following error endlessly repeated on the master:
slap_global_control: unavailable control: 1.3.6.1.4.1.4203.1.9.1.1
When I switch the backup config type to "refreshOnly", the syncrepl seems to
work fine.
Thanks!
Uwe
==================================================================================
My master config file looks like this:
include /opt/intrameta/etc/openldap/schema/core.schema
include /opt/intrameta/etc/openldap/schema/cosine.schema
include /opt/intrameta/etc/openldap/schema/nis.schema
include /opt/intrameta/etc/openldap/schema/intrameta.schema
allow bind_v2
moduleload syncprov
# access rules
# include /opt/intrameta/etc/openldap/access.conf
access to * by * write
pidfile /var/run/slapd.pid-master
argsfile /var/run/slapd.args-master
# loglevel 0
allow bind_v2
disallow bind_anon
threads 20
schemacheck on
# NOTE: Sizelimit must be bigger than userbase
sizelimit 150000
timelimit 300
# Syncrepl overlay
overlay syncprov
syncprov-checkpoint 100 10
syncprov-sessionlog 5000
#
database bdb
sessionlog 100 10000
lastmod on
cachesize 50000
idlcachesize 100000
suffix "o=intrameta"
checkpoint 500 5
rootdn "uid=Manager,o=intrameta"
rootpw "secret"
directory /var/openldap-master
index entryUUID,contextCSN eq
index uid,givenname,sn,mail,mailAlternateAddress eq,sub
index macAddress eq
index serverName,serverAlias,legacyID,guid,realm eq
index siteId,masterGUID,accountType eq
index objectClass,member,mailForwardingAddress eq
index addressType,hostName,interfaceRole eq
index status,city,ipAddress,hostType,siteCode eq
index ipSubnet,webNickname,zone,serialNumber,configId eq
replogfile /var/log/ldap-replication.log
===============================================================================
My backup config looks like this:
include /opt/intrameta/etc/openldap/schema/core.schema
include /opt/intrameta/etc/openldap/schema/cosine.schema
include /opt/intrameta/etc/openldap/schema/nis.schema
include /opt/intrameta/etc/openldap/schema/intrameta.schema
allow bind_v2
# access rules
access to * by * write
pidfile /var/run/slapd.pid-backup
argsfile /var/run/slapd.args-backup
#loglevel 0
allow bind_v2
disallow bind_anon
threads 20
schemacheck on
# NOTE: Sizelimit must be bigger than userbase
sizelimit 150000
timelimit 300
# bdb database definitions
database bdb
lastmod on
idlcachesize 5000
suffix "o=intrameta"
checkpoint 500 5
rootdn "uid=Manager,o=intrameta"
rootpw "secret"
directory /var/openldap-backup
cachesize 5000
index objectClass,entryUUID,contextCSN eq
#index uid,givenname,sn,mail,mailAlternateAddress eq,sub
#index macAddress eq,sub
#index serverName,serverAlias,legacyID,guid,realm eq
sessionlog 100 10000
# Replication Settings
syncrepl rid=100
provider=ldap://ldap1.tx2.im:389
type=refreshAndPersist
interval=00:00:00:05
filter="(objectClass=*)"
attrs="*"
binddn="uid=Manager,o=intrameta"
bindmethod=simple
credentials=secret
updatedn="uid=Manager,o=intrameta"
searchbase="o=intrameta"
schemachecking=off
scope=sub
#updatedn "uid=Manager,o=intrameta"
updateref "ldap://ldap1.tx2.im:389";
==================================================================================
I am starting the master like this:
# slapd -llocal4 -h "ldap://10.3.48.10:389"; -f /root/slapd.conf-master -d1
==================================================================================
Confirming that the ..4302.. control is present:
# ldapsearch -h 10.3.48.10:389 -v -x -D "uid=Manager,o=intrameta" -w secret -b
"" + -s base | grep -F '1.3.6.1.4.1.4203.1.9.1.1'
ldap_initialize( ldap://10.3.48.10:389 )
filter: (objectclass=*)
requesting: +
supportedControl: 1.3.6.1.4.1.4203.1.9.1.1
==================================================================================
Starting backup server:
# slapd -llocal4 -h "ldap://127.0.0.1:998"; -f /root/slapd.conf-backup -d1
This yields the following log:
@(#) $OpenLDAP: slapd 2.3.15 (Jan 7 2006 16:50:33) $
root@n2.tx2.im:/home/uwe/intrameta_rpm/intrameta/BUILD/openldap-2.3.15.IM/servers/slapd
daemon_init: listen on ldap://127.0.0.1:998
daemon_init: 1 listeners to open...
ldap_url_parse_ext(ldap://127.0.0.1:998)
daemon: listener initialized ldap://127.0.0.1:998
daemon_init: 1 listeners opened
slapd init: initiated server.
bdb_back_initialize: initialize BDB backend
bdb_back_initialize: Sleepycat Software: Berkeley DB 4.3.28: (April 22, 2005)
hdb_back_initialize: initialize HDB backend
hdb_back_initialize: Sleepycat Software: Berkeley DB 4.3.28: (April 22, 2005)
bdb_db_init: Initializing BDB database
>>> dnPrettyNormal: <o=intrameta>
=> ldap_bv2dn(o=intrameta,0)
ldap_err2string
<= ldap_bv2dn(o=intrameta)=0 Success
=> ldap_dn2bv(272)
ldap_err2string
<= ldap_dn2bv(o=intrameta)=0 Success
=> ldap_dn2bv(272)
ldap_err2string
<= ldap_dn2bv(o=intrameta)=0 Success
<<< dnPrettyNormal: <o=intrameta>, <o=intrameta>
>>> dnPrettyNormal: <uid=Manager,o=intrameta>
=> ldap_bv2dn(uid=Manager,o=intrameta,0)
ldap_err2string
<= ldap_bv2dn(uid=Manager,o=intrameta)=0 Success
=> ldap_dn2bv(272)
ldap_err2string
<= ldap_dn2bv(uid=Manager,o=intrameta)=0 Success
=> ldap_dn2bv(272)
ldap_err2string
<= ldap_dn2bv(uid=manager,o=intrameta)=0 Success
<<< dnPrettyNormal: <uid=Manager,o=intrameta>, <uid=manager,o=intrameta>
>>> dnNormalize: <o=intrameta>
=> ldap_bv2dn(o=intrameta,0)
ldap_err2string
<= ldap_bv2dn(o=intrameta)=0 Success
=> ldap_dn2bv(272)
ldap_err2string
<= ldap_dn2bv(o=intrameta)=0 Success
<<< dnNormalize: <o=intrameta>
ldap_url_parse_ext(ldap://ldap1.tx2.im:389)
>>> dnNormalize: <cn=Subschema>
=> ldap_bv2dn(cn=Subschema,0)
ldap_err2string
<= ldap_bv2dn(cn=Subschema)=0 Success
=> ldap_dn2bv(272)
ldap_err2string
<= ldap_dn2bv(cn=subschema)=0 Success
<<< dnNormalize: <cn=subschema>
matching_rule_use_init
.... SNIPPED A BUNCH OF STUFF .....
2.5.13.0 (objectIdentifierMatch): matchingRuleUse: ( 2.5.13.0 NAME
'objectIdentifierMatch' APPLIES ( supportedControl $ supportedExtension $
supportedFeatures $ supportedApplicationContext ) )
slapd startup: initiated.
backend_startup_one: starting "cn=config"
backend_startup_one: starting "o=intrameta"
bdb_db_open: dbenv_open(/var/openldap-backup)
slapd starting
=>do_syncrepl
ldap_create
ldap_url_parse_ext(ldap://ldap1.tx2.im:389)
ldap_sasl_bind_s
ldap_sasl_bind
ldap_send_initial_request
ldap_new_connection 1 1 0
ldap_int_open_connection
ldap_connect_to_host: TCP ldap1.tx2.im:389
ldap_new_socket: 11
ldap_prepare_socket: 11
ldap_connect_to_host: Trying 10.3.48.10:389
ldap_connect_timeout: fd: 11 tm: -1 async: 0
ldap_open_defconn: successful
ldap_send_server_request
ber_scanf fmt ({it) ber:
ber_scanf fmt ({i) ber:
ber_flush: 44 bytes to sd 11
ldap_result ld 0x87ed90 msgid 1
ldap_chkResponseList ld 0x87ed90 msgid 1 all 1
ldap_chkResponseList returns ld 0x87ed90 NULL
wait4msg ld 0x87ed90 msgid 1 (infinite timeout)
wait4msg continue ld 0x87ed90 msgid 1 all 1
** ld 0x87ed90 Connections:
* host: ldap1.tx2.im port: 389 (default)
refcnt: 2 status: Connected
last used: Mon Jan 9 06:23:15 2006
** ld 0x87ed90 Outstanding Requests:
* msgid 1, origid 1, status InProgress
outstanding referrals 0, parent count 0
** ld 0x87ed90 Response Queue:
Empty
ldap_chkResponseList ld 0x87ed90 msgid 1 all 1
ldap_chkResponseList returns ld 0x87ed90 NULL
ldap_int_select
read1msg: ld 0x87ed90 msgid 1 all 1
ber_get_next
ber_get_next: tag 0x30 len 12 contents:
read1msg: ld 0x87ed90 msgid 1 message type bind
ber_scanf fmt ({eaa) ber:
ber_scanf fmt ({eaa}) ber:
new result: res_errno: 0, res_error: <>, res_matched: <>
read1msg: ld 0x87ed90 0 new referrals
read1msg: mark request completed, ld 0x87ed90 msgid 1
request done: ld 0x87ed90 msgid 1
res_errno: 0, res_error: <>, res_matched: <>
ldap_free_request (origid 1, msgid 1)
ldap_free_connection 0 1
ldap_free_connection: refcnt 1
ldap_parse_result
ber_scanf fmt ({iaa) ber:
ber_scanf fmt (}) ber:
ldap_msgfree
bdb_dn2entry("o=intrameta")
=> bdb_dn2id("o=intrameta")
<= bdb_dn2id: got id=0x00000001
entry_decode: "o=intrameta"
<= entry_decode(o=intrameta)
bdb_entry_get: rc=0
ldap_search_ext
put_filter: "(objectClass=*)"
put_filter: simple
put_simple_filter: "objectClass=*"
ldap_send_initial_request
ldap_send_server_request
ber_scanf fmt ({it) ber:
ber_scanf fmt ({) ber:
ber_flush: 136 bytes to sd 11
=>do_syncrep2
ldap_result ld 0x87ed90 msgid -1
ldap_chkResponseList ld 0x87ed90 msgid -1 all 0
ldap_chkResponseList returns ld 0x87ed90 NULL
wait4msg ld 0x87ed90 msgid -1 (timeout 0 usec)
wait4msg continue ld 0x87ed90 msgid -1 all 0
** ld 0x87ed90 Connections:
* host: ldap1.tx2.im port: 389 (default)
refcnt: 2 status: Connected
last used: Mon Jan 9 06:23:15 2006
** ld 0x87ed90 Outstanding Requests:
* msgid 2, origid 2, status InProgress
outstanding referrals 0, parent count 0
** ld 0x87ed90 Response Queue:
Empty
ldap_chkResponseList ld 0x87ed90 msgid -1 all 0
ldap_chkResponseList returns ld 0x87ed90 NULL
ldap_int_select
connection_get(11): got connid=0
==================================================================================
The master log looks like this:
@(#) $OpenLDAP: slapd 2.3.15 (Jan 7 2006 16:50:33) $
root@n2.tx2.im:/home/uwe/intrameta_rpm/intrameta/BUILD/openldap-2.3.15.IM/servers/slapd
daemon_init: listen on ldap://10.3.48.10:389
daemon_init: 1 listeners to open...
ldap_url_parse_ext(ldap://10.3.48.10:389)
daemon: listener initialized ldap://10.3.48.10:389
daemon_init: 1 listeners opened
slapd init: initiated server.
bdb_back_initialize: initialize BDB backend
bdb_back_initialize: Sleepycat Software: Berkeley DB 4.3.28: (April 22, 2005)
hdb_back_initialize: initialize HDB backend
hdb_back_initialize: Sleepycat Software: Berkeley DB 4.3.28: (April 22, 2005)
bdb_db_init: Initializing BDB database
>>> dnPrettyNormal: <o=intrameta>
=> ldap_bv2dn(o=intrameta,0)
ldap_err2string
<= ldap_bv2dn(o=intrameta)=0 Success
=> ldap_dn2bv(272)
ldap_err2string
<= ldap_dn2bv(o=intrameta)=0 Success
=> ldap_dn2bv(272)
ldap_err2string
<= ldap_dn2bv(o=intrameta)=0 Success
<<< dnPrettyNormal: <o=intrameta>, <o=intrameta>
>>> dnPrettyNormal: <uid=Manager,o=intrameta>
=> ldap_bv2dn(uid=Manager,o=intrameta,0)
ldap_err2string
<= ldap_bv2dn(uid=Manager,o=intrameta)=0 Success
=> ldap_dn2bv(272)
ldap_err2string
<= ldap_dn2bv(uid=Manager,o=intrameta)=0 Success
=> ldap_dn2bv(272)
ldap_err2string
<= ldap_dn2bv(uid=manager,o=intrameta)=0 Success
<<< dnPrettyNormal: <uid=Manager,o=intrameta>, <uid=manager,o=intrameta>
>>> dnNormalize: <cn=Subschema>
=> ldap_bv2dn(cn=Subschema,0)
ldap_err2string
<= ldap_bv2dn(cn=Subschema)=0 Success
=> ldap_dn2bv(272)
ldap_err2string
<= ldap_dn2bv(cn=subschema)=0 Success
<<< dnNormalize: <cn=subschema>
matching_rule_use_init
.... SNIPPED A BUNCH OF STUFF .....
2.5.13.0 (objectIdentifierMatch): matchingRuleUse: ( 2.5.13.0 NAME
'objectIdentifierMatch' APPLIES ( supportedControl $ supportedExtension $
supportedFeatures $ supportedApplicationContext ) )
slapd startup: initiated.
backend_startup_one: starting "cn=config"
backend_startup_one: starting "o=intrameta"
bdb_db_open: unclean shutdown detected; attempting recovery.
bdb_db_open: dbenv_open(/var/openldap-master)
slapd starting
connection_get(11): got connid=0
connection_read(11): checking for input on id=0
ber_get_next
ber_get_next: tag 0x30 len 42 contents:
ber_get_next
ber_get_next on fd 11 failed errno=11 (Resource temporarily unavailable)
do_bind
ber_scanf fmt ({imt) ber:
ber_scanf fmt (m}) ber:
>>> dnPrettyNormal: <uid=Manager,o=intrameta>
=> ldap_bv2dn(uid=Manager,o=intrameta,0)
ldap_err2string
<= ldap_bv2dn(uid=Manager,o=intrameta)=0 Success
=> ldap_dn2bv(272)
ldap_err2string
<= ldap_dn2bv(uid=Manager,o=intrameta)=0 Success
=> ldap_dn2bv(272)
ldap_err2string
<= ldap_dn2bv(uid=manager,o=intrameta)=0 Success
<<< dnPrettyNormal: <uid=Manager,o=intrameta>, <uid=manager,o=intrameta>
do_bind: version=3 dn="uid=Manager,o=intrameta" method=128
do_bind: v3 bind: "uid=Manager,o=intrameta" to "uid=Manager,o=intrameta"
send_ldap_result: conn=0 op=0 p=3
send_ldap_response: msgid=1 tag=97 err=0
ber_flush: 14 bytes to sd 11
connection_get(11): got connid=0
connection_read(11): checking for input on id=0
ber_get_next
ber_get_next: tag 0x30 len 133 contents:
ber_get_next
ber_get_next on fd 11 failed errno=11 (Resource temporarily unavailable)
do_search
ber_scanf fmt ({miiiib) ber:
>>> dnPrettyNormal: <o=intrameta>
=> ldap_bv2dn(o=intrameta,0)
ldap_err2string
<= ldap_bv2dn(o=intrameta)=0 Success
=> ldap_dn2bv(272)
ldap_err2string
<= ldap_dn2bv(o=intrameta)=0 Success
=> ldap_dn2bv(272)
ldap_err2string
<= ldap_dn2bv(o=intrameta)=0 Success
<<< dnPrettyNormal: <o=intrameta>, <o=intrameta>
ber_scanf fmt (m) ber:
ber_scanf fmt ({M}}) ber:
=> get_ctrls
ber_scanf fmt ({m) ber:
ber_scanf fmt (m) ber:
=> get_ctrls: oid="1.3.6.1.4.1.4203.1.9.1.1" (noncritical)
ber_scanf fmt ({i) ber:
ber_scanf fmt (m) ber:
ber_scanf fmt (b) ber:
ber_scanf fmt (}) ber:
<= get_ctrls: n=1 rc=0 err=""
slap_global_control: unavailable control: 1.3.6.1.4.1.4203.1.9.1.1
=> bdb_search
bdb_dn2entry("o=intrameta")
=> bdb_dn2id("o=intrameta")
<= bdb_dn2id: got id=0x00000001
entry_decode: "o=intrameta"
<= entry_decode(o=intrameta)
send_ldap_result: conn=0 op=1 p=3
slap_global_control: unavailable control: 1.3.6.1.4.1.4203.1.9.1.1
slap_global_control: unavailable control: 1.3.6.1.4.1.4203.1.9.1.1
..... LAST MESSAGE REPEATS UNTIL CTRL C ......
================================================================================