import logging, logging.handlers, os, time, queue, threading, subprocess
+import traceback, smtplib
+from email.mime.text import MIMEText
+
+# Logging configuration
+syslogLevel = logging.INFO
+mailLevel = logging.CRITICAL # must be "larger" than syslog level!
+mailAddress = 'post+tuer'+'@'+'ralfj.de'
+
+# Mail logging handler
+def sendeMail(subject, text, receivers, sender='sphinx@hacksaar.de', replyTo=None):
+ if not isinstance(type(receivers), list): receivers = [receivers]
+ # construct content
+ msg = MIMEText(text.encode('UTF-8'), 'plain', 'UTF-8')
+ msg['Subject'] = subject
+ msg['From'] = sender
+ msg['To'] = ', '.join(receivers)
+ if replyTo is not None:
+ msg['Reply-To'] = replyTo
+ # put into envelope and send
+ s = smtplib.SMTP('ralfj.de')
+ s.sendmail(sender, receivers, msg.as_string())
+ s.quit()
# logging function
class Logger:
def __init__ (self):
- self.logger = logging.getLogger("tuerd")
- self.logger.setLevel(logging.INFO)
- self.handler = logging.handlers.SysLogHandler(address = '/dev/log', facility = logging.handlers.SysLogHandler.LOG_LOCAL0)
- self.logger.addHandler(self.handler)
+ self.syslog = logging.getLogger("tuerd")
+ self.syslog.setLevel(syslogLevel)
+ self.syslog.addHandler(logging.handlers.SysLogHandler(address = '/dev/log',
+ facility = logging.handlers.SysLogHandler.LOG_LOCAL0))
- def log (self, lvl, what):
+ def _log (self, lvl, what):
thestr = "%s[%d]: %s" % ("osspd", os.getpid(), what)
- print (thestr)
- self.logger.log(lvl, thestr)
+ # console log
+ print(thestr)
+ # syslog
+ self.syslog.log(lvl, thestr)
+ # mail log
+ if lvl >= mailLevel:
+ sendeMail('Kritischer Türfehler', what, mailAddress)
def debug(self, what):
- self.log(logging.DEBUG, what)
+ self._log(logging.DEBUG, what)
def info(self, what):
- self.log(logging.INFO, what)
+ self._log(logging.INFO, what)
def warning(self, what):
- self.log(logging.WARNING, what)
+ self._log(logging.WARNING, what)
def error(self, what):
- self.log(logging.ERROR, what)
+ self._log(logging.ERROR, what)
def critical(self, what):
- self.log(logging.CRITICAL, what)
+ self._log(logging.CRITICAL, what)
logger = Logger()
_CALL = 0
_TERM = 1
- def __init__(self, f):
+ def __init__(self, f, name):
+ self.name = name
self._f = f
self._q = queue.Queue()
self._t = threading.Thread(target=self._thread_func)
while True:
(cmd, data) = self._q.get()
# run command
- if cmd == _CALL:
+ if cmd == ThreadFunction._CALL:
try:
self._f(*data)
- except Exception:
- logger.error("ThreadFunction: Got exception out of handler thread: %s" % str(e))
- elif cmd == _TERM:
+ except Exception as e:
+ logger.critical("ThreadFunction: Got exception out of handler thread %s: %s" % (self.name, str(e)))
+ logger.debug(traceback.format_exc())
+ elif cmd == ThreadFunction._TERM:
assert data is None
break
else:
logger.error("ThreadFunction: Command %d does not exist" % cmd)
def __call__(self, *arg):
- self._q.put((self._CALL, arg))
+ self._q.put((ThreadFunction._CALL, arg))
def stop(self):
- self._q.put((_TERM, None))
+ self._q.put((ThreadFunction._TERM, None))
self._t.join()
# Thread timer-repeater class: Call a function every <sleep_time> seconds
class ThreadRepeater():
- def __init__(self, f, sleep_time):
+ def __init__(self, f, sleep_time, name):
+ self.name = name
self._f = f
self._stop = False
self._sleep_time = sleep_time
self._t = threading.Thread(target=self._thread_func)
self._t.start()
- def _thread_func():
+ def _thread_func(self):
while True:
if self._stop:
break
- self._f()
- time.sleep(sleep_time)
+ try:
+ self._f()
+ except Exception as e:
+ logger.critical("ThreadRepeater: Got exception out of handler thread %s: %s" % (self.name, str(e)))
+ logger.debug(traceback.format_exc())
+ time.sleep(self._sleep_time)
def stop(self):
self._stop = True
def read(self):
curstate = GPIO.input(self.pin)
assert curstate in (0, 1)
- if curstate != self._state:
+ if curstate != self.state:
# the state is about to change
if curstate == self._newstate:
# we already saw this new state
class PinsWatcher():
def __init__(self, state_machine):
- self.pins = {
+ self._pins = {
'bell_ringing': PinWatcher(18, 2),
- 'door_closed': PinWatcher(8, 5),
- 'door_locked': PinWatcher(10, 5),
- 'space_active': PinWatcher(24, 5),
+ 'door_closed': PinWatcher(8, 4),
+ 'door_locked': PinWatcher(10, 4),
+ 'space_active': PinWatcher(24, 4),
}
self._sm = state_machine
# start a thread doing the work
- self._t = ThreadRepeater(self._read, 0.02)
-
- def _read():
+ self._t = ThreadRepeater(self._read, 0.02, name="PinsWatcher")
+
+ def _read(self):
saw_change = False
- for name in self.pins.keys():
- pin = pins[name]
+ for name in self._pins.keys():
+ pin = self._pins[name]
if pin.read():
saw_change = True
- logger.debug("Pin %s changed to %d" % (name, pin.state)
- if not saw_change: return
+ logger.debug("Pin %s changed to %d" % (name, pin.state))
+ if not saw_change:
+ return None
# create return object
pinsState = PinsState()
- for name in self.pins.keys():
- setattr(pinsState, name, self.pins[name].state)
+ for name in self._pins.keys():
+ setattr(pinsState, name, self._pins[name].state)
# send it to state machine
self._sm.callback(StateMachine.CMD_PINS, pinsState)
- def stop():
+ def stop(self):
self._t.stop()
-8from libtuer import ThreadFunction, logger, fire_and_forget
+from libtuer import ThreadFunction, logger, fire_and_forget
from actor import Actor
-import os, random
+import os, random, time
# logger.{debug,info,warning,error,critical}
# StateUnlocking constants
-OPEN_REPEAT_TIMEOUT = 8
+OPEN_REPEAT_TIMEOUT = 7
OPEN_REPEAT_NUMBER = 3
# StateLocking constants
-CLOSE_REPEAT_TIMEOUT = 8
+CLOSE_REPEAT_TIMEOUT = 7
CLOSE_REPEAT_NUMBER = 3
# StateAboutToOpen constants
-ABOUTOPEN_NERVLIST = [(5, lambda : play_sound("flipswitch")), (5, lambda:play_sound("flipswitch")), (0, lambda:Logger.warning("Space open but switch not flipped for 10 seconds")),\
- (10, lambda:play_sound("flipswitch")), (10, lambda:play_sound("flipswitch")), (0, lambda:Logger.error("Space open but switch not flipped for 30 seconds")),\
- (10, lambda:play_sound("flipswitch")), (10, lambda:play_sound("flipswitch")), (6, lambda:play_sound("flipswitch")), (4, lambda:Logger.critical("Space open but switch not flipped for 60 seconds"))]
+ABOUTOPEN_NERVLIST = [(5, lambda : play_sound("flipswitch")), (5, lambda:play_sound("flipswitch")), (0, lambda:logger.warning("Space open but switch not flipped for 10 seconds")),\
+ (10, lambda:play_sound("flipswitch")), (10, lambda:play_sound("flipswitch")), (0, lambda:logger.error("Space open but switch not flipped for 30 seconds")),\
+ (10, lambda:play_sound("flipswitch")), (10, lambda:play_sound("flipswitch")), (6, lambda:play_sound("flipswitch")), (4, lambda:logger.critical("Space open but switch not flipped for 60 seconds"))]
# StateAuf constants
# time that must pass between two bell_ringing events to buzz the door again (seconds)
# Timeout we wait after the switch was switched to "Closed", until we assume nobody will open the door and we just lock it
# ALso the time we wait after the door was opend, till we assume something went wrong and start nerving
-LEAVE_TIMEOUT = 30
+LEAVE_TIMEOUT = 20
# play_sound constants
SOUNDS_DIRECTORY = "/opt/tuer/sounds/"
def nerv(self):
if len(self.nervlist):
- (time, f) = self.nervlist[0]
+ (wait_time, f) = self.nervlist[0]
now = time.time()
time_gone = now-self.last_event_time
# check if the first element is to be triggered
- if time_gone >= time:
+ if time_gone >= wait_time:
self.nervlist = self.nervlist[1:] # "pop" the first element, but do not modify original list
self.last_event_time = now
return f()
def handle_pins_event(self):
pass # one needn't implement this
def handle_buzz_event(self,arg): # this shouldn't be overwritten
- self.actor.act(Actor.CMD_BUZZ)
+ self.actor().act(Actor.CMD_BUZZ)
arg("200 okay: buzz executed")
def handle_cmd_unlock_event(self,arg):
if arg is not None:
def actor(self):
return self.state_machine.actor
def handle_event(self,ev,arg): # don't override
- if arg is CMD_PINS:
- self.handle_pins_event()
- elif arg is CMD_BUZZ:
- self.handle_buzz_event(arg)
- elif arg is CMD_UNLOCK:
- self.handle_cmd_unlock_event(arg)
- elif arg is CMD_WAKEUP:
- self.handle_wakeup_event()
+ if ev == StateMachine.CMD_PINS:
+ return self.handle_pins_event()
+ elif ev == StateMachine.CMD_BUZZ:
+ return self.handle_buzz_event(arg)
+ elif ev == StateMachine.CMD_UNLOCK:
+ return self.handle_cmd_unlock_event(arg)
+ elif ev == StateMachine.CMD_WAKEUP:
+ return self.handle_wakeup_event()
else:
raise Exception("Unknown command number: %d" % ev)
class StateStart(State):
def handle_pins_event(self):
super().handle_pins_event()
- thepins = self.pins()
- for pin in thepins:
- if pin is None:
- return None
- if thepins.door_locked:
- return StateZu(self.state_machine)
+ pins = self.pins()
+ if pins.door_locked is None or pins.door_closed is None or pins.space_dactive is None or pins.bell_ringing is None:
+ return None # wait till we have all sensors non-None
+ if pins.door_locked:
+ return StateMachine.StateZu(self.state_machine)
else:
- return StateAuf(self.state_machine)
-
+ return StateMachine.StateAuf(self.state_machine)
+
class StateZu(State):
def handle_pins_event(self):
super().handle_pins_event()
pins = self.pins()
if not pins.door_locked:
- return StateAboutToOpen(self.state_machine)
+ return StateMachine.StateAboutToOpen(self.state_machine)
def handle_cmd_unlock_event(self,callback):
# intentionally not calling super() implementation
- return StateUnlocking(self.state_machine, callback)
+ return StateMachine.StateUnlocking(self.state_machine, callback)
class StateUnlocking(State):
def __init__(self,sm,callback=None):
# construct a nervlist
- nervlist = [(OPEN_REPEAT_TIMEOUT, lambda: self.actor().act(Actor.CMD_UNLOCK)) for t in xrange(OPEN_REPEAT_NUMBER)]
+ nervlist = [(OPEN_REPEAT_TIMEOUT, lambda: self.actor().act(Actor.CMD_UNLOCK)) for t in range(OPEN_REPEAT_NUMBER)]
nervlist += [(OPEN_REPEAT_TIMEOUT, self.could_not_open)]
super().__init__(sm,nervlist)
self.callbacks=[callback]
pins = self.pins()
if not pins.door_locked:
self.notify(True)
- return StateAboutToOpen(self.state_machine)
+ return StateMachine.StateAboutToOpen(self.state_machine)
def handle_cmd_unlock_event(self,callback):
# intentionally not calling super() implementation
# TODO: 202 notification also here if possible
def could_not_open(self):
logger.critical("Couldn't open door after %d tries. Going back to StateZu." % OPEN_REPEAT_NUMBER)
self.notify(False)
- return StateZu(self.state_machine)
+ return StateMachine.StateZu(self.state_machine)
class AbstractStateWhereOpeningIsRedundant(State):
def handle_cmd_unlock_event(self, callback):
super().handle_pins_event()
pins = self.pins()
if pins.door_locked:
- return StateZu(self.state_machine)
+ return StateMachine.StateZu(self.state_machine)
elif pins.space_active:
- return StateAuf(self.state_machine)
+ return StateMachine.StateAuf(self.state_machine)
class StateAuf(AbstractStateWhereOpeningIsRedundant):
def __init__(self,sm):
self.last_buzzed = now
if not pins.space_active:
logger.info("space switch off - starting leaving procedure")
- return StateAboutToLeave(self.state_machine)
+ return StateMachine.StateAboutToLeave(self.state_machine)
if pins.door_locked:
logger.info("door manually locked, but space switch on - going to StateZu")
play_sound("manual_lock")
- return StateZu(self.state_machine)
+ return StateMachine.StateZu(self.state_machine)
class StateLocking(State):
# TODO: share code with StateUnlocking
nervlist = [(CLOSE_REPEAT_TIMEOUT, lambda: self.actor().act(Actor.CMD_LOCK)) for t in range(CLOSE_REPEAT_NUMBER)]
nervlist += [(CLOSE_REPEAT_TIMEOUT, self.could_not_close)]
super().__init__(sm, nervlist)
- if not pins.door_closed: # this should always be true, but just to be sure...
+ if self.pins().door_closed: # this should always be true, but just to be sure...
self.actor().act(Actor.CMD_LOCK)
def handle_pins_event(self):
pins = self.pins()
if not pins.door_closed:
# TODO play a sound? This shouldn't happen, door was opened while we are locking
logger.warning("door manually opened during locking")
- return StateAboutToOpen(self.state_machine)
+ return StateMachine.StateAboutToOpen(self.state_machine)
if pins.door_locked:
- return SpaceZu(self.state_machine)
+ return StateMachine.StateZu(self.state_machine)
def handle_cmd_unlock_event(self,callback):
callback("409 conflict: The server is currently trying to lock the door. Try again later.")
def could_not_close(self):
logger.critical("Couldn't close door after %d tries. Going back to StateAboutToOpen." % CLOSE_REPEAT_NUMBER)
- return StateAboutToOpen(self.state_machine)
+ return StateMachine.StateAboutToOpen(self.state_machine)
class StateAboutToLeave(State):
def __init__(self, sm):
- nervlist = [(LEAVE_TIMEOUT, lambda: StateLocking(self.state_machine))]
+ nervlist = [(LEAVE_TIMEOUT, lambda: StateMachine.StateLocking(self.state_machine))]
super().__init__(sm, nervlist)
def handle_pins_event(self):
if not self.pins().door_closed:
- return StateLeaving(self.state_machine)
+ return StateMachine.StateLeaving(self.state_machine)
if self.pins().door_locked:
- return StateZu(self.state_machine)
+ return StateMachine.StateZu(self.state_machine)
+ if self.pins().space_active:
+ return StateMachine.StateAuf(self.state_machine)
class StateLeaving(State):
def __init__(self, sm):
- nervlist = [(LEAVE_TIMEOUT, lambda: StateAboutToOpen(self.state_machine))]
+ nervlist = [(LEAVE_TIMEOUT, lambda: StateMachine.StateAboutToOpen(self.state_machine))]
super().__init__(sm, nervlist)
def handle_pins_event(self):
if self.pins().door_closed:
- return StateLocking(self.state_machine)
+ return StateMachine.StateLocking(self.state_machine)
if self.pins().door_locked:
- return StateZu(self.state_machine)
+ return StateMachine.StateZu(self.state_machine)
+ if self.pins().space_active:
+ return StateMachine.StateAuf(self.state_machine)
def __init__(self, actor):
self.actor = actor
- self.callback = ThreadFunction(self._callback)
- self.current_state = StateStart(self)
+ self.callback = ThreadFunction(self._callback, name="StateMachine")
+ self.current_state = StateMachine.StateStart(self)
self.pins = None
self.old_pins = None
newstate = self.current_state.handle_event(cmd,arg) # returns None or an instance of the new state
self.old_pins = self.pins
while newstate is not None:
- logger.info("StateMachine: new state = %s" % newstate.__class__.__name__)
+ logger.debug("StateMachine: new state = %s" % newstate.__class__.__name__)
self.current_state = newstate
newstate = self.current_state.handle_event(StateMachine.CMD_PINS, self.pins)