My Oracle Support Banner

OID 11g Intermittent Timeouts From Applications or LDAP Searches (ldapsearch). OID Server Log Shows: OID-5019: Cataloging For Attr <attribute> Was Not Performed, As Resource Is Busy. Alert Log Shows High OPTime (Doc ID 2396734.1)

Last updated on SEPTEMBER 23, 2019

Applies to:

Oracle Internet Directory - Version 11.1.1 and later
Information in this document applies to any platform.

Symptoms

Oracle Internet Directory (OID) 11g, e.g., 11.1.1.9.0.

OID servicing multiple applications and users for authentication and synchronization.

Since going to production, applications are getting timeouts while communicating with OID.

Sometimes it takes a while to open ldap entries in ldap browsers.

When using command line ldapsearch it is almost always fast (responds in milliseconds), but sometimes it also times out.

The OID server logs show the following messages, for example:

ConnID:<CONN_ID> mesgID:2 OpID:1  OpName:search ConnIP:::ffff:<IP_ADDRESS:PORT> ConnDN:cn=<USERNAME>,cn=users,dc=<COMPANY>,dc=com
gslbCallCatalog: OID-5019: Cataloging for attr memberof was not performed, as resource is busy.
END
]]
[2018-05-07T13:16:22.703381+02:00] [OID] [NOTIFICATION:16] [] [OIDLDAPD] [host:<OID_HOSTNAME>] [pid: <PID>] [tid: <TID>]  ServerWorker (REG):[[
BEGIN
ConnID:<CONN_ID> mesgID:2 OpID:1  OpName:search ConnIP:::ffff:<IP_ADDRESS:PORT> ConnDN:cn=<USERNAME>,cn=users,dc=<COMPANY>,dc=com
gslbmAutoCatalog: Initiated catalog with status = 2 for attribute memberof:OID-5019: Cataloging for attr memberof was not performed, as resource is busy.
END
]]


The alert logs show high or negative high OPTime (operation times):

2018-05-07T13:58:23.988059][PID:<PID>][TID:<TID>][connDN:cn=<USERNAME>,cn=users,dc=<COMPANY>,dc=com][connID:<CONN_ID>][connAddr:::ffff:<IP _ADDRESS_PORT>][ECID:<ECID>][OP:Search][BaseDN:cn=users,dc=<COMPANY>,dc=com][Filter:(&(&(objectclass=person)(orclmemberof=cn=<GROUPNAME>,cn=groups,dc=<COMPANY>,dc=com))(cn=<USERNAME>))][scp:2][ra:uid mail givenname cn sn ][nentries:0][OPTime:-1056545519 micro sec]
...
[2018-05-07T13:59:30.246265][PID:<PID>][TID:<TID>][connDN:cn=orcladmin][connID:<CONN_ID>][connAddr:::ffff:<IP_ADDRESS:PORT>][ECID:<ECID>][OP:Search][BaseDN:dc=<COMPANY>,dc=com][Filter:(objectclass=top)][scp:2][ra:cn orclguid ][nentries:9722][OPTime:8163848 micro sec]



Changes

 

Cause

To view full details, sign in with your My Oracle Support account.

Don't have a My Oracle Support account? Click to get started!


In this Document
Symptoms
Changes
Cause
Solution
References


My Oracle Support provides customers with access to over a million knowledge articles and a vibrant support community of peers and Oracle experts.