/mandos/trunk

To get this branch, use:
bzr branch http://bzr.recompile.se/loggerhead/mandos/trunk

« back to all changes in this revision

Viewing changes to mandos

  • Committer: Teddy Hogeborn
  • Date: 2008-08-22 00:16:20 UTC
  • mfrom: (24.1.57 mandos)
  • Revision ID: teddy@fukt.bsnet.se-20080822001620-vxpn1evy0t0kyvj0
* clients.conf ([DEFAULT]/checker): Update to new default value.

* mandos (Client.start_checker): Bug fix: OSError, not
                                 subprocess.OSError.
  (main): Use "fping -q -- %(host)s" instead of "fping -q --
          %%(host)s" as default value for "checker".  Always redirect
          stdin to be from /dev/null, even if in debug mode.

* mandos-clients.conf.xml (DESCRIPTION): Improved wording and refer to
                                         the EXPANSION section.
  (OPTIONS): Added synopsis and improved wording for "checker",
             "fingerprint", and "secret".  Refer to the RUNTIME
             EXPANSION section for the "checker" option.
  (EXAMPLE): Update to new default value for "checker".

* mandos-keygen (trap): Split lines and add "set +e".

Show diffs side-by-side

added added

removed removed

Lines of Context:
mandos
6
6
# This program is partly derived from an example program for an Avahi
7
7
# service publisher, downloaded from
8
8
# <http://avahi.org/wiki/PythonPublishExample>.  This includes the
9
 
# following functions: "AvahiService.add", "AvahiService.remove",
10
 
# "server_state_changed", "entry_group_state_changed", and some lines
11
 
# in "main".
 
9
# methods "add" and "remove" in the "AvahiService" class, the
 
10
# "server_state_changed" and "entry_group_state_changed" functions,
 
11
# and some lines in "main".
12
12
# 
13
13
# Everything else is
14
14
# Copyright © 2007-2008 Teddy Hogeborn & Björn Påhlsson
61
61
from dbus.mainloop.glib import DBusGMainLoop
62
62
import ctypes
63
63
 
64
 
# Brief description of the operation of this program:
65
 
# 
66
 
# This server announces itself as a Zeroconf service.  Connecting
67
 
# clients use the TLS protocol, with the unusual quirk that this
68
 
# server program acts as a TLS "client" while a connecting client acts
69
 
# as a TLS "server".  The client (acting as a TLS "server") must
70
 
# supply an OpenPGP certificate, and the fingerprint of this
71
 
# certificate is used by this server to look up (in a list read from a
72
 
# file at start time) which binary blob to give the client.  No other
73
 
# authentication or authorization is done by this server.
74
 
 
 
64
version = "1.0"
75
65
 
76
66
logger = logging.Logger('mandos')
77
67
syslogger = logging.handlers.SysLogHandler\
78
 
            (facility = logging.handlers.SysLogHandler.LOG_DAEMON)
 
68
            (facility = logging.handlers.SysLogHandler.LOG_DAEMON,
 
69
             address = "/dev/log")
79
70
syslogger.setFormatter(logging.Formatter\
80
 
                        ('%(levelname)s: %(message)s'))
 
71
                        ('Mandos: %(levelname)s: %(message)s'))
81
72
logger.addHandler(syslogger)
82
 
del syslogger
83
73
 
 
74
console = logging.StreamHandler()
 
75
console.setFormatter(logging.Formatter('%(name)s: %(levelname)s:'
 
76
                                       ' %(message)s'))
 
77
logger.addHandler(console)
84
78
 
85
79
class AvahiError(Exception):
86
80
    def __init__(self, value):
96
90
 
97
91
 
98
92
class AvahiService(object):
99
 
    """
 
93
    """An Avahi (Zeroconf) service.
 
94
    Attributes:
100
95
    interface: integer; avahi.IF_UNSPEC or an interface index.
101
96
               Used to optionally bind to the specified interface.
102
 
    name = string; Example: "Mandos"
103
 
    type = string; Example: "_mandos._tcp".
104
 
                   See <http://www.dns-sd.org/ServiceTypes.html>
105
 
    port = integer; what port to announce
106
 
    TXT = list of strings; TXT record for the service
107
 
    domain = string; Domain to publish on, default to .local if empty.
108
 
    host = string; Host to publish records for, default to localhost
109
 
                   if empty.
110
 
    max_renames = integer; maximum number of renames
111
 
    rename_count = integer; counter so we only rename after collisions
112
 
                   a sensible number of times
 
97
    name: string; Example: 'Mandos'
 
98
    type: string; Example: '_mandos._tcp'.
 
99
                  See <http://www.dns-sd.org/ServiceTypes.html>
 
100
    port: integer; what port to announce
 
101
    TXT: list of strings; TXT record for the service
 
102
    domain: string; Domain to publish on, default to .local if empty.
 
103
    host: string; Host to publish records for, default is localhost
 
104
    max_renames: integer; maximum number of renames
 
105
    rename_count: integer; counter so we only rename after collisions
 
106
                  a sensible number of times
113
107
    """
114
108
    def __init__(self, interface = avahi.IF_UNSPEC, name = None,
115
109
                 type = None, port = None, TXT = None, domain = "",
116
 
                 host = "", max_renames = 12):
117
 
        """An Avahi (Zeroconf) service. """
 
110
                 host = "", max_renames = 32768):
118
111
        self.interface = interface
119
112
        self.name = name
120
113
        self.type = type
126
119
        self.domain = domain
127
120
        self.host = host
128
121
        self.rename_count = 0
 
122
        self.max_renames = max_renames
129
123
    def rename(self):
130
124
        """Derived from the Avahi example code"""
131
125
        if self.rename_count >= self.max_renames:
132
126
            logger.critical(u"No suitable service name found after %i"
133
127
                            u" retries, exiting.", rename_count)
134
128
            raise AvahiServiceError("Too many renames")
135
 
        name = server.GetAlternativeServiceName(name)
136
 
        logger.notice(u"Changing name to %r ...", name)
 
129
        self.name = server.GetAlternativeServiceName(self.name)
 
130
        logger.info(u"Changing name to %r ...", str(self.name))
 
131
        syslogger.setFormatter(logging.Formatter\
 
132
                               ('Mandos (%s): %%(levelname)s:'
 
133
                               ' %%(message)s' % self.name))
137
134
        self.remove()
138
135
        self.add()
139
136
        self.rename_count += 1
175
172
    fingerprint: string (40 or 32 hexadecimal digits); used to
176
173
                 uniquely identify the client
177
174
    secret:    bytestring; sent verbatim (over TLS) to client
178
 
    fqdn:      string (FQDN); available for use by the checker command
 
175
    host:      string; available for use by the checker command
179
176
    created:   datetime.datetime(); object creation, not client host
180
177
    last_checked_ok: datetime.datetime() or None if not yet checked OK
181
178
    timeout:   datetime.timedelta(); How long from last_checked_ok
221
218
    interval = property(lambda self: self._interval,
222
219
                        _set_interval)
223
220
    del _set_interval
224
 
    def __init__(self, name=None, stop_hook=None, fingerprint=None,
225
 
                 secret=None, secfile=None, fqdn=None, timeout=None,
226
 
                 interval=-1, checker=None):
227
 
        """Note: the 'checker' argument sets the 'checker_command'
228
 
        attribute and not the 'checker' attribute.."""
 
221
    def __init__(self, name = None, stop_hook=None, config={}):
 
222
        """Note: the 'checker' key in 'config' sets the
 
223
        'checker_command' attribute and *not* the 'checker'
 
224
        attribute."""
229
225
        self.name = name
230
226
        logger.debug(u"Creating client %r", self.name)
231
 
        # Uppercase and remove spaces from fingerprint
232
 
        # for later comparison purposes with return value of
233
 
        # the fingerprint() function
234
 
        self.fingerprint = fingerprint.upper().replace(u" ", u"")
 
227
        # Uppercase and remove spaces from fingerprint for later
 
228
        # comparison purposes with return value from the fingerprint()
 
229
        # function
 
230
        self.fingerprint = config["fingerprint"].upper()\
 
231
                           .replace(u" ", u"")
235
232
        logger.debug(u"  Fingerprint: %s", self.fingerprint)
236
 
        if secret:
237
 
            self.secret = secret.decode(u"base64")
238
 
        elif secfile:
239
 
            sf = open(secfile)
 
233
        if "secret" in config:
 
234
            self.secret = config["secret"].decode(u"base64")
 
235
        elif "secfile" in config:
 
236
            sf = open(config["secfile"])
240
237
            self.secret = sf.read()
241
238
            sf.close()
242
239
        else:
243
240
            raise TypeError(u"No secret or secfile for client %s"
244
241
                            % self.name)
245
 
        self.fqdn = fqdn
 
242
        self.host = config.get("host", "")
246
243
        self.created = datetime.datetime.now()
247
244
        self.last_checked_ok = None
248
 
        self.timeout = string_to_delta(timeout)
249
 
        self.interval = string_to_delta(interval)
 
245
        self.timeout = string_to_delta(config["timeout"])
 
246
        self.interval = string_to_delta(config["interval"])
250
247
        self.stop_hook = stop_hook
251
248
        self.checker = None
252
249
        self.checker_initiator_tag = None
253
250
        self.stop_initiator_tag = None
254
251
        self.checker_callback_tag = None
255
 
        self.check_command = checker
 
252
        self.check_command = config["checker"]
256
253
    def start(self):
257
254
        """Start this client's checker and timeout hooks"""
