[SSSD] Announcing SSSD 1.5.14

GOLLSCHEWSKY, Tim Tim.GOLLSCHEWSKY at suncorp.com.au
Fri Oct 21 01:02:51 UTC 2011


Hi Jan, thanks for your response.

> > Reconnected to the Data Provider.
> >
> > ...here it just keeps trying to reconnect to the data provider.
> > Reconnection attempt... etc.  Over and over.
> >
> > I'm not sure what this means:
> >
> >   (Thu Oct 20 12:42:50 2011) [sssd] [ping_check] (4): Service
> > XXX.XXX.XXX replied to ping (Thu Oct 20 12:42:50 2011) [sssd[pam]]
> > [sbus_dispatch]
> > (1): Performing auto-reconnect (Thu Oct 20 12:42:50 2011) [sssd]
> > [sbus_dispatch] (3): Connection is not open for dispatching.
> >
> > Connection to what exactly... I'm not sure.  The LDAP server?  The pipe?
>
> It's sbus connection between NSS/PAM responder and the data provider.
> Could you please send sanitized logs separated for each process? You
> can achieve this by running sssd with -f. Also please set debug level a bit higher (7 or 8 will do) so it's easier to debug.

These are the sanitized log files with debug level 8:


== sssd_XXX.XXX.XXX.log ==

(Fri Oct 21 10:43:26 2011) [sssd[be[XXX.XXX.XXX]]] [main] (1): Backend provider (XXX.XXX.XXX) started!
(Fri Oct 21 10:43:36 2011) [sssd[be[XXX.XXX.XXX]]] [main] (1): Backend provider (XXX.XXX.XXX) started!
(Fri Oct 21 10:43:47 2011) [sssd[be[XXX.XXX.XXX]]] [main] (1): Backend provider (XXX.XXX.XXX) started!

== sssd.log ==

