7 from datetime import datetime
8 from collections import defaultdict
9 from core.models import *
10 from django.db.models import F, Q
11 from openstack.manager import OpenStackManager
12 from util.logger import Logger, logging, logger
13 #from timeout import timeout
14 from planetstack.config import Config
18 logger = Logger(logfile='observer.log', level=logging.INFO)
20 class StepNotReady(Exception):
23 def toposort(g, steps):
35 if not reverse.has_key(k):
39 for k,v in reverse.iteritems():
59 class PlanetStackObserver:
60 sync_steps = ['SyncNetworks','SyncNetworkSlivers','SyncSites','SyncSitePrivileges','SyncSlices','SyncSliceMemberships','SyncSlivers','SyncSliverIps']
63 # The Condition object that gets signalled by Feefie events
64 self.load_sync_steps()
65 self.event_cond = threading.Condition()
68 def wait_for_event(self, timeout):
69 self.event_cond.acquire()
70 self.event_cond.wait(timeout)
71 self.event_cond.release()
74 logger.info('Wake up routine called. Event cond %r'%self.event_cond)
75 self.event_cond.acquire()
76 self.event_cond.notify()
77 self.event_cond.release()
79 def load_sync_steps(self):
80 dep_path = Config().pl_dependency_path
82 # This contains dependencies between records, not sync steps
83 self.model_dependency_graph = json.loads(open(dep_path).read())
87 backend_path = Config().backend_dependency_path
89 # This contains dependencies between backend records
90 self.backend_dependency_graph = json.loads(open(backend_path).read())
97 provides_dict[m]=s.__name__
100 for k,v in model_dependency_graph.iteritems():
102 source = provides_dict[k]
105 dest = provides_dict[m]
109 step_graph[source]=dest
113 # no dependencies, pass
115 if (backend_dependency_graph):
119 backend_dict[m]=s.__name__
121 for k,v in backend_dependency_graph.iteritems():
123 source = backend_dict[k]
126 dest = backend_dict[m]
130 step_graph[source]=dest
134 # no dependencies, pass
136 dependency_graph = step_graph
138 self.ordered_steps = toposort(dependency_graph, steps)
139 self.load_run_times()
142 def check_duration(self):
144 if (duration > S.deadline):
145 logger.info('Sync step %s missed deadline, took %.2f seconds'%(S.name,duration))
146 except AttributeError:
147 # S doesn't have a deadline
150 def update_run_time(self, step):
151 self.last_run_times[step.name]=time.time()
153 def check_schedule(self, step):
154 time_since_last_run = time.time() - self.last_run_times[step.name]
156 if (time_since_last_run < step.requested_interval):
158 except AttributeError:
159 logger.info('Step %s does not have requested_interval set'%step.name)
162 def load_run_times(self):
164 jrun_times = open('/tmp/observer_run_times').read()
165 self.last_run_times = json.loads(jrun_times)
167 self.last_run_times={}
168 for e in self.ordered_steps:
169 self.last_run_times[e.name]=0
173 def save_run_times(self):
174 run_times = json.dumps(self.last_run_times)
175 open('/tmp/observer_run_times','w').write(run_times)
177 def check_class_dependency(self, step, failed_steps):
178 for failed_step in failed_steps:
179 if (failed_step in self.dependency_graph[step.name]):
183 if not self.manager.enabled or not self.manager.has_openstack:
188 logger.info('Waiting for event')
189 tBeforeWait = time.time()
190 self.wait_for_event(timeout=300)
191 logger.info('Observer woke up')
193 # Set of whole steps that failed
196 # Set of individual objects within steps that failed
197 failed_step_objects = []
199 for S in self.ordered_steps:
200 start_time=time.time()
203 sync_step.dependencies = self.dependencies[sync_step.name]
204 sync_step.debug_mode = debug_mode
208 # Various checks that decide whether
209 # this step runs or not
210 self.check_class_dependency(sync_step, failed_steps) # dont run Slices if Sites failed
211 self.check_schedule(sync_step) # dont run sync_network_routes if time since last run < 1 hour
214 logging.info('Step not ready: %s'%sync_step.name)
215 failed_steps.add(sync_step)
217 failed_steps.add(sync_step)
221 duration=time.time() - start_time
223 # ********* This is the actual sync step
224 failed_objects = sync_step(failed=failed_step_objects)
227 check_deadline(sync_step, duration)
228 failed_step_objects.extend(failed_objects)
229 self.update_run_time(sync_step)
232 self.save_run_times()
234 logger.log_exc("Exception in observer run loop")
235 traceback.print_exc()