258
255
        # Schedule a new checker to be started an 'interval' from now,
271
268
        The possibility that a client might be restarted is left open,
272
269
        but not currently used."""
273
270
        # If this client doesn't have a secret, it is already stopped.
274
 
        if self.secret:
275
 
            logger.debug(u"Stopping client %s", self.name)
 
271
        if hasattr(self, "secret") and self.secret:
 
272
            logger.info(u"Stopping client %s", self.name)
276
273
            self.secret = None
277
274
        else:
278
275
            return False
297
294
        self.checker = None
298
295
        if os.WIFEXITED(condition) \
299
296
               and (os.WEXITSTATUS(condition) == 0):
300
 
            logger.debug(u"Checker for %(name)s succeeded",
301
 
                         vars(self))
 
297
            logger.info(u"Checker for %(name)s succeeded",
 
298
                        vars(self))
302
299
            self.last_checked_ok = now
303
300
            gobject.source_remove(self.stop_initiator_tag)
304
301
            self.stop_initiator_tag = gobject.timeout_add\
308
305
            logger.warning(u"Checker for %(name)s crashed?",
309
306
                           vars(self))
310
307
        else:
311
 
            logger.debug(u"Checker for %(name)s failed",
312
 
                         vars(self))
 
308
            logger.info(u"Checker for %(name)s failed",
 
309
                        vars(self))
313
310
    def start_checker(self):
314
311
        """Start a new checker subprocess if one is not running.
315
312
        If a checker already exists, leave it running and do
325
322
        if self.checker is None:
326
323
            try:
327
324
                # In case check_command has exactly one % operator
328
 
                command = self.check_command % self.fqdn
 
325
                command = self.check_command % self.host
329
326
            except TypeError:
330
327
                # Escape attributes for the shell
331
328
                escaped_attrs = dict((key, re.escape(str(val)))
338
335
                                 u' %s', self.check_command, error)
339
336
                    return True # Try again later
340
337
            try:
341
 
                logger.debug(u"Starting checker %r for %s",
342
 
                             command, self.name)
 
338
                logger.info(u"Starting checker %r for %s",
 
339
                            command, self.name)
 
340
                # We don't need to redirect stdout and stderr, since
 
341
                # in normal mode, that is already done by daemon(),
 
342
                # and in debug mode we don't want to.  (Stdin is
 
343
                # always replaced by /dev/null.)
343
344
                self.checker = subprocess.Popen(command,
344
345
                                                close_fds=True,
345
346
                                                shell=True, cwd="/")
346
347
                self.checker_callback_tag = gobject.child_watch_add\
347
348
                                            (self.checker.pid,
348
349
                                             self.checker_callback)
349
 
            except subprocess.OSError, error:
 
350
            except OSError, error:
350
351
                logger.error(u"Failed to start subprocess: %s",
351
352
                             error)
352
353
        # Re-run this periodically if run by gobject.timeout_add
358
359
            self.checker_callback_tag = None
359
360
        if getattr(self, "checker", None) is None:
360
361
            return
361
 
        logger.debug("Stopping checker for %(name)s", vars(self))
 
362
        logger.debug(u"Stopping checker for %(name)s", vars(self))
362
363
        try:
363
364
            os.kill(self.checker.pid, signal.SIGTERM)
364
365
            #os.sleep(0.5)
396
397
 
397
398
def fingerprint(openpgp):
398
399
    "Convert an OpenPGP bytestring to a hexdigit fingerprint string"
399
 
    # New empty GnuTLS certificate
400
 
    crt = gnutls.library.types.gnutls_openpgp_crt_t()
401
 
    gnutls.library.functions.gnutls_openpgp_crt_init\
402
 
        (ctypes.byref(crt))
403
400
    # New GnuTLS "datum" with the OpenPGP public key
404
401
    datum = gnutls.library.types.gnutls_datum_t\
405
402
        (ctypes.cast(ctypes.c_char_p(openpgp),
406
403
                     ctypes.POINTER(ctypes.c_ubyte)),
407
404
         ctypes.c_uint(len(openpgp)))
 
405
    # New empty GnuTLS certificate
 
406
    crt = gnutls.library.types.gnutls_openpgp_crt_t()
 
407
    gnutls.library.functions.gnutls_openpgp_crt_init\
 
408
        (ctypes.byref(crt))
408
409
    # Import the OpenPGP public key into the certificate
409
 
    ret = gnutls.library.functions.gnutls_openpgp_crt_import\
410
 
        (crt,
411
 
         ctypes.byref(datum),
412
 
         gnutls.library.constants.GNUTLS_OPENPGP_FMT_RAW)
 
410
    gnutls.library.functions.gnutls_openpgp_crt_import\
 
411
                    (crt, ctypes.byref(datum),
 
412
                     gnutls.library.constants.GNUTLS_OPENPGP_FMT_RAW)
413
413
    # New buffer for the fingerprint
414
414
    buffer = ctypes.create_string_buffer(20)
415
415
    buffer_length = ctypes.c_size_t()
431
431
    Note: This will run in its own forked process."""
432
432
    
433
433
    def handle(self):
434
 
        logger.debug(u"TCP connection from: %s",
 
434
        logger.info(u"TCP connection from: %s",
435
435
                     unicode(self.client_address))
436
436
        session = gnutls.connection.ClientSession\
437
437
                  (self.request, gnutls.connection.X509Credentials())
463
463
        try:
464
464
            session.handshake()
465
465
        except gnutls.errors.GNUTLSError, error:
466
 
            logger.debug(u"Handshake failed: %s", error)
 
466
            logger.warning(u"Handshake failed: %s", error)
467
467
            # Do not run session.bye() here: the session is not
468
468
            # established.  Just abandon the request.
469
469
            return
470
470
        try:
471
471
            fpr = fingerprint(peer_certificate(session))
472
472
        except (TypeError, gnutls.errors.GNUTLSError), error:
473
 
            logger.debug(u"Bad certificate: %s", error)
 
473
            logger.warning(u"Bad certificate: %s", error)
474
474
            session.bye()
475
475
            return
476
476
        logger.debug(u"Fingerprint: %s", fpr)
480
480
                client = c
481
481
                break
482
482
        if not client:
483
 
            logger.debug(u"Client not found for fingerprint: %s", fpr)
 
483
            logger.warning(u"Client not found for fingerprint: %s",
 
484
                           fpr)
484
485
            session.bye()
485
486
            return
486
487
        # Have to check if client.still_valid(), since it is possible
487
488
        # that the client timed out while establishing the GnuTLS
488
489
        # session.
489
490
        if not client.still_valid():
490
 
            logger.debug(u"Client %(name)s is invalid", vars(client))
 
491
            logger.warning(u"Client %(name)s is invalid",
 
492
                           vars(client))
491
493
            session.bye()
492
494
            return
493
495
        sent_size = 0
528
530
                                       self.settings["interface"])
529
531
            except socket.error, error:
530
532
                if error[0] == errno.EPERM:
531
 
                    logger.warning(u"No permission to"
532
 
                                   u" bind to interface %s",
533
 
                                   self.settings["interface"])
 
533
                    logger.error(u"No permission to"
 
534
                                 u" bind to interface %s",
 
535
                                 self.settings["interface"])
534
536
                else:
535
537
                    raise error
536
538
        # Only bind(2) the socket if we really need to.
539
541
                in6addr_any = "::"
540
542
                self.server_address = (in6addr_any,
541
543
                                       self.server_address[1])
542
 
            elif self.server_address[1] is None:
 
544
            elif not self.server_address[1]:
543
545
                self.server_address = (self.server_address[0],
544
546
                                       0)
 
547
#                 if self.settings["interface"]:
 
548
#                     self.server_address = (self.server_address[0],
 
549
#                                            0, # port
 
550
#                                            0, # flowinfo
 
551
#                                            if_nametoindex
 
552
#                                            (self.settings
 
553
#                                             ["interface"]))
545
554
            return super(type(self), self).server_bind()
546
555
 
547
556
 
558
567
    datetime.timedelta(1)
559
568
    >>> string_to_delta(u'1w')
560
569
    datetime.timedelta(7)
 
570
    >>> string_to_delta('5m 30s')
 
571
    datetime.timedelta(0, 330)
561
572
    """
562
 
    try:
563
 
        suffix=unicode(interval[-1])
564
 
        value=int(interval[:-1])
565
 
        if suffix == u"d":
566
 
            delta = datetime.timedelta(value)
567
 
        elif suffix == u"s":
568
 
            delta = datetime.timedelta(0, value)
569
 
        elif suffix == u"m":
570
 
            delta = datetime.timedelta(0, 0, 0, 0, value)
571
 
        elif suffix == u"h":
572
 
            delta = datetime.timedelta(0, 0, 0, 0, 0, value)
573
 
        elif suffix == u"w":
574
 
            delta = datetime.timedelta(0, 0, 0, 0, 0, 0, value)
575
 
        else:
 
573
    timevalue = datetime.timedelta(0)
 
574
    for s in interval.split():
 
575
        try:
 
576
            suffix=unicode(s[-1])
 
577
            value=int(s[:-1])
 
578
            if suffix == u"d":
 
579
                delta = datetime.timedelta(value)
 
580
            elif suffix == u"s":
 
581
                delta = datetime.timedelta(0, value)
 
582
            elif suffix == u"m":
 
583
                delta = datetime.timedelta(0, 0, 0, 0, value)
 
584
            elif suffix == u"h":
 
585
                delta = datetime.timedelta(0, 0, 0, 0, 0, value)
 
586
            elif suffix == u"w":
 
587
                delta = datetime.timedelta(0, 0, 0, 0, 0, 0, value)
 
588
            else:
 
589
                raise ValueError
 
590
        except (ValueError, IndexError):
576
591
            raise ValueError
577
 
    except (ValueError, IndexError):
578
 
        raise ValueError
579
 
    return delta
 
592
        timevalue += delta
 
593
    return timevalue
580
594
 
581
595
 
582
596
def server_state_changed(state):
583
597
    """Derived from the Avahi example code"""
584
598
    if state == avahi.SERVER_COLLISION:
585
 
        logger.warning(u"Server name collision")
 
599
        logger.error(u"Server name collision")
586
600
        service.remove()
587
601
    elif state == avahi.SERVER_RUNNING:
588
602
        service.add()
627
641
    return if_nametoindex(interface)
628
642
 
629
643
 
630
 
def daemon(nochdir, noclose):
 
644
def daemon(nochdir = False, noclose = False):
631
645
    """See daemon(3).  Standard BSD Unix function.
632
646
    This should really exist as os.daemon, but it doesn't (yet)."""
633
647
    if os.fork():
635
649
    os.setsid()
636
650
    if not nochdir:
637
651
        os.chdir("/")
 
652
    if os.fork():
 
653
        sys.exit()
638
654
    if not noclose:
639
655
        # Close all standard open file descriptors
640
656
        null = os.open(os.path.devnull, os.O_NOCTTY | os.O_RDWR)
652
668
    global main_loop_started
653
669
    main_loop_started = False
654
670
    
655
 
    parser = OptionParser()
 
671
    parser = OptionParser(version = "%%prog %s" % version)
656
672
    parser.add_option("-i", "--interface", type="string",
657
673
                      metavar="IF", help="Bind to interface IF")
658
674
    parser.add_option("-a", "--address", type="string",
661
677
                      help="Port number to receive requests on")
662
678
    parser.add_option("--check", action="store_true", default=False,
663
679
                      help="Run self-test")
