[Freeipa-users] AD trust showing offline after reboot
Supratik Goswami
supratiksekhar at gmail.com
Fri May 16 10:59:33 UTC 2014
Yes DNS is working fine and is able to return the IP address of the AD
server.
[root at master samba]# dig SRV _ldap._tcp.ad.idm.example.com
; <<>> DiG 9.8.2rc1-RedHat-9.8.2-0.23.rc1.el6_5.1 <<>> SRV _ldap._
tcp.ad.idm.example.com
;; global options: +cmd
;; Got answer:
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 29147
;; flags: qr aa rd ra; QUERY: 1, ANSWER: 1, AUTHORITY: 0, ADDITIONAL: 1
;; QUESTION SECTION:
;_ldap._tcp.ad.idm.example.com. IN SRV
;; ANSWER SECTION:
_ldap._tcp.ad.idm.example.com. 600 IN SRV 0 100 389
master.ad.idm.example.com.
;; ADDITIONAL SECTION:
master.ad.idm.example.com. 3600 IN A 10.255.0.4
;; Query time: 1 msec
;; SERVER: 10.255.0.4#53(10.255.0.4)
;; WHEN: Fri May 16 10:46:23 2014
;; MSG SIZE rcvd: 106
In my case AD is the netbios name of the AD domain. Please find the log
message from the file log.wb-AD.
[2014/05/16 10:50:37.542420, 5, pid=3305, effective(0, 0), real(0, 0)]
../lib/util/debug.c:331(debug_dump_status)
INFO: Current debug levels:
all: 10
tdb: 10
printdrivers: 10
lanman: 10
smb: 10
rpc_parse: 10
rpc_srv: 10
rpc_cli: 10
passdb: 10
sam: 10
auth: 10
winbind: 10
vfs: 10
idmap: 10
quota: 10
acls: 10
locking: 10
msdfs: 10
dmapi: 10
registry: 10
[2014/05/16 10:50:37.543303, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/events.c:306(get_timed_events_timeout)
timed_events_timeout: 4/879652
[2014/05/16 10:50:37.543423, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/events.c:306(get_timed_events_timeout)
timed_events_timeout: 4/879521
[2014/05/16 10:50:42.428450, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/events.c:216(run_events_poll)
Running timed event "check_domain_online_handler" 0x1753150
[2014/05/16 10:50:42.428642, 10, pid=3305, effective(0, 0), real(0, 0),
class=winbind]
../source3/winbindd/winbindd_cm.c:299(check_domain_online_handler)
check_domain_online_handler: called for domain AD (online = False)
[2014/05/16 10:50:42.430896, 5, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/messages.c:293(messaging_register)
Registering messaging pointer for type 1030 - private_data=(nil)
[2014/05/16 10:50:42.431077, 5, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/messages.c:308(messaging_register)
Overriding messaging pointer for type 1030 - private_data=(nil)
[2014/05/16 10:50:42.431167, 5, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/messages.c:293(messaging_register)
Registering messaging pointer for type 1031 - private_data=(nil)
[2014/05/16 10:50:42.431253, 5, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/messages.c:308(messaging_register)
Overriding messaging pointer for type 1031 - private_data=(nil)
[2014/05/16 10:50:43.442198, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/messages_local.c:75(messaging_tdb_signal_handler)
messaging_tdb_signal_handler: sig[10] count[1] msgs[1]
[2014/05/16 10:50:43.442306, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/messages_local.c:496(message_dispatch)
message_dispatch: received_messages = 1
[2014/05/16 10:50:43.442460, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/messages_local.c:242(messaging_tdb_fetch)
messaging_tdb_fetch:
[2014/05/16 10:50:43.442575, 1, pid=3305, effective(0, 0), real(0, 0)]
../librpc/ndr/ndr.c:245(ndr_print_debug)
result: struct messaging_array
num_messages : 0x00000001 (1)
messages: ARRAY(1)
messages: struct messaging_rec
msg_version : 0x00000002 (2)
msg_type : MSG_WINBIND_TRY_TO_GO_ONLINE
(1030)
dest: struct server_id
pid : 0x0000000000000ce9 (3305)
task_id : 0x00000000 (0)
vnn : 0xffffffff (4294967295)
unique_id : 0x0000000000000000 (0)
src: struct server_id
pid : 0x0000000000000f4a (3914)
task_id : 0x00000000 (0)
vnn : 0xffffffff (4294967295)
unique_id : 0x0000000000000000 (0)
buf : DATA_BLOB length=3
[0000] 41 44 00 AD.
[2014/05/16 10:50:43.443463, 5, pid=3305, effective(0, 0), real(0, 0),
class=winbind] ../source3/winbindd/winbindd_cm.c:155(msg_try_to_go_online)
msg_try_to_go_online: received for domain AD.
[2014/05/16 10:50:43.443556, 3, pid=3305, effective(0, 0), real(0, 0),
class=winbind] ../source3/winbindd/winbindd_cm.c:1730(connection_ok)
connection_ok: Connection to for domain AD is not connected
[2014/05/16 10:50:43.443692, 5, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:208(saf_fetch)
saf_fetch: failed to find server for "AD" domain
[2014/05/16 10:50:43.443792, 10, pid=3305, effective(0, 0), real(0, 0),
class=winbind] ../source3/winbindd/winbindd_cm.c:1560(cm_open_connection)
cm_open_connection: dcname is '' for domain AD
[2014/05/16 10:50:43.443912, 8, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:3289(get_sorted_dc_list)
get_sorted_dc_list: attempting lookup for name AD (sitename NULL)
[2014/05/16 10:50:43.444041, 5, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:208(saf_fetch)
saf_fetch: failed to find server for "AD" domain
[2014/05/16 10:50:43.444136, 3, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:3102(get_dc_list)
get_dc_list: preferred server list: ", *"
[2014/05/16 10:50:43.444224, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:2598(internal_resolve_name)
internal_resolve_name: looking up AD#1c (sitename (null))
[2014/05/16 10:50:43.444332, 5, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namecache.c:160(namecache_fetch)
no entry for AD#1C found.
[2014/05/16 10:50:43.444426, 3, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:2266(resolve_lmhosts)
resolve_lmhosts: Attempting lmhosts lookup for name AD<0x1c>
[2014/05/16 10:50:43.444525, 3, pid=3305, effective(0, 0), real(0, 0)]
../libcli/nbt/lmhosts.c:185(resolve_lmhosts_file_as_sockaddr)
resolve_lmhosts: Attempting lmhosts lookup for name AD<0x1c>
[2014/05/16 10:50:43.444653, 4, pid=3305, effective(0, 0), real(0, 0)]
../libcli/nbt/lmhosts.c:111(getlmhostsent)
getlmhostsent: lmhost entry: 127.0.0.1 localhost
[2014/05/16 10:50:43.444854, 3, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:2068(resolve_wins_send)
resolve_wins: WINS server resolution selected and no WINS servers listed.
[2014/05/16 10:50:43.444959, 5, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:2315(resolve_hosts)
resolve_hosts: not appropriate for name type <0x1c>
[2014/05/16 10:50:43.445052, 3, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:1806(name_resolve_bcast_send)
name_resolve_bcast: Attempting broadcast lookup for name AD<0x1c>
[2014/05/16 10:50:43.445243, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/util_sock.c:499(open_socket_in)
bind succeeded on port 0
[2014/05/16 10:50:43.445352, 5, pid=3305, effective(0, 0), real(0, 0)]
../lib/util/util_net.c:848(print_socket_options)
Socket options:
SO_KEEPALIVE = 0
SO_REUSEADDR = 1
SO_BROADCAST = 1
Could not test socket option TCP_NODELAY.
Could not test socket option TCP_KEEPCNT.
Could not test socket option TCP_KEEPIDLE.
Could not test socket option TCP_KEEPINTVL.
IPTOS_LOWDELAY = 0
IPTOS_THROUGHPUT = 0
SO_REUSEPORT = 1
SO_SNDBUF = 124928
SO_RCVBUF = 124928
SO_SNDLOWAT = 1
SO_RCVLOWAT = 1
SO_SNDTIMEO = 0
SO_RCVTIMEO = 0
Could not test socket option TCP_QUICKACK.
Could not test socket option TCP_DEFER_ACCEPT.
[2014/05/16 10:50:43.447711, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/unexpected.c:546(nb_packet_reader_connected)
async_connect failed: No such file or directory
[2014/05/16 10:50:43.448042, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:600(nb_trans_got_reader)
nmbd not around
[2014/05/16 10:50:43.448178, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/events.c:216(run_events_poll)
Running timed event "tevent_req_timedout" 0x17515b0
[2014/05/16 10:50:43.448403, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/util_sock.c:499(open_socket_in)
bind succeeded on port 0
[2014/05/16 10:50:43.448513, 5, pid=3305, effective(0, 0), real(0, 0)]
../lib/util/util_net.c:848(print_socket_options)
Socket options:
SO_KEEPALIVE = 0
SO_REUSEADDR = 1
SO_BROADCAST = 1
Could not test socket option TCP_NODELAY.
Could not test socket option TCP_KEEPCNT.
Could not test socket option TCP_KEEPIDLE.
Could not test socket option TCP_KEEPINTVL.
IPTOS_LOWDELAY = 0
IPTOS_THROUGHPUT = 0
SO_REUSEPORT = 1
SO_SNDBUF = 124928
SO_RCVBUF = 124928
SO_SNDLOWAT = 1
SO_RCVLOWAT = 1
SO_SNDTIMEO = 0
SO_RCVTIMEO = 0
Could not test socket option TCP_QUICKACK.
Could not test socket option TCP_DEFER_ACCEPT.
[2014/05/16 10:50:43.449329, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/unexpected.c:546(nb_packet_reader_connected)
async_connect failed: No such file or directory
[2014/05/16 10:50:43.449442, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:600(nb_trans_got_reader)
nmbd not around
[2014/05/16 10:50:44.449727, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/events.c:216(run_events_poll)
Running timed event "tevent_req_timedout" 0x1750c10
[2014/05/16 10:50:44.449994, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/events.c:216(run_events_poll)
Running timed event "tevent_req_timedout" 0x1753b90
[2014/05/16 10:50:44.450115, 8, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:3123(get_dc_list)
Adding 0 DC's from auto lookup
[2014/05/16 10:50:44.450208, 4, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:3134(get_dc_list)
get_dc_list: no servers found
[2014/05/16 10:50:44.450294, 8, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:3289(get_sorted_dc_list)
get_sorted_dc_list: attempting lookup for name
ad.idm.example.com(sitename NULL)
[2014/05/16 10:50:44.450435, 5, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:208(saf_fetch)
saf_fetch: failed to find server for "ad.idm.example.com" domain
[2014/05/16 10:50:44.450531, 3, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:3102(get_dc_list)
get_dc_list: preferred server list: ", *"
[2014/05/16 10:50:44.450620, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:2598(internal_resolve_name)
internal_resolve_name: looking up ad.idm.example.com#1c (sitename (null))
[2014/05/16 10:50:44.450733, 5, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namecache.c:165(namecache_fetch)
name ad.idm.example.com#1C found.
[2014/05/16 10:50:44.450946, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:1110(remove_duplicate_addrs2)
remove_duplicate_addrs2: looking for duplicate address/port pairs
[2014/05/16 10:50:44.451046, 8, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:3123(get_dc_list)
Adding 1 DC's from auto lookup
[2014/05/16 10:50:44.451155, 9, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/conncache.c:150(check_negative_conn_cache)
check_negative_conn_cache returning result 0 for domain
ad.idm.example.comserver 10.255.0.4
[2014/05/16 10:50:44.451254, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:1110(remove_duplicate_addrs2)
remove_duplicate_addrs2: looking for duplicate address/port pairs
[2014/05/16 10:50:44.451342, 4, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:3239(get_dc_list)
get_dc_list: returning 1 ip addresses in an ordered list
[2014/05/16 10:50:44.451427, 4, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:3240(get_dc_list)
get_dc_list: 10.255.0.4:389
[2014/05/16 10:50:44.451530, 9, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/conncache.c:150(check_negative_conn_cache)
check_negative_conn_cache returning result 0 for domain AD server
10.255.0.4
[2014/05/16 10:50:44.451669, 3, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/util_sock.c:585(open_socket_out_send)
Connecting to 10.255.0.4 at port 445
[2014/05/16 10:50:44.452793, 3, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/clidgram.c:333(nbt_getdc_send)
No nmbd found
[2014/05/16 10:50:44.452930, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:916(name_status_find)
name_status_find: looking up AD#1c at 10.255.0.4
[2014/05/16 10:50:44.453044, 5, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namecache.c:299(namecache_status_fetch)
namecache_status_fetch: no entry for NBT/AD#1C.20.10.255.0.4 found.
[2014/05/16 10:50:44.453279, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/util_sock.c:499(open_socket_in)
bind succeeded on port 0
[2014/05/16 10:50:44.453449, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/unexpected.c:546(nb_packet_reader_connected)
async_connect failed: No such file or directory
[2014/05/16 10:50:44.453564, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:600(nb_trans_got_reader)
nmbd not around
[2014/05/16 10:50:45.454766, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/events.c:216(run_events_poll)
Running timed event "tevent_req_timedout" 0x1750470
[2014/05/16 10:50:46.456103, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/events.c:216(run_events_poll)
Running timed event "tevent_req_timedout" 0x1750470
[2014/05/16 10:50:47.457451, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/events.c:216(run_events_poll)
Running timed event "tevent_req_timedout" 0x1750470
[2014/05/16 10:50:48.458773, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/events.c:216(run_events_poll)
Running timed event "tevent_req_timedout" 0x1750470
[2014/05/16 10:50:49.460093, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/events.c:216(run_events_poll)
Running timed event "tevent_req_timedout" 0x1750470
[2014/05/16 10:50:50.461420, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/events.c:216(run_events_poll)
Running timed event "tevent_req_timedout" 0x1750470
[2014/05/16 10:50:51.462723, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/events.c:216(run_events_poll)
Running timed event "tevent_req_timedout" 0x1750470
[2014/05/16 10:50:52.464265, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/events.c:216(run_events_poll)
Running timed event "tevent_req_timedout" 0x1750470
[2014/05/16 10:50:53.465546, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/events.c:216(run_events_poll)
Running timed event "tevent_req_timedout" 0x1750470
[2014/05/16 10:50:54.455168, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/events.c:216(run_events_poll)
Running timed event "tevent_req_timedout" 0x1750590
[2014/05/16 10:50:54.455385, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:962(name_status_find)
name_status_find: name not found
[2014/05/16 10:50:54.455497, 10, pid=3305, effective(0, 0), real(0, 0),
class=tdb] ../source3/lib/gencache.c:179(gencache_set_data_blob)
Adding cache entry with key = NEG_CONN_CACHE/AD,10.255.0.4 and timeout =
Fri May 16 10:51:54 2014
(60 seconds ahead)
[2014/05/16 10:50:54.455739, 9, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/conncache.c:189(add_failed_connection_entry)
add_failed_connection_entry: added domain AD (10.255.0.4) to failed conn
cache
[2014/05/16 10:50:54.455853, 10, pid=3305, effective(0, 0), real(0, 0),
class=tdb] ../source3/lib/gencache.c:246(gencache_del)
Deleting cache entry (key = SAFJOIN/DOMAIN/AD)
[2014/05/16 10:50:54.455967, 10, pid=3305, effective(0, 0), real(0, 0),
class=tdb] ../source3/lib/gencache.c:246(gencache_del)
Deleting cache entry (key = SAF/DOMAIN/AD)
[2014/05/16 10:50:54.456078, 10, pid=3305, effective(0, 0), real(0, 0),
class=tdb] ../source3/lib/gencache.c:179(gencache_set_data_blob)
Adding cache entry with key = NEG_CONN_CACHE/ad.idm.example.com,10.255.0.4
and timeout = Fri May 16 10:51:54 2014
(60 seconds ahead)
[2014/05/16 10:50:54.456236, 9, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/conncache.c:189(add_failed_connection_entry)
add_failed_connection_entry: added domain ad.idm.example.com (10.255.0.4)
to failed conn cache
[2014/05/16 10:50:54.456330, 10, pid=3305, effective(0, 0), real(0, 0),
class=tdb] ../source3/lib/gencache.c:246(gencache_del)
Deleting cache entry (key = SAFJOIN/DOMAIN/AD.IDM.WEBYOG.COM)
[2014/05/16 10:50:54.456433, 10, pid=3305, effective(0, 0), real(0, 0),
class=tdb] ../source3/lib/gencache.c:246(gencache_del)
Deleting cache entry (key = SAF/DOMAIN/AD.IDM.WEBYOG.COM)
[2014/05/16 10:50:54.456601, 8, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:3289(get_sorted_dc_list)
get_sorted_dc_list: attempting lookup for name AD (sitename NULL)
[2014/05/16 10:50:54.456761, 5, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:208(saf_fetch)
saf_fetch: failed to find server for "AD" domain
[2014/05/16 10:50:54.456876, 3, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:3102(get_dc_list)
get_dc_list: preferred server list: ", *"
[2014/05/16 10:50:54.456966, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:2598(internal_resolve_name)
internal_resolve_name: looking up AD#1c (sitename (null))
[2014/05/16 10:50:54.457072, 5, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namecache.c:160(namecache_fetch)
no entry for AD#1C found.
[2014/05/16 10:50:54.457240, 3, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:2266(resolve_lmhosts)
resolve_lmhosts: Attempting lmhosts lookup for name AD<0x1c>
[2014/05/16 10:50:54.457332, 3, pid=3305, effective(0, 0), real(0, 0)]
../libcli/nbt/lmhosts.c:185(resolve_lmhosts_file_as_sockaddr)
resolve_lmhosts: Attempting lmhosts lookup for name AD<0x1c>
[2014/05/16 10:50:54.457446, 4, pid=3305, effective(0, 0), real(0, 0)]
../libcli/nbt/lmhosts.c:111(getlmhostsent)
getlmhostsent: lmhost entry: 127.0.0.1 localhost
[2014/05/16 10:50:54.457644, 3, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:2068(resolve_wins_send)
resolve_wins: WINS server resolution selected and no WINS servers listed.
[2014/05/16 10:50:54.457745, 5, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:2315(resolve_hosts)
resolve_hosts: not appropriate for name type <0x1c>
[2014/05/16 10:50:54.457854, 3, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:1806(name_resolve_bcast_send)
name_resolve_bcast: Attempting broadcast lookup for name AD<0x1c>
[2014/05/16 10:50:54.458057, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/util_sock.c:499(open_socket_in)
bind succeeded on port 0
[2014/05/16 10:50:54.458163, 5, pid=3305, effective(0, 0), real(0, 0)]
../lib/util/util_net.c:848(print_socket_options)
Socket options:
SO_KEEPALIVE = 0
SO_REUSEADDR = 1
SO_BROADCAST = 1
Could not test socket option TCP_NODELAY.
Could not test socket option TCP_KEEPCNT.
Could not test socket option TCP_KEEPIDLE.
Could not test socket option TCP_KEEPINTVL.
IPTOS_LOWDELAY = 0
IPTOS_THROUGHPUT = 0
SO_REUSEPORT = 1
SO_SNDBUF = 124928
SO_RCVBUF = 124928
SO_SNDLOWAT = 1
SO_RCVLOWAT = 1
SO_SNDTIMEO = 0
SO_RCVTIMEO = 0
Could not test socket option TCP_QUICKACK.
Could not test socket option TCP_DEFER_ACCEPT.
[2014/05/16 10:50:54.458970, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/unexpected.c:546(nb_packet_reader_connected)
async_connect failed: No such file or directory
[2014/05/16 10:50:54.459086, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:600(nb_trans_got_reader)
nmbd not around
[2014/05/16 10:50:54.459182, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/events.c:216(run_events_poll)
Running timed event "tevent_req_timedout" 0x1752640
[2014/05/16 10:50:54.459354, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/util_sock.c:499(open_socket_in)
bind succeeded on port 0
[2014/05/16 10:50:54.459458, 5, pid=3305, effective(0, 0), real(0, 0)]
../lib/util/util_net.c:848(print_socket_options)
Socket options:
SO_KEEPALIVE = 0
SO_REUSEADDR = 1
SO_BROADCAST = 1
Could not test socket option TCP_NODELAY.
Could not test socket option TCP_KEEPCNT.
Could not test socket option TCP_KEEPIDLE.
Could not test socket option TCP_KEEPINTVL.
IPTOS_LOWDELAY = 0
IPTOS_THROUGHPUT = 0
SO_REUSEPORT = 1
SO_SNDBUF = 124928
SO_RCVBUF = 124928
SO_SNDLOWAT = 1
SO_RCVLOWAT = 1
SO_SNDTIMEO = 0
SO_RCVTIMEO = 0
Could not test socket option TCP_QUICKACK.
Could not test socket option TCP_DEFER_ACCEPT.
[2014/05/16 10:50:54.460242, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/unexpected.c:546(nb_packet_reader_connected)
async_connect failed: No such file or directory
[2014/05/16 10:50:54.460363, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:600(nb_trans_got_reader)
nmbd not around
[2014/05/16 10:50:55.460608, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/events.c:216(run_events_poll)
Running timed event "tevent_req_timedout" 0x174f480
[2014/05/16 10:50:55.460853, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/events.c:216(run_events_poll)
Running timed event "tevent_req_timedout" 0x1753c10
[2014/05/16 10:50:55.460977, 8, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:3123(get_dc_list)
Adding 0 DC's from auto lookup
[2014/05/16 10:50:55.461070, 4, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:3134(get_dc_list)
get_dc_list: no servers found
[2014/05/16 10:50:55.461157, 8, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:3289(get_sorted_dc_list)
get_sorted_dc_list: attempting lookup for name
ad.idm.example.com(sitename NULL)
[2014/05/16 10:50:55.461297, 5, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:208(saf_fetch)
saf_fetch: failed to find server for "ad.idm.example.com" domain
[2014/05/16 10:50:55.461391, 3, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:3102(get_dc_list)
get_dc_list: preferred server list: ", *"
[2014/05/16 10:50:55.461480, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:2598(internal_resolve_name)
internal_resolve_name: looking up ad.idm.example.com#1c (sitename (null))
[2014/05/16 10:50:55.461593, 5, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namecache.c:165(namecache_fetch)
name ad.idm.example.com#1C found.
[2014/05/16 10:50:55.461788, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:1110(remove_duplicate_addrs2)
remove_duplicate_addrs2: looking for duplicate address/port pairs
[2014/05/16 10:50:55.461904, 8, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:3123(get_dc_list)
Adding 1 DC's from auto lookup
[2014/05/16 10:50:55.462020, 9, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/conncache.c:150(check_negative_conn_cache)
check_negative_conn_cache returning result -1073741823 for domain
ad.idm.example.com server 10.255.0.4
[2014/05/16 10:50:55.462115, 5, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:3175(get_dc_list)
get_dc_list: negative entry 10.255.0.4 removed from DC list
[2014/05/16 10:50:55.462200, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:1110(remove_duplicate_addrs2)
remove_duplicate_addrs2: looking for duplicate address/port pairs
[2014/05/16 10:50:55.462284, 4, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:3239(get_dc_list)
get_dc_list: returning 0 ip addresses in an ordered list
[2014/05/16 10:50:55.462367, 4, pid=3305, effective(0, 0), real(0, 0)]
../source3/libsmb/namequery.c:3240(get_dc_list)
get_dc_list:
[2014/05/16 10:50:55.462457, 10, pid=3305, effective(0, 0), real(0, 0),
class=winbind]
../source3/winbindd/winbindd_cache.c:3456(set_global_winbindd_state_offline)
set_global_winbindd_state_offline: offline requested.
[2014/05/16 10:50:55.462551, 10, pid=3305, effective(0, 0), real(0, 0),
class=winbind]
../source3/winbindd/winbindd_cache.c:3467(set_global_winbindd_state_offline)
set_global_winbindd_state_offline: rejecting.
[2014/05/16 10:50:55.462634, 10, pid=3305, effective(0, 0), real(0, 0),
class=winbind] ../source3/winbindd/winbindd_cm.c:351(set_domain_offline)
set_domain_offline: called for domain AD
[2014/05/16 10:50:55.462724, 10, pid=3305, effective(0, 0), real(0, 0),
class=winbind] ../source3/winbindd/winbindd_cm.c:395(set_domain_offline)
set_domain_offline: added event handler for domain AD
[2014/05/16 10:50:55.462817, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/messages_local.c:75(messaging_tdb_signal_handler)
messaging_tdb_signal_handler: sig[10] count[2] msgs[1]
[2014/05/16 10:50:55.462923, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/messages_local.c:496(message_dispatch)
message_dispatch: received_messages = 1
[2014/05/16 10:50:55.463051, 10, pid=3305, effective(0, 0), real(0, 0)]
../source3/lib/messages_local.c:242(messaging_tdb_fetch)
messaging_tdb_fetch:
[2014/05/16 10:50:55.463140, 1, pid=3305, effective(0, 0), real(0, 0)]
../librpc/ndr/ndr.c:245(ndr_print_debug)
result: struct messaging_array
num_messages : 0x00000002 (2)
messages: ARRAY(2)
messages: struct messaging_rec
msg_version : 0x00000002 (2)
msg_type : MSG_DEBUG (1)
dest: struct server_id
pid : 0x0000000000000ce9 (3305)
task_id : 0x00000000 (0)
vnn : 0xffffffff (4294967295)
unique_id : 0x0000000000000000 (0)
src: struct server_id
pid : 0x0000000000000c85 (3205)
task_id : 0x00000000 (0)
vnn : 0xffffffff (4294967295)
unique_id : 0x0000000000000000 (0)
buf : DATA_BLOB length=3
[0000] 31 31 00 11.
messages: struct messaging_rec
msg_version : 0x00000002 (2)
msg_type : MSG_DEBUG (1)
dest: struct server_id
pid : 0x0000000000000ce9 (3305)
task_id : 0x00000000 (0)
vnn : 0xffffffff (4294967295)
unique_id : 0x0000000000000000 (0)
src: struct server_id
pid : 0x0000000000000c85 (3205)
task_id : 0x00000000 (0)
vnn : 0xffffffff (4294967295)
unique_id : 0x0000000000000000 (0)
buf : DATA_BLOB length=2
[0000] 31 00 1.
[2014/05/16 10:50:55.464485, 3, pid=3305, effective(0, 0), real(0, 0)]
../lib/util/debug_s3.c:72(debug_message)
INFO: Remote set of debug to `11' (pid 3305 from pid 3205)
[2014/05/16 10:50:55.464605, 5, pid=3305, effective(0, 0), real(0, 0)]
../lib/util/debug.c:331(debug_dump_status)
On Fri, May 16, 2014 at 2:18 PM, Sumit Bose <sbose at redhat.com> wrote:
> On Thu, May 15, 2014 at 11:57:46PM +0530, Supratik Goswami wrote:
> > >
> > > Does ipa trust-find and trust-show still show the trust relationship?
> > >
> >
> > Yes, it is listing the AD domain.
> >
> > After setting the debug level to 10 I got the below message after running
> > the command "wbinfo -n 'AD\Domain Admins' "
> >
>
> The log.wb-DOMAIN is needed here to identify why winbindd is not able to
> reach the DC.
>
> Have you checked if DNS is still working and can resolve SRV records for
> the AD domain, e.g.
>
> dig SRV _ldap._tcp.AD.DNS.DOMAIN
>
> should return IP addresses for your DCs.
>
> bye,
> Sumit
>
> >
> >
>
> _______________________________________________
> Freeipa-users mailing list
> Freeipa-users at redhat.com
> https://www.redhat.com/mailman/listinfo/freeipa-users
>
--
Warm Regards
Supratik
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://listman.redhat.com/archives/freeipa-users/attachments/20140516/5455735f/attachment.htm>
More information about the Freeipa-users
mailing list