/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: 2014-05-12 21:02:38 UTC
  • Revision ID: teddy@recompile.se-20140512210238-t6o8b1ieeojrs0xl
Do not run self-tests when building arch-indep Debian package.

* debian/rules (override_dh_auto_test-arch): New; does nothing.

Show diffs side-by-side

added added

removed removed

Lines of Context:
11
11
# "AvahiService" class, and some lines in "main".
12
12
13
13
# Everything else is
14
 
# Copyright © 2008-2011 Teddy Hogeborn
15
 
# Copyright © 2008-2011 Björn Påhlsson
 
14
# Copyright © 2008-2014 Teddy Hogeborn
 
15
# Copyright © 2008-2014 Björn Påhlsson
16
16
17
17
# This program is free software: you can redistribute it and/or modify
18
18
# it under the terms of the GNU General Public License as published by
34
34
from __future__ import (division, absolute_import, print_function,
35
35
                        unicode_literals)
36
36
 
 
37
from future_builtins import *
 
38
 
37
39
import SocketServer as socketserver
38
40
import socket
39
41
import argparse
65
67
import types
66
68
import binascii
67
69
import tempfile
 
70
import itertools
 
71
import collections
68
72
 
69
73
import dbus
70
74
import dbus.service
75
79
import ctypes.util
76
80
import xml.dom.minidom
77
81
import inspect
78
 
import GnuPGInterface
79
82
 
80
83
try:
81
84
    SO_BINDTODEVICE = socket.SO_BINDTODEVICE
85
88
    except ImportError:
86
89
        SO_BINDTODEVICE = None
87
90
 
88
 
 
89
 
version = "1.4.1"
 
91
version = "1.6.5"
90
92
stored_state_file = "clients.pickle"
91
93
 
92
94
logger = logging.getLogger()
93
 
syslogger = (logging.handlers.SysLogHandler
94
 
             (facility = logging.handlers.SysLogHandler.LOG_DAEMON,
95
 
              address = str("/dev/log")))
 
95
syslogger = None
96
96
 
