qpid-commits mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From acon...@apache.org
Subject svn commit: r724169 - /incubator/qpid/trunk/qpid/cpp/src/qpid/sys/ActivityTimer.h
Date Sun, 07 Dec 2008 18:46:40 GMT
Author: aconway
Date: Sun Dec  7 10:46:40 2008
New Revision: 724169

URL: http://svn.apache.org/viewvc?rev=724169&view=rev
Log:
src/qpid/sys/ActivityTimer.h: record time spent in specific code segments, for profiling/debugging.

Added:
    incubator/qpid/trunk/qpid/cpp/src/qpid/sys/ActivityTimer.h   (with props)

Added: incubator/qpid/trunk/qpid/cpp/src/qpid/sys/ActivityTimer.h
URL: http://svn.apache.org/viewvc/incubator/qpid/trunk/qpid/cpp/src/qpid/sys/ActivityTimer.h?rev=724169&view=auto
==============================================================================
--- incubator/qpid/trunk/qpid/cpp/src/qpid/sys/ActivityTimer.h (added)
+++ incubator/qpid/trunk/qpid/cpp/src/qpid/sys/ActivityTimer.h Sun Dec  7 10:46:40 2008
@@ -0,0 +1,111 @@
+#ifndef QPID_SYS_ACTIVITYTIMER_H
+#define QPID_SYS_ACTIVITYTIMER_H
+
+/*
+ *
+ * Licensed to the Apache Software Foundation (ASF) under one
+ * or more contributor license agreements.  See the NOTICE file
+ * distributed with this work for additional information
+ * regarding copyright ownership.  The ASF licenses this file
+ * to you under the Apache License, Version 2.0 (the
+ * "License"); you may not use this file except in compliance
+ * with the License.  You may obtain a copy of the License at
+ * 
+ *   http://www.apache.org/licenses/LICENSE-2.0
+ * 
+ * Unless required by applicable law or agreed to in writing,
+ * software distributed under the License is distributed on an
+ * "AS IS" BASIS, WITHOUT WARRANTIES OR CONDITIONS OF ANY
+ * KIND, either express or implied.  See the License for the
+ * specific language governing permissions and limitations
+ * under the License.
+ *
+ */
+
+#include "qpid/sys/Time.h"
+#include "qpid/sys/Thread.h"
+#include <boost/current_function.hpp>
+#include <stdio.h>
+
+namespace qpid {
+namespace sys {
+
+/** 
+ * Measures and reports time spent in a particular segment of code.
+ * This is real time so it includes time blocked/sleeping as well as time on CPU.
+ *
+ * Intended to be used via the QPID_ACTIVITY_TIMER macro for profiling
+ * during development & debugging
+ */
+class ActivityTimer
+{
+  public:
+
+    struct Stat {               // Must be a POD
+        uint64_t total, count;
+        void sample(uint64_t value) { total += value; ++count; }
+        uint64_t mean() { return count ? total/count : 0; }
+        void reset() { total = count = 0; }
+    };
+
+    struct Data {               // Must be a POD
+        uint64_t start, entered, exited;
+        Stat active, inactive;
+
+        void reset() {
+            start = entered = exited = 0;
+            active.reset();
+            inactive.reset();
+        }
+
+        void enter(uint64_t now) {
+            entered=now;
+            if (start) {
+                assert(exited);
+                assert(entered > exited);
+                inactive.sample(entered - exited);
+            }
+            else
+                start = Duration(now);
+        }
+
+        void exit(uint64_t now) {
+            assert(start);
+            assert(entered);
+            exited=now;
+            assert(exited > entered);
+            active.sample(exited - entered);
+        }
+    };
+
+    ActivityTimer(Data& d, const char* fn, const char* file, int line, uint64_t reportInterval)
: data(d) {
+        uint64_t now = Duration(qpid::sys::now());
+        if (data.start && now - data.start > reportInterval)
+            report(fn, file, line);
+        data.enter(now);
+    }
+
+    ~ActivityTimer() {
+        data.exit(Duration(now()));
+    }
+
+  private:
+    Data& data;
+
+    void report(const char* fn, const char* file, int line) {
+        uint64_t secs = (Duration(now())-data.start)/TIME_SEC;
+        printf("[%lu]%s:%d: %s: rate=%llu/sec active=%llu inactive=%llu\n", Thread::current().id(),
file, line, fn, data.active.count/secs, data.active.mean()/TIME_USEC, data.inactive.mean()/TIME_USEC);
+        data.reset();
+    }
+};
+
+}} // namespace qpid::sys
+
+/** Measures time between the point of declaration and the end of the innermost enclosing
scope.
+ * Can only have one in a given scope.
+ */
+#define ACTIVITY_TIMER(REPORT_INTERVAL_SECS) \
+    static __thread ::qpid::sys::ActivityTimer::Data qpid__ActivityTimerData__ = { 0, 0,
0, { 0, 0 }, { 0, 0 } }; \
+    ActivityTimer qpid__ActivityTimerInstance__(qpid__ActivityTimerData__, BOOST_CURRENT_FUNCTION,
__FILE__, __LINE__, 2*TIME_SEC)
+
+#endif  /*!QPID_SYS_ACTIVITYTIMER_H*/

Propchange: incubator/qpid/trunk/qpid/cpp/src/qpid/sys/ActivityTimer.h
------------------------------------------------------------------------------
    svn:eol-style = native

Propchange: incubator/qpid/trunk/qpid/cpp/src/qpid/sys/ActivityTimer.h
------------------------------------------------------------------------------
    svn:keywords = Rev Date



Mime
View raw message