def stats_collection_end(self): if self.monitor is not None: try: self.monitor.stop() except: pass finally: self.monitor = None current_run_time = time.time() - self.start_time # discard empty cicles from stats if current_run_time > 0.00: self.mean_time = ((self.mean_time * self.iterations) + current_run_time) / (self.iterations + 1) if self.low_time == -1 or current_run_time < self.low_time: self.low_time = current_run_time if self.high_time == -1 or current_run_time > self.high_time: self.high_time = current_run_time log.time_debug("Ended job [%s] with an execution time of %.2f seconds" % (self.name, current_run_time)) self.iterations += 1 TimingStatsHandler.log_measured_timing("JOB", self.name, self.start_time, current_run_time)
def stats_collection_end(self): if self.monitor is not None: try: self.monitor.stop() except: pass finally: self.monitor = None current_run_time = time.time() - self.start_time # discard empty cicles from stats if current_run_time > 0.00: self.mean_time = ((self.mean_time * self.iterations) + current_run_time) / (self.iterations + 1) if self.low_time == -1 or current_run_time < self.low_time: self.low_time = current_run_time if self.high_time == -1 or current_run_time > self.high_time: self.high_time = current_run_time log.time_debug( "Ended job [%s] with an execution time of %.2f seconds" % (self.name, current_run_time)) self.iterations += 1 TimingStatsHandler.log_measured_timing("JOB", self.name, self.start_time, current_run_time)
def test_get_feature_enabled_discard_timingstatss_handler_logging(self): GLSettings.log_timing_stats = True TimingStatsHandler.log_measured_timing("GET", "/s/timings", 1443252274.44, 0) handler = self.request() yield handler.get() splits = self.responses[0].split("\n") self.assertEqual(len(splits), 2) self.assertEqual(splits[0], "category,method,uri,start_time,run_time") self.assertEqual(splits[1], "")
def test_get_feature_disabled(self): GLSettings.log_timing_stats = False TimingStatsHandler.log_measured_timing("JOB", "Session Management", 1443252274.44, 0) TimingStatsHandler.log_measured_timing("GET", "/styles/main.css", 1443252277.68, 0) handler = self.request() yield handler.get() splits = self.responses[0].split("\n") self.assertEqual(len(splits), 2) self.assertEqual(splits[0], "category,method,uri,start_time,run_time") self.assertEqual(splits[1], "")
def stats_collection_end(self): if self.monitor.running: self.monitor.stop() current_run_time = time.time() - self.start_time # discard empty cicles from stats if current_run_time > 0.000000: self.mean_time = ((self.mean_time * (self.job_runs - 1)) + current_run_time) / self.job_runs if self.low_time == -1 or current_run_time < self.low_time: self.low_time = current_run_time if self.high_time == -1 or current_run_time > self.high_time: self.high_time = current_run_time log.time_debug("Job %s ended with an execution time of %.4f seconds" % (self.name, current_run_time)) TimingStatsHandler.log_measured_timing("JOB", self.name, self.start_time, current_run_time)
def test_get_feature_enabled(self): GLSettings.log_timing_stats = True TimingStatsHandler.log_measured_timing("JOB", "Session Management", 1443252274.44, 0) TimingStatsHandler.log_measured_timing("GET", "/styles/main.css", 1443252277.68, 0) TimingStatsHandler.log_measured_timing("JOB", "Delivery", 1443252279.0, 0) TimingStatsHandler.log_measured_timing("POST", "/token", 1443252280.0, 0) TimingStatsHandler.log_measured_timing( "PUT", "/submission/XXA82cSXFHTOoVroWlOGqg2VF8XtJQ57QIYM09YanY", 1443252281.0, 0) TimingStatsHandler.log_measured_timing("POST", "/wbtip/comments", 1443252282.0, 0) handler = self.request() yield handler.get() splits = self.responses[0].split("\n") self.assertEqual(len(splits), 8) self.assertEqual(splits[0], "category,method,uri,start_time,run_time") self.assertEqual( splits[1], "uncategorized,JOB,Session Management,1443252274.44,0") self.assertEqual(splits[2], "uncategorized,GET,/styles/main.css,1443252277.68,0") self.assertEqual(splits[3], "delivery,JOB,Delivery,1443252279.0,0") self.assertEqual(splits[4], "token,POST,/token,1443252280.0,0") self.assertEqual( splits[5], "submission,PUT,/submission/XXA82cSXFHTOoVroWlOGqg2VF8XtJQ57QIYM09YanY,1443252281.0,0" ) self.assertEqual(splits[6], "comment,POST,/wbtip/comments,1443252282.0,0") self.assertEqual(splits[7], "")
def test_get_feature_enabled(self): GLSettings.log_timing_stats = True TimingStatsHandler.log_measured_timing("JOB", "Session Management", 1443252274.44, 0) TimingStatsHandler.log_measured_timing("GET", "/styles/main.css", 1443252277.68, 0) TimingStatsHandler.log_measured_timing("JOB", "Delivery", 1443252279.0, 0) TimingStatsHandler.log_measured_timing("POST", "/token", 1443252280.0, 0) TimingStatsHandler.log_measured_timing("PUT", "/submission/XXA82cSXFHTOoVroWlOGqg2VF8XtJQ57QIYM09YanY", 1443252281.0, 0) TimingStatsHandler.log_measured_timing("POST", "/wbtip/comments", 1443252282.0, 0) handler = self.request() yield handler.get() splits = self.responses[0].split("\n") self.assertEqual(len(splits), 8) self.assertEqual(splits[0], "category,method,uri,start_time,run_time") self.assertEqual(splits[1], "uncategorized,JOB,Session Management,1443252274.44,0") self.assertEqual(splits[2], "uncategorized,GET,/styles/main.css,1443252277.68,0") self.assertEqual(splits[3], "delivery,JOB,Delivery,1443252279.0,0") self.assertEqual(splits[4], "token,POST,/token,1443252280.0,0") self.assertEqual(splits[5], "submission,PUT,/submission/XXA82cSXFHTOoVroWlOGqg2VF8XtJQ57QIYM09YanY,1443252281.0,0") self.assertEqual(splits[6], "comment,POST,/wbtip/comments,1443252282.0,0") self.assertEqual(splits[7], "")