664
 
    parser.add_option("--debug", action="store_true", default=False,
 
680
    parser.add_option("--debug", action="store_true",
665
681
                      help="Debug mode; run in foreground and log to"
666
682
                      " terminal")
667
683
    parser.add_option("--priority", type="string", help="GnuTLS"
692
708
    # Parse config file for server-global settings
693
709
    server_config = ConfigParser.SafeConfigParser(server_defaults)
694
710
    del server_defaults
695
 
    server_config.read(os.path.join(options.configdir, "server.conf"))
696
 
    server_section = "server"
 
711
    server_config.read(os.path.join(options.configdir, "mandos.conf"))
697
712
    # Convert the SafeConfigParser object to a dict
698
 
    server_settings = dict(server_config.items(server_section))
 
713
    server_settings = server_config.defaults()
699
714
    # Use getboolean on the boolean config option
700
715
    server_settings["debug"] = server_config.getboolean\
701
 
                               (server_section, "debug")
 
716
                               ("DEFAULT", "debug")
702
717
    del server_config
703
718
    
704
719
    # Override the settings from the config file with command line
711
726
    del options
712
727
    # Now we have our good server settings in "server_settings"
713
728
    
 
729
    debug = server_settings["debug"]
 
730
    
 
731
    if not debug:
 
732
        syslogger.setLevel(logging.WARNING)
 
733
        console.setLevel(logging.WARNING)
 
734
    
 
735
    if server_settings["servicename"] != "Mandos":
 
736
        syslogger.setFormatter(logging.Formatter\
 
737
                               ('Mandos (%s): %%(levelname)s:'
 
738
                                ' %%(message)s'
 
739
                                % server_settings["servicename"]))
 
740
    
714
741
    # Parse config file with clients
715
742
    client_defaults = { "timeout": "1h",
716
743
                        "interval": "5m",
717
 
                        "checker": "fping -q -- %%(fqdn)s",
 
744
                        "checker": "fping -q -- %(host)s",
 
745
                        "host": "",
718
746
                        }
719
747
    client_config = ConfigParser.SafeConfigParser(client_defaults)
720
748
    client_config.read(os.path.join(server_settings["configdir"],
738
766
            avahi.DBUS_INTERFACE_SERVER )
739
767
    # End of Avahi example code
740
768
    
741
 
    debug = server_settings["debug"]
742
 
    
743
 
    if debug:
744
 
        console = logging.StreamHandler()
745
 
        # console.setLevel(logging.DEBUG)
746
 
        console.setFormatter(logging.Formatter\
747
 
                             ('%(levelname)s: %(message)s'))
748
 
        logger.addHandler(console)
749
 
        del console
750
 
    
751
769
    clients = Set()
752
770
    def remove_from_clients(client):
753
771
        clients.remove(client)
754
772
        if not clients:
755
 
            logger.debug(u"No clients left, exiting")
 
773
            logger.critical(u"No clients left, exiting")
756
774
            sys.exit()
757
775
    
758
 
    clients.update(Set(Client(name=section,
 
776
    clients.update(Set(Client(name = section,
759
777
                              stop_hook = remove_from_clients,
760
 
                              **(dict(client_config\
761
 
                                      .items(section))))
 
778
                              config
 
779
                              = dict(client_config.items(section)))
762
780
                       for section in client_config.sections()))
763
 
    
764
 
    if not debug:
765
 
        daemon(False, False)
 
781
    if not clients:
 
782
        logger.critical(u"No clients defined")
 
783
        sys.exit(1)
 
784
    
 
785
    if debug:
 
786
        # Redirect stdin so all checkers get /dev/null
 
787
        null = os.open(os.path.devnull, os.O_NOCTTY | os.O_RDWR)
 
788
        os.dup2(null, sys.stdin.fileno())
 
789
        if null > 2:
 
790
            os.close(null)
 
791
    else:
 
792
        # No console logging
 
793
        logger.removeHandler(console)
 
794
        # Close all input and output, do double fork, etc.
 
795
        daemon()
 
796
    
 
797
    pidfilename = "/var/run/mandos/mandos.pid"
 
798
    pid = os.getpid()
 
799
    try:
 
800
        pidfile = open(pidfilename, "w")
 
801
        pidfile.write(str(pid) + "\n")
 
802
        pidfile.close()
 
803
        del pidfile
 
804
    except IOError, err:
 
805
        logger.error(u"Could not write %s file with PID %d",
 
806
                     pidfilename, os.getpid())
766
807
    
767
808
    def cleanup():
768
809
        "Cleanup function; run on exit"
795
836
                                clients=clients)
796
837
    # Find out what port we got
797
838
    service.port = tcp_server.socket.getsockname()[1]
798
 
    logger.debug(u"Now listening on address %r, port %d, flowinfo %d,"
799
 
                 u" scope_id %d" % tcp_server.socket.getsockname())
 
839
    logger.info(u"Now listening on address %r, port %d, flowinfo %d,"
 
840
                u" scope_id %d" % tcp_server.socket.getsockname())
800
841
    
801
842
    #service.interface = tcp_server.socket.getsockname()[3]
802
843
    
815
856
                             tcp_server.handle_request\
816
857
                             (*args[2:], **kwargs) or True)
817
858
        
818
 
        logger.debug("Starting main loop")
 
859
        logger.debug(u"Starting main loop")
819
860
        main_loop_started = True
820
861
        main_loop.run()
821
862
    except AvahiError, error: