/mandos/trunk : revision 1250

1

#!/usr/bin/python3 -bI

2

# -*- coding: utf-8; lexical-binding: t -*-

2

# -*- mode: python; after-save-hook: (lambda () (let ((command (if (fboundp 'file-local-name) (file-local-name (buffer-file-name)) (or (file-remote-p (buffer-file-name) 'localname) (buffer-file-name))))) (if (= (progn (if (get-buffer "*Test*") (kill-buffer "*Test*")) (process-file-shell-command (format "%s --check" (shell-quote-argument command)) nil "*Test*")) 0) (let ((w (get-buffer-window "*Test*"))) (if w (delete-window w))) (progn (with-current-buffer "*Test*" (compilation-mode)) (display-buffer "*Test*" '(display-buffer-in-side-window)))))); coding: utf-8 -*-

3

#

4

# Mandos server - give out binary blobs to connecting clients.

5

#

11

# "AvahiService" class, and some lines in "main".

12

#

13

# Everything else is

14

15

14

15

16

#

17

# This file is part of Mandos.

18

#

31

#

32

# Contact the authors at <mandos@recompile.se>.

33

#

34

35

from __future__ import (division, absolute_import, print_function,

35

36

unicode_literals)

36

37

39

40

except ImportError:

40

41

pass

41

42

import sys

43

import unittest

44

import argparse

45

import logging

46

import os

47

43

try:

48

44

import SocketServer as socketserver

49

45

except ImportError:

50

46

import socketserver

51

47

import socket

48

import argparse

52

49

import datetime

53

50

import errno

54

51

try:

55

52

import ConfigParser as configparser

56

53

except ImportError:

57

54

import configparser

55

import sys

58

56

import re

57

import os

59

58

import signal

60

59

import subprocess

61

60

import atexit

62

61

import stat

62

import logging

63

import logging.handlers

64

import pwd

65

import contextlib

77

import itertools

78

import collections

79

import codecs

80

import unittest

80

81

import random

81

82

import shlex

82

83

93

94

if sys.version_info.major == 2:

94

95

__metaclass__ = type

95

96

str = unicode

96

input = raw_input

97

98

# Add collections.abc.Callable if it does not exist

99

try:

143

if sys.version_info < (3, 2):

144

configparser.Configparser = configparser.SafeConfigParser

145

146

version = "1.8.17"

146

version = "1.8.14"

147

stored_state_file = "clients.pickle"

148

149

log = logging.getLogger(os.path.basename(sys.argv[0]))

149

logger = logging.getLogger()

150

logging.captureWarnings(True) # Show warnings via the logging system

151

syslogger = None

152

191

syslogger.setFormatter(logging.Formatter

192

("Mandos [%(process)d]: %(levelname)s:"

193

" %(message)s"))

194

log.addHandler(syslogger)

194

logger.addHandler(syslogger)

195

196

if debug:

197

console = logging.StreamHandler()

199

" [%(process)d]:"

200

" %(levelname)s:"

201

" %(message)s"))

202

log.addHandler(console)

203

log.setLevel(level)

202

logger.addHandler(console)

203

logger.setLevel(level)

204

205

206

class PGPError(Exception):

394

def rename(self, remove=True):

395

"""Derived from the Avahi example code"""

396

if self.rename_count >= self.max_renames:

397

log.critical("No suitable Zeroconf service name found"

398

" after %i retries, exiting.",

399

self.rename_count)

397

logger.critical("No suitable Zeroconf service name found"

398

" after %i retries, exiting.",

399

self.rename_count)

400

raise AvahiServiceError("Too many renames")

401

self.name = str(

402

self.server.GetAlternativeServiceName(self.name))

403

self.rename_count += 1

404

log.info("Changing Zeroconf service name to %r ...",

405

self.name)

404

logger.info("Changing Zeroconf service name to %r ...",

405

self.name)

406

if remove:

407

self.remove()

408

try:

410

except dbus.exceptions.DBusException as error:

411

if (error.get_dbus_name()

412

== "org.freedesktop.Avahi.CollisionError"):

413

log.info("Local Zeroconf service name collision.")

413

logger.info("Local Zeroconf service name collision.")

414

return self.rename(remove=False)

415

else:

416

log.critical("D-Bus Exception", exc_info=error)

416

logger.critical("D-Bus Exception", exc_info=error)

417

self.cleanup()

418

os._exit(1)

419

436

self.entry_group_state_changed_match = (

437

self.group.connect_to_signal(

438

"StateChanged", self.entry_group_state_changed))

