Re: slapd crashing with daemon: select failed (89) (ITS#3206)

[Kurt@OpenLDAP.org]

At 02:00 PM 6/25/2004, mvanni@concordefs.com wrote:
>Full_Name: Mark Vanni
>Version: 2.1.23

2.1.23 is quite old.  Please update to at least the
current "stable" release and retest.  Thanks, Kurt

>OS: Sun8
>URL: ftp://ftp.openldap.org/incoming/
>Submission from: (NULL) (160.79.69.199)
>
>
>Our slapd daemon is failing overy 30-40 minutes with the error message "daemon:
>select failed (89): Operation not applicable".  Listed below a section of log
>file running at level 9.
>
>Jun 24 17:22:51 up27 slapd[4060]: ber_get_next on fd 11 failed errno=11
>(Resource temporarily unavailable)
>Jun 24 17:22:51 up27 slapd[4060]: do_search
>Jun 24 17:22:51 up27 slapd[4060]: daemon: select: listen=7 active_threads=1
>tvp=NULL
>Jun 24 17:22:51 up27 slapd[4060]: >>> dnPrettyNormal:
><uid=1249830,ou=members,o=program,dc=cft,dc=com>
>Jun 24 17:22:51 up27 slapd[4060]: daemon: activity on 1 descriptors
>Jun 24 17:22:51 up27 slapd[4060]: <<< dnPrettyNormal:
><uid=1249830,ou=members,o=program,dc=cft,dc=com>,
><uid=1249830,ou=members,o=program,dc=cft,dc=com>
>Jun 24 17:22:51 up27 slapd[4060]: daemon: activity on:
>Jun 24 17:22:51 up27 slapd[4060]:  13r
>Jun 24 17:22:51 up27 slapd[4060]: 
>Jun 24 17:22:51 up27 slapd[4060]: daemon: read activity on 13
>Jun 24 17:22:51 up27 slapd[4060]: connection_get(13): got connid=165618
>Jun 24 17:22:51 up27 slapd[4060]: connection_read(13): checking for input on
>id=165618
>Jun 24 17:22:51 up27 slapd[4060]: => bdb_back_search
>Jun 24 17:22:51 up27 slapd[4060]: do_unbind
>Jun 24 17:22:51 up27 slapd[4060]: ber_get_next on fd 13 failed errno=11
>(Resource temporarily unavailable)
>Jun 24 17:22:51 up27 slapd[4060]:
>bdb_dn2entry_rw("uid=1249830,ou=members,o=program,dc=cft,dc=com")
>Jun 24 17:22:51 up27 slapd[4060]: => bdb_dn2id_matched(
>"uid=1249830,ou=members,o=program,dc=cft,dc=com" )
>Jun 24 17:22:51 up27 slapd[4060]: connection_closing: readying conn=165618 sd=13
>for close
>Jun 24 17:22:51 up27 slapd[4060]: ====>
>bdb_cache_find_entry_dn2id("ou=members,o=program,dc=cft,dc=com"): 4 (1 tries)
>Jun 24 17:22:51 up27 slapd[4060]: connection_resched: attempting closing
>conn=165618 sd=13
>Jun 24 17:22:51 up27 slapd[4060]: ====> bdb_cache_find_entry_id( 4 )
>"ou=members,o=program,dc=cft,dc=com" (found) (1 tries)
>Jun 24 17:22:51 up27 slapd[4060]: connection_close: conn=165618 sd=13
>Jun 24 17:22:51 up27 slapd[4060]: ====> bdb_cache_return_entry_r( 4 ): returned
>(0)
>Jun 24 17:22:51 up27 slapd[4060]: daemon: removing 13
>Jun 24 17:22:51 up27 slapd[4060]: send_ldap_result: conn=165619 op=1 p=3
>Jun 24 17:22:51 up27 slapd[4060]: daemon: select: listen=7 active_threads=2
>tvp=NULL
>Jun 24 17:22:51 up27 slapd[4060]: send_ldap_response: msgid=1170099 tag=101
>err=32
>Jun 24 17:22:51 up27 slapd[4060]: daemon: select failed (89): Operation not
>applicable
>Jun 24 17:22:51 up27 slapd[4060]: daemon: abnormal condition, shutdown
>initiated.
>Jun 24 17:22:51 up27 slapd[4060]: daemon: closing 7
>Jun 24 17:22:51 up27 slapd[4060]: connection_closing: readying conn=165619 sd=11
>for close
>Jun 24 17:22:51 up27 slapd[4060]: connection_close: conn=165619 sd=11
>Jun 24 17:22:51 up27 slapd[4060]: daemon: removing 11
>Jun 24 17:22:51 up27 slapd[4060]: connection_closing: readying conn=165620 sd=14
>for close
>Jun 24 17:22:51 up27 slapd[4060]: connection_close: conn=165620 sd=14
>Jun 24 17:22:51 up27 slapd[4060]: daemon: removing 14
>Jun 24 17:22:51 up27 slapd[4060]: connection_closing: readying conn=165621 sd=15
>for close
>Jun 24 17:22:51 up27 slapd[4060]: connection_close: conn=165621 sd=15
>Jun 24 17:22:51 up27 slapd[4060]: daemon: removing 15
>Jun 24 17:22:51 up27 slapd[4060]: slapd shutdown: waiting for 0 threads to
>terminate
>Jun 24 17:22:51 up27 slapd[4060]: slapd shutdown: initiated
>Jun 24 17:22:51 up27 slapd[4060]: ====> bdb_cache_release_all
>Jun 24 17:22:51 up27 slapd[4060]: slapd shutdown: freeing system resources.
>Jun 24 17:22:51 up27 slapd[4060]: ====> bdb_cache_release_all
>Jun 24 17:22:51 up27 slapd[4060]: slapd stopped.
>Jun 24 17:23:04 up27 su: 'su root' succeeded for root on /dev/???
>Jun 24 17:23:07 up27 last message repeated 1 time
>Jun 24 17:23:08 up27 slapd[7496]: bdb_initialize: Sleepycat Software: Berkeley
>DB 4.2.52: (December  3, 2003)
>Jun 24 17:23:08 up27 slapd[7496]: bdb_db_init: Initializing BDB database
>Jun 24 17:23:08 up27 slapd[7496]: matching_rule_use_init
>Jun 24 17:35:50 up27 slapd[7497]: conn=21227 op=0 RESULT tag=97 err=0 text=
>Jun 24 17:35:50 up27 slapd[7497]: daemon: select: listen=7 active_threads=0
>tvp=NULL
>Jun 24 17:35:50 up27 slapd[7497]: daemon: activity on 1 descriptors
>Jun 24 17:35:50 up27 slapd[7497]: daemon: activity on: