test.py prints example elapsed times
authorcraigdo@ee.washington.edu
Tue, 27 Oct 2009 00:19:02 -0700
changeset 5460 7c6f8ebf4a34
parent 5459 3c240ed38d99
child 5461 ac47584eca3e
test.py prints example elapsed times
test.py
--- a/test.py	Mon Oct 26 23:44:04 2009 -0700
+++ b/test.py	Tue Oct 27 00:19:02 2009 -0700
@@ -202,7 +202,8 @@
     for example in dom.getElementsByTagName("Example"):
         result = get_node_text(example.getElementsByTagName("Result")[0])
         name = get_node_text(example.getElementsByTagName("Name")[0])
-        output = "%s: Example \"%s\"\n" % (result, name)
+        time = get_node_text(example.getElementsByTagName("ElapsedTime")[0])
+        output = "%s: Example \"%s\" (%s)\n" % (result, name, time)
         f.write(output)
 
     f.close()
@@ -408,12 +409,13 @@
     #
     # The table headings look like,
     #
-    #   +--------+--------------+
-    #   | Result | Example Name |
-    #   +--------+--------------+
+    #   +--------+--------------+--------------+
+    #   | Result | Example Name | Elapsed Time |
+    #   +--------+--------------+--------------+
     #
     f.write("<th> Result </th>\n")
     f.write("<th>Example Name</th>\n")
+    f.write("<th>Elapsed Time</th>\n")
 
     #
     # Now iterate through all of the examples
@@ -430,6 +432,7 @@
         #
         result = get_node_text(example.getElementsByTagName("Result")[0])
         name =   get_node_text(example.getElementsByTagName("Name")[0])
+        time =   get_node_text(example.getElementsByTagName("ElapsedTime")[0])
 
         #
         # If the example either failed or crashed, print its result status
@@ -448,6 +451,11 @@
         f.write("<td>%s</td>\n" % name)
 
         #
+        # Write the elapsed time as a new tag data.
+        #
+        f.write("<td>%s</td>\n" % time)
+
+        #
         # That's it for the current example, so terminate the row.
         #
         f.write("</tr>\n")
@@ -585,10 +593,10 @@
     if options.verbose:
         print "Synchronously execute %s" % cmd
 
-    start_time = time.clock()
+    start_time = time.time()
     proc = subprocess.Popen(cmd, shell = True, cwd = directory, stdout=subprocess.PIPE, stderr=subprocess.PIPE)
     stdout_results, stderr_results = proc.communicate()
-    elapsed_time = time.clock() - start_time
+    elapsed_time = time.time() - start_time
 
     if options.verbose:
         print "Return code = ", proc.returncode
@@ -1153,7 +1161,7 @@
             else:
                 f.write('  <Result>CRASH</Result>\n')
 
-            f.write('  <ElapsedTime>%s</ElapsedTime>\n' % job.elapsed_time)
+            f.write('  <ElapsedTime>%.3f</ElapsedTime>\n' % job.elapsed_time)
             f.write('</Example>\n')
             f.close()