policy.py

   1 #
   2 # Copyright (c) 2004  The Trustees of Princeton University (Trustees).
   3 #
   4 # Faiyaz Ahmed <faiyaza@cs.princeton.edu>
   5 #
   6 # $Id: policy.py,v 1.6 2007/01/10 20:08:44 faiyaza Exp $
   7 #
   8 # Policy Engine.
   9
  10 #from monitor import *
  11 from threading import *
  12 import time
  13 import logging
  14 import mailer
  15 import emailTxt
  16 import pickle
  17 import Queue
  18 import plc
  19 import reboot
  20 import config
  21
  22 DAT="./monitor.dat"
  23
  24 logger = logging.getLogger("monitor")
  25
  26 # Time to enforce policy
  27 POLSLEEP = 7200
  28
  29 # Where to email the summary
  30 SUMTO = "faiyaza@cs.princeton.edu"
  31 TECHEMAIL="tech-%s@sites.planet-lab.org"
  32 PIEMAIL="pi-%s@sites.planet-lab.org"
  33 SLICEMAIL="%s@slices.planet-lab.org"
  34 PLCEMAIL="support@planet-lab.org"
  35
  36 #Thresholds (DAYS)
  37 SPERDAY = 86400
  38 PITHRESH = 2 * SPERDAY
  39 SLICETHRESH = 5 * SPERDAY
  40 # Days before attempting rins again
  41 RINSTHRESH = 5 * SPERDAY
  42
  43 # Minimum number of nodes up before squeezing
  44 MINUP = 2
  45
  46 # IF:
  47 #  no SSH, down.
  48 #  bad disk, down
  49 #  DNS, kinda down (sick)
  50 #  clock, kinda down (sick)
  51 #  Full disk, going to be down
  52
  53 # Actions:
  54 #  Email
  55 #  suspend slice creation
  56 #  kill slices
  57 class Policy(Thread):
  58         def __init__(self, comonthread, sickNoTicket, emailed):
  59                 self.cmn = comonthread
  60                 # host - > (time of email, type of email)
  61                 self.emailed = emailed
  62                 # all sick nodes w/o tickets
  63                 self.sickNoTicket = sickNoTicket
  64                 # Sitess we've Squeezed.
  65                 self.squeezed = {}
  66                 Thread.__init__(self)
  67
  68
  69         '''
  70         What to do when node is in dbg (as reported by CoMon).
  71         '''
  72         def __actOnDebug(self, node):
  73                 # Check to see if we've done this before
  74                 if (node in self.emailed.keys()):
  75                         if (self.emailed[node][0] == "dbg"):
  76                                 delta = time.time() - self.emailed[node][1]
  77                                 if (delta <= RINSTHRESH ):
  78                                         # Don't mess with node if under Thresh.
  79                                         # Return, move on.
  80                                         logger.info("POLICY:  %s in dbg, but acted on %s days ago" % (node, delta // SPERDAY))
  81                                         return
  82                         logger.info("POLICY:  Node in dbg - " + node)
  83                         plc.nodeBootState(node, "rins")
  84                         # If it has a PCU
  85                         return reboot.reboot(node)
  86
  87         '''
  88         What to do when node is in dbg (as reported by CoMon).
  89         '''
  90         def __actOnFilerw(self, node):
  91                 target = [PLCEMAIL]
  92                 logger.info("POLICY:  Emailing PLC for " + node)
  93                 tmp = emailTxt.mailtxt.filerw
  94                 sbj = tmp[0] % {'hostname': node}
  95                 msg = tmp[1] % {'hostname': node}
  96                 mailer.email(sbj, msg, target)
  97                 self.emailed[node] = ("filerw", time.time())
  98
  99
 100         '''
 101         Acts on sick nodes.
 102         '''
 103         def actOnSick(self):
 104                 # Get list of nodes in debug from PLC
 105                 #dbgNodes = NodesDebug()
 106                 global TECHEMAIL, PIEMAIL
 107                 # Grab a node from the queue (pushed by rt thread).
 108                 node = self.sickNoTicket.get(block = True)
 109                 # Get the login base
 110                 loginbase = plc.siteId(node)
 111
 112                 # Send appropriate message for node if in appropriate bucket.
 113                 # If we know where to send a message
 114                 if not loginbase:
 115                         logger.info("POLICY:  loginbase for %s not found" %node)
 116                 # And we didn't email already.
 117                 else:
 118                         # If first email, send to Tech
 119                         target = [TECHEMAIL % loginbase]
 120
 121                         # If disk is foobarred, PLC should check it.
 122                         if (node in self.cmn.filerw) and \
 123                         (node not in self.emailed.keys()):
 124                                 self.__actOnFilerw(node)
 125                                 return
 126
 127                         # If in dbg, set to rins, then reboot.  Inform PLC.
 128                         if (node in self.cmn.dbg):
 129                         # If reboot failure via PCU, POD and send email
 130                         # if contacted PCU, return
 131                                 if self.__actOnDebug(node):  return
 132
 133                         if (node in self.emailed.keys()) and \
 134                         (node not in self.cmn.filerw)    and \
 135                         (node not in self.cmn.clock_drift):
 136                                 # If we emailed before, how long ago?
 137                                 delta = time.time() - self.emailed[node][1]
 138                                 if delta < SPERDAY:
 139                                         logger.info("POLICY:  already acted on %s today." % node)
 140                                         return
 141
 142                                 logger.info("POLICY:  acted %s on %s days ago" % (node,
 143                                 delta // SPERDAY))
 144
 145                                 # If no luck with tech, email PI
 146                                 if (delta >= 1):
 147                                         target.append(PIEMAIL % loginbase)
 148
 149                                 # If more than PI thresh, but less than slicethresh
 150                                 if (delta >= PITHRESH) and (delta < SLICETHRESH):
 151                                         #remove slice creation if enough nodes arent up
 152                                         if not self.enoughUp(loginbase):
 153                                                 slices = plc.slices(loginbase)
 154                                                 if len(slices) >= 1:
 155                                                         for slice in slices:
 156                                                                 target.append(SLICEMAIL % slice)
 157                                                 logger.info("POLICY:  Removing slice creation from %s" % loginbase)
 158                                                 tmp = emailTxt.mailtxt.removedSliceCreation
 159                                                 sbj = tmp[0]
 160                                                 msg = tmp[1] % {'loginbase': loginbase}
 161                                                 plc.removeSliceCreation(node)
 162                                                 mailer.email(sbj, msg, target)
 163                                                 self.squeezed[loginbase] = (time.time(), "creation")
 164                                                 return
 165
 166                                 # If more than PI thresh and slicethresh
 167                                 if (delta >= PITHRESH) and (delta > SLICETHRESH):
 168                                         target.append(PIEMAIL % loginbase)
 169                                         # Email slices at site.
 170                                         slices = plc.slices(loginbase)
 171                                         if len(slices) >= 1:
 172                                                 for slice in slices:
 173                                                         target.append(SLICEMAIL % slice)
 174                                         # If not enough up, freeze slices and email everyone.
 175                                         if not self.enoughUp(loginbase):
 176                                                 logger.info("POLICY:  Suspending %s slices." % loginbase)
 177                                                 tmp = emailTxt.mailtxt.suspendSlices
 178                                                 sbj = tmp[0]
 179                                                 msg = tmp[1] % {'loginbase': loginbase}
 180                                                 plc.suspendSlices(node)
 181                                                 self.squeezed[loginbase] = (time.time(), "freeze")
 182                                                 mailer.email(sbj, msg, target)
 183                                                 return
 184
 185                         # Find the bucket the node is in and send appropriate email
 186                         # to approriate list of people.
 187                         for bkt in self.cmn.comonbkts.keys():
 188                                 if (node in getattr(self.cmn, bkt)):
 189                                         # Send predefined message for that bucket.
 190                                         logger.info("POLICY: Emailing (%s) %s - %s"\
 191                                                 %(bkt, node, target))
 192                                         tmp = getattr(emailTxt.mailtxt, bkt)
 193                                         sbj = tmp[0] % {'hostname': node}
 194                                         msg = tmp[1] % {'hostname': node}
 195                                         mailer.email(sbj, msg, target)
 196                                         self.emailed[node] = (bkt , time.time())
 197                                         return
 198
 199
 200         '''
 201         Prints, logs, and emails status of up nodes, down nodes, and buckets.
 202         '''
 203         def status(self):
 204                 sub = "Monitor Summary"
 205                 msg = "\nThe following nodes were acted upon:  \n\n"
 206                 for (node, (type, date)) in self.emailed.items():
 207                         # Print only things acted on today.
 208                         if (time.gmtime(time.time())[2] == time.gmtime(date)[2]):
 209                                 msg +="%s\t(%s)\t%s\n" %(node, type, time.ctime(date))
 210                 msg +="\n\nThe following sites have been 'squeezed':\n\n"
 211                 for (loginbase, (date, type)) in self.squeezed.items():
 212                         # Print only things acted on today.
 213                         if (time.gmtime(time.time())[2] == time.gmtime(date)[2]):
 214                                 msg +="%s\t(%s)\t%s\n" %(loginbase, type, time.ctime(date))
 215                 mailer.email(sub, msg, [SUMTO])
 216                 logger.info(msg)
 217                 return
 218
 219         '''
 220         Store/Load state of emails.  When, where, what.
 221         '''
 222         def emailedStore(self, action):
 223                 try:
 224                         if action == "LOAD":
 225                                 f = open(DAT, "r+")
 226                                 logger.info("POLICY:  Found and reading " + DAT)
 227                                 self.emailed.update(pickle.load(f))
 228                         if action == "WRITE":
 229                                 f = open(DAT, "w")
 230                                 #logger.debug("Writing " + DAT)
 231                                 pickle.dump(self.emailed, f)
 232                         f.close()
 233                 except Exception, err:
 234                         logger.info("POLICY:  Problem with DAT, %s" %err)
 235
 236         '''
 237         Returns True if more than MINUP nodes are up at a site.
 238         '''
 239         def enoughUp(self, loginbase):
 240                 allsitenodes = plc.getSiteNodes(loginbase)
 241                 if len(allsitenodes) == 0:
 242                         logger.info("Node not in db")
 243                         return
 244
 245                 numnodes = len(allsitenodes)
 246                 sicknodes = []
 247                 # Get all sick nodes from comon
 248                 for bucket in self.cmn.comonbkts.keys():
 249                         for host in getattr(self.cmn, bucket):
 250                                 sicknodes.append(host)
 251                 # Diff.
 252                 for node in allsitenodes:
 253                         if node in sicknodes:
 254                                 numnodes -= 1
 255
 256                 if numnodes < MINUP:
 257                         logger.info(\
 258 "POLICY:  site with %s has nodes %s up." %(loginbase, numnodes))
 259                         return False
 260                 else:
 261                         return True
 262
 263
 264
 265
 266         def run(self):
 267                 while 1:
 268                         self.actOnSick()
 269                         self.emailedStore("WRITE")
 270
 271
 272 def main():
 273         logger.setLevel(logging.DEBUG)
 274         ch = logging.StreamHandler()
 275         ch.setLevel(logging.DEBUG)
 276         formatter = logging.Formatter('%(message)s')
 277         ch.setFormatter(formatter)
 278         logger.addHandler(ch)
 279
 280         #print NodesDebug()
 281         #tmp = Queue.Queue()
 282         #a = Policy(None, tmp)
 283         #a.emailedStore("LOAD")
 284         #print a.emailed
 285
 286         print plc.slices(plc.siteId("alice.cs.princeton.edu"))
 287         os._exit(0)
 288 if __name__ == '__main__':
 289         import os
 290         import plc
 291         try:
 292                 main()
 293         except KeyboardInterrupt:
 294                 print "Killed.  Exitting."
 295                 logger.info('Monitor Killed')
 296                 os._exit(0)