(Fri Oct 21 10:43:25 2011) [sssd] [check_file] (1): lstat for [/var/run/nscd/socket] failed: [2][No such file or directory].
(Fri Oct 21 10:43:25 2011) [sssd] [ldb] (6): server_sort:Unable to register control with rootdse!
(Fri Oct 21 10:43:25 2011) [sssd] [ldb] (6): server_sort:Unable to register control with rootdse!
(Fri Oct 21 10:43:25 2011) [sssd] [server_setup] (3): CONFDB: /apps/sssd-1.5.14/var/lib/sss/db/config.ldb
(Fri Oct 21 10:43:26 2011) [sssd] [sysdb_domain_init_internal] (5): DB File for XXX.XXX.XXX: /apps/sssd-1.5.14/var/lib/sss/db/cache_XXX.XXX.XXX.ldb
(Fri Oct 21 10:43:26 2011) [sssd] [ldb] (6): asq: Unable to register control with rootdse!
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_new_server] (3): D-BUS Server listening on unix:path=/apps/sssd-1.5.14/var/lib/sss/pipes/private/sbus-monitor,guid=4fb4f113909773159c2870c000025772
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_add_watch] (8): 0x810520/0x80ead0 (13), R/- (enabled)
(Fri Oct 21 10:43:26 2011) [sssd] [start_service] (4): Queueing service XXX.XXX.XXX for startup
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_server_init_new_connection] (5): Entering.
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_server_init_new_connection] (5): Adding connection 0x813380.
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_init_connection] (5): Adding connection 813380
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_add_watch] (8): 0x80f2c0/0x80efe0 (15), -/W (disabled)
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_toggle_watch] (8): 0x80f2c0/0x80f520 (15), R/- (enabled)
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_server_init_new_connection] (5): Got a connection
(Fri Oct 21 10:43:26 2011) [sssd] [monitor_service_init] (3): Initializing D-BUS Service
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_toggle_watch] (8): 0x80f2c0/0x80f520 (15), R/- (disabled)
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_toggle_watch] (8): 0x80f2c0/0x80efe0 (15), -/W (enabled)
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_toggle_watch] (8): 0x80f2c0/0x80f520 (15), R/- (enabled)
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_toggle_watch] (8): 0x80f2c0/0x80efe0 (15), -/W (disabled)
(Fri Oct 21 10:43:26 2011) [sssd] [client_registration] (4): Received ID registration: (%BE_XXX.XXX.XXX,1)
(Fri Oct 21 10:43:26 2011) [sssd] [mark_service_as_started] (5): Marking XXX.XXX.XXX as started.
(Fri Oct 21 10:43:26 2011) [sssd] [mark_service_as_started] (4): Now starting services!
(Fri Oct 21 10:43:26 2011) [sssd] [start_service] (4): Queueing service nss for startup
(Fri Oct 21 10:43:26 2011) [sssd] [start_service] (4): Queueing service pam for startup
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_server_init_new_connection] (5): Entering.
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_server_init_new_connection] (5): Adding connection 0x814790.
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_init_connection] (5): Adding connection 814790
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_add_watch] (8): 0x814ab0/0x8110d0 (16), -/W (disabled)
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_toggle_watch] (8): 0x814ab0/0x811f30 (16), R/- (enabled)
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_server_init_new_connection] (5): Got a connection
(Fri Oct 21 10:43:26 2011) [sssd] [monitor_service_init] (3): Initializing D-BUS Service
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_toggle_watch] (8): 0x814ab0/0x811f30 (16), R/- (disabled)
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_toggle_watch] (8): 0x814ab0/0x8110d0 (16), -/W (enabled)
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_toggle_watch] (8): 0x814ab0/0x811f30 (16), R/- (enabled)
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_toggle_watch] (8): 0x814ab0/0x8110d0 (16), -/W (disabled)
(Fri Oct 21 10:43:26 2011) [sssd] [client_registration] (4): Received ID registration: (pam,1)
(Fri Oct 21 10:43:26 2011) [sssd] [mark_service_as_started] (5): Marking pam as started.
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_server_init_new_connection] (5): Entering.
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_server_init_new_connection] (5): Adding connection 0x816b90.
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_init_connection] (5): Adding connection 816B90
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_add_watch] (8): 0x8171f0/0x814280 (17), -/W (disabled)
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_toggle_watch] (8): 0x8171f0/0x8155e0 (17), R/- (enabled)
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_server_init_new_connection] (5): Got a connection
(Fri Oct 21 10:43:26 2011) [sssd] [monitor_service_init] (3): Initializing D-BUS Service
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_toggle_watch] (8): 0x8171f0/0x8155e0 (17), R/- (disabled)
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_toggle_watch] (8): 0x8171f0/0x814280 (17), -/W (enabled)
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_toggle_watch] (8): 0x8171f0/0x8155e0 (17), R/- (enabled)
(Fri Oct 21 10:43:26 2011) [sssd] [sbus_toggle_watch] (8): 0x8171f0/0x814280 (17), -/W (disabled)
(Fri Oct 21 10:43:26 2011) [sssd] [client_registration] (4): Received ID registration: (nss,1)
(Fri Oct 21 10:43:26 2011) [sssd] [mark_service_as_started] (5): Marking nss as started.
(Fri Oct 21 10:43:31 2011) [sssd] [services_startup_timeout] (6): Handling timeout
(Fri Oct 21 10:43:35 2011) [sssd] [sbus_remove_watch] (8): 0x80f2c0/0x80f520
(Fri Oct 21 10:43:35 2011) [sssd] [sbus_remove_watch] (8): 0x80f2c0/0x80efe0
(Fri Oct 21 10:43:35 2011) [sssd] [sbus_dispatch] (3): Connection is not open for dispatching.
(Fri Oct 21 10:43:36 2011) [sssd] [service_check_alive] (4): Checking service XXX.XXX.XXX(9250) is still alive
(Fri Oct 21 10:43:36 2011) [sssd] [tasks_check_handler] (1): Process (XXX.XXX.XXX) is stopped!
(Fri Oct 21 10:43:36 2011) [sssd] [start_service] (4): Queueing service XXX.XXX.XXX for startup
(Fri Oct 21 10:43:36 2011) [sssd] [service_check_alive] (4): Checking service nss(9251) is still alive
(Fri Oct 21 10:43:36 2011) [sssd] [service_send_ping] (4): Pinging nss
(Fri Oct 21 10:43:36 2011) [sssd] [sbus_add_timeout] (8): 0x8172e0
(Fri Oct 21 10:43:36 2011) [sssd] [service_check_alive] (4): Checking service pam(9252) is still alive
(Fri Oct 21 10:43:36 2011) [sssd] [service_send_ping] (4): Pinging pam
(Fri Oct 21 10:43:36 2011) [sssd] [sbus_add_timeout] (8): 0x80ffd0
(Fri Oct 21 10:43:36 2011) [sssd] [sbus_remove_timeout] (8): 0x80ffd0
(Fri Oct 21 10:43:36 2011) [sssd] [ping_check] (4): Service pam replied to ping
(Fri Oct 21 10:43:36 2011) [sssd] [sbus_remove_timeout] (8): 0x8172e0
(Fri Oct 21 10:43:36 2011) [sssd] [ping_check] (4): Service nss replied to ping
(Fri Oct 21 10:43:36 2011) [sssd] [sbus_server_init_new_connection] (5): Entering.
(Fri Oct 21 10:43:36 2011) [sssd] [sbus_server_init_new_connection] (5): Adding connection 0x8194f0.
(Fri Oct 21 10:43:36 2011) [sssd] [sbus_init_connection] (5): Adding connection 8194F0
(Fri Oct 21 10:43:36 2011) [sssd] [sbus_add_watch] (8): 0x819a50/0x80f520 (15), -/W (disabled)
(Fri Oct 21 10:43:36 2011) [sssd] [sbus_toggle_watch] (8): 0x819a50/0x80efe0 (15), R/- (enabled)
(Fri Oct 21 10:43:36 2011) [sssd] [sbus_server_init_new_connection] (5): Got a connection
(Fri Oct 21 10:43:36 2011) [sssd] [monitor_service_init] (3): Initializing D-BUS Service
(Fri Oct 21 10:43:36 2011) [sssd] [sbus_toggle_watch] (8): 0x819a50/0x80efe0 (15), R/- (disabled)
(Fri Oct 21 10:43:36 2011) [sssd] [sbus_toggle_watch] (8): 0x819a50/0x80f520 (15), -/W (enabled)
(Fri Oct 21 10:43:36 2011) [sssd] [sbus_toggle_watch] (8): 0x819a50/0x80efe0 (15), R/- (enabled)
(Fri Oct 21 10:43:36 2011) [sssd] [sbus_toggle_watch] (8): 0x819a50/0x80f520 (15), -/W (disabled)
(Fri Oct 21 10:43:36 2011) [sssd] [client_registration] (4): Received ID registration: (%BE_XXX.XXX.XXX,1)
(Fri Oct 21 10:43:36 2011) [sssd] [mark_service_as_started] (5): Marking XXX.XXX.XXX as started.
(Fri Oct 21 10:43:46 2011) [sssd] [service_check_alive] (4): Checking service nss(9251) is still alive
(Fri Oct 21 10:43:46 2011) [sssd] [service_send_ping] (4): Pinging nss
(Fri Oct 21 10:43:46 2011) [sssd] [sbus_add_timeout] (8): 0x819b40
(Fri Oct 21 10:43:46 2011) [sssd] [service_check_alive] (4): Checking service pam(9252) is still alive
(Fri Oct 21 10:43:46 2011) [sssd] [service_send_ping] (4): Pinging pam
(Fri Oct 21 10:43:46 2011) [sssd] [sbus_add_timeout] (8): 0x810af0
(Fri Oct 21 10:43:46 2011) [sssd] [service_check_alive] (4): Checking service XXX.XXX.XXX(9256) is still alive
(Fri Oct 21 10:43:46 2011) [sssd] [service_send_ping] (4): Pinging XXX.XXX.XXX
(Fri Oct 21 10:43:46 2011) [sssd] [sbus_add_timeout] (8): 0x8192a0
(Fri Oct 21 10:43:46 2011) [sssd] [sbus_remove_timeout] (8): 0x819b40
(Fri Oct 21 10:43:46 2011) [sssd] [ping_check] (4): Service nss replied to ping
(Fri Oct 21 10:43:46 2011) [sssd] [sbus_remove_timeout] (8): 0x8192a0
(Fri Oct 21 10:43:46 2011) [sssd] [ping_check] (4): Service XXX.XXX.XXX replied to ping
(Fri Oct 21 10:43:46 2011) [sssd] [sbus_remove_timeout] (8): 0x810af0
(Fri Oct 21 10:43:46 2011) [sssd] [ping_check] (4): Service pam replied to ping
(Fri Oct 21 10:43:46 2011) [sssd] [sbus_remove_watch] (8): 0x819a50/0x80efe0
(Fri Oct 21 10:43:46 2011) [sssd] [sbus_remove_watch] (8): 0x819a50/0x80f520
(Fri Oct 21 10:43:46 2011) [sssd] [sbus_dispatch] (3): Connection is not open for dispatching.
(Fri Oct 21 10:43:47 2011) [sssd] [global_checks_handler] (1): Service [XXX.XXX.XXX] did exit
(Fri Oct 21 10:43:47 2011) [sssd] [start_service] (4): Queueing service XXX.XXX.XXX for startup
(Fri Oct 21 10:43:47 2011) [sssd] [sbus_server_init_new_connection] (5): Entering.
(Fri Oct 21 10:43:47 2011) [sssd] [sbus_server_init_new_connection] (5): Adding connection 0x81b9d0.
(Fri Oct 21 10:43:47 2011) [sssd] [sbus_init_connection] (5): Adding connection 81B9D0
(Fri Oct 21 10:43:47 2011) [sssd] [sbus_add_watch] (8): 0x819c50/0x80efe0 (15), -/W (disabled)
(Fri Oct 21 10:43:47 2011) [sssd] [sbus_toggle_watch] (8): 0x819c50/0x80f520 (15), R/- (enabled)
(Fri Oct 21 10:43:47 2011) [sssd] [sbus_server_init_new_connection] (5): Got a connection
(Fri Oct 21 10:43:47 2011) [sssd] [monitor_service_init] (3): Initializing D-BUS Service
(Fri Oct 21 10:43:47 2011) [sssd] [sbus_toggle_watch] (8): 0x819c50/0x80f520 (15), R/- (disabled)
(Fri Oct 21 10:43:47 2011) [sssd] [sbus_toggle_watch] (8): 0x819c50/0x80efe0 (15), -/W (enabled)
(Fri Oct 21 10:43:47 2011) [sssd] [sbus_toggle_watch] (8): 0x819c50/0x80f520 (15), R/- (enabled)
(Fri Oct 21 10:43:47 2011) [sssd] [sbus_toggle_watch] (8): 0x819c50/0x80efe0 (15), -/W (disabled)
(Fri Oct 21 10:43:47 2011) [sssd] [client_registration] (4): Received ID registration: (%BE_XXX.XXX.XXX,1)
(Fri Oct 21 10:43:47 2011) [sssd] [mark_service_as_started] (5): Marking XXX.XXX.XXX as started.
(Fri Oct 21 10:43:52 2011) [sssd] [monitor_quit] (8): Received shutdown command
(Fri Oct 21 10:43:52 2011) [sssd] [monitor_quit] (0): Monitor received Interrupt: terminating children
(Fri Oct 21 10:43:52 2011) [sssd] [monitor_quit] (1): Terminating [XXX.XXX.XXX][9258]
(Fri Oct 21 10:43:52 2011) [sssd] [monitor_quit] (1): Child [XXX.XXX.XXX] exited gracefully
(Fri Oct 21 10:43:52 2011) [sssd] [monitor_quit] (1): Terminating [pam][9252]
(Fri Oct 21 10:43:52 2011) [sssd] [monitor_quit] (1): Child [pam] exited gracefully
(Fri Oct 21 10:43:52 2011) [sssd] [monitor_quit] (1): Terminating [nss][9251]
(Fri Oct 21 10:43:52 2011) [sssd] [monitor_quit] (1): Child [nss] exited gracefully
(Fri Oct 21 10:43:52 2011) [sssd] [sbus_remove_watch] (8): 0x810520/0x80ead0