97
97
try:
98
98
    if_nametoindex = (ctypes.cdll.LoadLibrary
111
111
        return interface_index
112
112
 
113
113
 
114
 
def initlogger(level=logging.WARNING):
 
114
def initlogger(debug, level=logging.WARNING):
115
115
    """init logger and add loglevel"""
116
116
    
 
117
    syslogger = (logging.handlers.SysLogHandler
 
118
                 (facility =
 
119
                  logging.handlers.SysLogHandler.LOG_DAEMON,
 
120
                  address = str("/dev/log")))
117
121
    syslogger.setFormatter(logging.Formatter
118
122
                           ('Mandos [%(process)d]: %(levelname)s:'
119
123
                            ' %(message)s'))
120
124
    logger.addHandler(syslogger)
121
125
    
122
 
    console = logging.StreamHandler()
123
 
    console.setFormatter(logging.Formatter('%(asctime)s %(name)s'
124
 
                                           ' [%(process)d]:'
125
 
                                           ' %(levelname)s:'
126
 
                                           ' %(message)s'))
127
 
    logger.addHandler(console)
 
126
    if debug:
 
127
        console = logging.StreamHandler()
 
128
        console.setFormatter(logging.Formatter('%(asctime)s %(name)s'
 
129
                                               ' [%(process)d]:'
 
130
                                               ' %(levelname)s:'
 
131
                                               ' %(message)s'))
 
132
        logger.addHandler(console)
128
133
    logger.setLevel(level)
129
134
 
130
135
 
131
 
class CryptoError(Exception):
 
136
class PGPError(Exception):
 
137
    """Exception if encryption/decryption fails"""
132
138
    pass
133
139
 
134
140
 
135
 
class Crypto(object):
 
141
class PGPEngine(object):
136
142
    """A simple class for OpenPGP symmetric encryption & decryption"""
137
143
    def __init__(self):
138
 
        self.gnupg = GnuPGInterface.GnuPG()
139
144
        self.tempdir = tempfile.mkdtemp(prefix="mandos-")
140
 
        self.gnupg = GnuPGInterface.GnuPG()
141
 
        self.gnupg.options.meta_interactive = False
142
 
        self.gnupg.options.homedir = self.tempdir
143
 
        self.gnupg.options.extra_args.extend(['--force-mdc',
144
 
                                              '--quiet'])
 
145
        self.gnupgargs = ['--batch',
 
146
                          '--home', self.tempdir,
 
147
                          '--force-mdc',
 
148
                          '--quiet',
 
149
                          '--no-use-agent']
145
150
    
146
151
    def __enter__(self):
147
152
        return self
148
153
    
149
 
    def __exit__ (self, exc_type, exc_value, traceback):
 
154
    def __exit__(self, exc_type, exc_value, traceback):
150
155
        self._cleanup()
151
156
        return False
152
157
    
169
174
    def password_encode(self, password):
170
175
        # Passphrase can not be empty and can not contain newlines or
171
176
        # NUL bytes.  So we prefix it and hex encode it.
172
 
        return b"mandos" + binascii.hexlify(password)
 
177
        encoded = b"mandos" + binascii.hexlify(password)
 
178
        if len(encoded) > 2048:
 
179
            # GnuPG can't handle long passwords, so encode differently
 
180
            encoded = (b"mandos" + password.replace(b"\\", b"\\\\")
 
181
                       .replace(b"\n", b"\\n")
 
182
                       .replace(b"\0", b"\\x00"))
 
183
        return encoded
173
184
    
174
185
    def encrypt(self, data, password):
175
 
        self.gnupg.passphrase = self.password_encode(password)
176
 
        with open(os.devnull) as devnull:
177
 
            try:
178
 
                proc = self.gnupg.run(['--symmetric'],
179
 
                                      create_fhs=['stdin', 'stdout'],
180
 
                                      attach_fhs={'stderr': devnull})
181
 
                with contextlib.closing(proc.handles['stdin']) as f:
182
 
                    f.write(data)
183
 
                with contextlib.closing(proc.handles['stdout']) as f:
184
 
                    ciphertext = f.read()
185
 
                proc.wait()
186
 
            except IOError as e:
187
 
                raise CryptoError(e)
188
 
        self.gnupg.passphrase = None
 
186
        passphrase = self.password_encode(password)
 
187
        with tempfile.NamedTemporaryFile(dir=self.tempdir
 
188
                                         ) as passfile:
 
189
            passfile.write(passphrase)
 
190
            passfile.flush()
 
191
            proc = subprocess.Popen(['gpg', '--symmetric',
 
192
                                     '--passphrase-file',
 
193
                                     passfile.name]
 
194
                                    + self.gnupgargs,
 
195
                                    stdin = subprocess.PIPE,
 
196
                                    stdout = subprocess.PIPE,
 
197
                                    stderr = subprocess.PIPE)
 
198
            ciphertext, err = proc.communicate(input = data)
 
199
        if proc.returncode != 0:
 
200
            raise PGPError(err)
189
201
        return ciphertext
190
202
    
191
203
    def decrypt(self, data, password):
192
 
        self.gnupg.passphrase = self.password_encode(password)
193
 
        with open(os.devnull) as devnull:
194
 
            try:
195
 
                proc = self.gnupg.run(['--decrypt'],
196
 
                                      create_fhs=['stdin', 'stdout'],
197
 
                                      attach_fhs={'stderr': devnull})
198
 
                with contextlib.closing(proc.handles['stdin'] ) as f:
199
 
                    f.write(data)
200
 
                with contextlib.closing(proc.handles['stdout']) as f:
201
 
                    decrypted_plaintext = f.read()
202
 
                proc.wait()
203
 
            except IOError as e:
204
 
                raise CryptoError(e)
205
 
        self.gnupg.passphrase = None
 
204
        passphrase = self.password_encode(password)
 
205
        with tempfile.NamedTemporaryFile(dir = self.tempdir
 
206
                                         ) as passfile:
 
207
            passfile.write(passphrase)
 
208
            passfile.flush()
 
209
            proc = subprocess.Popen(['gpg', '--decrypt',
 
210
                                     '--passphrase-file',
 
211
                                     passfile.name]
 
212
                                    + self.gnupgargs,
 
213
                                    stdin = subprocess.PIPE,
 
214
                                    stdout = subprocess.PIPE,
 
215
                                    stderr = subprocess.PIPE)
 
216
            decrypted_plaintext, err = proc.communicate(input
 
217
                                                        = data)
 
218
        if proc.returncode != 0:
 
219
            raise PGPError(err)
206
220
        return decrypted_plaintext
207
221
 
208
222
 
209
 
 
210
223
class AvahiError(Exception):
211
224
    def __init__(self, value, *args, **kwargs):
212
225
        self.value = value
229
242
               Used to optionally bind to the specified interface.
230
243
    name: string; Example: 'Mandos'
231
244
    type: string; Example: '_mandos._tcp'.
232
 
                  See <http://www.dns-sd.org/ServiceTypes.html>
 
245
     See <https://www.iana.org/assignments/service-names-port-numbers>
233
246
    port: integer; what port to announce
234
247
    TXT: list of strings; TXT record for the service
235
248
    domain: string; Domain to publish on, default to .local if empty.
241
254
    server: D-Bus Server
242
255
    bus: dbus.SystemBus()
243
256
    """
 
257
    
244
258
    def __init__(self, interface = avahi.IF_UNSPEC, name = None,
245
259
                 servicetype = None, port = None, TXT = None,
246
260
                 domain = "", host = "", max_renames = 32768,
259
273
        self.server = None
260
274
        self.bus = bus
261
275
        self.entry_group_state_changed_match = None
 
276
    
262
277
    def rename(self):
263
278
        """Derived from the Avahi example code"""
264
279
        if self.rename_count >= self.max_renames:
274
289
        try:
275
290
            self.add()
276
291
        except dbus.exceptions.DBusException as error:
277
 
            logger.critical("DBusException: %s", error)
 
292
            logger.critical("D-Bus Exception", exc_info=error)
278
293
            self.cleanup()
279
294
            os._exit(1)
280
295
        self.rename_count += 1
 
296
    
281
297
    def remove(self):
282
298
        """Derived from the Avahi example code"""
283
299
        if self.entry_group_state_changed_match is not None:
285
301
            self.entry_group_state_changed_match = None
286
302
        if self.group is not None:
287
303
            self.group.Reset()
 
304
    
288
305
    def add(self):
289
306
        """Derived from the Avahi example code"""
290
307
        self.remove()
307
324
            dbus.UInt16(self.port),
308
325
            avahi.string_array_to_txt_array(self.TXT))
309
326
        self.group.Commit()
 
327
    
310
328
    def entry_group_state_changed(self, state, error):
311
329
        """Derived from the Avahi example code"""
312
330
        logger.debug("Avahi entry group state change: %i", state)
319
337
        elif state == avahi.ENTRY_GROUP_FAILURE:
320
338
            logger.critical("Avahi: Error in group state changed %s",
321
339
                            unicode(error))
322
 
            raise AvahiGroupError("State changed: %s"
323
 
                                  % unicode(error))
 
340
            raise AvahiGroupError("State changed: {0!s}"
 
341
                                  .format(error))
 
342
    
324
343
    def cleanup(self):
325
344
        """Derived from the Avahi example code"""
326
345
        if self.group is not None:
331
350
                pass
332
351
            self.group = None
333
352
        self.remove()
 
353
    
334
354
    def server_state_changed(self, state, error=None):
335
355
        """Derived from the Avahi example code"""
336
356
        logger.debug("Avahi server state change: %i", state)
355
375
                logger.debug("Unknown state: %r", state)
356
376
            else:
357
377
                logger.debug("Unknown state: %r: %r", state, error)
 
378
    
358
379
    def activate(self):
359
380
        """Derived from the Avahi example code"""
360
381
        if self.server is None:
367
388
                                 self.server_state_changed)
368
389
        self.server_state_changed(self.server.GetState())
369
390
 
 
391
 
370
392
class AvahiServiceToSyslog(AvahiService):
371
393
    def rename(self):
372
394
        """Add the new name to the syslog messages"""
373
395
        ret = AvahiService.rename(self)
374
396
        syslogger.setFormatter(logging.Formatter
375
 
                               ('Mandos (%s) [%%(process)d]:'
376
 
                                ' %%(levelname)s: %%(message)s'
377
 
                                % self.name))
 
397
                               ('Mandos ({0}) [%(process)d]:'
 
398
                                ' %(levelname)s: %(message)s'
 
399
                                .format(self.name)))
378
400
        return ret
379
401
 
380
 
def _timedelta_to_milliseconds(td):
 
402
 
 
403
def timedelta_to_milliseconds(td):
381
404
    "Convert a datetime.timedelta() to milliseconds"
382
405
    return ((td.days * 24 * 60 * 60 * 1000)
383
406
            + (td.seconds * 1000)
384
407
            + (td.microseconds // 1000))
385
 
        
 
408
 
 
409
 
386
410
class Client(object):
387
411
    """A representation of a client host served by this server.
388
412
    
389
413
    Attributes:
390
 
    _approved:   bool(); 'None' if not yet approved/disapproved
 
414
    approved:   bool(); 'None' if not yet approved/disapproved
391
415
    approval_delay: datetime.timedelta(); Time to wait for approval
392
416
    approval_duration: datetime.timedelta(); Duration of one approval
393
417
    checker:    subprocess.Popen(); a running checker process used
411
435
    interval:   datetime.timedelta(); How often to start a new checker
412
436
    last_approval_request: datetime.datetime(); (UTC) or None
413
437
    last_checked_ok: datetime.datetime(); (UTC) or None
414
 
 
415
438
    last_checker_status: integer between 0 and 255 reflecting exit
416
439
                         status of last checker. -1 reflects crashed
417
 
                         checker, or None.
 
440
                         checker, -2 means no checker completed yet.
418
441
    last_enabled: datetime.datetime(); (UTC) or None
419
442
    name:       string; from the config file, used in log messages and
420
443
                        D-Bus identifiers
421
444
    secret:     bytestring; sent verbatim (over TLS) to client
422
445
    timeout:    datetime.timedelta(); How long from last_checked_ok
423
446
                                      until this client is disabled
424
 
    extended_timeout:   extra long timeout when password has been sent
 
447
    extended_timeout:   extra long timeout when secret has been sent
425
448
    runtime_expansions: Allowed attributes for runtime expansion.
426
449
    expires:    datetime.datetime(); time (UTC) when a client will be
427
450
                disabled, or None
 
451
    server_settings: The server_settings dict from main()
428
452
    """
429
453
    
430
454
    runtime_expansions = ("approval_delay", "approval_duration",
431
 
                          "created", "enabled", "fingerprint",
432
 
                          "host", "interval", "last_checked_ok",
 
455
                          "created", "enabled", "expires",
 
456
                          "fingerprint", "host", "interval",
 
457
                          "last_approval_request", "last_checked_ok",
433
458
                          "last_enabled", "name", "timeout")
 
459
    client_defaults = { "timeout": "PT5M",
 
460
                        "extended_timeout": "PT15M",
 
461
                        "interval": "PT2M",
 
462
                        "checker": "fping -q -- %%(host)s",
 
463
                        "host": "",
 
464
                        "approval_delay": "PT0S",
 
465
                        "approval_duration": "PT1S",
 
466
                        "approved_by_default": "True",
 
467
                        "enabled": "True",
 
468
                        }
434
469
    
435
470
    def timeout_milliseconds(self):
436
471
        "Return the 'timeout' attribute in milliseconds"
437
 
        return _timedelta_to_milliseconds(self.timeout)
 
472
        return timedelta_to_milliseconds(self.timeout)
438
473
    
439
474
    def extended_timeout_milliseconds(self):
440
475
        "Return the 'extended_timeout' attribute in milliseconds"
441
 
        return _timedelta_to_milliseconds(self.extended_timeout)
 
476
        return timedelta_to_milliseconds(self.extended_timeout)
442
477
    
443
478
    def interval_milliseconds(self):
444
479
        "Return the 'interval' attribute in milliseconds"
445
 
        return _timedelta_to_milliseconds(self.interval)
 
480
        return timedelta_to_milliseconds(self.interval)
446
481
    
447
482
    def approval_delay_milliseconds(self):
448
 
        return _timedelta_to_milliseconds(self.approval_delay)
449
 
    
450
 
    def __init__(self, name = None, config=None):
451
 
        """Note: the 'checker' key in 'config' sets the
452
 
        'checker_command' attribute and *not* the 'checker'
453
 
        attribute."""
 
483
        return timedelta_to_milliseconds(self.approval_delay)
 
484
    
 
485
    @staticmethod
 
486
    def config_parser(config):
 
487
        """Construct a new dict of client settings of this form:
 
488
        { client_name: {setting_name: value, ...}, ...}
 
489
        with exceptions for any special settings as defined above.
 
490
        NOTE: Must be a pure function. Must return the same result
 
491
        value given the same arguments.
 
492
        """
 
493
        settings = {}
 
494
        for client_name in config.sections():
 
495
            section = dict(config.items(client_name))
 
496
            client = settings[client_name] = {}
 
497
            
 
498
            client["host"] = section["host"]
 
499
            # Reformat values from string types to Python types
 
500
            client["approved_by_default"] = config.getboolean(
 
501
                client_name, "approved_by_default")
 
502
            client["enabled"] = config.getboolean(client_name,
 
503
                                                  "enabled")
 
504
            
 
505
            client["fingerprint"] = (section["fingerprint"].upper()
 
506
                                     .replace(" ", ""))
 
507
            if "secret" in section:
 
508
                client["secret"] = section["secret"].decode("base64")
 
509
            elif "secfile" in section:
 
510
                with open(os.path.expanduser(os.path.expandvars
 
511
                                             (section["secfile"])),
 
512
                          "rb") as secfile:
 
513
                    client["secret"] = secfile.read()
 
514
            else:
 
515
                raise TypeError("No secret or secfile for section {0}"
 
516
                                .format(section))
 
517
            client["timeout"] = string_to_delta(section["timeout"])
 
518
            client["extended_timeout"] = string_to_delta(
 
519
                section["extended_timeout"])
 
520
            client["interval"] = string_to_delta(section["interval"])
 
521
            client["approval_delay"] = string_to_delta(
 
522
                section["approval_delay"])
 
523
            client["approval_duration"] = string_to_delta(
 
524
                section["approval_duration"])
 
525
            client["checker_command"] = section["checker"]
 
526
            client["last_approval_request"] = None
 
527
            client["last_checked_ok"] = None
 
528
            client["last_checker_status"] = -2
 
529
        
 
530
        return settings
 
531
    
 
532
    def __init__(self, settings, name = None, server_settings=None):
454
533
        self.name = name
455
 
        if config is None:
456
 
            config = {}
 
534
        if server_settings is None:
 
535
            server_settings = {}
 
536
        self.server_settings = server_settings
 
537
        # adding all client settings
 
538
        for setting, value in settings.iteritems():
 
539
            setattr(self, setting, value)
 
540
        
 
541
        if self.enabled:
 
542
            if not hasattr(self, "last_enabled"):
 
543
                self.last_enabled = datetime.datetime.utcnow()
 
544
            if not hasattr(self, "expires"):
 
545
                self.expires = (datetime.datetime.utcnow()
 
546
                                + self.timeout)
 
547
        else:
 
548
            self.last_enabled = None
 
549
            self.expires = None
 
550
        
457
551
        logger.debug("Creating client %r", self.name)
458
552
        # Uppercase and remove spaces from fingerprint for later
459
553
        # comparison purposes with return value from the fingerprint()
460
554
        # function
461
 
        self.fingerprint = (config["fingerprint"].upper()
462
 
                            .replace(" ", ""))
463
555
        logger.debug("  Fingerprint: %s", self.fingerprint)
464
 
        if "secret" in config:
465
 
            self.secret = config["secret"].decode("base64")
466
 
        elif "secfile" in config:
467
 
            with open(os.path.expanduser(os.path.expandvars
468
 
                                         (config["secfile"])),
469
 
                      "rb") as secfile:
470
 
                self.secret = secfile.read()
471
 
        else:
472
 
            raise TypeError("No secret or secfile for client %s"
473
 
                            % self.name)
474
 
        self.host = config.get("host", "")
475
 
        self.created = datetime.datetime.utcnow()
476
 
        self.enabled = config.get("enabled", True)
477
 
        self.last_approval_request = None
478
 
        if self.enabled:
479
 
            self.last_enabled = datetime.datetime.utcnow()
480
 
        else:
481
 
            self.last_enabled = None
482
 
        self.last_checked_ok = None
483
 
        self.last_checker_status = None
484
 
        self.timeout = string_to_delta(config["timeout"])
485
 
        self.extended_timeout = string_to_delta(config
486
 
                                                ["extended_timeout"])
487
 
        self.interval = string_to_delta(config["interval"])
 
556
        self.created = settings.get("created",
 
557
                                    datetime.datetime.utcnow())
 
558
        
 
559
        # attributes specific for this server instance
488
560
        self.checker = None
489
561
        self.checker_initiator_tag = None
490
562
        self.disable_initiator_tag = None
491
 
        if self.enabled:
492
 
            self.expires = datetime.datetime.utcnow() + self.timeout
493
 
        else:
494
 
            self.expires = None
495
563
        self.checker_callback_tag = None
496
 
        self.checker_command = config["checker"]
497
564
        self.current_checker_command = None
498
 
        self._approved = None
499
 
        self.approved_by_default = config.get("approved_by_default",
500
 
                                              True)
 
565
        self.approved = None
501
566
        self.approvals_pending = 0
502
 
        self.approval_delay = string_to_delta(
503
 
            config["approval_delay"])
504
 
        self.approval_duration = string_to_delta(
505
 
            config["approval_duration"])
506
567
        self.changedstate = (multiprocessing_manager
507
568
                             .Condition(multiprocessing_manager
508
569
                                        .Lock()))
528
589
        if getattr(self, "enabled", False):
529
590
            # Already enabled
530
591
            return
531
 
        self.send_changedstate()
532
592
        self.expires = datetime.datetime.utcnow() + self.timeout
533
593
        self.enabled = True
534
594
        self.last_enabled = datetime.datetime.utcnow()
535
595
        self.init_checker()
 
596
        self.send_changedstate()
536
597
    
537
598
    def disable(self, quiet=True):
538
599
        """Disable this client."""
539
600
        if not getattr(self, "enabled", False):
540
601
            return False
541
602
        if not quiet:
542
 
            self.send_changedstate()
543
 
        if not quiet:
544
603
            logger.info("Disabling client %s", self.name)
545
 
        if getattr(self, "disable_initiator_tag", False):
 
604
        if getattr(self, "disable_initiator_tag", None) is not None:
546
605
            gobject.source_remove(self.disable_initiator_tag)
547
606
            self.disable_initiator_tag = None
548
607
        self.expires = None
549
 
        if getattr(self, "checker_initiator_tag", False):
 
608
        if getattr(self, "checker_initiator_tag", None) is not None:
550
609
            gobject.source_remove(self.checker_initiator_tag)
551
610
            self.checker_initiator_tag = None
552
611
        self.stop_checker()
553
612
        self.enabled = False
 
613
        if not quiet:
 
614
            self.send_changedstate()
554
615
        # Do not run this again if called by a gobject.timeout_add
555
616
        return False
556
617
    
560
621
    def init_checker(self):
561
622
        # Schedule a new checker to be started an 'interval' from now,
562
623
        # and every interval from then on.
 
624
        if self.checker_initiator_tag is not None:
 
625
            gobject.source_remove(self.checker_initiator_tag)
563
626
        self.checker_initiator_tag = (gobject.timeout_add
564
627
                                      (self.interval_milliseconds(),
565
628
                                       self.start_checker))
566
629
        # Schedule a disable() when 'timeout' has passed
 
630
        if self.disable_initiator_tag is not None:
 
631
            gobject.source_remove(self.disable_initiator_tag)
567
632
        self.disable_initiator_tag = (gobject.timeout_add
568
633
                                   (self.timeout_milliseconds(),
569
634
                                    self.disable))
575
640
        self.checker_callback_tag = None
576
641
        self.checker = None
577
642
        if os.WIFEXITED(condition):
578
 
            self.last_checker_status =  os.WEXITSTATUS(condition)
 
643
            self.last_checker_status = os.WEXITSTATUS(condition)
579
644
            if self.last_checker_status == 0:
580
645
                logger.info("Checker for %(name)s succeeded",
581
646
                            vars(self))
588
653
            logger.warning("Checker for %(name)s crashed?",
589
654
                           vars(self))
590
655
    
591
 
    def checked_ok(self, timeout=None):
592
 
        """Bump up the timeout for this client.
593
 
        
594
 
        This should only be called when the client has been seen,
595
 
        alive and well.
596
 
        """
 
656
    def checked_ok(self):
 
657
        """Assert that the client has been seen, alive and well."""
 
658
        self.last_checked_ok = datetime.datetime.utcnow()
 
659
        self.last_checker_status = 0
 
660
        self.bump_timeout()
 
661
    
 
662
    def bump_timeout(self, timeout=None):
 
663
        """Bump up the timeout for this client."""
597
664
        if timeout is None:
598
665
            timeout = self.timeout
599
 
        self.last_checked_ok = datetime.datetime.utcnow()
600
666
        if self.disable_initiator_tag is not None:
601
667
            gobject.source_remove(self.disable_initiator_tag)
 
668
            self.disable_initiator_tag = None
602
669
        if getattr(self, "enabled", False):
603
670
            self.disable_initiator_tag = (gobject.timeout_add
604
 
                                          (_timedelta_to_milliseconds
 
671
                                          (timedelta_to_milliseconds
605
672
                                           (timeout), self.disable))
606
673
            self.expires = datetime.datetime.utcnow() + timeout
607
674
    
614
681
        If a checker already exists, leave it running and do
615
682
        nothing."""
616
683
        # The reason for not killing a running checker is that if we
617
 
        # did that, then if a checker (for some reason) started
618
 
        # running slowly and taking more than 'interval' time, the
619
 
        # client would inevitably timeout, since no checker would get
620
 
        # a chance to run to completion.  If we instead leave running
 
684
        # did that, and if a checker (for some reason) started running
 
685
        # slowly and taking more than 'interval' time, then the client
 
686
        # would inevitably timeout, since no checker would get a
 
687
        # chance to run to completion.  If we instead leave running
621
688
        # checkers alone, the checker would have to take more time
622
689
        # than 'timeout' for the client to be disabled, which is as it
623
690
        # should be.
625
692
        # If a checker exists, make sure it is not a zombie
626
693
        try:
627
694
            pid, status = os.waitpid(self.checker.pid, os.WNOHANG)
628
 
        except (AttributeError, OSError) as error:
629
 
            if (isinstance(error, OSError)
630
 
                and error.errno != errno.ECHILD):
631
 
                raise error
 
695
        except AttributeError:
 
696
            pass
 
697
        except OSError as error:
 
698
            if error.errno != errno.ECHILD:
 
699
                raise
632
700
        else:
633
701
            if pid:
634
702
                logger.warning("Checker was a zombie")
637
705
                                      self.current_checker_command)
