<!DOCTYPE html PUBLIC "-//W3C//DTD XHTML 1.1//EN"
"http://www.w3.org/TR/xhtml11/DTD/xhtml11.dtd">
<html xmlns="http://www.w3.org/1999/xhtml">
<head><meta http-equiv="content-type" content="text/html; charset=utf-8" />
<title>[15626] CalendarServer/trunk/contrib/performance/loadtest</title>
</head>
<body>
<style type="text/css"><!--
#msg dl.meta { border: 1px #006 solid; background: #369; padding: 6px; color: #fff; }
#msg dl.meta dt { float: left; width: 6em; font-weight: bold; }
#msg dt:after { content:':';}
#msg dl, #msg dt, #msg ul, #msg li, #header, #footer, #logmsg { font-family: verdana,arial,helvetica,sans-serif; font-size: 10pt; }
#msg dl a { font-weight: bold}
#msg dl a:link { color:#fc3; }
#msg dl a:active { color:#ff0; }
#msg dl a:visited { color:#cc6; }
h3 { font-family: verdana,arial,helvetica,sans-serif; font-size: 10pt; font-weight: bold; }
#msg pre { overflow: auto; background: #ffc; border: 1px #fa0 solid; padding: 6px; }
#logmsg { background: #ffc; border: 1px #fa0 solid; padding: 1em 1em 0 1em; }
#logmsg p, #logmsg pre, #logmsg blockquote { margin: 0 0 1em 0; }
#logmsg p, #logmsg li, #logmsg dt, #logmsg dd { line-height: 14pt; }
#logmsg h1, #logmsg h2, #logmsg h3, #logmsg h4, #logmsg h5, #logmsg h6 { margin: .5em 0; }
#logmsg h1:first-child, #logmsg h2:first-child, #logmsg h3:first-child, #logmsg h4:first-child, #logmsg h5:first-child, #logmsg h6:first-child { margin-top: 0; }
#logmsg ul, #logmsg ol { padding: 0; list-style-position: inside; margin: 0 0 0 1em; }
#logmsg ul { text-indent: -1em; padding-left: 1em; }#logmsg ol { text-indent: -1.5em; padding-left: 1.5em; }
#logmsg > ul, #logmsg > ol { margin: 0 0 1em 0; }
#logmsg pre { background: #eee; padding: 1em; }
#logmsg blockquote { border: 1px solid #fa0; border-left-width: 10px; padding: 1em 1em 0 1em; background: white;}
#logmsg dl { margin: 0; }
#logmsg dt { font-weight: bold; }
#logmsg dd { margin: 0; padding: 0 0 0.5em 0; }
#logmsg dd:before { content:'\00bb';}
#logmsg table { border-spacing: 0px; border-collapse: collapse; border-top: 4px solid #fa0; border-bottom: 1px solid #fa0; background: #fff; }
#logmsg table th { text-align: left; font-weight: normal; padding: 0.2em 0.5em; border-top: 1px dotted #fa0; }
#logmsg table td { text-align: right; border-top: 1px dotted #fa0; padding: 0.2em 0.5em; }
#logmsg table thead th { text-align: center; border-bottom: 1px solid #fa0; }
#logmsg table th.Corner { text-align: left; }
#logmsg hr { border: none 0; border-top: 2px dashed #fa0; height: 1px; }
#header, #footer { color: #fff; background: #636; border: 1px #300 solid; padding: 6px; }
#patch { width: 100%; }
#patch h4 {font-family: verdana,arial,helvetica,sans-serif;font-size:10pt;padding:8px;background:#369;color:#fff;margin:0;}
#patch .propset h4, #patch .binary h4 {margin:0;}
#patch pre {padding:0;line-height:1.2em;margin:0;}
#patch .diff {width:100%;background:#eee;padding: 0 0 10px 0;overflow:auto;}
#patch .propset .diff, #patch .binary .diff {padding:10px 0;}
#patch span {display:block;padding:0 10px;}
#patch .modfile, #patch .addfile, #patch .delfile, #patch .propset, #patch .binary, #patch .copfile {border:1px solid #ccc;margin:10px 0;}
#patch ins {background:#dfd;text-decoration:none;display:block;padding:0 10px;}
#patch del {background:#fdd;text-decoration:none;display:block;padding:0 10px;}
#patch .lines, .info {color:#888;background:#fff;}
--></style>
<div id="msg">
<dl class="meta">
<dt>Revision</dt> <dd><a href="http://trac.calendarserver.org//changeset/15626">15626</a></dd>
<dt>Author</dt> <dd>sagen@apple.com</dd>
<dt>Date</dt> <dd>2016-05-20 12:45:30 -0700 (Fri, 20 May 2016)</dd>
</dl>
<h3>Log Message</h3>
<pre>Client sim enhancement: log request/response whenever the duration exceeds a threshold or an incorrect response code is received.</pre>
<h3>Modified Paths</h3>
<ul>
<li><a href="#CalendarServertrunkcontribperformanceloadtestconfigplist">CalendarServer/trunk/contrib/performance/loadtest/config.plist</a></li>
<li><a href="#CalendarServertrunkcontribperformanceloadtesticalpy">CalendarServer/trunk/contrib/performance/loadtest/ical.py</a></li>
</ul>
</div>
<div id="patch">
<h3>Diff</h3>
<a id="CalendarServertrunkcontribperformanceloadtestconfigplist"></a>
<div class="modfile"><h4>Modified: CalendarServer/trunk/contrib/performance/loadtest/config.plist (15625 => 15626)</h4>
<pre class="diff"><span>
<span class="info">--- CalendarServer/trunk/contrib/performance/loadtest/config.plist        2016-05-20 19:01:26 UTC (rev 15625)
+++ CalendarServer/trunk/contrib/performance/loadtest/config.plist        2016-05-20 19:45:30 UTC (rev 15626)
</span><span class="lines">@@ -197,6 +197,20 @@
</span><span class="cx">                                 </dict>
</span><span class="cx">                         </dict>
</span><span class="cx">
</span><ins>+                        <!-- ErrorLogger logs the request/response bodies whenever an incorrect
+                                response code is received, or if the duration exceeds threshold. -->
+                        <dict>
+                                <key>type</key>
+                                <string>contrib.performance.loadtest.ical.ErrorLogger</string>
+                                <key>params</key>
+                                <dict>
+                                        <key>directory</key>
+                                        <string>/tmp/sim_errors</string>
+                                        <key>durationThreshold</key>
+                                        <real>10.0</real>
+                                </dict>
+                        </dict>
+
</ins><span class="cx">                         <!-- OperationLogger generates an end-of-run summary of the gross operations
</span><span class="cx">                                 performed (logical operations which may span more than one HTTP request,
</span><span class="cx">                                 such as inviting an attendee to an event). -->
</span></span></pre></div>
<a id="CalendarServertrunkcontribperformanceloadtesticalpy"></a>
<div class="modfile"><h4>Modified: CalendarServer/trunk/contrib/performance/loadtest/ical.py (15625 => 15626)</h4>
<pre class="diff"><span>
<span class="info">--- CalendarServer/trunk/contrib/performance/loadtest/ical.py        2016-05-20 19:01:26 UTC (rev 15625)
+++ CalendarServer/trunk/contrib/performance/loadtest/ical.py        2016-05-20 19:45:30 UTC (rev 15626)
</span><span class="lines">@@ -2601,7 +2601,74 @@
</span><span class="cx"> return []
</span><span class="cx">
</span><span class="cx">
</span><ins>+class ErrorLogger(object):
+ """
+ Requests which get an incorrect response code or take too long are logged
+ """
</ins><span class="cx">
</span><ins>+ def __init__(self, directory, durationThreshold):
+ self.directory = directory
+ self.durationThreshold = durationThreshold
+ if os.path.isdir(directory):
+ shutil.rmtree(directory)
+ os.mkdir(directory)
+ self.errorCounter = 0
+ self.durationCounter = 0
+
+
+ def _getBodies(self, event):
+ body = event['body']
+ if isinstance(body, StringProducer):
+ body = body._body
+ if body:
+ body = body[:5000]
+ responseBody = event['responseBody']
+ return body, responseBody
+
+
+ def observe(self, event):
+ if event.get("type") == "response":
+ if not event['success']:
+ body, responseBody = self._getBodies(event)
+ self.errorCounter += 1
+ filename = "error-{:08d}.txt".format(self.errorCounter)
+ fullname = os.path.join(self.directory, filename)
+ with open(fullname, "w") as f:
+ f.write("RESPONSE CODE: {}\n".format(event['code']))
+ f.write("URL: {}\n".format(event['url']))
+ f.write("METHOD: {}\n".format(event['method']))
+ f.write("USER: {}\n".format(event['user']))
+ f.write("REQUEST BODY:\n{}\n".format(body))
+ f.write("RESPONSE BODY:\n{}\n".format(responseBody))
+
+ print("Incorrect Response Code logged to {}".format(fullname))
+
+ elif event["duration"] > self.durationThreshold:
+ body, responseBody = self._getBodies(event)
+ self.durationCounter += 1
+
+ filename = "duration-{:08d}.txt".format(self.durationCounter)
+ fullname = os.path.join(self.directory, filename)
+ with open(fullname, "w") as f:
+ f.write("LONG RESPONSE: {:.1f} sec\n".format(event['duration']))
+ f.write("RESPONSE CODE: {}\n".format(event['code']))
+ f.write("URL: {}\n".format(event['url']))
+ f.write("METHOD: {}\n".format(event['method']))
+ f.write("USER: {}\n".format(event['user']))
+ f.write("REQUEST BODY:\n{}\n".format(body))
+ f.write("RESPONSE BODY:\n{}\n".format(responseBody))
+
+ print("Long Duration logged to {}".format(fullname))
+
+
+ def report(self, output):
+ pass
+
+
+ def failures(self):
+ return []
+
+
</ins><span class="cx"> def main():
</span><span class="cx"> from urllib2 import HTTPDigestAuthHandler
</span><span class="cx"> from twisted.internet import reactor
</span></span></pre>
</div>
</div>
</body>
</html>