== sssd_nss.log ==

(Fri Oct 21 10:43:26 2011) [sssd[nss]] [server_setup] (3): CONFDB: /apps/sssd-1.5.14/var/lib/sss/db/config.ldb
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sbus_init_connection] (5): Adding connection 175D7B0
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sbus_add_watch] (8): 0x175f880/0x175f110 (19), -/W (enabled)
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sbus_toggle_watch] (8): 0x175f880/0x175b850 (19), R/- (disabled)
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [monitor_common_send_id] (4): Sending ID: (nss,1)
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sbus_add_timeout] (8): 0x175d8c0
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sbus_toggle_watch] (8): 0x175f880/0x175b850 (19), R/- (enabled)
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sbus_toggle_watch] (8): 0x175f880/0x175f110 (19), -/W (disabled)
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sbus_init_connection] (5): Adding connection 1762E00
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sbus_add_watch] (8): 0x1763650/0x1762950 (20), -/W (enabled)
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sbus_toggle_watch] (8): 0x1763650/0x17629a0 (20), R/- (disabled)
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [dp_common_send_id] (4): Sending ID to DP: (1,NSS)
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sbus_add_timeout] (8): 0x1763b10
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sbus_toggle_watch] (8): 0x1763650/0x17629a0 (20), R/- (enabled)
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sbus_toggle_watch] (8): 0x1763650/0x1762950 (20), -/W (disabled)
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sysdb_domain_init_internal] (5): DB File for XXX.XXX.XXX: /apps/sssd-1.5.14/var/lib/sss/db/cache_XXX.XXX.XXX.ldb
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [ldb] (6): asq: Unable to register control with rootdse!
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sss_process_init] (1): Responder Initialization complete
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sss_ncache_set_str] (6): Adding [NCE/USER/XXX.XXX.XXX/root] to negative cache permanently
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sss_ncache_set_str] (6): Adding [NCE/USER/XXX.XXX.XXX/ldap] to negative cache permanently
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sss_ncache_set_str] (6): Adding [NCE/USER/XXX.XXX.XXX/named] to negative cache permanently
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sss_ncache_set_str] (6): Adding [NCE/USER/XXX.XXX.XXX/avahi] to negative cache permanently
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sss_ncache_set_str] (6): Adding [NCE/USER/XXX.XXX.XXX/haldaemon] to negative cache permanently
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sss_ncache_set_str] (6): Adding [NCE/USER/XXX.XXX.XXX/dbus] to negative cache permanently
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sss_ncache_set_str] (6): Adding [NCE/USER/XXX.XXX.XXX/radvd] to negative cache permanently
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sss_ncache_set_str] (6): Adding [NCE/USER/XXX.XXX.XXX/tomcat] to negative cache permanently
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sss_ncache_set_str] (6): Adding [NCE/USER/XXX.XXX.XXX/radiusd] to negative cache permanently
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sss_ncache_set_str] (6): Adding [NCE/USER/XXX.XXX.XXX/news] to negative cache permanently
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sss_ncache_set_str] (6): Adding [NCE/USER/XXX.XXX.XXX/mailman] to negative cache permanently
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sss_ncache_set_str] (6): Adding [NCE/USER/XXX.XXX.XXX/midrange] to negative cache permanently
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sss_ncache_set_str] (6): Adding [NCE/GROUP/XXX.XXX.XXX/root] to negative cache permanently
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [nss_get_etc_shells] (6): Found shell /bin/sh in /etc/shells
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [nss_get_etc_shells] (6): Found shell /bin/bash in /etc/shells
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [nss_get_etc_shells] (6): Found shell /sbin/nologin in /etc/shells
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [nss_get_etc_shells] (6): Found shell /bin/ksh in /etc/shells
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [nss_get_etc_shells] (6): Found shell /bin/tcsh in /etc/shells
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [nss_get_etc_shells] (6): Found shell /bin/csh in /etc/shells
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [nss_process_init] (1): NSS Initialization complete
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sbus_toggle_watch] (8): 0x175f880/0x175b850 (19), R/- (disabled)
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sbus_toggle_watch] (8): 0x175f880/0x175f110 (19), -/W (enabled)
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sbus_toggle_watch] (8): 0x1763650/0x17629a0 (20), R/- (disabled)
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sbus_toggle_watch] (8): 0x1763650/0x1762950 (20), -/W (enabled)
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sbus_toggle_watch] (8): 0x175f880/0x175b850 (19), R/- (enabled)
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sbus_toggle_watch] (8): 0x175f880/0x175f110 (19), -/W (disabled)
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sbus_toggle_watch] (8): 0x1763650/0x17629a0 (20), R/- (enabled)
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sbus_toggle_watch] (8): 0x1763650/0x1762950 (20), -/W (disabled)
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sbus_remove_timeout] (8): 0x175d8c0
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [id_callback] (4): Got id ack and version (1) from Monitor
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [sbus_remove_timeout] (8): 0x1763b10
(Fri Oct 21 10:43:26 2011) [sssd[nss]] [dp_id_callback] (4): Got id ack and version (1) from DP
(Fri Oct 21 10:43:35 2011) [sssd[nss]] [accept_fd_handler] (4): Client connected!
(Fri Oct 21 10:43:35 2011) [sssd[nss]] [sss_cmd_get_version] (5): Received client version [1].
(Fri Oct 21 10:43:35 2011) [sssd[nss]] [sss_cmd_get_version] (5): Offered version [1].
(Fri Oct 21 10:43:35 2011) [sssd[nss]] [nss_cmd_getpwnam] (4): Requesting info for [u999999] from [<ALL>]
(Fri Oct 21 10:43:35 2011) [sssd[nss]] [sss_ncache_check_str] (8): Checking negative cache for [NCE/USER/XXX.XXX.XXX/u999999]
(Fri Oct 21 10:43:35 2011) [sssd[nss]] [nss_cmd_getpwnam_search] (4): Requesting info for [u999999 at XXX.XXX.XXX]
(Fri Oct 21 10:43:35 2011) [sssd[nss]] [sss_dp_send_acct_req_create] (4): Sending request for [XXX.XXX.XXX][4097][1][name=u999999]
(Fri Oct 21 10:43:35 2011) [sssd[nss]] [sbus_add_timeout] (8): 0x175fda0
(Fri Oct 21 10:43:35 2011) [sssd[nss]] [sbus_remove_watch] (8): 0x1763650/0x17629a0
(Fri Oct 21 10:43:35 2011) [sssd[nss]] [sbus_remove_watch] (8): 0x1763650/0x1762950
(Fri Oct 21 10:43:35 2011) [sssd[nss]] [sbus_remove_timeout] (8): 0x175fda0
(Fri Oct 21 10:43:35 2011) [sssd[nss]] [sbus_dispatch] (1): Performing auto-reconnect
(Fri Oct 21 10:43:35 2011) [sssd[nss]] [sbus_dispatch] (6): SBUS is reconnecting. Deferring.
(Fri Oct 21 10:43:36 2011) [sssd[nss]] [sbus_dispatch] (6): SBUS is reconnecting. Deferring.
(Fri Oct 21 10:43:36 2011) [sssd[nss]] [sbus_dispatch] (6): SBUS is reconnecting. Deferring.
(Fri Oct 21 10:43:36 2011) [sssd[nss]] [sbus_dispatch] (6): SBUS is reconnecting. Deferring.
(Fri Oct 21 10:43:36 2011) [sssd[nss]] [sbus_dispatch] (6): SBUS is reconnecting. Deferring.
(Fri Oct 21 10:43:36 2011) [sssd[nss]] [sbus_dispatch] (6): SBUS is reconnecting. Deferring.
(Fri Oct 21 10:43:36 2011) [sssd[nss]] [sbus_dispatch] (6): SBUS is reconnecting. Deferring.
(Fri Oct 21 10:43:36 2011) [sssd[nss]] [sbus_dispatch] (6): SBUS is reconnecting. Deferring.
(Fri Oct 21 10:43:36 2011) [sssd[nss]] [sbus_dispatch] (6): SBUS is reconnecting. Deferring.
(Fri Oct 21 10:43:36 2011) [sssd[nss]] [sbus_dispatch] (6): SBUS is reconnecting. Deferring.
(Fri Oct 21 10:43:36 2011) [sssd[nss]] [sbus_reconnect] (3): Making reconnection attempt 1 to [unix:path=/apps/sssd-1.5.14/var/lib/sss/pipes/private/sbus-dp_XXX.XXX.XXX]
(Fri Oct 21 10:43:36 2011) [sssd[nss]] [sbus_reconnect] (3): Reconnected to [unix:path=/apps/sssd-1.5.14/var/lib/sss/pipes/private/sbus-dp_XXX.XXX.XXX]
(Fri Oct 21 10:43:36 2011) [sssd[nss]] [sbus_add_watch] (8): 0x17648f0/0x17629a0 (20), -/W (enabled)
(Fri Oct 21 10:43:36 2011) [sssd[nss]] [sbus_toggle_watch] (8): 0x17648f0/0x1762950 (20), R/- (disabled)
(Fri Oct 21 10:43:36 2011) [sssd[nss]] [nss_dp_reconnect_init] (1): Reconnected to the Data Provider.
(Fri Oct 21 10:43:36 2011) [sssd[nss]] [dp_common_send_id] (4): Sending ID to DP: (1,NSS)
(Fri Oct 21 10:43:36 2011) [sssd[nss]] [sbus_add_timeout] (8): 0x1761670
(Fri Oct 21 10:43:36 2011) [sssd[nss]] [sbus_toggle_watch] (8): 0x17648f0/0x1762950 (20), R/- (enabled)
(Fri Oct 21 10:43:36 2011) [sssd[nss]] [sbus_toggle_watch] (8): 0x17648f0/0x17629a0 (20), -/W (disabled)
(Fri Oct 21 10:43:36 2011) [sssd[nss]] [handle_requests_after_reconnect] (7): Will handle 1 requests after reconnect
(Fri Oct 21 10:43:36 2011) [sssd[nss]] [sbus_toggle_watch] (8): 0x17648f0/0x1762950 (20), R/- (disabled)
(Fri Oct 21 10:43:36 2011) [sssd[nss]] [sbus_toggle_watch] (8): 0x17648f0/0x17629a0 (20), -/W (enabled)
(Fri Oct 21 10:43:36 2011) [sssd[nss]] [sbus_toggle_watch] (8): 0x17648f0/0x1762950 (20), R/- (enabled)
(Fri Oct 21 10:43:36 2011) [sssd[nss]] [sbus_toggle_watch] (8): 0x17648f0/0x17629a0 (20), -/W (disabled)
(Fri Oct 21 10:43:36 2011) [sssd[nss]] [sbus_remove_timeout] (8): 0x1761670
(Fri Oct 21 10:43:36 2011) [sssd[nss]] [dp_id_callback] (4): Got id ack and version (1) from DP
(Fri Oct 21 10:43:46 2011) [sssd[nss]] [sbus_remove_watch] (8): 0x17648f0/0x1762950
(Fri Oct 21 10:43:46 2011) [sssd[nss]] [sbus_remove_watch] (8): 0x17648f0/0x17629a0
(Fri Oct 21 10:43:46 2011) [sssd[nss]] [sbus_dispatch] (1): Performing auto-reconnect
(Fri Oct 21 10:43:47 2011) [sssd[nss]] [sbus_reconnect] (3): Making reconnection attempt 1 to [unix:path=/apps/sssd-1.5.14/var/lib/sss/pipes/private/sbus-dp_XXX.XXX.XXX]
(Fri Oct 21 10:43:47 2011) [sssd[nss]] [sbus_reconnect] (3): Reconnected to [unix:path=/apps/sssd-1.5.14/var/lib/sss/pipes/private/sbus-dp_XXX.XXX.XXX]
(Fri Oct 21 10:43:47 2011) [sssd[nss]] [sbus_add_watch] (8): 0x1763c70/0x1762950 (20), -/W (enabled)
(Fri Oct 21 10:43:47 2011) [sssd[nss]] [sbus_toggle_watch] (8): 0x1763c70/0x17629a0 (20), R/- (disabled)
(Fri Oct 21 10:43:47 2011) [sssd[nss]] [nss_dp_reconnect_init] (1): Reconnected to the Data Provider.
(Fri Oct 21 10:43:47 2011) [sssd[nss]] [dp_common_send_id] (4): Sending ID to DP: (1,NSS)
(Fri Oct 21 10:43:47 2011) [sssd[nss]] [sbus_add_timeout] (8): 0x1765210
(Fri Oct 21 10:43:47 2011) [sssd[nss]] [sbus_toggle_watch] (8): 0x1763c70/0x17629a0 (20), R/- (enabled)
(Fri Oct 21 10:43:47 2011) [sssd[nss]] [sbus_toggle_watch] (8): 0x1763c70/0x1762950 (20), -/W (disabled)
(Fri Oct 21 10:43:47 2011) [sssd[nss]] [handle_requests_after_reconnect] (7): Will handle 0 requests after reconnect
(Fri Oct 21 10:43:47 2011) [sssd[nss]] [sbus_toggle_watch] (8): 0x1763c70/0x17629a0 (20), R/- (disabled)
(Fri Oct 21 10:43:47 2011) [sssd[nss]] [sbus_toggle_watch] (8): 0x1763c70/0x1762950 (20), -/W (enabled)
(Fri Oct 21 10:43:47 2011) [sssd[nss]] [sbus_toggle_watch] (8): 0x1763c70/0x17629a0 (20), R/- (enabled)
(Fri Oct 21 10:43:47 2011) [sssd[nss]] [sbus_toggle_watch] (8): 0x1763c70/0x1762950 (20), -/W (disabled)
(Fri Oct 21 10:43:47 2011) [sssd[nss]] [sbus_remove_timeout] (8): 0x1765210
(Fri Oct 21 10:43:47 2011) [sssd[nss]] [dp_id_callback] (4): Got id ack and version (1) from DP
(Fri Oct 21 10:43:52 2011) [sssd[nss]] [sbus_remove_watch] (8): 0x1763c70/0x17629a0
(Fri Oct 21 10:43:52 2011) [sssd[nss]] [sbus_remove_watch] (8): 0x1763c70/0x1762950
(Fri Oct 21 10:43:52 2011) [sssd[nss]] [sbus_dispatch] (1): Performing auto-reconnect

== sssd_pam.log ==

(Fri Oct 21 10:43:26 2011) [sssd[pam]] [server_setup] (3): CONFDB: /apps/sssd-1.5.14/var/lib/sss/db/config.ldb
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sbus_init_connection] (5): Adding connection 1C58780
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sbus_add_watch] (8): 0x1c59480/0x1c58c60 (19), -/W (enabled)
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sbus_toggle_watch] (8): 0x1c59480/0x1c56070 (19), R/- (disabled)
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [monitor_common_send_id] (4): Sending ID: (pam,1)
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sbus_add_timeout] (8): 0x1c59860
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sbus_toggle_watch] (8): 0x1c59480/0x1c56070 (19), R/- (enabled)
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sbus_toggle_watch] (8): 0x1c59480/0x1c58c60 (19), -/W (disabled)
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sbus_init_connection] (5): Adding connection 1C5C900
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sbus_add_watch] (8): 0x1c5d150/0x1c5c420 (20), -/W (enabled)
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sbus_toggle_watch] (8): 0x1c5d150/0x1c5c470 (20), R/- (disabled)
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [dp_common_send_id] (4): Sending ID to DP: (1,PAM)
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sbus_add_timeout] (8): 0x1c5d610
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sbus_toggle_watch] (8): 0x1c5d150/0x1c5c470 (20), R/- (enabled)
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sbus_toggle_watch] (8): 0x1c5d150/0x1c5c420 (20), -/W (disabled)
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sysdb_domain_init_internal] (5): DB File for XXX.XXX.XXX: /apps/sssd-1.5.14/var/lib/sss/db/cache_XXX.XXX.XXX.ldb
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [ldb] (6): asq: Unable to register control with rootdse!
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sss_process_init] (1): Responder Initialization complete
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sss_ncache_set_str] (6): Adding [NCE/USER/XXX.XXX.XXX/root] to negative cache permanently
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sss_ncache_set_str] (6): Adding [NCE/USER/XXX.XXX.XXX/ldap] to negative cache permanently
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sss_ncache_set_str] (6): Adding [NCE/USER/XXX.XXX.XXX/named] to negative cache permanently
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sss_ncache_set_str] (6): Adding [NCE/USER/XXX.XXX.XXX/avahi] to negative cache permanently
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sss_ncache_set_str] (6): Adding [NCE/USER/XXX.XXX.XXX/haldaemon] to negative cache permanently
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sss_ncache_set_str] (6): Adding [NCE/USER/XXX.XXX.XXX/dbus] to negative cache permanently
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sss_ncache_set_str] (6): Adding [NCE/USER/XXX.XXX.XXX/radvd] to negative cache permanently
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sss_ncache_set_str] (6): Adding [NCE/USER/XXX.XXX.XXX/tomcat] to negative cache permanently
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sss_ncache_set_str] (6): Adding [NCE/USER/XXX.XXX.XXX/radiusd] to negative cache permanently
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sss_ncache_set_str] (6): Adding [NCE/USER/XXX.XXX.XXX/news] to negative cache permanently
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sss_ncache_set_str] (6): Adding [NCE/USER/XXX.XXX.XXX/mailman] to negative cache permanently
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sss_ncache_set_str] (6): Adding [NCE/USER/XXX.XXX.XXX/midrange] to negative cache permanently
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sss_ncache_set_str] (6): Adding [NCE/GROUP/XXX.XXX.XXX/root] to negative cache permanently
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sbus_toggle_watch] (8): 0x1c59480/0x1c56070 (19), R/- (disabled)
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sbus_toggle_watch] (8): 0x1c59480/0x1c58c60 (19), -/W (enabled)
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sbus_toggle_watch] (8): 0x1c5d150/0x1c5c470 (20), R/- (disabled)
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sbus_toggle_watch] (8): 0x1c5d150/0x1c5c420 (20), -/W (enabled)
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sbus_toggle_watch] (8): 0x1c59480/0x1c56070 (19), R/- (enabled)
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sbus_toggle_watch] (8): 0x1c59480/0x1c58c60 (19), -/W (disabled)
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sbus_toggle_watch] (8): 0x1c5d150/0x1c5c470 (20), R/- (enabled)
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sbus_toggle_watch] (8): 0x1c5d150/0x1c5c420 (20), -/W (disabled)
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sbus_remove_timeout] (8): 0x1c59860
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [id_callback] (4): Got id ack and version (1) from Monitor
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [sbus_remove_timeout] (8): 0x1c5d610
(Fri Oct 21 10:43:26 2011) [sssd[pam]] [dp_id_callback] (4): Got id ack and version (1) from DP
(Fri Oct 21 10:43:35 2011) [sssd[pam]] [sbus_remove_watch] (8): 0x1c5d150/0x1c5c470
(Fri Oct 21 10:43:35 2011) [sssd[pam]] [sbus_remove_watch] (8): 0x1c5d150/0x1c5c420
(Fri Oct 21 10:43:35 2011) [sssd[pam]] [sbus_dispatch] (1): Performing auto-reconnect
(Fri Oct 21 10:43:36 2011) [sssd[pam]] [sbus_reconnect] (3): Making reconnection attempt 1 to [unix:path=/apps/sssd-1.5.14/var/lib/sss/pipes/private/sbus-dp_XXX.XXX.XXX]
(Fri Oct 21 10:43:36 2011) [sssd[pam]] [sbus_reconnect] (3): Reconnected to [unix:path=/apps/sssd-1.5.14/var/lib/sss/pipes/private/sbus-dp_XXX.XXX.XXX]
(Fri Oct 21 10:43:36 2011) [sssd[pam]] [sbus_add_watch] (8): 0x1c59860/0x1c5c470 (20), -/W (enabled)
(Fri Oct 21 10:43:36 2011) [sssd[pam]] [sbus_toggle_watch] (8): 0x1c59860/0x1c5c420 (20), R/- (disabled)
(Fri Oct 21 10:43:36 2011) [sssd[pam]] [pam_dp_reconnect_init] (1): Reconnected to the Data Provider.
(Fri Oct 21 10:43:36 2011) [sssd[pam]] [dp_common_send_id] (4): Sending ID to DP: (1,PAM)
(Fri Oct 21 10:43:36 2011) [sssd[pam]] [sbus_add_timeout] (8): 0x1c5e550
(Fri Oct 21 10:43:36 2011) [sssd[pam]] [sbus_toggle_watch] (8): 0x1c59860/0x1c5c420 (20), R/- (enabled)
(Fri Oct 21 10:43:36 2011) [sssd[pam]] [sbus_toggle_watch] (8): 0x1c59860/0x1c5c470 (20), -/W (disabled)
(Fri Oct 21 10:43:36 2011) [sssd[pam]] [sbus_toggle_watch] (8): 0x1c59860/0x1c5c420 (20), R/- (disabled)
(Fri Oct 21 10:43:36 2011) [sssd[pam]] [sbus_toggle_watch] (8): 0x1c59860/0x1c5c470 (20), -/W (enabled)
(Fri Oct 21 10:43:36 2011) [sssd[pam]] [sbus_toggle_watch] (8): 0x1c59860/0x1c5c420 (20), R/- (enabled)
(Fri Oct 21 10:43:36 2011) [sssd[pam]] [sbus_toggle_watch] (8): 0x1c59860/0x1c5c470 (20), -/W (disabled)
(Fri Oct 21 10:43:36 2011) [sssd[pam]] [sbus_remove_timeout] (8): 0x1c5e550
(Fri Oct 21 10:43:36 2011) [sssd[pam]] [dp_id_callback] (4): Got id ack and version (1) from DP
(Fri Oct 21 10:43:46 2011) [sssd[pam]] [sbus_remove_watch] (8): 0x1c59860/0x1c5c420
(Fri Oct 21 10:43:46 2011) [sssd[pam]] [sbus_remove_watch] (8): 0x1c59860/0x1c5c470
(Fri Oct 21 10:43:46 2011) [sssd[pam]] [sbus_dispatch] (1): Performing auto-reconnect
(Fri Oct 21 10:43:47 2011) [sssd[pam]] [sbus_reconnect] (3): Making reconnection attempt 1 to [unix:path=/apps/sssd-1.5.14/var/lib/sss/pipes/private/sbus-dp_XXX.XXX.XXX]
(Fri Oct 21 10:43:47 2011) [sssd[pam]] [sbus_reconnect] (3): Reconnected to [unix:path=/apps/sssd-1.5.14/var/lib/sss/pipes/private/sbus-dp_XXX.XXX.XXX]
(Fri Oct 21 10:43:47 2011) [sssd[pam]] [sbus_add_watch] (8): 0x1c59860/0x1c5c420 (20), -/W (enabled)
(Fri Oct 21 10:43:47 2011) [sssd[pam]] [sbus_toggle_watch] (8): 0x1c59860/0x1c5c470 (20), R/- (disabled)
(Fri Oct 21 10:43:47 2011) [sssd[pam]] [pam_dp_reconnect_init] (1): Reconnected to the Data Provider.
(Fri Oct 21 10:43:47 2011) [sssd[pam]] [dp_common_send_id] (4): Sending ID to DP: (1,PAM)
(Fri Oct 21 10:43:47 2011) [sssd[pam]] [sbus_add_timeout] (8): 0x1c58ba0
(Fri Oct 21 10:43:47 2011) [sssd[pam]] [sbus_toggle_watch] (8): 0x1c59860/0x1c5c470 (20), R/- (enabled)
(Fri Oct 21 10:43:47 2011) [sssd[pam]] [sbus_toggle_watch] (8): 0x1c59860/0x1c5c420 (20), -/W (disabled)
(Fri Oct 21 10:43:47 2011) [sssd[pam]] [sbus_toggle_watch] (8): 0x1c59860/0x1c5c470 (20), R/- (disabled)
(Fri Oct 21 10:43:47 2011) [sssd[pam]] [sbus_toggle_watch] (8): 0x1c59860/0x1c5c420 (20), -/W (enabled)
(Fri Oct 21 10:43:47 2011) [sssd[pam]] [sbus_toggle_watch] (8): 0x1c59860/0x1c5c470 (20), R/- (enabled)
(Fri Oct 21 10:43:47 2011) [sssd[pam]] [sbus_toggle_watch] (8): 0x1c59860/0x1c5c420 (20), -/W (disabled)
(Fri Oct 21 10:43:47 2011) [sssd[pam]] [sbus_remove_timeout] (8): 0x1c58ba0
(Fri Oct 21 10:43:47 2011) [sssd[pam]] [dp_id_callback] (4): Got id ack and version (1) from DP
(Fri Oct 21 10:43:52 2011) [sssd[pam]] [sbus_remove_watch] (8): 0x1c59860/0x1c5c470
(Fri Oct 21 10:43:52 2011) [sssd[pam]] [sbus_remove_watch] (8): 0x1c59860/0x1c5c420
(Fri Oct 21 10:43:52 2011) [sssd[pam]] [sbus_dispatch] (1): Performing auto-reconnect


Cheers,

Tim Gollschewsky.

This e-mail is sent by Suncorp Group Limited ABN 66 145 290 124 or one of its related entities "Suncorp".
Suncorp may be contacted at Level 18, 36 Wickham Terrace, Brisbane or on 13 11 55 or at suncorp.com.au.
The content of this e-mail is the view of the sender or stated author and does not necessarily reflect the view of Suncorp. The content, including attachments, is a confidential communication between Suncorp and the intended recipient. If you are not the intended recipient, any use, interference with, disclosure or copying of this e-mail, including attachments, is unauthorised and expressly prohibited. If you have received this e-mail in error please contact the sender immediately and delete the e-mail and any attachments from your system.



More information about the sssd-devel mailing list