# HG changeset patch
# User drewp@bigasterisk.com
# Date 1465679736 0
# Node ID 5bd2d036ae7448195ade16672196b845933feaa1
# Parent  dd3f72ac72146c248994850d32599184ac434c00
rdfdb log patch-to-client send times
Ignore-this: af10a7e205f559da6a7addd4a0ab93e6

diff -r dd3f72ac7214 -r 5bd2d036ae74 light9/rdfdb/patchsender.py
--- a/light9/rdfdb/patchsender.py	Sat Jun 11 21:14:55 2016 +0000
+++ b/light9/rdfdb/patchsender.py	Sat Jun 11 21:15:36 2016 +0000
@@ -103,10 +103,14 @@
     if len(body) > 200:
         intro = intro + "..."
     log.debug("send body (rendered %.1fkB in %.1fms): %s", len(body) / 1024, jsonTime * 1000, intro)
+    sendTime = time.time()
     def putDone(done):
         if not str(done.code).startswith('2'):
-            raise ValueError("sendPatch request failed %s: %s" % (done.code, done.body))
-        log.debug("sendPatch finished, response: %r" % done.body)
+            raise ValueError("sendPatch request failed %s: %s" %
+                             (done.code, done.body))
+        dt = 1000 * (time.time() - sendTime)
+        log.debug("sendPatch to %s took %sms, response: %r" %
+                  (putUri, dt, done.body))
         return done
 
     return cyclone.httpclient.fetch(