From owner-freebsd-ports@FreeBSD.ORG Fri Nov 12 14:17:35 2004 Return-Path: Delivered-To: freebsd-ports@freebsd.org Received: from mx1.FreeBSD.org (mx1.freebsd.org [216.136.204.125]) by hub.freebsd.org (Postfix) with ESMTP id AAEF616A4CE; Fri, 12 Nov 2004 14:17:35 +0000 (GMT) Received: from smtp-vbr14.xs4all.nl (smtp-vbr14.xs4all.nl [194.109.24.34]) by mx1.FreeBSD.org (Postfix) with ESMTP id 0C7B243D46; Fri, 12 Nov 2004 14:17:35 +0000 (GMT) (envelope-from Geert.Rolf@xs4all.nl) Received: from speedy.museum.iaf.nl (warp2dot4.xs4all.nl [80.127.48.150]) iACEHX0W079682; Fri, 12 Nov 2004 15:17:33 +0100 (CET) (envelope-from Geert.Rolf@xs4all.nl) Received: from xs4all.nl (warp.office.local [192.168.33.32]) iACEHXjE065404; Fri, 12 Nov 2004 15:17:33 +0100 (CET) (envelope-from Geert.Rolf@xs4all.nl) Message-ID: <4194C60B.400EF2B9@xs4all.nl> Date: Fri, 12 Nov 2004 15:17:47 +0100 From: Geert Rolf Organization: Rolf Consultancy X-Mailer: Mozilla 4.7 [nl] (WinNT; I) X-Accept-Language: nl MIME-Version: 1.0 To: eik@FreeBSD.org Content-Type: text/plain; charset=us-ascii Content-Transfer-Encoding: 7bit X-Virus-Scanned: by XS4ALL Virus Scanner cc: ports@FreeBSD.org Subject: FreeBSD Port: openldap-sasl-server-2.2.18 X-BeenThere: freebsd-ports@freebsd.org X-Mailman-Version: 2.1.1 Precedence: list List-Id: Porting software to FreeBSD List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Fri, 12 Nov 2004 14:17:35 -0000 Dear Oliver, After a full day of Trial and Error I pull up a white flag and surrender... I've tried openldap-server versions 2.0, 2.1 2.2 alpha (as with FreeBSD 4.9) and the 2.2.18 from the current ports collection. I'm trying to make an Addressbook for Netscape. With all versions I get the same problem and it's getting hard to believe that its a pilot-error. ;-) The plane crashes as follows: I do a: ldapsearch -x -b 'ou=abook,dc=office,dc=local' '(cn=Geert Rolf)' I get: # extended LDIF # # LDAPv3 # base with scope sub # filter: (cn=Geert Rolf) # requesting: ALL # # search result search: 2 result: 0 Success # numResponses: 1 And extended logging says: Nov 12 14:53:50 speedy slapd[61787]: ====> bdb_cache_find_entry_id( 3 ) "cn=Geert Rolf,ou=abook,dc=office,dc=local" (found) (1 tries ) Nov 12 14:53:50 speedy slapd[61787]: bdb_search: 3 does not match filter >From logfile, I conclude: The record is there, but the filter does not match (it should IMHO) Same results on all mentioned versions and switching to ldbm does not help. There are Google results on "bdb_search does not match filter", but they are a bit off subject compared with this strange case. Do you have any hints?? Kind regards, Geert Rolf FYI platform= FreeBSD 4.9 Complete logging: Nov 12 15:05:44 speedy slapd[61787]: connection_get(13): got connid=9 Nov 12 15:05:44 speedy slapd[61787]: connection_read(13): checking for input on id=9 Nov 12 15:05:44 speedy slapd[61787]: ber_get_next on fd 13 failed errno=35 (Resource temporarily unavailable) Nov 12 15:05:44 speedy slapd[61787]: do_bind Nov 12 15:05:44 speedy slapd[61787]: >>> dnPrettyNormal: <> Nov 12 15:05:44 speedy slapd[61787]: <<< dnPrettyNormal: <>, <> Nov 12 15:05:44 speedy slapd[61787]: do_bind: version=3 dn="" method=128 Nov 12 15:05:44 speedy slapd[61787]: send_ldap_result: conn=9 op=0 p=3 Nov 12 15:05:44 speedy slapd[61787]: send_ldap_response: msgid=1 tag=97 err=0 Nov 12 15:05:44 speedy slapd[61787]: do_bind: v3 anonymous bind Nov 12 15:05:44 speedy slapd[61787]: connection_get(13): got connid=9 Nov 12 15:05:44 speedy slapd[61787]: connection_read(13): checking for input on id=9 Nov 12 15:05:44 speedy slapd[61787]: ber_get_next on fd 13 failed errno=35 (Resource temporarily unavailable) Nov 12 15:05:44 speedy slapd[61787]: do_search Nov 12 15:05:44 speedy slapd[61787]: >>> dnPrettyNormal: Nov 12 15:05:44 speedy slapd[61787]: <<< dnPrettyNormal: , Nov 12 15:05:44 speedy slapd[61787]: => bdb_back_search Nov 12 15:05:44 speedy slapd[61787]: bdb_dn2entry_rw("ou=abook,dc=office,dc=local") Nov 12 15:05:44 speedy slapd[61787]: => bdb_dn2id_matched( "ou=abook,dc=office,dc=local" ) Nov 12 15:05:44 speedy slapd[61787]: ====> bdb_cache_find_entry_dn2id("ou=abook,dc=office,dc=local"): 2 (1 tries) Nov 12 15:05:44 speedy slapd[61787]: ====> bdb_cache_find_entry_id( 2 ) "ou=abook,dc=office,dc=local" (found) (1 tries) Nov 12 15:05:44 speedy slapd[61787]: search_candidates: base="ou=abook,dc=office,dc=local" (0x00000002) scope=2 Nov 12 15:05:44 speedy slapd[61787]: => bdb_dn2idl( "ou=abook,dc=office,dc=local" ) Nov 12 15:05:44 speedy slapd[61787]: <= bdb_dn2idl: id=5 first=2 last=6 Nov 12 15:05:44 speedy slapd[61787]: => bdb_equality_candidates (objectClass) Nov 12 15:05:44 speedy slapd[61787]: => key_read Nov 12 15:05:44 speedy slapd[61787]: <= bdb_index_read: failed (-30991) Nov 12 15:05:44 speedy slapd[61787]: <= bdb_equality_candidates: id=0, first=0, last=0 Nov 12 15:05:44 speedy slapd[61787]: => bdb_equality_candidates (cn) Nov 12 15:05:44 speedy slapd[61787]: => key_read Nov 12 15:05:44 speedy slapd[61787]: <= bdb_index_read 1 candidates Nov 12 15:05:44 speedy slapd[61787]: <= bdb_equality_candidates: id=1, first=3, last=3 Nov 12 15:05:44 speedy slapd[61787]: bdb_search_candidates: id=1 first=3 last=3 Nov 12 15:05:44 speedy slapd[61787]: ====> bdb_cache_return_entry_r( 2 ): returned (0) Nov 12 15:05:44 speedy slapd[61787]: ====> bdb_cache_find_entry_id( 3 ) "cn=Geert Rolf,ou=abook,dc=office,dc=local" (found) (1 tries ) Nov 12 15:05:44 speedy slapd[61787]: bdb_search: 3 does not match filter Nov 12 15:05:44 speedy slapd[61787]: ====> bdb_cache_return_entry_r( 3 ): returned (0) Nov 12 15:05:44 speedy slapd[61787]: send_search_result: err=0 matched="" text="" Nov 12 15:05:44 speedy slapd[61787]: send_ldap_response: msgid=2 tag=101 err=0 Nov 12 15:05:44 speedy slapd[61787]: connection_get(13): got connid=9 Nov 12 15:05:44 speedy slapd[61787]: connection_read(13): checking for input on id=9 Nov 12 15:05:44 speedy slapd[61787]: ber_get_next on fd 13 failed errno=0 (Undefined error: 0) Nov 12 15:05:44 speedy slapd[61787]: connection_read(13): input error=-2 id=9, closing. Nov 12 15:05:44 speedy slapd[61787]: connection_closing: readying conn=9 sd=13 for close Nov 12 15:05:44 speedy slapd[61787]: connection_close: deferring conn=9 sd=13 Nov 12 15:05:44 speedy slapd[61787]: do_unbind Nov 12 15:05:44 speedy slapd[61787]: connection_resched: attempting closing conn=9 sd=13 Nov 12 15:05:44 speedy slapd[61787]: connection_close: conn=9 sd=13