638
706
        # Start a new checker if needed
639
707
        if self.checker is None:
 
708
            # Escape attributes for the shell
 
709
            escaped_attrs = dict(
 
710
                (attr, re.escape(unicode(getattr(self, attr))))
 
711
                for attr in
 
712
                self.runtime_expansions)
640
713
            try:
641
 
                # In case checker_command has exactly one % operator
642
 
                command = self.checker_command % self.host
643
 
            except TypeError:
644
 
                # Escape attributes for the shell
645
 
                escaped_attrs = dict(
646
 
                    (attr,
647
 
                     re.escape(unicode(str(getattr(self, attr, "")),
648
 
                                       errors=
649
 
                                       'replace')))
650
 
                    for attr in
651
 
                    self.runtime_expansions)
652
 
                
653
 
                try:
654
 
                    command = self.checker_command % escaped_attrs
655
 
                except TypeError as error:
656
 
                    logger.error('Could not format string "%s":'
657
 
                                 ' %s', self.checker_command, error)
658
 
                    return True # Try again later
 
714
                command = self.checker_command % escaped_attrs
 
715
            except TypeError as error:
 
716
                logger.error('Could not format string "%s"',
 
717
                             self.checker_command, exc_info=error)
 
718
                return True # Try again later
659
719
            self.current_checker_command = command
660
720
            try:
661
721
                logger.info("Starting checker %r for %s",
664
724
                # in normal mode, that is already done by daemon(),
665
725
                # and in debug mode we don't want to.  (Stdin is
666
726
                # always replaced by /dev/null.)
 
727
                # The exception is when not debugging but nevertheless
 
728
                # running in the foreground; use the previously
 
729
                # created wnull.
 
730
                popen_args = {}
 
731
                if (not self.server_settings["debug"]
 
732
                    and self.server_settings["foreground"]):
 
733
                    popen_args.update({"stdout": wnull,
 
734
                                       "stderr": wnull })
667
735
                self.checker = subprocess.Popen(command,
668
736
                                                close_fds=True,
669
 
                                                shell=True, cwd="/")
670
 
                self.checker_callback_tag = (gobject.child_watch_add
671
 
                                             (self.checker.pid,
672
 
                                              self.checker_callback,
673
 
                                              data=command))
674
 
                # The checker may have completed before the gobject
675
 
                # watch was added.  Check for this.
 
737
                                                shell=True, cwd="/",
 
738
                                                **popen_args)
 
739
            except OSError as error:
 
740
                logger.error("Failed to start subprocess",
 
741
                             exc_info=error)
 
742
                return True
 
743
            self.checker_callback_tag = (gobject.child_watch_add
 
744
                                         (self.checker.pid,
 
745
                                          self.checker_callback,
 
746
                                          data=command))
 
747
            # The checker may have completed before the gobject
 
748
            # watch was added.  Check for this.
 
749
            try:
676
750
                pid, status = os.waitpid(self.checker.pid, os.WNOHANG)
677
 
                if pid:
678
 
                    gobject.source_remove(self.checker_callback_tag)
679
 
                    self.checker_callback(pid, status, command)
680
751
            except OSError as error:
681
 
                logger.error("Failed to start subprocess: %s",
682
 
                             error)
 
752
                if error.errno == errno.ECHILD:
 
753
                    # This should never happen
 
754
                    logger.error("Child process vanished",
 
755
                                 exc_info=error)
 
756
                    return True
 
757
                raise
 
758
            if pid:
 
759
                gobject.source_remove(self.checker_callback_tag)
 
760
                self.checker_callback(pid, status, command)
683
761
        # Re-run this periodically if run by gobject.timeout_add
684
762
        return True
685
763
    
692
770
            return
693
771
        logger.debug("Stopping checker for %(name)s", vars(self))
694
772
        try:
695
 
            os.kill(self.checker.pid, signal.SIGTERM)
 
773
            self.checker.terminate()
696
774
            #time.sleep(0.5)
697
775
            #if self.checker.poll() is None:
698
 
            #    os.kill(self.checker.pid, signal.SIGKILL)
 
776
            #    self.checker.kill()
699
777
        except OSError as error:
700
778
            if error.errno != errno.ESRCH: # No such process
701
779
                raise
718
796
    # "Set" method, so we fail early here:
719
797
    if byte_arrays and signature != "ay":
720
798
        raise ValueError("Byte arrays not supported for non-'ay'"
721
 
                         " signature %r" % signature)
 
799
                         " signature {0!r}".format(signature))
722
800
    def decorator(func):
723
801
        func._dbus_is_property = True
724
802
        func._dbus_interface = dbus_interface
732
810
    return decorator
733
811
 
734
812
 
 
813
def dbus_interface_annotations(dbus_interface):
 
814
    """Decorator for marking functions returning interface annotations
 
815
    
 
816
    Usage:
 
817
    
 
818
    @dbus_interface_annotations("org.example.Interface")
 
819
    def _foo(self):  # Function name does not matter
 
820
        return {"org.freedesktop.DBus.Deprecated": "true",
 
821
                "org.freedesktop.DBus.Property.EmitsChangedSignal":
 
822
                    "false"}
 
823
    """
 
824
    def decorator(func):
 
825
        func._dbus_is_interface = True
 
826
        func._dbus_interface = dbus_interface
 
827
        func._dbus_name = dbus_interface
 
828
        return func
 
829
    return decorator
 
830
 
 
831
 
 
832
def dbus_annotations(annotations):
 
833
    """Decorator to annotate D-Bus methods, signals or properties
 
834
    Usage:
 
835
    
 
836
    @dbus_service_property("org.example.Interface", signature="b",
 
837
                           access="r")
 
838
    @dbus_annotations({{"org.freedesktop.DBus.Deprecated": "true",
 
839
                        "org.freedesktop.DBus.Property."
 
840
                        "EmitsChangedSignal": "false"})
 
841
    def Property_dbus_property(self):
 
842
        return dbus.Boolean(False)
 
843
    """
 
844
    def decorator(func):
 
845
        func._dbus_annotations = annotations
 
846
        return func
 
847
    return decorator
 
848
 
 
849
 
735
850
class DBusPropertyException(dbus.exceptions.DBusException):
736
851
    """A base class for D-Bus property-related exceptions
737
852
    """
760
875
    """
761
876
    
762
877
    @staticmethod
763
 
    def _is_dbus_property(obj):
764
 
        return getattr(obj, "_dbus_is_property", False)
 
878
    def _is_dbus_thing(thing):
 
879
        """Returns a function testing if an attribute is a D-Bus thing
 
880
        
 
881
        If called like _is_dbus_thing("method") it returns a function
 
882
        suitable for use as predicate to inspect.getmembers().
 
883
        """
 
884
        return lambda obj: getattr(obj, "_dbus_is_{0}".format(thing),
 
885
                                   False)
765
886
    
766
 
    def _get_all_dbus_properties(self):
 
887
    def _get_all_dbus_things(self, thing):
767
888
        """Returns a generator of (name, attribute) pairs
768
889
        """
769
 
        return ((prop.__get__(self)._dbus_name, prop.__get__(self))
 
890
        return ((getattr(athing.__get__(self), "_dbus_name",
 
891
                         name),
 
892
                 athing.__get__(self))
770
893
                for cls in self.__class__.__mro__
771
 
                for name, prop in
772
 
                inspect.getmembers(cls, self._is_dbus_property))
 
894
                for name, athing in
 
895
                inspect.getmembers(cls,
 
896
                                   self._is_dbus_thing(thing)))
773
897
    
774
898
    def _get_dbus_property(self, interface_name, property_name):
775
899
        """Returns a bound method if one exists which is a D-Bus
777
901
        """
778
902
        for cls in  self.__class__.__mro__:
779
903
            for name, value in (inspect.getmembers
780
 
                                (cls, self._is_dbus_property)):
 
904
                                (cls,
 
905
                                 self._is_dbus_thing("property"))):
781
906
                if (value._dbus_name == property_name
782
907
                    and value._dbus_interface == interface_name):
783
908
                    return value.__get__(self)
811
936
            # The byte_arrays option is not supported yet on
812
937
            # signatures other than "ay".
813
938
            if prop._dbus_signature != "ay":
814
 
                raise ValueError
815
 
            value = dbus.ByteArray(''.join(unichr(byte)
816
 
                                           for byte in value))
 
939
                raise ValueError("Byte arrays not supported for non-"
 
940
                                 "'ay' signature {0!r}"
 
941
                                 .format(prop._dbus_signature))
 
942
            value = dbus.ByteArray(b''.join(chr(byte)
 
943
                                            for byte in value))
817
944
        prop(value)
818
945
    
819
946
    @dbus.service.method(dbus.PROPERTIES_IFACE, in_signature="s",
825
952
        Note: Will not include properties with access="write".
826
953
        """
827
954
        properties = {}
828
 
        for name, prop in self._get_all_dbus_properties():
 
955
        for name, prop in self._get_all_dbus_things("property"):
829
956
            if (interface_name
830
957
                and interface_name != prop._dbus_interface):
831
958
                # Interface non-empty but did not match
846
973
                         path_keyword='object_path',
847
974
                         connection_keyword='connection')
848
975
    def Introspect(self, object_path, connection):
849
 
        """Standard D-Bus method, overloaded to insert property tags.
 
976
        """Overloading of standard D-Bus method.
 
977
        
 
978
        Inserts property tags and interface annotation tags.
850
979
        """
851
980
        xmlstring = dbus.service.Object.Introspect(self, object_path,
852
981
                                                   connection)
859
988
                e.setAttribute("access", prop._dbus_access)
860
989
                return e
861
990
            for if_tag in document.getElementsByTagName("interface"):
 
991
                # Add property tags
862
992
                for tag in (make_tag(document, name, prop)
863
993
                            for name, prop
864
 
                            in self._get_all_dbus_properties()
 
994
                            in self._get_all_dbus_things("property")
865
995
                            if prop._dbus_interface
866
996
                            == if_tag.getAttribute("name")):
867
997
                    if_tag.appendChild(tag)
 
998
                # Add annotation tags
 
999
                for typ in ("method", "signal", "property"):
 
1000
                    for tag in if_tag.getElementsByTagName(typ):
 
1001
                        annots = dict()
 
1002
                        for name, prop in (self.
 
1003
                                           _get_all_dbus_things(typ)):
 
1004
                            if (name == tag.getAttribute("name")
 
1005
                                and prop._dbus_interface
 
1006
                                == if_tag.getAttribute("name")):
 
1007
                                annots.update(getattr
 
1008
                                              (prop,
 
1009
                                               "_dbus_annotations",
 
1010
                                               {}))
 
1011
                        for name, value in annots.iteritems():
 
1012
                            ann_tag = document.createElement(
 
1013
                                "annotation")
 
1014
                            ann_tag.setAttribute("name", name)
 
1015
                            ann_tag.setAttribute("value", value)
 
1016
                            tag.appendChild(ann_tag)
 
1017
                # Add interface annotation tags
 
1018
                for annotation, value in dict(
 
1019
                    itertools.chain.from_iterable(
 
1020
                        annotations().iteritems()
 
1021
                        for name, annotations in
 
1022
                        self._get_all_dbus_things("interface")
 
1023
                        if name == if_tag.getAttribute("name")
 
1024
                        )).iteritems():
 
1025
                    ann_tag = document.createElement("annotation")
 
1026
                    ann_tag.setAttribute("name", annotation)
 
1027
                    ann_tag.setAttribute("value", value)
 
1028
                    if_tag.appendChild(ann_tag)
868
1029
                # Add the names to the return values for the
869
1030
                # "org.freedesktop.DBus.Properties" methods
870
1031
                if (if_tag.getAttribute("name")
885
1046
        except (AttributeError, xml.dom.DOMException,
886
1047
                xml.parsers.expat.ExpatError) as error:
887
1048
            logger.error("Failed to override Introspection method",
888
 
                         error)
 
1049
                         exc_info=error)
889
1050
        return xmlstring
890
1051
 
891
1052
 
892
 
def datetime_to_dbus (dt, variant_level=0):
 
1053
def datetime_to_dbus(dt, variant_level=0):
893
1054
    """Convert a UTC datetime.datetime() to a D-Bus type."""
894
1055
    if dt is None:
895
1056
        return dbus.String("", variant_level = variant_level)
897
1058
                       variant_level=variant_level)
898
1059
 
899
1060
 
900
 
class AlternateDBusNamesMetaclass(DBusObjectWithProperties
901
 
                                  .__metaclass__):
902
 
    """Applied to an empty subclass of a D-Bus object, this metaclass
903
 
    will add additional D-Bus attributes matching a certain pattern.
 
1061
def alternate_dbus_interfaces(alt_interface_names, deprecate=True):
 
1062
    """A class decorator; applied to a subclass of
 
1063
    dbus.service.Object, it will add alternate D-Bus attributes with
 
1064
    interface names according to the "alt_interface_names" mapping.
 
1065
    Usage:
 
1066
    
 
1067
    @alternate_dbus_interfaces({"org.example.Interface":
 
1068
                                    "net.example.AlternateInterface"})
 
1069
    class SampleDBusObject(dbus.service.Object):
 
1070
        @dbus.service.method("org.example.Interface")
 
1071
        def SampleDBusMethod():
 
1072
            pass
 
1073
    
 
1074
    The above "SampleDBusMethod" on "SampleDBusObject" will be
 
1075
    reachable via two interfaces: "org.example.Interface" and
 
1076
    "net.example.AlternateInterface", the latter of which will have
 
1077
    its D-Bus annotation "org.freedesktop.DBus.Deprecated" set to
 
1078
    "true", unless "deprecate" is passed with a False value.
 
1079
    
 
1080
    This works for methods and signals, and also for D-Bus properties
 
1081
    (from DBusObjectWithProperties) and interfaces (from the
 
1082
    dbus_interface_annotations decorator).
904
1083
    """
905
 
    def __new__(mcs, name, bases, attr):
906
 
        # Go through all the base classes which could have D-Bus
907
 
        # methods, signals, or properties in them
908
 
        for base in (b for b in bases
909
 
                     if issubclass(b, dbus.service.Object)):
910
 
            # Go though all attributes of the base class
911
 
            for attrname, attribute in inspect.getmembers(base):
 
1084
    def wrapper(cls):
 
1085
        for orig_interface_name, alt_interface_name in (
 
1086
            alt_interface_names.iteritems()):
 
1087
            attr = {}
 
1088
            interface_names = set()
 
1089
            # Go though all attributes of the class
 
1090
            for attrname, attribute in inspect.getmembers(cls):
912
1091
                # Ignore non-D-Bus attributes, and D-Bus attributes
913
1092
                # with the wrong interface name
914
1093
                if (not hasattr(attribute, "_dbus_interface")
915
1094
                    or not attribute._dbus_interface
916
 
                    .startswith("se.recompile.Mandos")):
 
1095
                    .startswith(orig_interface_name)):
917
1096
                    continue
918
1097
                # Create an alternate D-Bus interface name based on
919
1098
                # the current name
920
1099
                alt_interface = (attribute._dbus_interface
921
 
                                 .replace("se.recompile.Mandos",
922
 
                                          "se.bsnet.fukt.Mandos"))
 
1100
                                 .replace(orig_interface_name,
 
1101
                                          alt_interface_name))
 
1102
                interface_names.add(alt_interface)
923
1103
                # Is this a D-Bus signal?
924
1104
                if getattr(attribute, "_dbus_is_signal", False):
925
 
                    # Extract the original non-method function by
926
 
                    # black magic
 
1105
                    # Extract the original non-method undecorated
 
1106
                    # function by black magic
927
1107
                    nonmethod_func = (dict(
928
1108
                            zip(attribute.func_code.co_freevars,
929
1109
                                attribute.__closure__))["func"]
940
1120
                                nonmethod_func.func_name,
941
1121
                                nonmethod_func.func_defaults,
942
1122
                                nonmethod_func.func_closure)))
 
1123
                    # Copy annotations, if any
 
1124
                    try:
 
1125
                        new_function._dbus_annotations = (
 
1126
                            dict(attribute._dbus_annotations))
 
1127
                    except AttributeError:
 
1128
                        pass
943
1129
                    # Define a creator of a function to call both the
944
 
                    # old and new functions, so both the old and new
945
 
                    # signals gets sent when the function is called
 
1130
                    # original and alternate functions, so both the
 
1131
                    # original and alternate signals gets sent when
 
1132
                    # the function is called
946
1133
                    def fixscope(func1, func2):
947
1134
                        """This function is a scope container to pass
948
1135
                        func1 and func2 to the "call_both" function
955
1142
                        return call_both
956
1143
                    # Create the "call_both" function and add it to
957
1144
                    # the class
958
 
                    attr[attrname] = fixscope(attribute,
959
 
                                              new_function)
 
1145
                    attr[attrname] = fixscope(attribute, new_function)
960
1146
                # Is this a D-Bus method?
961
1147
                elif getattr(attribute, "_dbus_is_method", False):
962
1148
                    # Create a new, but exactly alike, function
973
1159
                                        attribute.func_name,
974
1160
                                        attribute.func_defaults,
975
1161
                                        attribute.func_closure)))
 
1162
                    # Copy annotations, if any
 
1163
                    try:
 
1164
                        attr[attrname]._dbus_annotations = (
 
1165
                            dict(attribute._dbus_annotations))
 
1166
                    except AttributeError:
 
1167
                        pass
976
1168
                # Is this a D-Bus property?
977
1169
                elif getattr(attribute, "_dbus_is_property", False):
978
1170
                    # Create a new, but exactly alike, function
992
1184
                                        attribute.func_name,
993
1185
                                        attribute.func_defaults,
994
1186
                                        attribute.func_closure)))
995
 
        return type.__new__(mcs, name, bases, attr)
996
 
 
997
 
 
 
1187
                    # Copy annotations, if any
 
1188
                    try:
 
1189
                        attr[attrname]._dbus_annotations = (
 
1190
                            dict(attribute._dbus_annotations))
 
1191
                    except AttributeError:
 
1192
                        pass
 
1193
                # Is this a D-Bus interface?
 
1194
                elif getattr(attribute, "_dbus_is_interface", False):
 
1195
                    # Create a new, but exactly alike, function
 
1196
                    # object.  Decorate it to be a new D-Bus interface
 
1197
                    # with the alternate D-Bus interface name.  Add it
 
1198
                    # to the class.
 
1199
                    attr[attrname] = (dbus_interface_annotations
 
1200
                                      (alt_interface)
 
1201
                                      (types.FunctionType
 
1202
                                       (attribute.func_code,
 
1203
                                        attribute.func_globals,
 
1204
                                        attribute.func_name,
 
1205
                                        attribute.func_defaults,
 
1206
                                        attribute.func_closure)))
 
1207
            if deprecate:
 
1208
                # Deprecate all alternate interfaces
 
1209
                iname="_AlternateDBusNames_interface_annotation{0}"
 
1210
                for interface_name in interface_names:
 
1211
                    @dbus_interface_annotations(interface_name)
 
1212
                    def func(self):
 
1213
                        return { "org.freedesktop.DBus.Deprecated":
 
1214
                                     "true" }
 
1215
                    # Find an unused name
 
1216
                    for aname in (iname.format(i)
 
1217
                                  for i in itertools.count()):
 
1218
                        if aname not in attr:
 
1219
                            attr[aname] = func
 
1220
                            break
 
1221
            if interface_names:
 
1222
                # Replace the class with a new subclass of it with
 
1223
                # methods, signals, etc. as created above.
 
1224
                cls = type(b"{0}Alternate".format(cls.__name__),
 
1225
                           (cls,), attr)
 
1226
        return cls
 
1227
    return wrapper
 
1228
 
 
1229
 
 
1230
@alternate_dbus_interfaces({"se.recompile.Mandos":
 
1231
                                "se.bsnet.fukt.Mandos"})
998
1232
class ClientDBus(Client, DBusObjectWithProperties):
999
1233
    """A Client class using D-Bus
1000
1234
    
1011
1245
    def __init__(self, bus = None, *args, **kwargs):
1012
1246
        self.bus = bus
1013
1247
        Client.__init__(self, *args, **kwargs)
1014
 
        
1015
 
        self._approvals_pending = 0
1016
1248
        # Only now, when this client is initialized, can it show up on
1017
1249
        # the D-Bus
1018
1250
        client_object_name = unicode(self.name).translate(
1022
1254
                                 ("/clients/" + client_object_name))
1023
1255
        DBusObjectWithProperties.__init__(self, self.bus,
1024
1256
                                          self.dbus_object_path)
1025
 
        
 
1257
    
1026
1258
    def notifychangeproperty(transform_func,
1027
1259
                             dbus_name, type_func=lambda x: x,
1028
1260
                             variant_level=1):
1051
1283
        
1052
1284
        return property(lambda self: getattr(self, attrname), setter)
1053
1285
    
1054
 
    
1055
1286
    expires = notifychangeproperty(datetime_to_dbus, "Expires")
1056
1287
    approvals_pending = notifychangeproperty(dbus.Boolean,
1057
1288
                                             "ApprovalPending",
1064
1295
                                       checker is not None)
1065
1296
    last_checked_ok = notifychangeproperty(datetime_to_dbus,
1066
1297
                                           "LastCheckedOK")
 
1298
    last_checker_status = notifychangeproperty(dbus.Int16,
 
1299
                                               "LastCheckerStatus")
1067
1300
    last_approval_request = notifychangeproperty(
1068
1301
        datetime_to_dbus, "LastApprovalRequest")
1069
1302
    approved_by_default = notifychangeproperty(dbus.Boolean,
1070
1303
                                               "ApprovedByDefault")
1071
 
    approval_delay = notifychangeproperty(dbus.UInt16,
 
1304
    approval_delay = notifychangeproperty(dbus.UInt64,
1072
1305
                                          "ApprovalDelay",
1073
1306
                                          type_func =
1074
 
                                          _timedelta_to_milliseconds)
 
1307
                                          timedelta_to_milliseconds)
1075
1308
    approval_duration = notifychangeproperty(
1076
 
        dbus.UInt16, "ApprovalDuration",
1077
 
        type_func = _timedelta_to_milliseconds)
 
1309
        dbus.UInt64, "ApprovalDuration",
 
1310
        type_func = timedelta_to_milliseconds)
1078
1311
    host = notifychangeproperty(dbus.String, "Host")
1079
 
    timeout = notifychangeproperty(dbus.UInt16, "Timeout",
 
1312
    timeout = notifychangeproperty(dbus.UInt64, "Timeout",
1080
1313
                                   type_func =
1081
 
                                   _timedelta_to_milliseconds)
 
1314
                                   timedelta_to_milliseconds)
1082
1315
    extended_timeout = notifychangeproperty(
1083
 
        dbus.UInt16, "ExtendedTimeout",
1084
 
        type_func = _timedelta_to_milliseconds)
1085
 
    interval = notifychangeproperty(dbus.UInt16,
 
1316
        dbus.UInt64, "ExtendedTimeout",
 
1317
        type_func = timedelta_to_milliseconds)
 
1318
    interval = notifychangeproperty(dbus.UInt64,
1086
1319
                                    "Interval",
1087
1320
                                    type_func =
1088
 
                                    _timedelta_to_milliseconds)
 
1321
                                    timedelta_to_milliseconds)
1089
1322
    checker_command = notifychangeproperty(dbus.String, "Checker")
1090
1323
    
1091
1324
    del notifychangeproperty
1119
1352
                                       *args, **kwargs)
1120
1353
    
1121
1354
    def start_checker(self, *args, **kwargs):
1122
 
        old_checker = self.checker
1123
 
        if self.checker is not None:
1124
 
            old_checker_pid = self.checker.pid
1125
 
        else:
1126
 
            old_checker_pid = None
 
1355
        old_checker_pid = getattr(self.checker, "pid", None)
1127
1356
        r = Client.start_checker(self, *args, **kwargs)
1128
1357
        # Only if new checker process was started
