You are viewing a plain text version of this content. The canonical link for it is here.
Posted to users@directory.apache.org by Karsten Kosmala <ko...@cosmocode.de> on 2014/12/03 16:08:17 UTC
Replication fails
Hi all,
we set up two apacheds, one as master and one as slave system. Both master and slave do have the same partitions.
When we start the slave the replication starts but this error appears on the master:
jvm 1 | [15:58:07] DEBUG [org.apache.directory.server.PROVIDER_LOG] - syncrepl provider initialized successfully
jvm 1 | [15:58:11] DEBUG [org.apache.directory.server.PROVIDER_LOG] - Received a Syncrepl request : MessageType : SEARCH_REQUEST
jvm 1 | Message ID : 3
jvm 1 | SearchRequest
jvm 1 | baseDn : 'dc=example,dc=com'
jvm 1 | filter : '(objectClass=*)'
jvm 1 | scope : whole subtree
jvm 1 | typesOnly : false
jvm 1 | Size Limit : no limit
jvm 1 | Time Limit : no limit
jvm 1 | Deref Aliases : never Deref Aliases
jvm 1 | attributes : '*'
jvm 1 | org.apache.directory.api.ldap.model.message.SearchRequestImpl@5eb17feb SyncRequestValue control :
jvm 1 | oid : 1.3.6.1.4.1.4203.1.9.1.1
jvm 1 | critical : false
jvm 1 | mode : 'REFRESH_AND_PERSIST'
jvm 1 | cookie : ''
jvm 1 | reloadHint : 'false'
jvm 1 | ManageDsaITImpl Control
jvm 1 | Type OID : '2.16.840.1.113730.3.4.2'
jvm 1 | Criticality : 'false'
jvm 1 | '
jvm 1 | from LdapSession : <0.9.2342.19200300.100.1.1=admin,2.5.4.11=system,/1.2.3.4:36815>
jvm 1 | [15:58:11] DEBUG [org.apache.directory.server.PROVIDER_LOG] - Received a replication request with no cookie
jvm 1 | [15:58:11] DEBUG [org.apache.directory.server.PROVIDER_LOG] - Starting an initial refresh
jvm 1 | [15:58:11] DEBUG [org.apache.directory.server.PROVIDER_LOG] - Adding sort control to sort the entries by entryDn attribute to preserve order of insertion
jvm 1 | [15:58:11] DEBUG [org.apache.directory.server.PROVIDER_LOG] - creating a new event log for the replica with id 35
jvm 1 | [15:58:11] DEBUG [org.apache.directory.server.PROVIDER_LOG] - Creating the replication queue for replica 35
jvm 1 | [15:58:11] DEBUG [org.apache.directory.server.PROVIDER_LOG] - Starting the replicaLog ReplicaEventLog [hostName=ourhost.dynamic.ourprovider.de, searchFilter=(objectClass=*), lastSentCsn=null, searchCriteria=Notification criteria : 'null', '(objectClass=*)', 'one', 'DEREF_ALWAYS', 'ALL EVENTS', replicaId=35, refreshNPersist=true, maxInactivePeriod=-1, purgeThresholdCount=10000, journalFile=/var/lib/apacheds-2.0.0-M19/default/syncrepl-data/REPL_EVENT_LOG.35, dirty=false, consumerEntryDn=null]
jvm 1 | [15:58:11] DEBUG [org.apache.directory.server.PROVIDER_LOG] - Simple Search MessageType : SEARCH_REQUEST
jvm 1 | Message ID : 3
jvm 1 | SearchRequest
jvm 1 | baseDn : 'dc=example,dc=com'
jvm 1 | filter : '(objectClass=*)'
jvm 1 | scope : whole subtree
jvm 1 | typesOnly : false
jvm 1 | Size Limit : no limit
jvm 1 | Time Limit : no limit
jvm 1 | Deref Aliases : never Deref Aliases
jvm 1 | attributes : '*', '+'
jvm 1 | org.apache.directory.api.ldap.model.message.SearchRequestImpl@17ebcfa0 SyncRequestValue control :
jvm 1 | oid : 1.3.6.1.4.1.4203.1.9.1.1
jvm 1 | critical : false
jvm 1 | mode : 'REFRESH_AND_PERSIST'
jvm 1 | cookie : ''
jvm 1 | reloadHint : 'false'
jvm 1 | SortRequestControlImpl [sortKeys=[SortKey : [entryDN, 2.5.13.1, reverse]]] ManageDsaITImpl Control
jvm 1 | Type OID : '2.16.840.1.113730.3.4.2'
jvm 1 | Criticality : 'false'
jvm 1 | '
jvm 1 | for LdapSession : <0.9.2342.19200300.100.1.1=admin,2.5.4.11=system,ourhost.dynamic.ourprovider.de/1.2.3.4:36815>
jvm 1 | [15:58:12] DEBUG [org.apache.directory.server.PROVIDER_LOG] - search operation requested size limit 9223372036854775807, server size limit 9223372036854775807
jvm 1 | [15:58:12] ERROR [org.apache.directory.server.PROVIDER_LOG] - Failed to handle the syncrepl request
jvm 1 | java.lang.NullPointerException
jvm 1 | at org.apache.directory.server.ldap.replication.provider.SyncReplRequestHandler.sendSearchResultEntry(SyncReplRequestHandler.java:754)
jvm 1 | at org.apache.directory.server.ldap.replication.provider.SyncReplRequestHandler.readResults(SyncReplRequestHandler.java:722)
jvm 1 | at org.apache.directory.server.ldap.replication.provider.SyncReplRequestHandler.doSimpleSearch(SyncReplRequestHandler.java:671)
jvm 1 | at org.apache.directory.server.ldap.replication.provider.SyncReplRequestHandler.doInitialRefresh(SyncReplRequestHandler.java:562)
jvm 1 | at org.apache.directory.server.ldap.replication.provider.SyncReplRequestHandler.handleSyncRequest(SyncReplRequestHandler.java:311)
jvm 1 | at org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.handleReplication(SearchRequestHandler.java:240)
jvm 1 | at org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.handle(SearchRequestHandler.java:200)
jvm 1 | at org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.handle(SearchRequestHandler.java:93)
jvm 1 | at org.apache.directory.server.ldap.handlers.LdapRequestHandler.handleMessage(LdapRequestHandler.java:207)
jvm 1 | at org.apache.directory.server.ldap.handlers.LdapRequestHandler.handleMessage(LdapRequestHandler.java:56)
jvm 1 | at org.apache.mina.handler.demux.DemuxingIoHandler.messageReceived(DemuxingIoHandler.java:221)
jvm 1 | at org.apache.directory.server.ldap.LdapProtocolHandler.messageReceived(LdapProtocolHandler.java:217)
jvm 1 | at org.apache.mina.core.filterchain.DefaultIoFilterChain$TailFilter.messageReceived(DefaultIoFilterChain.java:854)
jvm 1 | at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:542)
jvm 1 | at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1300(DefaultIoFilterChain.java:48)
jvm 1 | at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:943)
jvm 1 | at org.apache.mina.core.filterchain.IoFilterEvent.fire(IoFilterEvent.java:74)
jvm 1 | at org.apache.mina.core.session.IoEvent.run(IoEvent.java:63)
jvm 1 | at org.apache.mina.filter.executor.UnorderedThreadPoolExecutor$Worker.runTask(UnorderedThreadPoolExecutor.java:475)
jvm 1 | at org.apache.mina.filter.executor.UnorderedThreadPoolExecutor$Worker.run(UnorderedThreadPoolExecutor.java:429)
jvm 1 | at java.lang.Thread.run(Thread.java:745)
What is wrong?
thanks, Karsten
Re: Replication fails
Posted by Kiran Ayyagari <ka...@apache.org>.
On Wed, Dec 3, 2014 at 11:08 PM, Karsten Kosmala <ko...@cosmocode.de>
wrote:
> Hi all,
>
> we set up two apacheds, one as master and one as slave system. Both master
> and slave do have the same partitions.
> When we start the slave the replication starts but this error appears on
> the master:
>
> jvm 1 | [15:58:07] DEBUG [org.apache.directory.server.PROVIDER_LOG] -
> syncrepl provider initialized successfully
> jvm 1 | [15:58:11] DEBUG [org.apache.directory.server.PROVIDER_LOG] -
> Received a Syncrepl request : MessageType : SEARCH_REQUEST
> jvm 1 | Message ID : 3
> jvm 1 | SearchRequest
> jvm 1 | baseDn : 'dc=example,dc=com'
> jvm 1 | filter : '(objectClass=*)'
> jvm 1 | scope : whole subtree
> jvm 1 | typesOnly : false
> jvm 1 | Size Limit : no limit
> jvm 1 | Time Limit : no limit
> jvm 1 | Deref Aliases : never Deref Aliases
> jvm 1 | attributes : '*'
> jvm 1 |
> org.apache.directory.api.ldap.model.message.SearchRequestImpl@5eb17feb
> SyncRequestValue control :
> jvm 1 | oid : 1.3.6.1.4.1.4203.1.9.1.1
> jvm 1 | critical : false
> jvm 1 | mode : 'REFRESH_AND_PERSIST'
> jvm 1 | cookie : ''
> jvm 1 | reloadHint : 'false'
> jvm 1 | ManageDsaITImpl Control
> jvm 1 | Type OID : '2.16.840.1.113730.3.4.2'
> jvm 1 | Criticality : 'false'
> jvm 1 | '
> jvm 1 | from LdapSession :
> <0.9.2342.19200300.100.1.1=admin,2.5.4.11=system,/1.2.3.4:36815>
> jvm 1 | [15:58:11] DEBUG [org.apache.directory.server.PROVIDER_LOG] -
> Received a replication request with no cookie
> jvm 1 | [15:58:11] DEBUG [org.apache.directory.server.PROVIDER_LOG] -
> Starting an initial refresh
> jvm 1 | [15:58:11] DEBUG [org.apache.directory.server.PROVIDER_LOG] -
> Adding sort control to sort the entries by entryDn attribute to preserve
> order of insertion
> jvm 1 | [15:58:11] DEBUG [org.apache.directory.server.PROVIDER_LOG] -
> creating a new event log for the replica with id 35
> jvm 1 | [15:58:11] DEBUG [org.apache.directory.server.PROVIDER_LOG] -
> Creating the replication queue for replica 35
> jvm 1 | [15:58:11] DEBUG [org.apache.directory.server.PROVIDER_LOG] -
> Starting the replicaLog ReplicaEventLog [hostName=
> ourhost.dynamic.ourprovider.de, searchFilter=(objectClass=*),
> lastSentCsn=null, searchCriteria=Notification criteria : 'null',
> '(objectClass=*)', 'one', 'DEREF_ALWAYS', 'ALL EVENTS', replicaId=35,
> refreshNPersist=true, maxInactivePeriod=-1, purgeThresholdCount=10000,
> journalFile=/var/lib/apacheds-2.0.0-M19/default/syncrepl-data/REPL_EVENT_LOG.35,
> dirty=false, consumerEntryDn=null]
> jvm 1 | [15:58:11] DEBUG [org.apache.directory.server.PROVIDER_LOG] -
> Simple Search MessageType : SEARCH_REQUEST
> jvm 1 | Message ID : 3
> jvm 1 | SearchRequest
> jvm 1 | baseDn : 'dc=example,dc=com'
> jvm 1 | filter : '(objectClass=*)'
> jvm 1 | scope : whole subtree
> jvm 1 | typesOnly : false
> jvm 1 | Size Limit : no limit
> jvm 1 | Time Limit : no limit
> jvm 1 | Deref Aliases : never Deref Aliases
> jvm 1 | attributes : '*', '+'
> jvm 1 |
> org.apache.directory.api.ldap.model.message.SearchRequestImpl@17ebcfa0
> SyncRequestValue control :
> jvm 1 | oid : 1.3.6.1.4.1.4203.1.9.1.1
> jvm 1 | critical : false
> jvm 1 | mode : 'REFRESH_AND_PERSIST'
> jvm 1 | cookie : ''
> jvm 1 | reloadHint : 'false'
> jvm 1 | SortRequestControlImpl [sortKeys=[SortKey : [entryDN, 2.5.13.1,
> reverse]]] ManageDsaITImpl Control
> jvm 1 | Type OID : '2.16.840.1.113730.3.4.2'
> jvm 1 | Criticality : 'false'
> jvm 1 | '
> jvm 1 | for LdapSession :
> <0.9.2342.19200300.100.1.1=admin,2.5.4.11=system,
> ourhost.dynamic.ourprovider.de/1.2.3.4:36815>
> jvm 1 | [15:58:12] DEBUG [org.apache.directory.server.PROVIDER_LOG] -
> search operation requested size limit 9223372036854775807, server size
> limit 9223372036854775807
> jvm 1 | [15:58:12] ERROR [org.apache.directory.server.PROVIDER_LOG] -
> Failed to handle the syncrepl request
> jvm 1 | java.lang.NullPointerException
> jvm 1 | at
> org.apache.directory.server.ldap.replication.provider.SyncReplRequestHandler.sendSearchResultEntry(SyncReplRequestHandler.java:754)
> jvm 1 | at
> org.apache.directory.server.ldap.replication.provider.SyncReplRequestHandler.readResults(SyncReplRequestHandler.java:722)
> jvm 1 | at
> org.apache.directory.server.ldap.replication.provider.SyncReplRequestHandler.doSimpleSearch(SyncReplRequestHandler.java:671)
> jvm 1 | at
> org.apache.directory.server.ldap.replication.provider.SyncReplRequestHandler.doInitialRefresh(SyncReplRequestHandler.java:562)
> jvm 1 | at
> org.apache.directory.server.ldap.replication.provider.SyncReplRequestHandler.handleSyncRequest(SyncReplRequestHandler.java:311)
> jvm 1 | at
> org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.handleReplication(SearchRequestHandler.java:240)
> jvm 1 | at
> org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.handle(SearchRequestHandler.java:200)
> jvm 1 | at
> org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.handle(SearchRequestHandler.java:93)
> jvm 1 | at
> org.apache.directory.server.ldap.handlers.LdapRequestHandler.handleMessage(LdapRequestHandler.java:207)
> jvm 1 | at
> org.apache.directory.server.ldap.handlers.LdapRequestHandler.handleMessage(LdapRequestHandler.java:56)
> jvm 1 | at
> org.apache.mina.handler.demux.DemuxingIoHandler.messageReceived(DemuxingIoHandler.java:221)
> jvm 1 | at
> org.apache.directory.server.ldap.LdapProtocolHandler.messageReceived(LdapProtocolHandler.java:217)
> jvm 1 | at
> org.apache.mina.core.filterchain.DefaultIoFilterChain$TailFilter.messageReceived(DefaultIoFilterChain.java:854)
> jvm 1 | at
> org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:542)
> jvm 1 | at
> org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1300(DefaultIoFilterChain.java:48)
> jvm 1 | at
> org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:943)
> jvm 1 | at
> org.apache.mina.core.filterchain.IoFilterEvent.fire(IoFilterEvent.java:74)
> jvm 1 | at
> org.apache.mina.core.session.IoEvent.run(IoEvent.java:63)
> jvm 1 | at
> org.apache.mina.filter.executor.UnorderedThreadPoolExecutor$Worker.runTask(UnorderedThreadPoolExecutor.java:475)
> jvm 1 | at
> org.apache.mina.filter.executor.UnorderedThreadPoolExecutor$Worker.run(UnorderedThreadPoolExecutor.java:429)
> jvm 1 | at java.lang.Thread.run(Thread.java:745)
>
> What is wrong?
>
> which version are you using?
> thanks, Karsten
>
--
Kiran Ayyagari
http://keydap.com