439

log.debug("Adding Zeroconf service '%s' of type '%s' ...",

440

self.name, self.type)

439

logger.debug("Adding Zeroconf service '%s' of type '%s' ...",

440

self.name, self.type)

441

self.group.AddService(

442

self.interface,

443

self.protocol,

450

451

def entry_group_state_changed(self, state, error):

452

"""Derived from the Avahi example code"""

453

log.debug("Avahi entry group state change: %i", state)

453

logger.debug("Avahi entry group state change: %i", state)

454

455

if state == avahi.ENTRY_GROUP_ESTABLISHED:

456

log.debug("Zeroconf service established.")

456

logger.debug("Zeroconf service established.")

457

elif state == avahi.ENTRY_GROUP_COLLISION:

458

log.info("Zeroconf service name collision.")

458

logger.info("Zeroconf service name collision.")

459

self.rename()

460

elif state == avahi.ENTRY_GROUP_FAILURE:

461

log.critical("Avahi: Error in group state changed %s",

462

str(error))

461

logger.critical("Avahi: Error in group state changed %s",

462

str(error))

463

raise AvahiGroupError("State changed: {!s}".format(error))

464

465

def cleanup(self):

475

476

def server_state_changed(self, state, error=None):

477

"""Derived from the Avahi example code"""

478

log.debug("Avahi server state change: %i", state)

478

logger.debug("Avahi server state change: %i", state)

479

bad_states = {

480

avahi.SERVER_INVALID: "Zeroconf server invalid",

481

avahi.SERVER_REGISTERING: None,

485

if state in bad_states:

486

if bad_states[state] is not None:

487

if error is None:

488

log.error(bad_states[state])

488

logger.error(bad_states[state])

489

else:

490

log.error(bad_states[state] + ": %r", error)

490

logger.error(bad_states[state] + ": %r", error)

491

self.cleanup()

492

elif state == avahi.SERVER_RUNNING:

493

try:

495

except dbus.exceptions.DBusException as error:

496

if (error.get_dbus_name()

497

== "org.freedesktop.Avahi.CollisionError"):

498

log.info("Local Zeroconf service name collision.")

498

logger.info("Local Zeroconf service name"

499

" collision.")

499

500

return self.rename(remove=False)

500

501

else:

501

log.critical("D-Bus Exception", exc_info=error)

502

logger.critical("D-Bus Exception", exc_info=error)

502

503

self.cleanup()

503

504

os._exit(1)

504

505

else:

505

506

if error is None:

506

log.debug("Unknown state: %r", state)

507

logger.debug("Unknown state: %r", state)

507

508

else:

508

log.debug("Unknown state: %r: %r", state, error)

509

logger.debug("Unknown state: %r: %r", state, error)

509

510

511

def activate(self):

511

512

"""Derived from the Avahi example code"""

961

962

# key_id() and fingerprint() functions

962

963

client["key_id"] = (section.get("key_id", "").upper()

963

964

.replace(" ", ""))

964

client["fingerprint"] = (section.get("fingerprint",

965

"").upper()

965

client["fingerprint"] = (section["fingerprint"].upper()

966

.replace(" ", ""))

967

if not (client["key_id"] or client["fingerprint"]):

968

log.error("Skipping client %s without key_id or"

969

" fingerprint", client_name)

970

del settings[client_name]

971

continue

972

967

if "secret" in section:

973

968

client["secret"] = codecs.decode(section["secret"]

974

969

.encode("utf-8"),

1015

1010

self.last_enabled = None

1016

1011

self.expires = None

1017

1012

1018

log.debug("Creating client %r", self.name)

1019

log.debug(" Key ID: %s", self.key_id)

1020

log.debug(" Fingerprint: %s", self.fingerprint)

1013

logger.debug("Creating client %r", self.name)

1014

logger.debug(" Key ID: %s", self.key_id)

1015

logger.debug(" Fingerprint: %s", self.fingerprint)

1021

1016

self.created = settings.get("created",

1022

1017

datetime.datetime.utcnow())

1023

1018

1051

1046

if getattr(self, "enabled", False):

1052

1047

# Already enabled

1053

1048

return

1049

self.expires = datetime.datetime.utcnow() + self.timeout

1054

1050

self.enabled = True

1055

1051

self.last_enabled = datetime.datetime.utcnow()

1056

1052

self.init_checker()

1061

1057

if not getattr(self, "enabled", False):

1062

1058

return False

1063

1059

if not quiet:

1064

log.info("Disabling client %s", self.name)

1060

logger.info("Disabling client %s", self.name)

1065

1061

if getattr(self, "disable_initiator_tag", None) is not None:

1066

1062

GLib.source_remove(self.disable_initiator_tag)

1067

1063

self.disable_initiator_tag = None

1079

1075

def __del__(self):

1080

1076

self.disable()

1081

1077

1082

def init_checker(self, randomize_start=False):

1083

# Schedule a new checker to be started a randomly selected

1084

# time (a fraction of 'interval') from now. This spreads out

1085

# the startup of checkers over time when the server is

1086

# started.

1078

def init_checker(self):

1079

# Schedule a new checker to be started an 'interval' from now,

1080

# and every interval from then on.

1087

1081

if self.checker_initiator_tag is not None:

1088

1082

GLib.source_remove(self.checker_initiator_tag)

1089

interval_milliseconds = int(self.interval.total_seconds()

1090

* 1000)

1091

if randomize_start:

1092

delay_milliseconds = random.randrange(

1093

interval_milliseconds + 1)

1094

else:

1095

delay_milliseconds = interval_milliseconds

1096

1083

self.checker_initiator_tag = GLib.timeout_add(

1097

delay_milliseconds, self.start_checker, randomize_start)

1098

delay = datetime.timedelta(0, 0, 0, delay_milliseconds)

1099

# A checker might take up to an 'interval' of time, so we can

1100

# expire at the soonest one interval after a checker was

1101

# started. Since the initial checker is delayed, the expire

1102

# time might have to be extended.

1103

now = datetime.datetime.utcnow()

1104

self.expires = now + delay + self.interval

1105

# Schedule a disable() at expire time

1084

random.randrange(int(self.interval.total_seconds() * 1000

1085

+ 1)),

1086

self.start_checker)

1087

# Schedule a disable() when 'timeout' has passed

1106

1088

if self.disable_initiator_tag is not None:

1107

1089

GLib.source_remove(self.disable_initiator_tag)

1108

1090

self.disable_initiator_tag = GLib.timeout_add(

1109

int((self.expires - now).total_seconds() * 1000),

1110

self.disable)

1091

int(self.timeout.total_seconds() * 1000), self.disable)

1092

# Also start a new checker *right now*.

1093

self.start_checker()

1111

1094

1112

1095

def checker_callback(self, source, condition, connection,

1113

1096

command):

1124

1107

self.last_checker_status = returncode

1125

1108

self.last_checker_signal = None

1126

1109

if self.last_checker_status == 0:

1127

log.info("Checker for %(name)s succeeded", vars(self))

1110

logger.info("Checker for %(name)s succeeded",

1111

vars(self))

1128

1112

self.checked_ok()

1129

1113

else:

1130

log.info("Checker for %(name)s failed", vars(self))

1114

logger.info("Checker for %(name)s failed", vars(self))

1131

1115

else:

1132

1116

self.last_checker_status = -1

1133

1117

self.last_checker_signal = -returncode

1134

log.warning("Checker for %(name)s crashed?", vars(self))

1118

logger.warning("Checker for %(name)s crashed?",

1119

vars(self))

1135

1120

return False

1136

1121

1137

1122

def checked_ok(self):

1156

1141

def need_approval(self):

1157

1142

self.last_approval_request = datetime.datetime.utcnow()

1158

1143

1159

def start_checker(self, start_was_randomized=False):

1144

def start_checker(self):

1160

1145

"""Start a new checker subprocess if one is not running.

1161

1146

1162

1147

If a checker already exists, leave it running and do

1171

1156

# should be.

1172

1157

1173

1158

if self.checker is not None and not self.checker.is_alive():

1174

log.warning("Checker was not alive; joining")

1159

logger.warning("Checker was not alive; joining")

1175

1160

self.checker.join()

1176

1161

self.checker = None

1177

1162

# Start a new checker if needed

1183

1168

try:

1184

1169

command = self.checker_command % escaped_attrs

1185

1170

except TypeError as error:

1186

log.error('Could not format string "%s"',

1187

self.checker_command, exc_info=error)

1171

logger.error('Could not format string "%s"',

1172

self.checker_command,

1173

exc_info=error)

1188

1174

return True # Try again later

1189

1175

self.current_checker_command = command

1190

log.info("Starting checker %r for %s", command, self.name)

1176

logger.info("Starting checker %r for %s", command,

1177

self.name)

1191

1178

# We don't need to redirect stdout and stderr, since

1192

1179

# in normal mode, that is already done by daemon(),

1193

1180

# and in debug mode we don't want to. (Stdin is

1212

1199

GLib.IOChannel.unix_new(pipe[0].fileno()),

1213

1200

GLib.PRIORITY_DEFAULT, GLib.IO_IN,

1214

1201

self.checker_callback, pipe[0], command)

1215

if start_was_randomized:

1216

# We were started after a random delay; Schedule a new

1217

# checker to be started an 'interval' from now, and every

1218

# interval from then on.

1219

now = datetime.datetime.utcnow()

1220

self.checker_initiator_tag = GLib.timeout_add(

1221

int(self.interval.total_seconds() * 1000),

1222

self.start_checker)

1223

self.expires = max(self.expires, now + self.interval)

1224

# Don't start a new checker again after same random delay

1225

return False

1226

1202

# Re-run this periodically if run by GLib.timeout_add

1227

1203

return True

1228

1204

1233

1209

self.checker_callback_tag = None

1234

1210

if getattr(self, "checker", None) is None:

1235

1211

return

1236

log.debug("Stopping checker for %(name)s", vars(self))

1212

logger.debug("Stopping checker for %(name)s", vars(self))

1237

1213

self.checker.terminate()

1238

1214

self.checker = None

1239

1215

1417

1393

document.unlink()

1418

1394

except (AttributeError, xml.dom.DOMException,

1419

1395

xml.parsers.expat.ExpatError) as error:

1420

log.error("Failed to override Introspection method",

1421

exc_info=error)

1396

logger.error("Failed to override Introspection method",

1397

exc_info=error)

1422

1398

return xmlstring

1423

1399

1424

1400

1584

1560

document.unlink()

1585

1561

except (AttributeError, xml.dom.DOMException,

1586

1562

xml.parsers.expat.ExpatError) as error:

1587

log.error("Failed to override Introspection method",

1588

exc_info=error)

1563

logger.error("Failed to override Introspection method",

1564

exc_info=error)

1589

1565

return xmlstring

1590

1566

1591

1567

1655

1631

document.unlink()

1656

1632

except (AttributeError, xml.dom.DOMException,

1657

1633

xml.parsers.expat.ExpatError) as error:

1658

log.error("Failed to override Introspection method",

1659

exc_info=error)

1634

logger.error("Failed to override Introspection method",

1635

exc_info=error)

1660

1636

return xmlstring

1661

1637

1662

1638

2329

2305

2330

2306

def handle(self):

2331

2307

with contextlib.closing(self.server.child_pipe) as child_pipe:

2332

log.info("TCP connection from: %s",

2333

str(self.client_address))

2334

log.debug("Pipe FD: %d", self.server.child_pipe.fileno())

2308

logger.info("TCP connection from: %s",

2309

str(self.client_address))

2310

logger.debug("Pipe FD: %d",

2311

self.server.child_pipe.fileno())

2335

2312

2336

2313

session = gnutls.ClientSession(self.request)

2337

2314

2349

2326

# Start communication using the Mandos protocol

2350

2327

# Get protocol number

2351

2328

line = self.request.makefile().readline()

2352

log.debug("Protocol version: %r", line)

2329

logger.debug("Protocol version: %r", line)

2353

2330

try:

2354

2331

if int(line.strip().split()[0]) > 1:

2355

2332

raise RuntimeError(line)

2356

2333

except (ValueError, IndexError, RuntimeError) as error:

2357

log.error("Unknown protocol version: %s", error)

2334

logger.error("Unknown protocol version: %s", error)

2358

2335

return

2359

2336

2360

2337

# Start GnuTLS connection

2361

2338

try:

2362

2339

session.handshake()

2363

2340

except gnutls.Error as error:

2364

log.warning("Handshake failed: %s", error)

2341

logger.warning("Handshake failed: %s", error)

2365

2342

# Do not run session.bye() here: the session is not

2366

2343

# established. Just abandon the request.

2367

2344

return

2368

log.debug("Handshake succeeded")

2345

logger.debug("Handshake succeeded")

2369

2346

2370

2347

approval_required = False

2371

2348

try:

2375

2352

key_id = self.key_id(

2376

2353

self.peer_certificate(session))

2377

2354

except (TypeError, gnutls.Error) as error:

2378

log.warning("Bad certificate: %s", error)

2355

logger.warning("Bad certificate: %s", error)

2379

2356

return

2380

log.debug("Key ID: %s",

2381

key_id.decode("utf-8",

2382

errors="replace"))

2357

logger.debug("Key ID: %s",

2358

key_id.decode("utf-8",

2359

errors="replace"))

2383

2360

2384

2361

else:

2385

2362

key_id = b""

2387

2364

fpr = self.fingerprint(

2388

2365

self.peer_certificate(session))

2389

2366

except (TypeError, gnutls.Error) as error:

2390

log.warning("Bad certificate: %s", error)

2367

logger.warning("Bad certificate: %s", error)

2391

2368

return

2392

log.debug("Fingerprint: %s", fpr)

2369

logger.debug("Fingerprint: %s", fpr)

2393

2370

2394

2371

try:

2395

2372

client = ProxyClient(child_pipe, key_id, fpr,

2404

2381

2405

2382

while True:

2406

2383

if not client.enabled:

2407

log.info("Client %s is disabled", client.name)

2384

logger.info("Client %s is disabled",

2385

client.name)

2408

2386

if self.server.use_dbus:

2409

2387

# Emit D-Bus signal

2410

2388

client.Rejected("Disabled")

2414

2392

# We are approved or approval is disabled

2415

2393

break

2416

2394

elif client.approved is None:

2417

log.info("Client %s needs approval",

2418

client.name)

2395

logger.info("Client %s needs approval",

2396

client.name)

2419

2397

if self.server.use_dbus:

2420

2398

# Emit D-Bus signal

2421

2399

client.NeedApproval(

2422

2400

client.approval_delay.total_seconds()

2423

2401

* 1000, client.approved_by_default)

2424

2402

else:

2425

log.warning("Client %s was not approved",

2426

client.name)

2403

logger.warning("Client %s was not approved",

2404

client.name)

2427

2405

if self.server.use_dbus:

2428

2406

# Emit D-Bus signal

2429

2407

client.Rejected("Denied")

2437

2415

time2 = datetime.datetime.now()

2438

2416

if (time2 - time) >= delay:

2439

2417

if not client.approved_by_default:

2440

log.warning("Client %s timed out while"

2441

" waiting for approval",

2442

client.name)

2418

logger.warning("Client %s timed out while"

2419

" waiting for approval",

2420

client.name)

2443

2421

if self.server.use_dbus:

2444

2422

# Emit D-Bus signal

2445

2423

client.Rejected("Approval timed out")

2452

2430

try:

2453

2431

session.send(client.secret)

2454

2432

except gnutls.Error as error:

2455

log.warning("gnutls send failed", exc_info=error)

2433

logger.warning("gnutls send failed",

2434

exc_info=error)

2456

2435

return

2457

2436

2458

log.info("Sending secret to %s", client.name)

2437

logger.info("Sending secret to %s", client.name)

2459

2438

# bump the timeout using extended_timeout

2460

2439

client.bump_timeout(client.extended_timeout)

2461

2440

if self.server.use_dbus:

2468

2447

try:

2469

2448

session.bye()

2470

2449

except gnutls.Error as error:

2471

log.warning("GnuTLS bye failed", exc_info=error)

2450

logger.warning("GnuTLS bye failed",

2451

exc_info=error)

2472

2452

2473

2453

@staticmethod

2474

2454

def peer_certificate(session):

2484

2464

valid_cert_types = frozenset((gnutls.CRT_OPENPGP,))

2485

2465

# If not a valid certificate type...

2486

2466

if cert_type not in valid_cert_types:

2487

log.info("Cert type %r not in %r", cert_type,

2488

valid_cert_types)

2467

logger.info("Cert type %r not in %r", cert_type,

2468

valid_cert_types)

2489

2469

# ...return invalid data

2490

2470

return b""

2491

2471

list_size = ctypes.c_uint(1)

2667

2647

if SO_BINDTODEVICE is None:

2668

2648

# Fall back to a hard-coded value which seems to be

2669

2649

# common enough.

2670

log.warning("SO_BINDTODEVICE not found, trying 25")

2650

logger.warning("SO_BINDTODEVICE not found, trying 25")

2671

2651

SO_BINDTODEVICE = 25

2672

2652

try:

2673

2653

self.socket.setsockopt(

2675

2655

(self.interface + "\0").encode("utf-8"))

2676

2656

except socket.error as error:

2677

2657

if error.errno == errno.EPERM:

2678

log.error("No permission to bind to interface %s",

2679

self.interface)

2658

logger.error("No permission to bind to"

2659

" interface %s", self.interface)

2680

2660

elif error.errno == errno.ENOPROTOOPT:

2681

log.error("SO_BINDTODEVICE not available; cannot"

2682

" bind to interface %s", self.interface)

2661

logger.error("SO_BINDTODEVICE not available;"

2662

" cannot bind to interface %s",

2663

self.interface)

2683

2664

elif error.errno == errno.ENODEV:

2684

log.error("Interface %s does not exist, cannot"

2685

" bind", self.interface)

2665

logger.error("Interface %s does not exist,"

2666

" cannot bind", self.interface)

2686

2667

else:

2687

2668

raise

2688

2669

# Only bind(2) the socket if we really need to.

2783

2764

client = c

2784

2765

break

2785

2766

else:

2786

log.info("Client not found for key ID: %s, address:"

2787

" %s", key_id or fpr, address)

2767

logger.info("Client not found for key ID: %s, address"

2768

": %s", key_id or fpr, address)

2788

2769

if self.use_dbus:

2789

2770

# Emit D-Bus signal

2790

2771

mandos_dbus_service.ClientNotFound(key_id or fpr,

3184

3165

try:

3185

3166

pidfile = codecs.open(pidfilename, "w", encoding="utf-8")

3186

3167

except IOError as e:

3187

log.error("Could not open file %r", pidfilename,

3188

exc_info=e)

3168

logger.error("Could not open file %r", pidfilename,

3169

exc_info=e)

3189

3170

3190

3171

for name, group in (("_mandos", "_mandos"),

3191

3172

("mandos", "mandos"),

3202

3183

try:

3203

3184

os.setgid(gid)

3204

3185

os.setuid(uid)

3205

log.debug("Did setuid/setgid to %s:%s", uid, gid)

3186

if debug:

3187

logger.debug("Did setuid/setgid to {}:{}".format(uid,

3188

gid))

3206

3189

except OSError as error:

3207

log.warning("Failed to setuid/setgid to %s:%s: %s", uid, gid,

3208

os.strerror(error.errno))

3190

logger.warning("Failed to setuid/setgid to {}:{}: {}"

3191

.format(uid, gid, os.strerror(error.errno)))

3209

3192

if error.errno != errno.EPERM:

3210

3193

raise

3211

3194

3218

3201

3219

3202

@gnutls.log_func

3220

3203

def debug_gnutls(level, string):

3221

log.debug("GnuTLS: %s",

3222

string[:-1].decode("utf-8", errors="replace"))

3204

logger.debug("GnuTLS: %s",

3205

string[:-1].decode("utf-8",

3206

errors="replace"))

3223

3207

3224

3208

gnutls.global_set_log_function(debug_gnutls)

3225

3209

3254

3238

"se.bsnet.fukt.Mandos", bus,

3255

3239

do_not_queue=True)

3256

3240

except dbus.exceptions.DBusException as e:

3257

log.error("Disabling D-Bus:", exc_info=e)

3241

logger.error("Disabling D-Bus:", exc_info=e)

3258

3242

use_dbus = False

3259

3243

server_settings["use_dbus"] = False

3260

3244

tcp_server.use_dbus = False

3345

3329

os.remove(stored_state_path)

3346

3330

except IOError as e:

3347

3331

if e.errno == errno.ENOENT:

3348

log.warning("Could not load persistent state:"

3349

" %s", os.strerror(e.errno))

3332

logger.warning("Could not load persistent state:"

3333

" {}".format(os.strerror(e.errno)))

3350

3334

else:

3351

log.critical("Could not load persistent state:",

3352

exc_info=e)

3335

logger.critical("Could not load persistent state:",

3336

exc_info=e)

3353

3337

raise

3354

3338

except EOFError as e:

3355

log.warning("Could not load persistent state: EOFError:",

3356

exc_info=e)

3339

logger.warning("Could not load persistent state: "

3340

"EOFError:",

3341

exc_info=e)

3357

3342

3358

3343

with PGPEngine() as pgp:

3359

3344

for client_name, client in clients_data.items():

3386

3371

if client["enabled"]:

3387

3372

if datetime.datetime.utcnow() >= client["expires"]:

3388

3373

if not client["last_checked_ok"]:

3389

log.warning("disabling client %s - Client"

3390

" never performed a successful"

3391

" checker", client_name)

3374

logger.warning(

3375

"disabling client {} - Client never "

3376

"performed a successful checker".format(

3377

client_name))

3392

3378

client["enabled"] = False

3393

3379

elif client["last_checker_status"] != 0:

3394

log.warning("disabling client %s - Client"

3395

" last checker failed with error"

3396

" code %s", client_name,

3397

client["last_checker_status"])

3380

logger.warning(

3381

"disabling client {} - Client last"

3382

" checker failed with error code"

3383

" {}".format(

3384

client_name,

3385

client["last_checker_status"]))

3398

3386

client["enabled"] = False

3399

3387

else:

3400

3388

client["expires"] = (

3401

3389

datetime.datetime.utcnow()

3402

3390

+ client["timeout"])

3403

log.debug("Last checker succeeded, keeping %s"

3404

" enabled", client_name)

3391

logger.debug("Last checker succeeded,"

3392

" keeping {} enabled".format(

3393

client_name))

3405

3394

try:

3406

3395

client["secret"] = pgp.decrypt(

3407

3396

client["encrypted_secret"],

3408

3397

client_settings[client_name]["secret"])

3409

3398

except PGPError:

3410

3399

# If decryption fails, we use secret from new settings

3411

log.debug("Failed to decrypt %s old secret",

3412

client_name)

3400

logger.debug("Failed to decrypt {} old secret".format(

3401

client_name))

3413

3402

client["secret"] = (client_settings[client_name]

3414

3403

["secret"])

3415

3404

3429

3418

server_settings=server_settings)

3430

3419

3431

3420

if not tcp_server.clients:

3432

log.warning("No clients defined")

3421

logger.warning("No clients defined")

3433

3422

3434

3423

if not foreground:

3435

3424

if pidfile is not None:

3438

3427

with pidfile:

3439

3428

print(pid, file=pidfile)

3440

3429

except IOError:

3441

log.error("Could not write to file %r with PID %d",

3442

pidfilename, pid)

3430

logger.error("Could not write to file %r with PID %d",

3431

pidfilename, pid)

3443

3432

del pidfile

3444

3433

del pidfilename

3445

3434

3611

3600

except NameError:

3612

3601

pass

3613

3602

if e.errno in (errno.ENOENT, errno.EACCES, errno.EEXIST):

3614

log.warning("Could not save persistent state: %s",

3615

os.strerror(e.errno))

3603

logger.warning("Could not save persistent state: {}"

3604

.format(os.strerror(e.errno)))

3616

3605

else:

3617

log.warning("Could not save persistent state:",

3618

exc_info=e)

3606

logger.warning("Could not save persistent state:",

3607

exc_info=e)

3619

3608

raise

3620

3609

3621

3610

# Delete all clients, and settings from config

3638

3627

mandos_dbus_service.client_added_signal(client)

3639

3628

# Need to initiate checking of clients

3640

3629

if client.enabled:

3641

client.init_checker(randomize_start=True)

3630

client.init_checker()

3642

3631

3643

3632

tcp_server.enable()

3644

3633

tcp_server.server_activate()

3647

3636

if zeroconf:

3648

3637

service.port = tcp_server.socket.getsockname()[1]

3649

3638

if use_ipv6:

3650

log.info("Now listening on address %r, port %d, flowinfo %d,"

3651

" scope_id %d", *tcp_server.socket.getsockname())

3639

logger.info("Now listening on address %r, port %d,"

3640

" flowinfo %d, scope_id %d",

3641

*tcp_server.socket.getsockname())

3652

3642

else: # IPv4

3653

log.info("Now listening on address %r, port %d",

3654

*tcp_server.socket.getsockname())

3643

logger.info("Now listening on address %r, port %d",

3644

*tcp_server.socket.getsockname())

3655

3645

3656

3646

# service.interface = tcp_server.socket.getsockname()[3]

3657

3647

3661

3651

try:

3662

3652

service.activate()

3663

3653

except dbus.exceptions.DBusException as error:

3664

log.critical("D-Bus Exception", exc_info=error)

3654

logger.critical("D-Bus Exception", exc_info=error)

3665

3655

cleanup()

3666

3656

sys.exit(1)

3667

3657

# End of Avahi example code

3672

3662

lambda *args, **kwargs: (tcp_server.handle_request

3673

3663

(*args[2:], **kwargs) or True))

3674

3664

3675

log.debug("Starting main loop")

3665

logger.debug("Starting main loop")

3676

3666

main_loop.run()

3677

3667

except AvahiError as error:

3678

log.critical("Avahi Error", exc_info=error)

3668

logger.critical("Avahi Error", exc_info=error)

3679

3669

cleanup()

3680

3670

sys.exit(1)

3681

3671

except KeyboardInterrupt:

3682

3672

if debug:

3683

3673

print("", file=sys.stderr)

3684

log.debug("Server received KeyboardInterrupt")

3685

log.debug("Server exiting")

3674

logger.debug("Server received KeyboardInterrupt")

3675

logger.debug("Server exiting")

3686

3676

# Must run before the D-Bus bus name gets deregistered

3687

3677

cleanup()

3688

3678

3689

3679

3690

def parse_test_args():

3691

# type: () -> argparse.Namespace

3680

def should_only_run_tests():

3692

3681

parser = argparse.ArgumentParser(add_help=False)

3693

3682

parser.add_argument("--check", action="store_true")

3694

parser.add_argument("--prefix", )

3695

3683

args, unknown_args = parser.parse_known_args()

3696

if args.check:

3697

# Remove test options from sys.argv

3684

run_tests = args.check

3685

if run_tests:

3686

# Remove --check argument from sys.argv

3698

3687

sys.argv[1:] = unknown_args

3699

return args

3688

return run_tests

3700

3689

3701

3690

# Add all tests from doctest strings

3702

3691

def load_tests(loader, tests, none):

3705

3694

return tests

3706

3695

3707

3696

if __name__ == "__main__":

3708

options = parse_test_args()

3709

3697

try:

3710

if options.check:

3711

extra_test_prefix = options.prefix

3712

if extra_test_prefix is not None:

3713

if not (unittest.main(argv=[""], exit=False)

3714

.result.wasSuccessful()):

3715

sys.exit(1)

3716

class ExtraTestLoader(unittest.TestLoader):

3717

testMethodPrefix = extra_test_prefix

3718

# Call using ./scriptname --test [--verbose]

3719

unittest.main(argv=[""], testLoader=ExtraTestLoader())

3720

else:

3721

unittest.main(argv=[""])

3698

if should_only_run_tests():

3699

# Call using ./mandos --check [--verbose]

3700

unittest.main()

3722

3701

else:

3723

3702

main()

3724

3703

finally:

3725

3704

logging.shutdown()

3726

3727

# Local Variables:

3728

# run-tests:

3729

# (lambda (&optional extra)

3730

# (if (not (funcall run-tests-in-test-buffer default-directory

3731

# extra))

3732

# (funcall show-test-buffer-in-test-window)

3733

# (funcall remove-test-window)

3734

# (if extra (message "Extra tests run successfully!"))))

3735

# run-tests-in-test-buffer:

3736

# (lambda (dir &optional extra)

3737

# (with-current-buffer (get-buffer-create "*Test*")

3738

# (setq buffer-read-only nil

3739

# default-directory dir)

3740

# (erase-buffer)

3741

# (compilation-mode))

3742

# (let ((process-result

3743

# (let ((inhibit-read-only t))

3744

# (process-file-shell-command

3745

# (funcall get-command-line extra) nil "*Test*"))))

3746

# (and (numberp process-result)

3747

# (= process-result 0))))

3748

# get-command-line:

3749

# (lambda (&optional extra)

3750

# (let ((quoted-script

3751

# (shell-quote-argument (funcall get-script-name))))

3752

# (format

3753

# (concat "%s --check" (if extra " --prefix=atest" ""))

3754

# quoted-script)))

3755

# get-script-name:

3756

# (lambda ()

3757

# (if (fboundp 'file-local-name)

3758

# (file-local-name (buffer-file-name))

3759

# (or (file-remote-p (buffer-file-name) 'localname)

3760

# (buffer-file-name))))

3761

# remove-test-window:

3762

# (lambda ()

3763

# (let ((test-window (get-buffer-window "*Test*")))

3764

# (if test-window (delete-window test-window))))

3765

# show-test-buffer-in-test-window:

3766

# (lambda ()

3767

# (when (not (get-buffer-window-list "*Test*"))

3768

# (setq next-error-last-buffer (get-buffer "*Test*"))

3769

# (let* ((side (if (>= (window-width) 146) 'right 'bottom))

3770

# (display-buffer-overriding-action

3771

# `((display-buffer-in-side-window) (side . ,side)

3772

# (window-height . fit-window-to-buffer)

3773

# (window-width . fit-window-to-buffer))))

3774

# (display-buffer "*Test*"))))

3775

# eval:

3776

# (progn

3777

# (let* ((run-extra-tests (lambda () (interactive)

3778

# (funcall run-tests t)))

3779

# (inner-keymap `(keymap (116 . ,run-extra-tests))) ; t

3780

# (outer-keymap `(keymap (3 . ,inner-keymap)))) ; C-c

3781

# (setq minor-mode-overriding-map-alist

3782

# (cons `(run-tests . ,outer-keymap)

3783

# minor-mode-overriding-map-alist)))

3784

# (add-hook 'after-save-hook run-tests 90 t))

3785

# End: