On Fri, Sep 26, 2014 at 2:20 PM, 최규우 <[email protected]> wrote: > I have a trouble while I try to make an replication. > > I set 2 ds, one for master, on for replication. > > for master I set below > > attr > > ads-replreqhandler=org.apache.directory.server.ldap.replication.provider.SyncReplRequestHandler > in > > org.apache.directory.server.ldap.replication.provider.SyncReplRequestHandler > > > for replication (host & password are replaced *) > > dn: > ads-replConsumerId=consumer1,ou=replConsumers,ads-serverId=ldapServer,ou > =servers,ads-directoryServiceId=default,ou=config > objectclass: top > objectclass: ads-base > objectclass: ads-replConsumer > ads-replaliasderefmode: never > ads-replattributes: * > ads-replconsumerid: consumer1 > ads-replprovhostname: ******** > ads-replprovport: 10389 > ads-replrefreshinterval: 60000 > ads-replrefreshnpersist: TRUE > ads-replsearchfilter: (objectClass=*) > ads-replsearchscope: sub > ads-replsearchsizelimit: 0 > ads-replsearchtimeout: 0 > ads-repluserdn: uid=admin,ou=system > ads-repluserpassword:: ******** > ads-searchbasedn: dc=example,dc=com > ads-enabled: TRUE > ads-replstrictcertvalidation: FALSE > ads-replusetls: FALSE > > > but It fails replicating on master error log. > > [17:34:38] DEBUG [org.apache.directory.server.OPERATION_LOG] - >> > LookupOperation : FilteringOperationContext for Dn 'uid=admin,ou=system', * > > [17:34:38] DEBUG > [org.apache.directory.server.core.authn.AuthenticationInterceptor] - > Operation Context: FilteringOperationContext for Dn 'uid=admin,ou=system', > * > > [17:34:38] DEBUG [org.apache.directory.server.OPERATION_LOG] - << > LookupOperation successful > > [17:34:38] DEBUG [org.apache.directory.server.OPERATION_TIME] - Lookup > operation took 285006 ns > > [17:34:38] DEBUG [org.apache.directory.server.OPERATION_LOG] - >> > BindOperation : BindContext for Dn 'uid=admin,ou=system', credentials <0x73 > 0x65 0x63 0x72 0x65 0x74 > > > [17:34:38] DEBUG > [org.apache.directory.server.core.authn.AuthenticationInterceptor] - > Operation Context: BindContext for Dn 'uid=admin,ou=system', credentials > <0x73 0x65 0x63 0x72 0x65 0x74 > > > [17:34:38] DEBUG > [org.apache.directory.server.core.authn.AbstractAuthenticator] - > Authenticating uid=admin,ou=system > > [17:34:38] DEBUG > [org.apache.directory.server.core.authn.AbstractAuthenticator] - checking > if account with the Dn uid=admin,ou=system is locked > > [17:34:38] DEBUG > [org.apache.directory.server.core.authn.AbstractAuthenticator] - > uid=admin,ou=system Authenticated > > [17:34:38] DEBUG [org.apache.directory.server.OPERATION_LOG] - << > BindOperation successful > > [17:34:38] DEBUG [org.apache.directory.server.OPERATION_TIME] - Bind > operation took 463063 ns > > [17:34:38] DEBUG [org.apache.directory.api.CODEC_LOG] - Encoded message > > MessageType : BIND_RESPONSE > > Message ID : 1 > > BindResponse > > Ldap Result > > Result code : (SUCCESS) success > > Matched Dn : 'null' > > Diagnostic message : 'null' > > > : 0x30 0x0C 0x02 0x01 0x01 0x61 0x07 0x0A 0x01 0x00 0x04 0x00 0x04 0x00 > > [17:34:38] DEBUG > [org.apache.directory.server.ldap.handlers.LdapResponseHandler] - Message > Sent : MessageType : BIND_RESPONSE > > Message ID : 1 > > BindResponse > > Ldap Result > > Result code : (SUCCESS) success > > Matched Dn : 'null' > > Diagnostic message : 'null' > > > [17:34:38] DEBUG > [org.apache.directory.server.ldap.handlers.request.BindRequestHandler] - > Returned SUCCESS message: MessageType : BIND_RESPONSE > > Message ID : 1 > > BindResponse > > Ldap Result > > Result code : (SUCCESS) success > > Matched Dn : 'null' > > Diagnostic message : 'null' > > . > > [17:34:38] DEBUG [org.apache.mina.core.filterchain.IoFilterEvent] - Event > MESSAGE_RECEIVED has been fired for session 151 > > [17:34:38] DEBUG [org.apache.mina.filter.codec.ProtocolCodecFilter] - > Processing a MESSAGE_RECEIVED for session 151 > > [17:34:38] DEBUG [org.apache.directory.api.CODEC_LOG] - Decoding the PDU : > > [17:34:38] DEBUG [org.apache.directory.api.CODEC_LOG] - 0x30 0x79 0x02 0x01 > 0x02 0x63 0x34 0x04 0x11 0x64 0x63 0x3D 0x65 0x78 0x61 0x6D 0x70 0x6C 0x65 > 0x2C 0x64 0x63 0x3D 0x63 0x6F 0x6D 0x0A 0x01 0x02 0x0A 0x01 0x00 0x02 0x01 > 0x00 0x02 0x01 0x00 0x01 0x01 0x00 0x87 0x0B 0x6F 0x62 0x6A 0x65 0x63 0x74 > 0x43 0x6C 0x61 0x73 0x73 0x30 0x03 0x04 0x01 0x2A 0xA0 0x3E 0x30 0x21 0x04 > 0x18 0x31 0x2E 0x33 0x2E 0x36 0x2E 0x31 0x2E 0x34 0x2E 0x31 0x2E 0x34 0x32 > 0x30 0x33 0x2E 0x31 0x2E 0x39 0x2E 0x31 0x2E 0x31 0x04 0x05 0x30 0x03 0x0A > 0x01 0x03 0x30 0x19 0x04 0x17 0x32 0x2E 0x31 0x36 0x2E 0x38 0x34 0x30 0x2E > 0x31 0x2E 0x31 0x31 0x33 0x37 0x33 0x30 0x2E 0x33 0x2E 0x34 0x2E 0x32 > > [17:34:38] DEBUG [org.apache.directory.api.CODEC_LOG] - Decoded LdapMessage > : MessageType : SEARCH_REQUEST > > Message ID : 2 > > SearchRequest > > baseDn : 'dc=example,dc=com' > > filter : '(objectClass=*)' > > scope : whole subtree > > typesOnly : false > > Size Limit : no limit > > Time Limit : no limit > > Deref Aliases : never Deref Aliases > > attributes : '*' > > org.apache.directory.api.ldap.model.message.SearchRequestImpl@326a523d > SyncRequestValue control : > > oid : 1.3.6.1.4.1.4203.1.9.1.1 > > critical : false > > mode : 'REFRESH_AND_PERSIST' > > cookie : '' > > reloadHint : 'false' > > ManageDsaITImpl Control > > Type OID : '2.16.840.1.113730.3.4.2' > > Criticality : 'false' > > ' > > > [17:34:38] DEBUG [org.apache.mina.core.filterchain.IoFilterEvent] - Firing > a MESSAGE_RECEIVED event for session 151 > > [17:34:38] DEBUG > [org.apache.directory.server.ldap.handlers.request.SearchRequestHandler] - > Handling single reply request: MessageType : SEARCH_REQUEST > > Message ID : 2 > > SearchRequest > > baseDn : 'dc=example,dc=com' > > filter : '(objectClass=*)' > > scope : whole subtree > > typesOnly : false > > Size Limit : no limit > > Time Limit : no limit > > Deref Aliases : never Deref Aliases > > attributes : '*' > > org.apache.directory.api.ldap.model.message.SearchRequestImpl@326a523d > SyncRequestValue control : > > oid : 1.3.6.1.4.1.4203.1.9.1.1 > > critical : false > > mode : 'REFRESH_AND_PERSIST' > > cookie : '' > > reloadHint : 'false' > > ManageDsaITImpl Control > > Type OID : '2.16.840.1.113730.3.4.2' > > Criticality : 'false' > > ' > > > [17:34:38] DEBUG [org.apache.directory.server.PROVIDER_LOG] - Received a > Syncrepl request : MessageType : SEARCH_REQUEST > > Message ID : 2 > > SearchRequest > > baseDn : 'dc=example,dc=com' > > filter : '(objectClass=*)' > > scope : whole subtree > > typesOnly : false > > Size Limit : no limit > > Time Limit : no limit > > Deref Aliases : never Deref Aliases > > attributes : '*' > > org.apache.directory.api.ldap.model.message.SearchRequestImpl@326a523d > SyncRequestValue control : > > oid : 1.3.6.1.4.1.4203.1.9.1.1 > > critical : false > > mode : 'REFRESH_AND_PERSIST' > > cookie : '' > > reloadHint : 'false' > > ManageDsaITImpl Control > > Type OID : '2.16.840.1.113730.3.4.2' > > Criticality : 'false' > > ' > > from LdapSession : <0.9.2342.19200300.100.1.1=admin,2.5.4.11=system,/ > 127.0.0.1:60165> > > [17:34:38] DEBUG [org.apache.directory.server.PROVIDER_LOG] - Received a > replication request with no cookie > > [17:34:38] DEBUG [org.apache.directory.server.PROVIDER_LOG] - Starting an > initial refresh > > [17:34:38] DEBUG [org.apache.directory.server.PROVIDER_LOG] - Adding sort > control to sort the entries by entryDn attribute to preserve order of > insertion > > [17:34:38] DEBUG [org.apache.directory.server.PROVIDER_LOG] - creating a > new event log for the replica with id 149 > > [17:34:38] DEBUG [org.apache.directory.server.PROVIDER_LOG] - Creating the > replication queue for replica 149 > > [17:34:38] DEBUG [org.apache.directory.server.PROVIDER_LOG] - Starting the > replicaLog ReplicaEventLog [hostName=127.0.0.1, > searchFilter=(objectClass=*), lastSentCsn=null, searchCriteria=Notification > criteria : 'null', '(objectClass=*)', 'one', 'DEREF_ALWAYS', 'ALL EVENTS', > replicaId=149, refreshNPersist=true, maxInactivePeriod=-1, > purgeThresholdCount=10000, journalFile=C:\Program Files > (x86)\ApacheDS\instances\default\syncrepl-data\REPL_EVENT_LOG.149, > dirty=false, consumerEntryDn=null] > > [17:34:38] DEBUG [org.apache.directory.server.PROVIDER_LOG] - Simple Search > MessageType : SEARCH_REQUEST > > Message ID : 2 > > SearchRequest > > baseDn : 'dc=example,dc=com' > > filter : '(objectClass=*)' > > scope : whole subtree > > typesOnly : false > > Size Limit : no limit > > Time Limit : no limit > > Deref Aliases : never Deref Aliases > > attributes : '*', '+' > > org.apache.directory.api.ldap.model.message.SearchRequestImpl@eba4a1f2 > SyncRequestValue control : > > oid : 1.3.6.1.4.1.4203.1.9.1.1 > > critical : false > > mode : 'REFRESH_AND_PERSIST' > > cookie : '' > > reloadHint : 'false' > > SortRequestControlImpl [sortKeys=[SortKey : [entryDN, 2.5.13.1, reverse]]] > ManageDsaITImpl Control > > Type OID : '2.16.840.1.113730.3.4.2' > > Criticality : 'false' > > ' > > for LdapSession : <0.9.2342.19200300.100.1.1=admin,2.5.4.11=system, > 127.0.0.1/127.0.0.1:60165> > > [17:34:38] DEBUG [org.apache.directory.server.OPERATION_LOG] - >> > SearchOperation : SearchContext for Dn 'dc=example,dc=com', filter > :'(objectClass=*)' > > [17:34:38] DEBUG > [org.apache.directory.server.core.authn.AuthenticationInterceptor] - > Operation Context: SearchContext for Dn 'dc=example,dc=com', filter :'All' > > [17:34:38] DEBUG > [org.apache.directory.server.xdbm.search.impl.DefaultSearchEngine] - Nb > results : 9223372036854775807 for filter : (#{SUBTREE_SCOPE (Estimated), > 'dc=example,dc=com', NEVER_DEREF_ALIASES}:[2]) > > [17:34:38] DEBUG [org.apache.directory.CURSOR_LOG] - Creating NoDupsCursor > > org.apache.directory.server.core.partition.impl.btree.jdbm.NoDupsCursor@403bbaac > > [17:34:38] DEBUG [org.apache.directory.CURSOR_LOG] - Creating > IndexCursorAdaptor IndexCursorAdaptor (absent) : > > > > [17:34:38] DEBUG [org.apache.directory.CURSOR_LOG] - Creating SetCursor > SetCursor : > > Index : -1 > > > [17:34:38] DEBUG [org.apache.directory.CURSOR_LOG] - Creating > EntryCursorAdaptor EntryCursorAdaptor > > > [17:34:38] DEBUG [org.apache.directory.CURSOR_LOG] - Creating > BaseEntryFilteringCursor BaseEntryFilteringCursor, no wrapped > > No filter > > No prefetched > > [17:34:38] DEBUG [org.apache.directory.server.OPERATION_LOG] - << > SearchOperation successful > > [17:34:38] DEBUG [org.apache.directory.server.OPERATION_TIME] - Search > operation took 377731 ns > > [17:34:38] ERROR [org.apache.directory.server.PROVIDER_LOG] - Failed to > handle the syncrepl request > > org.apache.directory.api.ldap.model.exception.LdapException: > java.io.IOException: ?????? ??θ? ã?? ?? ?????ϴ? > > I am assuming that the the reason for exception seems to be printing in locale specific language, can you transalte the message and send to us?
> at > > org.apache.directory.server.core.shared.DefaultCoreSession.search(DefaultCoreSession.java:1157) > > at > > org.apache.directory.server.ldap.replication.provider.SyncReplRequestHandler.doSimpleSearch(SyncReplRequestHandler.java:648) > > at > > org.apache.directory.server.ldap.replication.provider.SyncReplRequestHandler.doInitialRefresh(SyncReplRequestHandler.java:562) > > at > > org.apache.directory.server.ldap.replication.provider.SyncReplRequestHandler.handleSyncRequest(SyncReplRequestHandler.java:311) > > at > > org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.handleReplication(SearchRequestHandler.java:238) > > at > > org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.handle(SearchRequestHandler.java:198) > > at > > org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.handle(SearchRequestHandler.java:93) > > at > > org.apache.directory.server.ldap.handlers.LdapRequestHandler.handleMessage(LdapRequestHandler.java:207) > > at > > org.apache.directory.server.ldap.handlers.LdapRequestHandler.handleMessage(LdapRequestHandler.java:56) > > at > > org.apache.mina.handler.demux.DemuxingIoHandler.messageReceived(DemuxingIoHandler.java:221) > > at > > org.apache.directory.server.ldap.LdapProtocolHandler.messageReceived(LdapProtocolHandler.java:217) > > at > > org.apache.mina.core.filterchain.DefaultIoFilterChain$TailFilter.messageReceived(DefaultIoFilterChain.java:690) > > at > > org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:417) > > at > > org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1200(DefaultIoFilterChain.java:47) > > at > > org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:765) > > at > org.apache.mina.core.filterchain.IoFilterEvent.fire(IoFilterEvent.java:74) > > at org.apache.mina.core.session.IoEvent.run(IoEvent.java:63) > > at > > org.apache.mina.filter.executor.UnorderedThreadPoolExecutor$Worker.runTask(UnorderedThreadPoolExecutor.java:474) > > at > > org.apache.mina.filter.executor.UnorderedThreadPoolExecutor$Worker.run(UnorderedThreadPoolExecutor.java:428) > > at java.lang.Thread.run(Thread.java:744) > > Caused by: java.io.IOException: ?????? ??θ? ã?? ?? ?????ϴ? > > at java.io.WinNTFileSystem.createFileExclusively(Native Method) > > at java.io.File.createNewFile(File.java:1006) > > at java.io.File.createTempFile(File.java:1989) > > at java.io.File.createTempFile(File.java:2040) > > at > > org.apache.directory.server.core.shared.DefaultCoreSession.sortResults(DefaultCoreSession.java:1342) > > at > > org.apache.directory.server.core.shared.DefaultCoreSession.search(DefaultCoreSession.java:1130) > > ... 19 more > > [17:34:39] WARN [org.apache.directory.server.ldap.LdapProtocolHandler] - > Unexpected exception forcing session to close: sending disconnect notice to > client. > > org.apache.directory.api.ldap.model.exception.LdapException: > java.io.IOException: ?????? ??θ? ã?? ?? ?????ϴ? > > at > > org.apache.directory.server.ldap.replication.provider.SyncReplRequestHandler.handleSyncRequest(SyncReplRequestHandler.java:349) > > at > > org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.handleReplication(SearchRequestHandler.java:238) > > at > > org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.handle(SearchRequestHandler.java:198) > > at > > org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.handle(SearchRequestHandler.java:93) > > at > > org.apache.directory.server.ldap.handlers.LdapRequestHandler.handleMessage(LdapRequestHandler.java:207) > > at > > org.apache.directory.server.ldap.handlers.LdapRequestHandler.handleMessage(LdapRequestHandler.java:56) > > at > > org.apache.mina.handler.demux.DemuxingIoHandler.messageReceived(DemuxingIoHandler.java:221) > > at > > org.apache.directory.server.ldap.LdapProtocolHandler.messageReceived(LdapProtocolHandler.java:217) > > at > > org.apache.mina.core.filterchain.DefaultIoFilterChain$TailFilter.messageReceived(DefaultIoFilterChain.java:690) > > at > > org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:417) > > at > > org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1200(DefaultIoFilterChain.java:47) > > at > > org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:765) > > at > org.apache.mina.core.filterchain.IoFilterEvent.fire(IoFilterEvent.java:74) > > at org.apache.mina.core.session.IoEvent.run(IoEvent.java:63) > > at > > org.apache.mina.filter.executor.UnorderedThreadPoolExecutor$Worker.runTask(UnorderedThreadPoolExecutor.java:474) > > at > > org.apache.mina.filter.executor.UnorderedThreadPoolExecutor$Worker.run(UnorderedThreadPoolExecutor.java:428) > > at java.lang.Thread.run(Thread.java:744) > > Caused by: org.apache.directory.api.ldap.model.exception.LdapException: > java.io.IOException: ?????? ??θ? ã?? ?? ?????ϴ? > > at > > org.apache.directory.server.core.shared.DefaultCoreSession.search(DefaultCoreSession.java:1157) > > at > > org.apache.directory.server.ldap.replication.provider.SyncReplRequestHandler.doSimpleSearch(SyncReplRequestHandler.java:648) > > at > > org.apache.directory.server.ldap.replication.provider.SyncReplRequestHandler.doInitialRefresh(SyncReplRequestHandler.java:562) > > at > > org.apache.directory.server.ldap.replication.provider.SyncReplRequestHandler.handleSyncRequest(SyncReplRequestHandler.java:311) > > ... 16 more > > Caused by: java.io.IOException: ?????? ??θ? ã?? ?? ?????ϴ? > > at java.io.WinNTFileSystem.createFileExclusively(Native Method) > > at java.io.File.createNewFile(File.java:1006) > > at java.io.File.createTempFile(File.java:1989) > > at java.io.File.createTempFile(File.java:2040) > > at > > org.apache.directory.server.core.shared.DefaultCoreSession.sortResults(DefaultCoreSession.java:1342) > > at > > org.apache.directory.server.core.shared.DefaultCoreSession.search(DefaultCoreSession.java:1130) > > ... 19 more > > [17:34:39] DEBUG [org.apache.directory.api.CODEC_LOG] - Encoded message > > MessageType : EXTENDED_RESPONSE > > Message ID : 0 > > Extended Response > > ResponseName :'1.3.6.1.4.1.1466.20036' > > Ldap Result > > Result code : (PROTOCOL_ERROR) protocolError > > Matched Dn : 'null' > > Diagnostic message : 'PROTOCOL_ERROR: The server will > disconnect!' > > > : 0x30 0x4F 0x02 0x01 0x00 0x78 0x4A 0x0A 0x01 0x02 0x04 0x00 0x04 0x2B > 0x50 0x52 0x4F 0x54 0x4F 0x43 0x4F 0x4C 0x5F 0x45 0x52 0x52 0x4F 0x52 0x3A > 0x20 0x54 0x68 0x65 0x20 0x73 0x65 0x72 0x76 0x65 0x72 0x20 0x77 0x69 0x6C > 0x6C 0x20 0x64 0x69 0x73 0x63 0x6F 0x6E 0x6E 0x65 0x63 0x74 0x21 0x8A 0x16 > 0x31 0x2E 0x33 0x2E 0x36 0x2E 0x31 0x2E 0x34 0x2E 0x31 0x2E 0x31 0x34 0x36 > 0x36 0x2E 0x32 0x30 0x30 0x33 0x36 > > [17:34:39] DEBUG [org.apache.directory.server.ldap.LdapProtocolHandler] - > Cleaning the LdapSession : > <0.9.2342.19200300.100.1.1=admin,2.5.4.11=system, > 127.0.0.1/127.0.0.1:60165> session > > [17:34:39] DEBUG [org.apache.mina.core.filterchain.IoFilterEvent] - Event > MESSAGE_RECEIVED has been fired for session 151 > > [17:34:39] INFO > [org.apache.directory.server.ldap.handlers.LdapResponseHandler] - ignoring > the message MessageType : EXTENDED_RESPONSE > > Message ID : 0 > > Extended Response > > ResponseName :'1.3.6.1.4.1.1466.20036' > > Ldap Result > > Result code : (PROTOCOL_ERROR) protocolError > > Matched Dn : 'null' > > Diagnostic message : 'PROTOCOL_ERROR: The server will > disconnect!' > > received from null session > > [17:34:39] WARN [org.apache.directory.server.ldap.LdapProtocolHandler] - > Null LdapSession given to cleanUpSession. > -- Kiran Ayyagari http://keydap.com