1129
1358
        if (self.checker is not None
1133
1362
        return r
1134
1363
    
1135
1364
    def _reset_approved(self):
1136
 
        self._approved = None
 
1365
        self.approved = None
1137
1366
        return False
1138
1367
    
1139
1368
    def approve(self, value=True):
1140
 
        self.send_changedstate()
1141
 
        self._approved = value
1142
 
        gobject.timeout_add(_timedelta_to_milliseconds
 
1369
        self.approved = value
 
1370
        gobject.timeout_add(timedelta_to_milliseconds
1143
1371
                            (self.approval_duration),
1144
1372
                            self._reset_approved)
1145
 
    
 
1373
        self.send_changedstate()
1146
1374
    
1147
1375
    ## D-Bus methods, signals & properties
1148
1376
    _interface = "se.recompile.Mandos.Client"
1149
1377
    
 
1378
    ## Interfaces
 
1379
    
 
1380
    @dbus_interface_annotations(_interface)
 
1381
    def _foo(self):
 
1382
        return { "org.freedesktop.DBus.Property.EmitsChangedSignal":
 
1383
                     "false"}
 
1384
    
1150
1385
    ## Signals
1151
1386
    
1152
1387
    # CheckerCompleted - signal
1188
1423
        "D-Bus signal"
1189
1424
        return self.need_approval()
1190
1425
    
1191
 
    # NeRwequest - signal
1192
 
    @dbus.service.signal(_interface, signature="s")
1193
 
    def NewRequest(self, ip):
1194
 
        """D-Bus signal
1195
 
        Is sent after a client request a password.
1196
 
        """
1197
 
        pass
1198
 
    
1199
1426
    ## Methods
1200
1427
    
1201
1428
    # Approve - method
1259
1486
                           access="readwrite")
1260
1487
    def ApprovalDuration_dbus_property(self, value=None):
1261
1488
        if value is None:       # get
1262
 
            return dbus.UInt64(_timedelta_to_milliseconds(
 
1489
            return dbus.UInt64(timedelta_to_milliseconds(
1263
1490
                    self.approval_duration))
1264
1491
        self.approval_duration = datetime.timedelta(0, 0, 0, value)
1265
1492
    
1279
1506
    def Host_dbus_property(self, value=None):
1280
1507
        if value is None:       # get
1281
1508
            return dbus.String(self.host)
1282
 
        self.host = value
 
1509
        self.host = unicode(value)
1283
1510
    
1284
1511
    # Created - property
1285
1512
    @dbus_service_property(_interface, signature="s", access="read")
1311
1538
            return
1312
1539
        return datetime_to_dbus(self.last_checked_ok)
1313
1540
    
 
1541
    # LastCheckerStatus - property
 
1542
    @dbus_service_property(_interface, signature="n",
 
1543
                           access="read")
 
1544
    def LastCheckerStatus_dbus_property(self):
 
1545
        return dbus.Int16(self.last_checker_status)
 
1546
    
1314
1547
    # Expires - property
1315
1548
    @dbus_service_property(_interface, signature="s", access="read")
1316
1549
    def Expires_dbus_property(self):
1327
1560
    def Timeout_dbus_property(self, value=None):
1328
1561
        if value is None:       # get
1329
1562
            return dbus.UInt64(self.timeout_milliseconds())
 
1563
        old_timeout = self.timeout
1330
1564
        self.timeout = datetime.timedelta(0, 0, 0, value)
1331
 
        if getattr(self, "disable_initiator_tag", None) is None:
1332
 
            return
1333
 
        # Reschedule timeout
1334
 
        gobject.source_remove(self.disable_initiator_tag)
1335
 
        self.disable_initiator_tag = None
1336
 
        self.expires = None
1337
 
        time_to_die = _timedelta_to_milliseconds((self
1338
 
                                                  .last_checked_ok
1339
 
                                                  + self.timeout)
1340
 
                                                 - datetime.datetime
1341
 
                                                 .utcnow())
1342
 
        if time_to_die <= 0:
1343
 
            # The timeout has passed
1344
 
            self.disable()
1345
 
        else:
1346
 
            self.expires = (datetime.datetime.utcnow()
1347
 
                            + datetime.timedelta(milliseconds =
1348
 
                                                 time_to_die))
1349
 
            self.disable_initiator_tag = (gobject.timeout_add
1350
 
                                          (time_to_die, self.disable))
 
1565
        # Reschedule disabling
 
1566
        if self.enabled:
 
1567
            now = datetime.datetime.utcnow()
 
1568
            self.expires += self.timeout - old_timeout
 
1569
            if self.expires <= now:
 
1570
                # The timeout has passed
 
1571
                self.disable()
 
1572
            else:
 
1573
                if (getattr(self, "disable_initiator_tag", None)
 
1574
                    is None):
 
1575
                    return
 
1576
                gobject.source_remove(self.disable_initiator_tag)
 
1577
                self.disable_initiator_tag = (
 
1578
                    gobject.timeout_add(
 
1579
                        timedelta_to_milliseconds(self.expires - now),
 
1580
                        self.disable))
1351
1581
    
1352
1582
    # ExtendedTimeout - property
1353
1583
    @dbus_service_property(_interface, signature="t",
1379
1609
    def Checker_dbus_property(self, value=None):
1380
1610
        if value is None:       # get
1381
1611
            return dbus.String(self.checker_command)
1382
 
        self.checker_command = value
 
1612
        self.checker_command = unicode(value)
1383
1613
    
1384
1614
    # CheckerRunning - property
1385
1615
    @dbus_service_property(_interface, signature="b",
1414
1644
            raise KeyError()
1415
1645
    
1416
1646
    def __getattribute__(self, name):
1417
 
        if(name == '_pipe'):
 
1647
        if name == '_pipe':
1418
1648
            return super(ProxyClient, self).__getattribute__(name)
1419
1649
        self._pipe.send(('getattr', name))
1420
1650
        data = self._pipe.recv()
1427
1657
            return func
1428
1658
    
1429
1659
    def __setattr__(self, name, value):
1430
 
        if(name == '_pipe'):
 
1660
        if name == '_pipe':
1431
1661
            return super(ProxyClient, self).__setattr__(name, value)
1432
1662
        self._pipe.send(('setattr', name, value))
1433
1663
 
1434
1664
 
1435
 
class ClientDBusTransitional(ClientDBus):
1436
 
    __metaclass__ = AlternateDBusNamesMetaclass
1437
 
 
1438
 
 
1439
1665
class ClientHandler(socketserver.BaseRequestHandler, object):
1440
1666
    """A class to handle client connections.
1441
1667
    
1477
1703
            logger.debug("Protocol version: %r", line)
1478
1704
            try:
1479
1705
                if int(line.strip().split()[0]) > 1:
1480
 
                    raise RuntimeError
 
1706
                    raise RuntimeError(line)
1481
1707
            except (ValueError, IndexError, RuntimeError) as error:
1482
1708
                logger.error("Unknown protocol version: %s", error)
1483
1709
                return
1502
1728
                    logger.warning("Bad certificate: %s", error)
1503
1729
                    return
1504
1730
                logger.debug("Fingerprint: %s", fpr)
1505
 
                if self.server.use_dbus:
1506
 
                    # Emit D-Bus signal
1507
 
                    client.NewRequest(str(self.client_address))
1508
1731
                
1509
1732
                try:
1510
1733
                    client = ProxyClient(child_pipe, fpr,
1526
1749
                            client.Rejected("Disabled")
1527
1750
                        return
1528
1751
                    
1529
 
                    if client._approved or not client.approval_delay:
 
1752
                    if client.approved or not client.approval_delay:
1530
1753
                        #We are approved or approval is disabled
1531
1754
                        break
1532
 
                    elif client._approved is None:
 
1755
                    elif client.approved is None:
1533
1756
                        logger.info("Client %s needs approval",
1534
1757
                                    client.name)
1535
1758
                        if self.server.use_dbus:
1548
1771
                    #wait until timeout or approved
1549
1772
                    time = datetime.datetime.now()
1550
1773
                    client.changedstate.acquire()
1551
 
                    (client.changedstate.wait
1552
 
                     (float(client._timedelta_to_milliseconds(delay)
1553
 
                            / 1000)))
 
1774
                    client.changedstate.wait(
 
1775
                        float(timedelta_to_milliseconds(delay)
 
1776
                              / 1000))
1554
1777
                    client.changedstate.release()
1555
1778
                    time2 = datetime.datetime.now()
1556
1779
                    if (time2 - time) >= delay:
1572
1795
                    try:
1573
1796
                        sent = session.send(client.secret[sent_size:])
1574
1797
                    except gnutls.errors.GNUTLSError as error:
1575
 
                        logger.warning("gnutls send failed")
 
1798
                        logger.warning("gnutls send failed",
 
1799
                                       exc_info=error)
1576
1800
                        return
1577
1801
                    logger.debug("Sent: %d, remaining: %d",
1578
1802
                                 sent, len(client.secret)
1581
1805
                
1582
1806
                logger.info("Sending secret to %s", client.name)
1583
1807
                # bump the timeout using extended_timeout
1584
 
                client.checked_ok(client.extended_timeout)
 
1808
                client.bump_timeout(client.extended_timeout)
1585
1809
                if self.server.use_dbus:
1586
1810
                    # Emit D-Bus signal
1587
1811
                    client.GotSecret()
1592
1816
                try:
1593
1817
                    session.bye()
1594
1818
                except gnutls.errors.GNUTLSError as error:
1595
 
                    logger.warning("GnuTLS bye failed")
 
1819
                    logger.warning("GnuTLS bye failed",
 
1820
                                   exc_info=error)
1596
1821
    
1597
1822
    @staticmethod
1598
1823
    def peer_certificate(session):
1663
1888
    def sub_process_main(self, request, address):
1664
1889
        try:
1665
1890
            self.finish_request(request, address)
1666
 
        except:
 
1891
        except Exception:
1667
1892
            self.handle_error(request, address)
1668
1893
        self.close_request(request)
1669
1894
    
1670
1895
    def process_request(self, request, address):
1671
1896
        """Start a new process to process the request."""
1672
1897
        proc = multiprocessing.Process(target = self.sub_process_main,
1673
 
                                       args = (request,
1674
 
                                               address))
 
1898
                                       args = (request, address))
1675
1899
        proc.start()
1676
1900
        return proc
1677
1901
 
1692
1916
    
1693
1917
    def add_pipe(self, parent_pipe, proc):
1694
1918
        """Dummy function; override as necessary"""
1695
 
        raise NotImplementedError
 
1919
        raise NotImplementedError()
1696
1920
 
1697
1921
 
1698
1922
class IPv6_TCPServer(MultiprocessingMixInWithPipe,
1705
1929
        use_ipv6:       Boolean; to use IPv6 or not
1706
1930
    """
1707
1931
    def __init__(self, server_address, RequestHandlerClass,
1708
 
                 interface=None, use_ipv6=True):
 
1932
                 interface=None, use_ipv6=True, socketfd=None):
 
1933
        """If socketfd is set, use that file descriptor instead of
 
1934
        creating a new one with socket.socket().
 
1935
        """
1709
1936
        self.interface = interface
1710
1937
        if use_ipv6:
1711
1938
            self.address_family = socket.AF_INET6
 
1939
        if socketfd is not None:
 
1940
            # Save the file descriptor
 
1941
            self.socketfd = socketfd
 
1942
            # Save the original socket.socket() function
 
1943
            self.socket_socket = socket.socket
 
1944
            # To implement --socket, we monkey patch socket.socket.
 
1945
            # 
 
1946
            # (When socketserver.TCPServer is a new-style class, we
 
1947
            # could make self.socket into a property instead of monkey
 
1948
            # patching socket.socket.)
 
1949
            # 
 
1950
            # Create a one-time-only replacement for socket.socket()
 
1951
            @functools.wraps(socket.socket)
 
1952
            def socket_wrapper(*args, **kwargs):
 
1953
                # Restore original function so subsequent calls are
 
1954
                # not affected.
 
1955
                socket.socket = self.socket_socket
 
1956
                del self.socket_socket
 
1957
                # This time only, return a new socket object from the
 
1958
                # saved file descriptor.
 
1959
                return socket.fromfd(self.socketfd, *args, **kwargs)
 
1960
            # Replace socket.socket() function with wrapper
 
1961
            socket.socket = socket_wrapper
 
1962
        # The socketserver.TCPServer.__init__ will call
 
1963
        # socket.socket(), which might be our replacement,
 
1964
        # socket_wrapper(), if socketfd was set.
1712
1965
        socketserver.TCPServer.__init__(self, server_address,
1713
1966
                                        RequestHandlerClass)
 
1967
    
1714
1968
    def server_bind(self):
1715
1969
        """This overrides the normal server_bind() function
1716
1970
        to bind to an interface if one was specified, and also NOT to
1724
1978
                try:
1725
1979
                    self.socket.setsockopt(socket.SOL_SOCKET,
1726
1980
                                           SO_BINDTODEVICE,
1727
 
                                           str(self.interface
1728
 
                                               + '\0'))
 
1981
                                           str(self.interface + '\0'))
1729
1982
                except socket.error as error:
1730
 
                    if error[0] == errno.EPERM:
1731
 
                        logger.error("No permission to"
1732
 
                                     " bind to interface %s",
1733
 
                                     self.interface)
1734
 
                    elif error[0] == errno.ENOPROTOOPT:
 
1983
                    if error.errno == errno.EPERM:
 
1984
                        logger.error("No permission to bind to"
 
1985
                                     " interface %s", self.interface)
 
1986
                    elif error.errno == errno.ENOPROTOOPT:
1735
1987
                        logger.error("SO_BINDTODEVICE not available;"
1736
1988
                                     " cannot bind to interface %s",
1737
1989
                                     self.interface)
 
1990
                    elif error.errno == errno.ENODEV:
 
1991
                        logger.error("Interface %s does not exist,"
 
1992
                                     " cannot bind", self.interface)
1738
1993
                    else:
1739
1994
                        raise
1740
1995
        # Only bind(2) the socket if we really need to.
1743
1998
                if self.address_family == socket.AF_INET6:
1744
1999
                    any_address = "::" # in6addr_any
1745
2000
                else:
1746
 
                    any_address = socket.INADDR_ANY
 
2001
                    any_address = "0.0.0.0" # INADDR_ANY
1747
2002
                self.server_address = (any_address,
1748
2003
                                       self.server_address[1])
1749
2004
            elif not self.server_address[1]:
1770
2025
    """
1771
2026
    def __init__(self, server_address, RequestHandlerClass,
1772
2027
                 interface=None, use_ipv6=True, clients=None,
1773
 
                 gnutls_priority=None, use_dbus=True):
 
2028
                 gnutls_priority=None, use_dbus=True, socketfd=None):
1774
2029
        self.enabled = False
1775
2030
        self.clients = clients
1776
2031
        if self.clients is None:
1780
2035
        IPv6_TCPServer.__init__(self, server_address,
1781
2036
                                RequestHandlerClass,
1782
2037
                                interface = interface,
1783
 
                                use_ipv6 = use_ipv6)
 
2038
                                use_ipv6 = use_ipv6,
 
2039
                                socketfd = socketfd)
1784
2040
    def server_activate(self):
1785
2041
        if self.enabled:
1786
2042
            return socketserver.TCPServer.server_activate(self)
1799
2055
    
1800
2056
    def handle_ipc(self, source, condition, parent_pipe=None,
1801
2057
                   proc = None, client_object=None):
1802
 
        condition_names = {
1803
 
            gobject.IO_IN: "IN",   # There is data to read.
1804
 
            gobject.IO_OUT: "OUT", # Data can be written (without
1805
 
                                    # blocking).
1806
 
            gobject.IO_PRI: "PRI", # There is urgent data to read.
1807
 
            gobject.IO_ERR: "ERR", # Error condition.
1808
 
            gobject.IO_HUP: "HUP"  # Hung up (the connection has been
1809
 
                                    # broken, usually for pipes and
1810
 
                                    # sockets).
1811
 
            }
1812
 
        conditions_string = ' | '.join(name
1813
 
                                       for cond, name in
1814
 
                                       condition_names.iteritems()
1815
 
                                       if cond & condition)
1816
2058
        # error, or the other end of multiprocessing.Pipe has closed
1817
 
        if condition & (gobject.IO_ERR | condition & gobject.IO_HUP):
 
2059
        if condition & (gobject.IO_ERR | gobject.IO_HUP):
1818
2060
            # Wait for other process to exit
1819
2061
            proc.join()
1820
2062
            return False
1878
2120
        return True
1879
2121
 
1880
2122
 
 
2123
def rfc3339_duration_to_delta(duration):
 
2124
    """Parse an RFC 3339 "duration" and return a datetime.timedelta
 
2125
    
 
2126
    >>> rfc3339_duration_to_delta("P7D")
 
2127
    datetime.timedelta(7)
 
2128
    >>> rfc3339_duration_to_delta("PT60S")
 
2129
    datetime.timedelta(0, 60)
 
2130
    >>> rfc3339_duration_to_delta("PT60M")
 
2131
    datetime.timedelta(0, 3600)
 
2132
    >>> rfc3339_duration_to_delta("PT24H")
 
2133
    datetime.timedelta(1)
 
2134
    >>> rfc3339_duration_to_delta("P1W")
 
2135
    datetime.timedelta(7)
 
2136
    >>> rfc3339_duration_to_delta("PT5M30S")
 
2137
    datetime.timedelta(0, 330)
 
2138
    >>> rfc3339_duration_to_delta("P1DT3M20S")
 
2139
    datetime.timedelta(1, 200)
 
2140
    """
 
2141
    
 
2142
    # Parsing an RFC 3339 duration with regular expressions is not
 
2143
    # possible - there would have to be multiple places for the same
 
2144
    # values, like seconds.  The current code, while more esoteric, is
 
2145
    # cleaner without depending on a parsing library.  If Python had a
 
2146
    # built-in library for parsing we would use it, but we'd like to
 
2147
    # avoid excessive use of external libraries.
 
2148
    
 
2149
    # New type for defining tokens, syntax, and semantics all-in-one
 
2150
    Token = collections.namedtuple("Token",
 
2151
                                   ("regexp", # To match token; if
 
2152
                                              # "value" is not None,
 
2153
                                              # must have a "group"
 
2154
                                              # containing digits
 
2155
                                    "value",  # datetime.timedelta or
 
2156
                                              # None
 
2157
                                    "followers")) # Tokens valid after
 
2158
                                                  # this token
 
2159
    # RFC 3339 "duration" tokens, syntax, and semantics; taken from
 
2160
    # the "duration" ABNF definition in RFC 3339, Appendix A.
 
2161
    token_end = Token(re.compile(r"$"), None, frozenset())
 
2162
    token_second = Token(re.compile(r"(\d+)S"),
 
2163
                         datetime.timedelta(seconds=1),
 
2164
                         frozenset((token_end,)))
 
2165
    token_minute = Token(re.compile(r"(\d+)M"),
 
2166
                         datetime.timedelta(minutes=1),
 
2167
                         frozenset((token_second, token_end)))
 
2168
    token_hour = Token(re.compile(r"(\d+)H"),
 
2169
                       datetime.timedelta(hours=1),
 
2170
                       frozenset((token_minute, token_end)))
 
2171
    token_time = Token(re.compile(r"T"),
 
2172
                       None,
 
2173
                       frozenset((token_hour, token_minute,
 
2174
                                  token_second)))
 
2175
    token_day = Token(re.compile(r"(\d+)D"),
 
2176
                      datetime.timedelta(days=1),
 
2177
                      frozenset((token_time, token_end)))
 
2178
    token_month = Token(re.compile(r"(\d+)M"),
 
2179
                        datetime.timedelta(weeks=4),
 
2180
                        frozenset((token_day, token_end)))
 
2181
    token_year = Token(re.compile(r"(\d+)Y"),
 
2182
                       datetime.timedelta(weeks=52),
 
2183
                       frozenset((token_month, token_end)))
 
2184
    token_week = Token(re.compile(r"(\d+)W"),
 
2185
                       datetime.timedelta(weeks=1),
 
2186
                       frozenset((token_end,)))
 
2187
    token_duration = Token(re.compile(r"P"), None,
 
2188
                           frozenset((token_year, token_month,
 
2189
                                      token_day, token_time,
 
2190
                                      token_week))),
 
2191
    # Define starting values
 
2192
    value = datetime.timedelta() # Value so far
 
2193
    found_token = None
 
2194
    followers = frozenset(token_duration,) # Following valid tokens
 
2195
    s = duration                # String left to parse
 
2196
    # Loop until end token is found
 
2197
    while found_token is not token_end:
 
2198
        # Search for any currently valid tokens
 
2199
        for token in followers:
 
2200
            match = token.regexp.match(s)
 
2201
            if match is not None:
 
2202
                # Token found
 
2203
                if token.value is not None:
 
2204
                    # Value found, parse digits
 
2205
                    factor = int(match.group(1), 10)
 
2206
                    # Add to value so far
 
2207
                    value += factor * token.value
 
2208
                # Strip token from string
 
2209
                s = token.regexp.sub("", s, 1)
 
2210
                # Go to found token
 
2211
                found_token = token
 
2212
                # Set valid next tokens
 
2213
                followers = found_token.followers
 
2214
                break
 
2215
        else:
 
2216
            # No currently valid tokens were found
 
2217
            raise ValueError("Invalid RFC 3339 duration")
 
2218
    # End token found
 
2219
    return value
 
2220
 
 
2221
 
1881
2222
def string_to_delta(interval):
1882
2223
    """Parse a string and return a datetime.timedelta
1883
2224
    
1894
2235
    >>> string_to_delta('5m 30s')
1895
2236
    datetime.timedelta(0, 330)
1896
2237
    """
 
2238
    
 
2239
    try:
 
2240
        return rfc3339_duration_to_delta(interval)
 
2241
    except ValueError:
 
2242
        pass
 
2243
    
1897
2244
    timevalue = datetime.timedelta(0)
1898
2245
    for s in interval.split():
1899
2246
        try:
1910
2257
            elif suffix == "w":
1911
2258
                delta = datetime.timedelta(0, 0, 0, 0, 0, 0, value)
1912
2259
            else:
1913
 
                raise ValueError("Unknown suffix %r" % suffix)
1914
 
        except (ValueError, IndexError) as e:
 
2260
                raise ValueError("Unknown suffix {0!r}"
 
2261
                                 .format(suffix))
 
2262
        except IndexError as e:
1915
2263
            raise ValueError(*(e.args))
1916
2264
        timevalue += delta
1917
2265
    return timevalue
1930
2278
        sys.exit()
1931
2279
    if not noclose:
1932
2280
        # Close all standard open file descriptors
1933
 
        null = os.open(os.path.devnull, os.O_NOCTTY | os.O_RDWR)
 
2281
        null = os.open(os.devnull, os.O_NOCTTY | os.O_RDWR)
1934
2282
        if not stat.S_ISCHR(os.fstat(null).st_mode):
1935
2283
            raise OSError(errno.ENODEV,
1936
 
                          "%s not a character device"
1937
 
                          % os.path.devnull)
 
2284
                          "{0} not a character device"
 
2285
                          .format(os.devnull))
1938
2286
        os.dup2(null, sys.stdin.fileno())
1939
2287
        os.dup2(null, sys.stdout.fileno())
1940
2288
        os.dup2(null, sys.stderr.fileno())
1949
2297
    
1950
2298
    parser = argparse.ArgumentParser()
1951
2299
    parser.add_argument("-v", "--version", action="version",
1952
 
                        version = "%%(prog)s %s" % version,
 
2300
                        version = "%(prog)s {0}".format(version),
1953
2301
                        help="show version number and exit")
1954
2302
    parser.add_argument("-i", "--interface", metavar="IF",
1955
2303
                        help="Bind to interface IF")
1961
2309
                        help="Run self-test")
