[Samba] import_smbpasswd.pl problem

[Илья Шипицин]

Dear Sirs,

I'm trying to migrate to LDAP (OpenLDAP-2.1), and I encounter some problem
when running import_smbpasswd.pl script. I attached slapd's log file,
any can help me to understand what is required to be done ?

Regards, (Наилучшие пожелания)
Ilia Chipitsine (Илья Шипицин)
-------------- next part --------------
Mar 11 16:42:31 apollo slapd[14080]: daemon: activity on 1 descriptors 
Mar 11 16:42:31 apollo slapd[14080]: daemon: new connection on 12 
Mar 11 16:42:31 apollo slapd[14080]: conn=4 fd=12 ACCEPT from IP=127.0.0.1:1284 (IP=127.0.0.1:389) 
Mar 11 16:42:31 apollo slapd[14080]: daemon: added 12r 
Mar 11 16:42:31 apollo slapd[14080]: daemon: activity on:
Mar 11 16:42:31 apollo slapd[14080]:  
Mar 11 16:42:31 apollo slapd[14080]: daemon: select: listen=8 active_threads=0 tvp=NULL 
Mar 11 16:42:31 apollo slapd[14080]: daemon: activity on 1 descriptors 
Mar 11 16:42:31 apollo slapd[14080]: daemon: activity on:
Mar 11 16:42:31 apollo slapd[14080]:  12r
Mar 11 16:42:31 apollo slapd[14080]:  
Mar 11 16:42:31 apollo slapd[14080]: daemon: read activity on 12 
Mar 11 16:42:31 apollo slapd[14080]: connection_get(12) 
Mar 11 16:42:31 apollo slapd[14080]: connection_get(12): got connid=4 
Mar 11 16:42:31 apollo slapd[14080]: connection_read(12): checking for input on id=4 
Mar 11 16:42:31 apollo slapd[14080]: ber_get_next on fd 12 failed errno=35 (Resource temporarily unavailable) 
Mar 11 16:42:31 apollo slapd[14080]: do_bind 
Mar 11 16:42:31 apollo slapd[14080]: >>> dnPrettyNormal: <cn=Manager,dc=example,dc=com> 
Mar 11 16:42:31 apollo slapd[14080]: <<< dnPrettyNormal: <cn=Manager,dc=example,dc=com>, <cn=manager,dc=example,dc=com> 
Mar 11 16:42:31 apollo slapd[14080]: do_bind: version=2 dn="cn=Manager,dc=example,dc=com" method=128 
Mar 11 16:42:31 apollo slapd[14080]: conn=4 op=0 BIND dn="cn=Manager,dc=example,dc=com" method=128 
Mar 11 16:42:31 apollo slapd[14080]: send_ldap_result: conn=4 op=0 p=2 
Mar 11 16:42:31 apollo slapd[14080]: send_ldap_result: err=2 matched="" text="requested protocol version not allowed" 
Mar 11 16:42:31 apollo slapd[14080]: send_ldap_response: msgid=1 tag=97 err=2 
Mar 11 16:42:31 apollo slapd[14080]: conn=4 op=0 RESULT tag=97 err=2 text=requested protocol version not allowed 
Mar 11 16:42:31 apollo slapd[14080]: daemon: select: listen=8 active_threads=1 tvp=NULL 
Mar 11 16:42:31 apollo slapd[14080]: daemon: activity on 1 descriptors 
Mar 11 16:42:31 apollo slapd[14080]: daemon: activity on:
Mar 11 16:42:31 apollo slapd[14080]:  12r
Mar 11 16:42:31 apollo slapd[14080]:  
Mar 11 16:42:31 apollo slapd[14080]: daemon: read activity on 12 
Mar 11 16:42:31 apollo slapd[14080]: connection_get(12) 
Mar 11 16:42:31 apollo slapd[14080]: connection_get(12): got connid=4 
Mar 11 16:42:31 apollo slapd[14080]: connection_read(12): checking for input on id=4 
Mar 11 16:42:31 apollo slapd[14080]: ber_get_next on fd 12 failed errno=35 (Resource temporarily unavailable) 
Mar 11 16:42:31 apollo slapd[14080]: do_search 
Mar 11 16:42:31 apollo slapd[14080]: >>> dnPrettyNormal: <dc=example,dc=com> 
Mar 11 16:42:31 apollo slapd[14080]: <<< dnPrettyNormal: <dc=example,dc=com>, <dc=example,dc=com> 
Mar 11 16:42:31 apollo slapd[14080]: SRCH "dc=example,dc=com" 2 2
Mar 11 16:42:31 apollo slapd[14080]:     0 0 0 
Mar 11 16:42:31 apollo slapd[14080]: begin get_filter 
Mar 11 16:42:31 apollo slapd[14080]: EQUALITY 
Mar 11 16:42:31 apollo slapd[14080]: end get_filter 0 
Mar 11 16:42:31 apollo slapd[14080]:     filter: (uid=ilia) 
Mar 11 16:42:31 apollo slapd[14080]:     attrs:
Mar 11 16:42:31 apollo slapd[14080]:  
Mar 11 16:42:31 apollo slapd[14080]: conn=4 op=1 SRCH base="dc=example,dc=com" scope=2 filter="(uid=ilia)" 
Mar 11 16:42:31 apollo slapd[14080]: => bdb_back_search 
Mar 11 16:42:31 apollo slapd[14080]: bdb_dn2entry_rw("dc=example,dc=com") 
Mar 11 16:42:31 apollo slapd[14080]: => bdb_dn2id_matched( "dc=example,dc=com" ) 
Mar 11 16:42:31 apollo slapd[14080]: ====> bdb_cache_find_entry_dn2id("dc=example,dc=com"): 1 (1 tries) 
Mar 11 16:42:31 apollo slapd[14080]: ====> bdb_cache_find_entry_id( 1 ) "dc=example,dc=com" (found) (1 tries) 
Mar 11 16:42:31 apollo slapd[14080]: search_candidates: base="dc=example,dc=com" (0x00000001) scope=2 
Mar 11 16:42:31 apollo slapd[14080]: => bdb_filter_candidates 
Mar 11 16:42:31 apollo slapd[14080]: 	AND 
Mar 11 16:42:31 apollo slapd[14080]: => bdb_list_candidates 0xa0 
Mar 11 16:42:31 apollo slapd[14080]: => bdb_filter_candidates 
Mar 11 16:42:31 apollo slapd[14080]: 	DN SUBTREE 
Mar 11 16:42:31 apollo slapd[14080]: => bdb_dn2idl( "dc=example,dc=com" ) 
Mar 11 16:42:31 apollo slapd[14080]: <= bdb_filter_candidates: id=-1 first=1 last=2 
Mar 11 16:42:31 apollo slapd[14080]: => bdb_filter_candidates 
Mar 11 16:42:31 apollo slapd[14080]: 	OR 
Mar 11 16:42:31 apollo slapd[14080]: => bdb_list_candidates 0xa1 
Mar 11 16:42:31 apollo slapd[14080]: => bdb_filter_candidates 
Mar 11 16:42:31 apollo slapd[14080]: 	EQUALITY 
Mar 11 16:42:31 apollo slapd[14080]: => bdb_equality_candidates 
Mar 11 16:42:31 apollo slapd[14080]: => key_read 
Mar 11 16:42:31 apollo slapd[14080]: bdb_idl_fetch_key: [b49d1940] 
Mar 11 16:42:31 apollo slapd[14080]: <= bdb_index_read: failed (-30990) 
Mar 11 16:42:31 apollo slapd[14080]: <= bdb_equality_candidates: NULL 
Mar 11 16:42:31 apollo slapd[14080]: <= bdb_equality_candidates: id=0, first=0, last=0 
Mar 11 16:42:31 apollo slapd[14080]: <= bdb_filter_candidates: id=0 first=0 last=0 
Mar 11 16:42:31 apollo slapd[14080]: => bdb_filter_candidates 
Mar 11 16:42:31 apollo slapd[14080]: 	EQUALITY 
Mar 11 16:42:31 apollo slapd[14080]: => bdb_equality_candidates 
Mar 11 16:42:31 apollo slapd[14080]: <= bdb_equality_candidates: index_param failed (18) 
Mar 11 16:42:31 apollo slapd[14080]: <= bdb_filter_candidates: id=-1 first=1 last=2 
Mar 11 16:42:31 apollo slapd[14080]: <= bdb_list_candidates: undefined rc=18 
Mar 11 16:42:31 apollo slapd[14080]: <= bdb_filter_candidates: id=0 first=0 last=0 
Mar 11 16:42:31 apollo slapd[14080]: <= bdb_list_candidates: id=-1 first=1 last=2 
Mar 11 16:42:31 apollo slapd[14080]: <= bdb_filter_candidates: id=-1 first=1 last=2 
Mar 11 16:42:31 apollo slapd[14080]: bdb_search_candidates: id=-1 first=1 last=2 
Mar 11 16:42:31 apollo slapd[14080]: ====> bdb_cache_return_entry_r( 1 ): returned (0) 
Mar 11 16:42:31 apollo slapd[14080]: ====> bdb_cache_find_entry_id( 1 ) "dc=example,dc=com" (found) (1 tries) 
Mar 11 16:42:31 apollo slapd[14080]: => test_filter 
Mar 11 16:42:31 apollo slapd[14080]:     EQUALITY 
Mar 11 16:42:31 apollo slapd[14080]: => access_allowed: search access to "dc=example,dc=com" "uid" requested 
Mar 11 16:42:31 apollo slapd[14080]: => access_allowed: backend default search access granted to "" 
Mar 11 16:42:31 apollo slapd[14080]: <= test_filter 5 
Mar 11 16:42:31 apollo slapd[14080]: bdb_search: 1 does match filter 
Mar 11 16:42:31 apollo slapd[14080]: ====> bdb_cache_return_entry_r( 1 ): returned (0) 
Mar 11 16:42:31 apollo slapd[14080]: daemon: select: listen=8 active_threads=1 tvp=NULL 
Mar 11 16:42:31 apollo slapd[14080]: ====> bdb_cache_find_entry_id( 2 ) "cn=Manager,dc=example,dc=com" (found) (1 tries) 
Mar 11 16:42:31 apollo slapd[14080]: => test_filter 
Mar 11 16:42:31 apollo slapd[14080]:     EQUALITY 
Mar 11 16:42:31 apollo slapd[14080]: => access_allowed: search access to "cn=Manager,dc=example,dc=com" "uid" requested 
Mar 11 16:42:31 apollo slapd[14080]: => access_allowed: backend default search access granted to "" 
Mar 11 16:42:31 apollo slapd[14080]: <= test_filter 5 
Mar 11 16:42:31 apollo slapd[14080]: bdb_search: 2 does match filter 
Mar 11 16:42:31 apollo slapd[14080]: ====> bdb_cache_return_entry_r( 2 ): returned (0) 
Mar 11 16:42:31 apollo slapd[14080]: send_search_result: err=0 matched="" text="" 
Mar 11 16:42:31 apollo slapd[14080]: send_ldap_response: msgid=2 tag=101 err=0 
Mar 11 16:42:31 apollo slapd[14080]: conn=4 op=1 SEARCH RESULT tag=101 err=0 nentries=0 text= 
Mar 11 16:42:31 apollo slapd[14080]: daemon: activity on 1 descriptors 
Mar 11 16:42:31 apollo slapd[14080]: daemon: activity on:
Mar 11 16:42:31 apollo slapd[14080]:  12r
Mar 11 16:42:31 apollo slapd[14080]:  
Mar 11 16:42:31 apollo slapd[14080]: daemon: read activity on 12 
Mar 11 16:42:31 apollo slapd[14080]: connection_get(12) 
Mar 11 16:42:31 apollo slapd[14080]: connection_get(12): got connid=4 
Mar 11 16:42:31 apollo slapd[14080]: connection_read(12): checking for input on id=4 
Mar 11 16:42:31 apollo slapd[14080]: ber_get_next on fd 12 failed errno=35 (Resource temporarily unavailable) 
Mar 11 16:42:31 apollo slapd[14080]: do_unbind 
Mar 11 16:42:31 apollo slapd[14080]: conn=4 op=2 UNBIND 
Mar 11 16:42:31 apollo slapd[14080]: connection_closing: readying conn=4 sd=12 for close 
Mar 11 16:42:31 apollo slapd[14080]: connection_resched: attempting closing conn=4 sd=12 
Mar 11 16:42:31 apollo slapd[14080]: connection_close: conn=4 sd=12 
Mar 11 16:42:31 apollo slapd[14080]: daemon: removing 12 
Mar 11 16:42:31 apollo slapd[14080]: conn=4 fd=12 closed 
Mar 11 16:42:31 apollo slapd[14080]: daemon: select: listen=8 active_threads=1 tvp=NULL 
Mar 11 16:42:31 apollo slapd[14080]: daemon: activity on 1 descriptors 
Mar 11 16:42:31 apollo slapd[14080]: daemon: select: listen=8 active_threads=1 tvp=NULL