[DIRAPI-388] "No future" warning in the log

• Type: Bug
• Status: Resolved
• Priority: Minor
• Resolution: Fixed
• Affects Version/s: 2.1.2
• Fix Version/s: 2.1.3
• Assignee: Unassigned
• Reporter: Alexander Prishchepov
• Created: 08/Feb/23 16:50
• Updated: 27/Mar/23 10:22
• Resolved: 27/Mar/23 07:02

Description

We run queries that return single result.
Our code closes cursor after first Entry is retrieved.
We see a lot of "MSG_04165_NO_FUTURE_ASSOCIATED_TO_MSG_ID_COMPLETED" warnings in the log.

I turned on debug and in the log I see following sequence:
-----------------------------------------------------------------
[DEBUG 2023-02-07T15:14:46,091 org.apache.directory.ldap.client.api.LdapNetworkConnection] MSG_04104_SENDING_REQUEST (MessageType : SEARCH_REQUEST
Message ID : 90
    SearchRequest
        baseDn : 'ou=<ou>'
        filter : '(uid=<uid>)'
        scope : single level
        typesOnly : false
        Size Limit : no limit
        Time Limit : no limit
        Deref Aliases : deref Always
        attributes : <list_of_attributes>
org.apache.directory.api.ldap.model.message.SearchRequestImpl@607cd873)

[DEBUG 2023-02-07T15:14:46,091 org.apache.directory.ldap.client.api.LdapNetworkConnection] MSG_04106_ADDING (90,org.apache.directory.ldap.client.api.future.SearchFuture)

[DEBUG 2023-02-07T15:14:46,091 org.apache.directory.CURSOR_LOG] MSG_04170_CREATING_SEARCH_CURSOR (org.apache.directory.ldap.client.api.SearchCursorImpl@33950bea)

[DEBUG 2023-02-07T15:14:46,091 org.apache.directory.CURSOR_LOG] MSG_04161_CREATING_ENTRY_CURSOR (org.apache.directory.ldap.client.api.EntryCursorImpl@1d203a2b)

[DEBUG 2023-02-07T15:14:46,092 org.apache.directory.ldap.client.api.LdapNetworkConnection] MSG_04142_MESSAGE_RECEIVED (MessageType : SEARCH_RESULT_ENTRY
Message ID : 90
    Search Result Entry
Entry
    dn: uid=<uid>,ou=<ou>

)
[DEBUG 2023-02-07T15:14:46,092 org.apache.directory.ldap.client.api.LdapNetworkConnection] MSG_04119_GETTING (90,org.apache.directory.ldap.client.api.future.SearchFuture)
[DEBUG 2023-02-07T15:14:46,092 org.apache.directory.ldap.client.api.LdapNetworkConnection] MSG_04128_SEARCH_ENTRY_FOUND (MessageType : SEARCH_RESULT_ENTRY
Message ID : 90
    Search Result Entry
Entry
    dn: <uid>,ou=<ou>

)
[DEBUG 2023-02-07T15:14:46,092 org.apache.directory.ldap.client.api.LdapNetworkConnection] MSG_04142_MESSAGE_RECEIVED (MessageType : SEARCH_RESULT_DONE
Message ID : 90
    Search Result Done
        Ldap Result
            Result code : (SUCCESS) success
            Matched Dn : ''
            Diagnostic message : ''
)
[DEBUG 2023-02-07T15:14:46,092 org.apache.directory.CURSOR_LOG] MSG_04162_CLOSING_ENTRY_CURSOR (org.apache.directory.ldap.client.api.EntryCursorImpl@1d203a2b)
[DEBUG 2023-02-07T15:14:46,092 org.apache.directory.CURSOR_LOG] MSG_04171_CLOSING_SEARCH_CURSOR (org.apache.directory.ldap.client.api.SearchCursorImpl@33950bea)

[DEBUG 2023-02-07T15:14:46,092 org.apache.directory.ldap.client.api.LdapNetworkConnection] MSG_04104_SENDING_REQUEST (    Abandon Request :
        Message Id : 90org.apache.directory.api.ldap.model.message.AbandonRequestImpl@bda59659)
[DEBUG 2023-02-07T15:14:46,092 org.apache.directory.ldap.client.api.LdapNetworkConnection] MSG_04126_REMOVING (90,org.apache.directory.ldap.client.api.future.SearchFuture)
[WARN 2023-02-07T15:14:46,092 org.apache.directory.ldap.client.api.LdapNetworkConnection] MSG_04165_NO_FUTURE_ASSOCIATED_TO_MSG_ID_COMPLETED (90)
-----------------------------------------------------------------

Is this warning really needed?
It looks like a race condition and unnecessary logging.