1962
2310
    parser.add_argument("--debug", action="store_true",
1963
2311
                        help="Debug mode; run in foreground and log"
1964
 
                        " to terminal")
 
2312
                        " to terminal", default=None)
1965
2313
    parser.add_argument("--debuglevel", metavar="LEVEL",
1966
2314
                        help="Debug level for stdout output")
1967
2315
    parser.add_argument("--priority", help="GnuTLS"
1974
2322
                        " files")
1975
2323
    parser.add_argument("--no-dbus", action="store_false",
1976
2324
                        dest="use_dbus", help="Do not provide D-Bus"
1977
 
                        " system bus interface")
 
2325
                        " system bus interface", default=None)
1978
2326
    parser.add_argument("--no-ipv6", action="store_false",
1979
 
                        dest="use_ipv6", help="Do not use IPv6")
 
2327
                        dest="use_ipv6", help="Do not use IPv6",
 
2328
                        default=None)
1980
2329
    parser.add_argument("--no-restore", action="store_false",
1981
2330
                        dest="restore", help="Do not restore stored"
1982
 
                        " state")
 
2331
                        " state", default=None)
 
2332
    parser.add_argument("--socket", type=int,
 
2333
                        help="Specify a file descriptor to a network"
 
2334
                        " socket to use instead of creating one")
1983
2335
    parser.add_argument("--statedir", metavar="DIR",
1984
2336
                        help="Directory to save/restore state in")
 
2337
    parser.add_argument("--foreground", action="store_true",
 
2338
                        help="Run in foreground", default=None)
1985
2339
    
1986
2340
    options = parser.parse_args()
1987
2341
    
1988
2342
    if options.check:
1989
2343
        import doctest
1990
 
        doctest.testmod()
1991
 
        sys.exit()
 
2344
        fail_count, test_count = doctest.testmod()
 
