[
https://issues.apache.org/jira/browse/DIRSERVER-2007?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel
]
Emmanuel Lecharny updated DIRSERVER-2007:
-----------------------------------------
Component/s: (was: ldap)
replication
> Error while replicating DS on windows
> -------------------------------------
>
> Key: DIRSERVER-2007
> URL: https://issues.apache.org/jira/browse/DIRSERVER-2007
> Project: Directory ApacheDS
> Issue Type: Bug
> Components: replication
> Affects Versions: 2.0.0-M17
> Environment: Windows Server 2008 R2 Standard.
> java 1.7.0_51
> Reporter: KyuWoo Choi
> Priority: Major
>
> I have some 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.
> I see IOException while searching job in server.
> please guide me how to solve this problem.
> [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: ?????? ??θ? ã?? ?? ?????ϴ?
> 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.
> It came out of user mailing list.
> http://mail-archives.apache.org/mod_mbox/directory-users/201409.mbox/browser
--
This message was sent by Atlassian JIRA
(v7.6.3#76005)
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
