def results(self): """Return appstats results in a dictionary for template context.""" if not self.recorder: # If appstats fails to initialize for any reason, return an empty # set of results. logging.warn("Missing recorder for appstats profiler.") return {"calls": [], "total_time": 0} total_call_count = 0 total_time = 0 calls = [] service_totals_dict = {} likely_dupes = False end_offset_last = 0 requests_set = set() appstats_key = long(self.recorder.start_timestamp * 1000) for trace in self.recorder.traces: total_call_count += 1 total_time += trace.duration_milliseconds() # Don't accumulate total RPC time for traces that overlap asynchronously if trace.start_offset_milliseconds() < end_offset_last: total_time -= end_offset_last - trace.start_offset_milliseconds() end_offset_last = trace.start_offset_milliseconds() + trace.duration_milliseconds() service_prefix = trace.service_call_name() if "." in service_prefix: service_prefix = service_prefix[: service_prefix.find(".")] if service_prefix not in service_totals_dict: service_totals_dict[service_prefix] = {"total_call_count": 0, "total_time": 0, "total_misses": 0} service_totals_dict[service_prefix]["total_call_count"] += 1 service_totals_dict[service_prefix]["total_time"] += trace.duration_milliseconds() stack_frames_desc = [] for frame in trace.call_stack_list(): stack_frames_desc.append( "%s:%s %s" % (util.short_rpc_file_fmt(frame.class_or_file_name()), frame.line_number(), frame.function_name()) ) request = trace.request_data_summary() response = trace.response_data_summary() likely_dupe = request in requests_set likely_dupes = likely_dupes or likely_dupe requests_set.add(request) request_short = request_pretty = None response_short = response_pretty = None miss = 0 try: request_object = unformatter.unformat(request) response_object = unformatter.unformat(response) request_short, response_short, miss = cleanup.cleanup(request_object, response_object) request_pretty = pformat(request_object) response_pretty = pformat(response_object) except Exception, e: logging.warning( "Prettifying RPC calls failed.\n%s\nRequest: %s\nResponse: %s", e, request, response, exc_info=True ) service_totals_dict[service_prefix]["total_misses"] += miss calls.append( { "service": trace.service_call_name(), "start_offset": util.milliseconds_fmt(trace.start_offset_milliseconds()), "total_time": util.milliseconds_fmt(trace.duration_milliseconds()), "request": request_pretty or request, "response": response_pretty or response, "request_short": request_short or cleanup.truncate(request), "response_short": response_short or cleanup.truncate(response), "stack_frames_desc": stack_frames_desc, "likely_dupe": likely_dupe, } )
def results(self): """Return appstats results in a dictionary for template context.""" if not self.recorder: # If appstats fails to initialize for any reason, return an empty # set of results. logging.warn("Missing recorder for appstats profiler.") return { "calls": [], "total_time": 0, } total_call_count = 0 total_time = 0 calls = [] service_totals_dict = {} likely_dupes = False end_offset_last = 0 requests_set = set() appstats_key = long(self.recorder.start_timestamp * 1000) for trace in self.recorder.traces: total_call_count += 1 total_time += trace.duration_milliseconds() # Don't accumulate total RPC time for traces that overlap asynchronously if trace.start_offset_milliseconds() < end_offset_last: total_time -= (end_offset_last - trace.start_offset_milliseconds()) end_offset_last = trace.start_offset_milliseconds() + trace.duration_milliseconds() service_prefix = trace.service_call_name() if "." in service_prefix: service_prefix = service_prefix[:service_prefix.find(".")] if service_prefix not in service_totals_dict: service_totals_dict[service_prefix] = { "total_call_count": 0, "total_time": 0, "total_misses": 0, } service_totals_dict[service_prefix]["total_call_count"] += 1 service_totals_dict[service_prefix]["total_time"] += trace.duration_milliseconds() stack_frames_desc = [] for frame in trace.call_stack_list(): stack_frames_desc.append("%s:%s %s" % (util.short_rpc_file_fmt(frame.class_or_file_name()), frame.line_number(), frame.function_name())) request = trace.request_data_summary() response = trace.response_data_summary() likely_dupe = request in requests_set likely_dupes = likely_dupes or likely_dupe requests_set.add(request) request_short = request_pretty = None response_short = response_pretty = None miss = 0 try: request_object = unformatter.unformat(request) response_object = unformatter.unformat(response) request_short, response_short, miss = cleanup.cleanup(request_object, response_object) request_pretty = pformat(request_object) response_pretty = pformat(response_object) except Exception, e: pass # enable this if you want to improve prettification # logging.warning("Prettifying RPC calls failed.\n%s\nRequest: %s\nResponse: %s", # e, request, response, exc_info=True) service_totals_dict[service_prefix]["total_misses"] += miss calls.append({ "service": trace.service_call_name(), "start_offset": util.milliseconds_fmt(trace.start_offset_milliseconds()), "total_time": util.milliseconds_fmt(trace.duration_milliseconds()), "request": request_pretty or request, "response": response_pretty or response, "request_short": request_short or cleanup.truncate(request), "response_short": response_short or cleanup.truncate(response), "stack_frames_desc": stack_frames_desc, "likely_dupe": likely_dupe, })