2345
        sys.exit(os.EX_OK if fail_count == 0 else 1)
1992
2346
    
1993
2347
    # Default values for config file for server-global settings
1994
2348
    server_defaults = { "interface": "",
1996
2350
                        "port": "",
1997
2351
                        "debug": "False",
1998
2352
                        "priority":
1999
 
                        "SECURE256:!CTYPE-X.509:+CTYPE-OPENPGP",
 
2353
                        "SECURE256:!CTYPE-X.509:+CTYPE-OPENPGP:+SIGN-RSA-SHA224:+SIGN-RSA-RMD160",
2000
2354
                        "servicename": "Mandos",
2001
2355
                        "use_dbus": "True",
2002
2356
                        "use_ipv6": "True",
2003
2357
                        "debuglevel": "",
2004
2358
                        "restore": "True",
2005
 
                        "statedir": "/var/lib/mandos"
 
2359
                        "socket": "",
 
2360
                        "statedir": "/var/lib/mandos",
 
2361
                        "foreground": "False",
2006
2362
                        }
2007
2363
    
2008
2364
    # Parse config file for server-global settings
2013
2369
    # Convert the SafeConfigParser object to a dict
2014
2370
    server_settings = server_config.defaults()
2015
2371
    # Use the appropriate methods on the non-string config options
2016
 
    for option in ("debug", "use_dbus", "use_ipv6"):
 
2372
    for option in ("debug", "use_dbus", "use_ipv6", "foreground"):
2017
2373
        server_settings[option] = server_config.getboolean("DEFAULT",
2018
2374
                                                           option)
2019
2375
    if server_settings["port"]:
2020
2376
        server_settings["port"] = server_config.getint("DEFAULT",
2021
2377
                                                       "port")
 
2378
    if server_settings["socket"]:
 
2379
        server_settings["socket"] = server_config.getint("DEFAULT",
 
2380
                                                         "socket")
 
2381
        # Later, stdin will, and stdout and stderr might, be dup'ed
 
2382
        # over with an opened os.devnull.  But we don't want this to
 
2383
        # happen with a supplied network socket.
 
2384
        if 0 <= server_settings["socket"] <= 2:
 
2385
            server_settings["socket"] = os.dup(server_settings
 
2386
                                               ["socket"])
2022
2387
    del server_config
2023
2388
    
2024
2389
    # Override the settings from the config file with command line
2026
2391
    for option in ("interface", "address", "port", "debug",
2027
2392
                   "priority", "servicename", "configdir",
2028
2393
                   "use_dbus", "use_ipv6", "debuglevel", "restore",
2029
 
                   "statedir"):
 
2394
                   "statedir", "socket", "foreground"):
2030
2395
        value = getattr(options, option)
2031
2396
        if value is not None:
2032
2397
            server_settings[option] = value
2035
2400
    for option in server_settings.keys():
2036
2401
        if type(server_settings[option]) is str:
2037
2402
            server_settings[option] = unicode(server_settings[option])
 
2403
    # Force all boolean options to be boolean
 
2404
    for option in ("debug", "use_dbus", "use_ipv6", "restore",
 
2405
                   "foreground"):
 
2406
        server_settings[option] = bool(server_settings[option])
 
2407
    # Debug implies foreground
 
2408
    if server_settings["debug"]:
 
2409
        server_settings["foreground"] = True
2038
2410
    # Now we have our good server settings in "server_settings"
2039
2411
    
2040
2412
    ##################################################################
2046
2418
    use_ipv6 = server_settings["use_ipv6"]
2047
2419
    stored_state_path = os.path.join(server_settings["statedir"],
2048
2420
                                     stored_state_file)
 
2421
    foreground = server_settings["foreground"]
2049
2422
    
2050
2423
    if debug:
2051
 
        initlogger(logging.DEBUG)
 
2424
        initlogger(debug, logging.DEBUG)
2052
2425
    else:
2053
2426
        if not debuglevel:
2054
 
            initlogger()
 
2427
            initlogger(debug)
2055
2428
        else:
2056
2429
            level = getattr(logging, debuglevel.upper())
2057
 
            initlogger(level)
 
2430
            initlogger(debug, level)
2058
2431
    
2059
2432
    if server_settings["servicename"] != "Mandos":
2060
2433
        syslogger.setFormatter(logging.Formatter
2061
 
                               ('Mandos (%s) [%%(process)d]:'
2062
 
                                ' %%(levelname)s: %%(message)s'
2063
 
                                % server_settings["servicename"]))
 
2434
                               ('Mandos ({0}) [%(process)d]:'
 
2435
                                ' %(levelname)s: %(message)s'
 
2436
                                .format(server_settings
 
2437
                                        ["servicename"])))
2064
2438
    
2065
2439
    # Parse config file with clients
2066
 
    client_defaults = { "timeout": "5m",
2067
 
                        "extended_timeout": "15m",
2068
 
                        "interval": "2m",
2069
 
                        "checker": "fping -q -- %%(host)s",
2070
 
                        "host": "",
2071
 
                        "approval_delay": "0s",
2072
 
                        "approval_duration": "1s",
2073
 
                        }
2074
 
    client_config = configparser.SafeConfigParser(client_defaults)
 
2440
    client_config = configparser.SafeConfigParser(Client
 
2441
                                                  .client_defaults)
2075
2442
    client_config.read(os.path.join(server_settings["configdir"],
2076
2443
                                    "clients.conf"))
2077
2444
    
2086
2453
                              use_ipv6=use_ipv6,
2087
2454
                              gnutls_priority=
2088
2455
                              server_settings["priority"],
2089
 
                              use_dbus=use_dbus)
2090
 
    if not debug:
2091
 
        pidfilename = "/var/run/mandos.pid"
 
2456
                              use_dbus=use_dbus,
 
2457
                              socketfd=(server_settings["socket"]
 
2458
                                        or None))
 
2459
    if not foreground:
 
2460
        pidfilename = "/run/mandos.pid"
 
2461
        if not os.path.isdir("/run/."):
 
2462
            pidfilename = "/var/run/mandos.pid"
 
2463
        pidfile = None
2092
2464
        try:
2093
2465
            pidfile = open(pidfilename, "w")
2094
 
        except IOError:
2095
 
            logger.error("Could not open file %r", pidfilename)
 
2466
        except IOError as e:
 
2467
            logger.error("Could not open file %r", pidfilename,
 
2468
                         exc_info=e)
2096
2469
    
2097
 
    try:
2098
 
        uid = pwd.getpwnam("_mandos").pw_uid
2099
 
        gid = pwd.getpwnam("_mandos").pw_gid
2100
 
    except KeyError:
 
2470
    for name in ("_mandos", "mandos", "nobody"):
2101
2471
        try:
2102
 
            uid = pwd.getpwnam("mandos").pw_uid
2103
 
            gid = pwd.getpwnam("mandos").pw_gid
 
2472
            uid = pwd.getpwnam(name).pw_uid
 
2473
            gid = pwd.getpwnam(name).pw_gid
 
2474
            break
2104
2475
        except KeyError:
2105
 
            try:
2106
 
                uid = pwd.getpwnam("nobody").pw_uid
2107
 
                gid = pwd.getpwnam("nobody").pw_gid
2108
 
            except KeyError:
2109
 
                uid = 65534
2110
 
                gid = 65534
 
2476
            continue
 
2477
    else:
 
2478
        uid = 65534
 
2479
        gid = 65534
2111
2480
    try:
2112
2481
        os.setgid(gid)
2113
2482
        os.setuid(uid)
2114
2483
    except OSError as error:
2115
 
        if error[0] != errno.EPERM:
2116
 
            raise error
 
2484
        if error.errno != errno.EPERM:
 
2485
            raise
2117
2486
    
2118
2487
    if debug:
2119
2488
        # Enable all possible GnuTLS debugging
2130
2499
         .gnutls_global_set_log_function(debug_gnutls))
2131
2500
        
2132
2501
        # Redirect stdin so all checkers get /dev/null
2133
 
        null = os.open(os.path.devnull, os.O_NOCTTY | os.O_RDWR)
 
2502
        null = os.open(os.devnull, os.O_NOCTTY | os.O_RDWR)
2134
2503
        os.dup2(null, sys.stdin.fileno())
2135
2504
        if null > 2:
2136
2505
            os.close(null)
2137
 
    else:
2138
 
        # No console logging
2139
 
        logger.removeHandler(console)
2140
2506
    
2141
2507
    # Need to fork before connecting to D-Bus
2142
 
    if not debug:
 
2508
    if not foreground:
2143
2509
        # Close all input and output, do double fork, etc.
2144
2510
        daemon()
2145
2511
    
 
2512
    # multiprocessing will use threads, so before we use gobject we
 
2513
    # need to inform gobject that threads will be used.
 
2514
    gobject.threads_init()
 
2515
    
2146
2516
    global main_loop
2147
2517
    # From the Avahi example code
2148
 
    DBusGMainLoop(set_as_default=True )
 
2518
    DBusGMainLoop(set_as_default=True)
2149
2519
    main_loop = gobject.MainLoop()
2150
2520
    bus = dbus.SystemBus()
2151
2521
    # End of Avahi example code
2157
2527
                            ("se.bsnet.fukt.Mandos", bus,
2158
2528
                             do_not_queue=True))
2159
2529
        except dbus.exceptions.NameExistsException as e:
2160
 
            logger.error(unicode(e) + ", disabling D-Bus")
 
2530
            logger.error("Disabling D-Bus:", exc_info=e)
2161
2531
            use_dbus = False
2162
2532
            server_settings["use_dbus"] = False
2163
2533
            tcp_server.use_dbus = False
2175
2545
    
2176
2546
    client_class = Client
2177
2547
    if use_dbus:
2178
 
        client_class = functools.partial(ClientDBusTransitional,
2179
 
                                         bus = bus)
2180
 
    
2181
 
    special_settings = {
2182
 
        # Some settings need to be accessd by special methods;
2183
 
        # booleans need .getboolean(), etc.  Here is a list of them:
2184
 
        "approved_by_default":
2185
 
            lambda section:
2186
 
            client_config.getboolean(section, "approved_by_default"),
2187
 
        "enabled":
2188
 
            lambda section:
2189
 
            client_config.getboolean(section, "enabled"),
2190
 
        }
2191
 
    # Construct a new dict of client settings of this form:
2192
 
    # { client_name: {setting_name: value, ...}, ...}
2193
 
    # with exceptions for any special settings as defined above
2194
 
    client_settings = dict((clientname,
2195
 
                           dict((setting,
2196
 
                                 (value
2197
 
                                  if setting not in special_settings
2198
 
                                  else special_settings[setting]
2199
 
                                  (clientname)))
2200
 
                                for setting, value in
2201
 
                                client_config.items(clientname)))
2202
 
                          for clientname in client_config.sections())
2203
 
    
 
2548
        client_class = functools.partial(ClientDBus, bus = bus)
 
2549
    
 
2550
    client_settings = Client.config_parser(client_config)
2204
2551
    old_client_settings = {}
2205
 
    clients_data = []
 
2552
    clients_data = {}
 
2553
    
 
2554
    # This is used to redirect stdout and stderr for checker processes
 
2555
    global wnull
 
2556
    wnull = open(os.devnull, "w") # A writable /dev/null
 
2557
    # Only used if server is running in foreground but not in debug
 
2558
    # mode
 
2559
    if debug or not foreground:
 
2560
        wnull.close()
2206
2561
    
2207
2562
    # Get client data and settings from last running state.
2208
2563
    if server_settings["restore"]:
2212
2567
                                                     (stored_state))
2213
2568
            os.remove(stored_state_path)
2214
2569
        except IOError as e:
2215
 
            logger.warning("Could not load persistent state: {0}"
2216
 
                           .format(e))
2217
 
            if e.errno != errno.ENOENT:
 
2570
            if e.errno == errno.ENOENT:
 
2571
                logger.warning("Could not load persistent state: {0}"
 
2572
                                .format(os.strerror(e.errno)))
 
2573
            else:
 
2574
                logger.critical("Could not load persistent state:",
 
2575
                                exc_info=e)
2218
2576
                raise
 
2577
        except EOFError as e:
 
2578
            logger.warning("Could not load persistent state: "
 
2579
                           "EOFError:", exc_info=e)
2219
2580
    
2220
 
    with Crypto() as crypt:
2221
 
        for client in clients_data:
2222
 
            client_name = client["name"]
 
2581
    with PGPEngine() as pgp:
 
2582
        for client_name, client in clients_data.iteritems():
 
2583
            # Skip removed clients
 
2584
            if client_name not in client_settings:
 
2585
                continue
2223
2586
            
2224
2587
            # Decide which value to use after restoring saved state.
2225
2588
            # We have three different values: Old config file,
2234
2597
                    if (name != "secret" and
2235
2598
                        value != old_client_settings[client_name]
2236
2599
                        [name]):
2237
 
                        setattr(client, name, value)
 
