[krbdev.mit.edu #3277] doubled kerberos logging to stderr

[Denis Vlasenko via RT]

On Thursday 08 December 2005 19:39, Tom Yu via RT wrote:
> >>>>> "Denis" == Denis Vlasenko via RT <rt-comment at krbdev.mit.edu> writes:
> 
> Denis> IOW, /etc/krb5.conf is read once, yet "default = FILE:/proc/self/fd/2"
> Denis> directive seems to be processed twice.
> 
> If you set the KRB5_CONFIG environment variable to "/etc/krb5.conf",
> do you still get the duplicates?

No, I do not. This is instrumented version of kdc running:

2005-12-09 10:02:54.655785500 kdc
2005-12-09 10:02:54.656054500 krb5kdc
2005-12-09 10:02:54.656147500 FILE:/proc/self/fd/2   <=== parses config
2005-12-09 10:02:54.656335500 FILE
2005-12-09 10:02:55.046682500 !    <=== about to emit message
2005-12-09 10:02:55.046787500 *    <=== one and only log destination
2005-12-09 10:02:55.046991500 Dec 09 10:02:55 logic krb5kdc[4905](info): setting up network...
2005-12-09 10:02:55.047331500 !
2005-12-09 10:02:55.047390500 *
2005-12-09 10:02:55.047447500 Dec 09 10:02:55 logic krb5kdc[4905](info): listening on fd 6: udp 172.16.22.2.750
2005-12-09 10:02:55.047551500 !
2005-12-09 10:02:55.047632500 *
2005-12-09 10:02:55.047688500 Dec 09 10:02:55 logic krb5kdc[4905](info): listening on fd 7: udp 172.16.22.2.88
...

Without KRB5_CONFIG:

2005-12-08 14:46:04.467856500 kdc
2005-12-08 14:46:04.468130500 krb5kdc
2005-12-08 14:46:04.468231500 FILE:/proc/self/fd/2   <=== parses config, gets FILE:... twice
2005-12-08 14:46:04.468306500 FILE:/proc/self/fd/2
2005-12-08 14:46:04.468521500 FILE
2005-12-08 14:46:04.468613500 FILE
2005-12-08 14:46:04.814418500 !    <=== about to emit message
2005-12-08 14:46:04.814508500 *    <=== log to first FILE:
2005-12-08 14:46:04.814616500 Dec 08 14:46:04 logic krb5kdc[31794](info): setting up network...
2005-12-08 14:46:04.814678500 *    <=== log to second FILE:
2005-12-08 14:46:04.814758500 Dec 08 14:46:04 logic krb5kdc[31794](info): setting up network...
...

--
vda