 d8e8ef4ee0
			
		
	
	
		d8e8ef4ee0
		
	
	
	
	
		
			
			The simpletrace.process() function invokes analyzer methods with the wrong number of arguments if a timestamp should be included. This patch fixes the issue so that trace analysis scripts can make use of timestamps. Signed-off-by: Stefan Hajnoczi <stefanha@linux.vnet.ibm.com>
		
			
				
	
	
		
			152 lines
		
	
	
		
			4.6 KiB
		
	
	
	
		
			Python
		
	
	
		
			Executable File
		
	
	
	
	
			
		
		
	
	
			152 lines
		
	
	
		
			4.6 KiB
		
	
	
	
		
			Python
		
	
	
		
			Executable File
		
	
	
	
	
| #!/usr/bin/env python
 | |
| #
 | |
| # Pretty-printer for simple trace backend binary trace files
 | |
| #
 | |
| # Copyright IBM, Corp. 2010
 | |
| #
 | |
| # This work is licensed under the terms of the GNU GPL, version 2.  See
 | |
| # the COPYING file in the top-level directory.
 | |
| #
 | |
| # For help see docs/tracing.txt
 | |
| 
 | |
| import struct
 | |
| import re
 | |
| import inspect
 | |
| 
 | |
| header_event_id = 0xffffffffffffffff
 | |
| header_magic    = 0xf2b177cb0aa429b4
 | |
| header_version  = 0
 | |
| dropped_event_id = 0xfffffffffffffffe
 | |
| 
 | |
| trace_fmt = '=QQQQQQQQ'
 | |
| trace_len = struct.calcsize(trace_fmt)
 | |
| event_re  = re.compile(r'(disable\s+)?([a-zA-Z0-9_]+)\(([^)]*)\).*')
 | |
| 
 | |
| def parse_events(fobj):
 | |
|     """Parse a trace-events file into {event_num: (name, arg1, ...)}."""
 | |
| 
 | |
|     def get_argnames(args):
 | |
|         """Extract argument names from a parameter list."""
 | |
|         return tuple(arg.split()[-1].lstrip('*') for arg in args.split(','))
 | |
| 
 | |
|     events = {dropped_event_id: ('dropped', 'count')}
 | |
|     event_num = 0
 | |
|     for line in fobj:
 | |
|         m = event_re.match(line.strip())
 | |
|         if m is None:
 | |
|             continue
 | |
| 
 | |
|         disable, name, args = m.groups()
 | |
|         events[event_num] = (name,) + get_argnames(args)
 | |
|         event_num += 1
 | |
|     return events
 | |
| 
 | |
| def read_record(fobj):
 | |
|     """Deserialize a trace record from a file into a tuple (event_num, timestamp, arg1, ..., arg6)."""
 | |
|     s = fobj.read(trace_len)
 | |
|     if len(s) != trace_len:
 | |
|         return None
 | |
|     return struct.unpack(trace_fmt, s)
 | |
| 
 | |
| def read_trace_file(fobj):
 | |
|     """Deserialize trace records from a file, yielding record tuples (event_num, timestamp, arg1, ..., arg6)."""
 | |
|     header = read_record(fobj)
 | |
|     if header is None or \
 | |
|        header[0] != header_event_id or \
 | |
|        header[1] != header_magic or \
 | |
|        header[2] != header_version:
 | |
|         raise ValueError('not a trace file or incompatible version')
 | |
| 
 | |
|     while True:
 | |
|         rec = read_record(fobj)
 | |
|         if rec is None:
 | |
|             break
 | |
| 
 | |
|         yield rec
 | |
| 
 | |
| class Analyzer(object):
 | |
|     """A trace file analyzer which processes trace records.
 | |
| 
 | |
|     An analyzer can be passed to run() or process().  The begin() method is
 | |
|     invoked, then each trace record is processed, and finally the end() method
 | |
|     is invoked.
 | |
| 
 | |
|     If a method matching a trace event name exists, it is invoked to process
 | |
|     that trace record.  Otherwise the catchall() method is invoked."""
 | |
| 
 | |
|     def begin(self):
 | |
|         """Called at the start of the trace."""
 | |
|         pass
 | |
| 
 | |
|     def catchall(self, event, rec):
 | |
|         """Called if no specific method for processing a trace event has been found."""
 | |
|         pass
 | |
| 
 | |
|     def end(self):
 | |
|         """Called at the end of the trace."""
 | |
|         pass
 | |
| 
 | |
| def process(events, log, analyzer):
 | |
|     """Invoke an analyzer on each event in a log."""
 | |
|     if isinstance(events, str):
 | |
|         events = parse_events(open(events, 'r'))
 | |
|     if isinstance(log, str):
 | |
|         log = open(log, 'rb')
 | |
| 
 | |
|     def build_fn(analyzer, event):
 | |
|         fn = getattr(analyzer, event[0], None)
 | |
|         if fn is None:
 | |
|             return analyzer.catchall
 | |
| 
 | |
|         event_argcount = len(event) - 1
 | |
|         fn_argcount = len(inspect.getargspec(fn)[0]) - 1
 | |
|         if fn_argcount == event_argcount + 1:
 | |
|             # Include timestamp as first argument
 | |
|             return lambda _, rec: fn(*rec[1:2 + event_argcount])
 | |
|         else:
 | |
|             # Just arguments, no timestamp
 | |
|             return lambda _, rec: fn(*rec[2:2 + event_argcount])
 | |
| 
 | |
|     analyzer.begin()
 | |
|     fn_cache = {}
 | |
|     for rec in read_trace_file(log):
 | |
|         event_num = rec[0]
 | |
|         event = events[event_num]
 | |
|         if event_num not in fn_cache:
 | |
|             fn_cache[event_num] = build_fn(analyzer, event)
 | |
|         fn_cache[event_num](event, rec)
 | |
|     analyzer.end()
 | |
| 
 | |
| def run(analyzer):
 | |
|     """Execute an analyzer on a trace file given on the command-line.
 | |
| 
 | |
|     This function is useful as a driver for simple analysis scripts.  More
 | |
|     advanced scripts will want to call process() instead."""
 | |
|     import sys
 | |
| 
 | |
|     if len(sys.argv) != 3:
 | |
|         sys.stderr.write('usage: %s <trace-events> <trace-file>\n' % sys.argv[0])
 | |
|         sys.exit(1)
 | |
| 
 | |
|     events = parse_events(open(sys.argv[1], 'r'))
 | |
|     process(events, sys.argv[2], analyzer)
 | |
| 
 | |
| if __name__ == '__main__':
 | |
|     class Formatter(Analyzer):
 | |
|         def __init__(self):
 | |
|             self.last_timestamp = None
 | |
| 
 | |
|         def catchall(self, event, rec):
 | |
|             timestamp = rec[1]
 | |
|             if self.last_timestamp is None:
 | |
|                 self.last_timestamp = timestamp
 | |
|             delta_ns = timestamp - self.last_timestamp
 | |
|             self.last_timestamp = timestamp
 | |
| 
 | |
|             fields = [event[0], '%0.3f' % (delta_ns / 1000.0)]
 | |
|             for i in xrange(1, len(event)):
 | |
|                 fields.append('%s=0x%x' % (event[i], rec[i + 1]))
 | |
|             print ' '.join(fields)
 | |
| 
 | |
|     run(Formatter())
 |