2600
                        client[name] = value
2238
2601
                except KeyError:
2239
2602
                    pass
2240
2603
            
2241
2604
            # Clients who has passed its expire date can still be
2242
 
            # enabled if its last checker was sucessful.  Clients
2243
 
            # whose checker failed before we stored its state is
2244
 
            # assumed to have failed all checkers during downtime.
2245
 
            if client["enabled"] and client["last_checked_ok"]:
2246
 
                if ((datetime.datetime.utcnow()
2247
 
                     - client["last_checked_ok"])
2248
 
                    > client["interval"]):
2249
 
                    if client["last_checker_status"] != 0:
 
2605
            # enabled if its last checker was successful.  Clients
 
2606
            # whose checker succeeded before we stored its state is
 
2607
            # assumed to have successfully run all checkers during
 
2608
            # downtime.
 
2609
            if client["enabled"]:
 
2610
                if datetime.datetime.utcnow() >= client["expires"]:
 
2611
                    if not client["last_checked_ok"]:
 
2612
                        logger.warning(
 
2613
                            "disabling client {0} - Client never "
 
2614
                            "performed a successful checker"
 
2615
                            .format(client_name))
 
2616
                        client["enabled"] = False
 
2617
                    elif client["last_checker_status"] != 0:
 
2618
                        logger.warning(
 
2619
                            "disabling client {0} - Client "
 
2620
                            "last checker failed with error code {1}"
 
2621
                            .format(client_name,
 
2622
                                    client["last_checker_status"]))
2250
2623
                        client["enabled"] = False
2251
2624
                    else:
2252
2625
                        client["expires"] = (datetime.datetime
2253
2626
                                             .utcnow()
2254
2627
                                             + client["timeout"])
2255
 
            
2256
 
            client["changedstate"] = (multiprocessing_manager
2257
 
                                      .Condition
2258
 
                                      (multiprocessing_manager
2259
 
                                       .Lock()))
2260
 
            if use_dbus:
2261
 
                new_client = (ClientDBusTransitional.__new__
2262
 
                              (ClientDBusTransitional))
2263
 
                tcp_server.clients[client_name] = new_client
2264
 
                new_client.bus = bus
2265
 
                for name, value in client.iteritems():
2266
 
                    setattr(new_client, name, value)
2267
 
                client_object_name = unicode(client_name).translate(
2268
 
                    {ord("."): ord("_"),
2269
 
                     ord("-"): ord("_")})
2270
 
                new_client.dbus_object_path = (dbus.ObjectPath
2271
 
                                               ("/clients/"
2272
 
                                                + client_object_name))
2273
 
                DBusObjectWithProperties.__init__(new_client,
2274
 
                                                  new_client.bus,
2275
 
                                                  new_client
2276
 
                                                  .dbus_object_path)
2277
 
            else:
2278
 
                tcp_server.clients[client_name] = (Client.__new__
2279
 
                                                   (Client))
2280
 
                for name, value in client.iteritems():
2281
 
                    setattr(tcp_server.clients[client_name],
2282
 
                            name, value)
2283
 
            
 
2628
                        logger.debug("Last checker succeeded,"
 
2629
                                     " keeping {0} enabled"
 
2630
                                     .format(client_name))
2284
2631
            try:
2285
 
                tcp_server.clients[client_name].secret = (
2286
 
                    crypt.decrypt(tcp_server.clients[client_name]
2287
 
                                  .encrypted_secret,
2288
 
                                  client_settings[client_name]
2289
 
                                  ["secret"]))
2290
 
            except CryptoError:
 
2632
                client["secret"] = (
 
2633
                    pgp.decrypt(client["encrypted_secret"],
 
2634
                                client_settings[client_name]
 
2635
                                ["secret"]))
 
2636
            except PGPError:
2291
2637
                # If decryption fails, we use secret from new settings
2292
 
                tcp_server.clients[client_name].secret = (
 
2638
                logger.debug("Failed to decrypt {0} old secret"
 
2639
                             .format(client_name))
 
2640
                client["secret"] = (
2293
2641
                    client_settings[client_name]["secret"])
2294
2642
    
2295
 
    # Create/remove clients based on new changes made to config
2296
 
    for clientname in set(old_client_settings) - set(client_settings):
2297
 
        del tcp_server.clients[clientname]
2298
 
    for clientname in set(client_settings) - set(old_client_settings):
2299
 
        tcp_server.clients[clientname] = (client_class(name
2300
 
                                                       = clientname,
2301
 
                                                       config =
2302
 
                                                       client_settings
2303
 
                                                       [clientname]))
 
2643
    # Add/remove clients based on new changes made to config
 
2644
    for client_name in (set(old_client_settings)
 
2645
                        - set(client_settings)):
 
2646
        del clients_data[client_name]
 
2647
    for client_name in (set(client_settings)
 
2648
                        - set(old_client_settings)):
 
2649
        clients_data[client_name] = client_settings[client_name]
 
2650
    
 
2651
    # Create all client objects
 
2652
    for client_name, client in clients_data.iteritems():
 
2653
        tcp_server.clients[client_name] = client_class(
 
2654
            name = client_name, settings = client,
 
2655
            server_settings = server_settings)
2304
2656
    
2305
2657
    if not tcp_server.clients:
2306
2658
        logger.warning("No clients defined")
2307
 
        
2308
 
    if not debug:
2309
 
        try:
2310
 
            with pidfile:
2311
 
                pid = os.getpid()
2312
 
                pidfile.write(str(pid) + "\n".encode("utf-8"))
2313
 
            del pidfile
2314
 
        except IOError:
2315
 
            logger.error("Could not write to file %r with PID %d",
2316
 
                         pidfilename, pid)
2317
 
        except NameError:
2318
 
            # "pidfile" was never created
2319
 
            pass
 
2659
    
 
2660
    if not foreground:
 
2661
        if pidfile is not None:
 
2662
            try:
 
2663
                with pidfile:
 
2664
                    pid = os.getpid()
 
2665
                    pidfile.write(str(pid) + "\n".encode("utf-8"))
 
2666
            except IOError:
 
2667
                logger.error("Could not write to file %r with PID %d",
 
2668
                             pidfilename, pid)
 
2669
        del pidfile
2320
2670
        del pidfilename
2321
 
        
2322
 
        signal.signal(signal.SIGINT, signal.SIG_IGN)
2323
2671
    
2324
2672
    signal.signal(signal.SIGHUP, lambda signum, frame: sys.exit())
2325
2673
    signal.signal(signal.SIGTERM, lambda signum, frame: sys.exit())
2326
2674
    
2327
2675
    if use_dbus:
2328
 
        class MandosDBusService(dbus.service.Object):
 
2676
        @alternate_dbus_interfaces({"se.recompile.Mandos":
 
2677
                                        "se.bsnet.fukt.Mandos"})
 
2678
        class MandosDBusService(DBusObjectWithProperties):
2329
2679
            """A D-Bus proxy object"""
2330
2680
            def __init__(self):
2331
2681
                dbus.service.Object.__init__(self, bus, "/")
2332
2682
            _interface = "se.recompile.Mandos"
2333
2683
            
 
2684
            @dbus_interface_annotations(_interface)
 
2685
            def _foo(self):
 
2686
                return { "org.freedesktop.DBus.Property"
 
2687
                         ".EmitsChangedSignal":
 
2688
                             "false"}
 
2689
            
2334
2690
            @dbus.service.signal(_interface, signature="o")
2335
2691
            def ClientAdded(self, objpath):
2336
2692
                "D-Bus signal"
2378
2734
            
2379
2735
            del _interface
2380
2736
        
2381
 
        class MandosDBusServiceTransitional(MandosDBusService):
2382
 
            __metaclass__ = AlternateDBusNamesMetaclass
2383
 
        mandos_dbus_service = MandosDBusServiceTransitional()
 
2737
        mandos_dbus_service = MandosDBusService()
2384
2738
    
2385
2739
    def cleanup():
2386
2740
        "Cleanup function; run on exit"
2387
2741
        service.cleanup()
2388
2742
        
2389
2743
        multiprocessing.active_children()
 
2744
        wnull.close()
2390
2745
        if not (tcp_server.clients or client_settings):
2391
2746
            return
2392
2747
        
2393
2748
        # Store client before exiting. Secrets are encrypted with key
2394
2749
        # based on what config file has. If config file is
2395
2750
        # removed/edited, old secret will thus be unrecovable.
2396
 
        clients = []
2397
 
        with Crypto() as crypt:
 
2751
        clients = {}
 
2752
        with PGPEngine() as pgp:
2398
2753
            for client in tcp_server.clients.itervalues():
2399
2754
                key = client_settings[client.name]["secret"]
2400
 
                client.encrypted_secret = crypt.encrypt(client.secret,
2401
 
                                                        key)
 
2755
                client.encrypted_secret = pgp.encrypt(client.secret,
 
2756
                                                      key)
2402
2757
                client_dict = {}
2403
2758
                
2404
 
                # A list of attributes that will not be stored when
2405
 
                # shutting down.
2406
 
                exclude = set(("bus", "changedstate", "secret"))
 
2759
                # A list of attributes that can not be pickled
 
2760
                # + secret.
 
2761
                exclude = set(("bus", "changedstate", "secret",
 
2762
                               "checker", "server_settings"))
2407
2763
                for name, typ in (inspect.getmembers
2408
2764
                                  (dbus.service.Object)):
2409
2765
                    exclude.add(name)
2414
2770
                    if attr not in exclude:
2415
2771
                        client_dict[attr] = getattr(client, attr)
2416
2772
                
2417
 
                clients.append(client_dict)
 
2773
                clients[client.name] = client_dict
2418
2774
                del client_settings[client.name]["secret"]
2419
2775
        
2420
2776
        try:
2421
 
            with os.fdopen(os.open(stored_state_path,
2422
 
                                   os.O_CREAT|os.O_WRONLY|os.O_TRUNC,
2423
 
                                   0600), "wb") as stored_state:
 
2777
            with (tempfile.NamedTemporaryFile
 
2778
                  (mode='wb', suffix=".pickle", prefix='clients-',
 
2779
                   dir=os.path.dirname(stored_state_path),
 
2780
                   delete=False)) as stored_state:
2424
2781
                pickle.dump((clients, client_settings), stored_state)
 
2782
                tempname=stored_state.name
 
2783
            os.rename(tempname, stored_state_path)
2425
2784
        except (IOError, OSError) as e:
2426
 
            logger.warning("Could not save persistent state: {0}"
2427
 
                           .format(e))
2428
 
            if e.errno not in (errno.ENOENT, errno.EACCES):
 
2785
            if not debug:
 
2786
                try:
 
2787
                    os.remove(tempname)
 
2788
                except NameError:
 
2789
                    pass
 
2790
            if e.errno in (errno.ENOENT, errno.EACCES, errno.EEXIST):
 
2791
                logger.warning("Could not save persistent state: {0}"
 
2792
                               .format(os.strerror(e.errno)))
 
2793
            else:
 
2794
                logger.warning("Could not save persistent state:",
 
2795
                               exc_info=e)
2429
2796
                raise
2430
2797
        
2431
2798
        # Delete all clients, and settings from config
2459
2826
    service.port = tcp_server.socket.getsockname()[1]
2460
2827
    if use_ipv6:
2461
2828
        logger.info("Now listening on address %r, port %d,"
2462
 
                    " flowinfo %d, scope_id %d"
2463
 
                    % tcp_server.socket.getsockname())
 
2829
                    " flowinfo %d, scope_id %d",
 
2830
                    *tcp_server.socket.getsockname())
2464
2831
    else:                       # IPv4
2465
 
        logger.info("Now listening on address %r, port %d"
2466
 
                    % tcp_server.socket.getsockname())
 
2832
        logger.info("Now listening on address %r, port %d",
 
2833
                    *tcp_server.socket.getsockname())
2467
2834
    
2468
2835
    #service.interface = tcp_server.socket.getsockname()[3]
2469
2836
    
2472
2839
        try:
2473
2840
            service.activate()
2474
2841
        except dbus.exceptions.DBusException as error:
2475
 
            logger.critical("DBusException: %s", error)
 
2842
            logger.critical("D-Bus Exception", exc_info=error)
2476
2843
            cleanup()
2477
2844
            sys.exit(1)
2478
2845
        # End of Avahi example code
2485
2852
        logger.debug("Starting main loop")
2486
2853
        main_loop.run()
2487
2854
    except AvahiError as error:
2488
 
        logger.critical("AvahiError: %s", error)
 
2855
        logger.critical("Avahi Error", exc_info=error)
2489
2856
        cleanup()
2490
2857
        sys.exit(1)
2491
2858
    except KeyboardInterrupt:
2496
2863
    # Must run before the D-Bus bus name gets deregistered
2497
2864
    cleanup()
2498
2865
 
2499
 
 
2500
2866
if __name__ == '__main__':
2501
2867
    main()