[PATCH spice-streaming-agent 1/9] Separate the code for logging frames/times into a class

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]

 



The FrameLog class provides RAII for the FILE and encapsulates the
logging functionality.

Signed-off-by: Lukáš Hrázký <lhrazky@xxxxxxxxxx>
---
While I retained all the behaviour of the original implementation, I
don't like it as it is.

1. The class is doing two different things:
   a) logging the binary frames for later replay
   b) writing a time-stamped log for diagnostics

2. The time-stamped diagnostics lines seem quite rudimentary, like
   some short helper messages I put in my code when debugging a problem.
   Doesn't look like something we'd want to release, god forbid we'd have
   to keep the log format backwards compatible in the future :)

However, I don't know how the frame log is used (I guess it's mostly
Frediano who uses it?), so I didn't try to improve it, as I don't really
know how. I'd like to:

a) either get some input on how to improve it - address the two mentioned
issues, or (much rather)

b) merge this separation and have someone post a followup that cleans it
up.


 src/Makefile.am               |  2 +
 src/frame-log.cpp             | 76 +++++++++++++++++++++++++++++++++++
 src/frame-log.hpp             | 39 ++++++++++++++++++
 src/spice-streaming-agent.cpp | 71 ++++++++------------------------
 4 files changed, 134 insertions(+), 54 deletions(-)
 create mode 100644 src/frame-log.cpp
 create mode 100644 src/frame-log.hpp

diff --git a/src/Makefile.am b/src/Makefile.am
index 18ed22c..fead680 100644
--- a/src/Makefile.am
+++ b/src/Makefile.am
@@ -54,6 +54,8 @@ spice_streaming_agent_SOURCES = \
 	concrete-agent.hpp \
 	error.cpp \
 	error.hpp \
+	frame-log.cpp \
+	frame-log.hpp \
 	mjpeg-fallback.cpp \
 	mjpeg-fallback.hpp \
 	jpeg.cpp \
diff --git a/src/frame-log.cpp b/src/frame-log.cpp
new file mode 100644
index 0000000..b0bd09e
--- /dev/null
+++ b/src/frame-log.cpp
@@ -0,0 +1,76 @@
+/* A utility logger for logging frames and/or time information.
+ *
+ * \copyright
+ * Copyright 2018 Red Hat Inc. All rights reserved.
+ */
+
+#include "frame-log.hpp"
+
+#include "error.hpp"
+#include "hexdump.h"
+
+#include <cstdarg>
+#include <string.h>
+#include <sys/time.h>
+
+
+namespace spice {
+namespace streaming_agent {
+
+FrameLog::FrameLog(const char *log_name, bool log_binary, bool log_frames) :
+    log_binary(log_binary),
+    log_frames(log_frames)
+{
+    if (log_name) {
+        log_file = fopen(log_name, "wb");
+        if (!log_file) {
+            throw Error(std::string("Failed to open log file '") + log_name + "': " + strerror(errno));
+        }
+        if (!log_binary) {
+            setlinebuf(log_file);
+        }
+    }
+}
+
+FrameLog::~FrameLog()
+{
+    if (log_file) {
+        fclose(log_file);
+    }
+}
+
+void FrameLog::log_stat(const char* format, ...)
+{
+    if (log_file && !log_binary) {
+        fprintf(log_file, "%" PRIu64 ": ", get_time());
+        va_list ap;
+        va_start(ap, format);
+        vfprintf(log_file, format, ap);
+        va_end(ap);
+        fputs("\n", log_file);
+    }
+}
+
+void FrameLog::log_frame(const void* buffer, size_t buffer_size)
+{
+    if (log_file) {
+        if (log_binary) {
+            fwrite(buffer, buffer_size, 1, log_file);
+        } else if (log_frames) {
+            hexdump(buffer, buffer_size, log_file);
+        }
+    }
+}
+
+/**
+ * Returns current time in microseconds.
+ */
+uint64_t FrameLog::get_time()
+{
+    struct timeval now;
+    gettimeofday(&now, NULL);
+
+    return (uint64_t)now.tv_sec * 1000000 + (uint64_t)now.tv_usec;
+}
+
+}} // namespace spice::streaming_agent
diff --git a/src/frame-log.hpp b/src/frame-log.hpp
new file mode 100644
index 0000000..2ebe01b
--- /dev/null
+++ b/src/frame-log.hpp
@@ -0,0 +1,39 @@
+/* A utility logger for logging frames and/or time information.
+ *
+ * \copyright
+ * Copyright 2018 Red Hat Inc. All rights reserved.
+ */
+
+#ifndef SPICE_STREAMING_AGENT_FRAME_LOG_HPP
+#define SPICE_STREAMING_AGENT_FRAME_LOG_HPP
+
+#include <cinttypes>
+#include <stddef.h>
+#include <stdio.h>
+
+
+namespace spice {
+namespace streaming_agent {
+
+class FrameLog {
+public:
+    FrameLog(const char *log_name, bool log_binary, bool log_frames);
+    FrameLog(const FrameLog &) = delete;
+    FrameLog &operator=(const FrameLog &) = delete;
+    ~FrameLog();
+
+    __attribute__ ((format (printf, 2, 3)))
+    void log_stat(const char* format, ...);
+    void log_frame(const void* buffer, size_t buffer_size);
+
+    static uint64_t get_time();
+
+private:
+    FILE *log_file = NULL;
+    bool log_binary = false;
+    bool log_frames = false;
+};
+
+}} // namespace spice::streaming_agent
+
+#endif // SPICE_STREAMING_AGENT_FRAME_LOG_HPP
diff --git a/src/spice-streaming-agent.cpp b/src/spice-streaming-agent.cpp
index 1121f35..aef49c7 100644
--- a/src/spice-streaming-agent.cpp
+++ b/src/spice-streaming-agent.cpp
@@ -5,8 +5,8 @@
  */
 
 #include "concrete-agent.hpp"
-#include "hexdump.h"
 #include "mjpeg-fallback.hpp"
+#include "frame-log.hpp"
 #include "stream-port.hpp"
 #include "error.hpp"
 
@@ -57,8 +57,6 @@ struct SpiceStreamDataMessage
 
 static bool streaming_requested = false;
 static bool quit_requested = false;
-static bool log_binary = false;
-static bool log_frames = false;
 static std::set<SpiceVideoCodecType> client_codecs;
 
 static bool have_something_to_read(StreamPort &stream_port, bool blocking)
@@ -221,17 +219,6 @@ static void spice_stream_send_frame(StreamPort &stream_port, const void *buf, co
     syslog(LOG_DEBUG, "Sent a frame of size %u\n", size);
 }
 
-/* returns current time in micro-seconds */
-static uint64_t get_time(void)
-{
-    struct timeval now;
-
-    gettimeofday(&now, NULL);
-
-    return (uint64_t)now.tv_sec * 1000000 + (uint64_t)now.tv_usec;
-
-}
-
 static void handle_interrupt(int intr)
 {
     syslog(LOG_INFO, "Got signal %d, exiting", intr);
@@ -330,14 +317,8 @@ static void cursor_changes(StreamPort *stream_port, Display *display, int event_
     }
 }
 
-#define STAT_LOG(format, ...) do { \
-    if (f_log && !log_binary) { \
-        fprintf(f_log, "%" PRIu64 ": " format "\n", get_time(), ## __VA_ARGS__); \
-    } \
-} while(0)
-
 static void
-do_capture(StreamPort &stream_port, FILE *f_log)
+do_capture(StreamPort &stream_port, FrameLog &frame_log)
 {
     unsigned int frame_count = 0;
     while (!quit_requested) {
@@ -361,13 +342,13 @@ do_capture(StreamPort &stream_port, FILE *f_log)
             if (++frame_count % 100 == 0) {
                 syslog(LOG_DEBUG, "SENT %d frames\n", frame_count);
             }
-            uint64_t time_before = get_time();
+            uint64_t time_before = FrameLog::get_time();
 
-            STAT_LOG("Capturing...");
+            frame_log.log_stat("Capturing...");
             FrameInfo frame = capture->CaptureFrame();
-            STAT_LOG("Captured");
+            frame_log.log_stat("Captured");
 
-            uint64_t time_after = get_time();
+            uint64_t time_after = FrameLog::get_time();
             syslog(LOG_DEBUG,
                    "got a frame -- size is %zu (%" PRIu64 " ms) "
                    "(%" PRIu64 " ms from last frame)(%" PRIu64 " us)\n",
@@ -385,18 +366,12 @@ do_capture(StreamPort &stream_port, FILE *f_log)
                 codec = capture->VideoCodecType();
 
                 syslog(LOG_DEBUG, "wXh %uX%u  codec=%u\n", width, height, codec);
-                STAT_LOG("Started new stream wXh %uX%u  codec=%u", width, height, codec);
+                frame_log.log_stat("Started new stream wXh %uX%u  codec=%u", width, height, codec);
 
                 spice_stream_send_format(stream_port, width, height, codec);
             }
-            STAT_LOG("Frame of %zu bytes:", frame.buffer_size);
-            if (f_log) {
-                if (log_binary) {
-                    fwrite(frame.buffer, frame.buffer_size, 1, f_log);
-                } else if (log_frames) {
-                    hexdump(frame.buffer, frame.buffer_size, f_log);
-                }
-            }
+            frame_log.log_stat("Frame of %zu bytes:", frame.buffer_size);
+            frame_log.log_frame(frame.buffer, frame.buffer_size);
 
             try {
                 spice_stream_send_frame(stream_port, frame.buffer, frame.buffer_size);
@@ -404,7 +379,7 @@ do_capture(StreamPort &stream_port, FILE *f_log)
                 syslog(e);
                 break;
             }
-            STAT_LOG("Sent");
+            frame_log.log_stat("Sent");
 
             read_command(stream_port, false);
         }
@@ -418,6 +393,8 @@ int main(int argc, char* argv[])
     const char *stream_port_name = "/dev/virtio-ports/org.spice-space.stream.0";
     int opt;
     const char *log_filename = NULL;
+    bool log_binary = false;
+    bool log_frames = false;
     int logmask = LOG_UPTO(LOG_WARNING);
     const char *pluginsdir = PLUGINSDIR;
     enum {
@@ -493,20 +470,10 @@ int main(int argc, char* argv[])
 
     register_interrupts();
 
-    FILE *f_log = NULL;
-    if (log_filename) {
-        f_log = fopen(log_filename, "wb");
-        if (!f_log) {
-            syslog(LOG_ERR, "Failed to open log file '%s': %s\n",
-                   log_filename, strerror(errno));
-            return EXIT_FAILURE;
-        }
-        if (!log_binary) {
-            setlinebuf(f_log);
-        }
-        for (const std::string& arg: old_args) {
-            STAT_LOG("Args: %s", arg.c_str());
-        }
+    FrameLog frame_log(log_filename, log_binary, log_frames);
+
+    for (const std::string& arg: old_args) {
+        frame_log.log_stat("Args: %s", arg.c_str());
     }
     old_args.clear();
 
@@ -531,17 +498,13 @@ int main(int argc, char* argv[])
         std::thread cursor_th(cursor_changes, &stream_port, display, event_base);
         cursor_th.detach();
 
-        do_capture(stream_port, f_log);
+        do_capture(stream_port, frame_log);
     }
     catch (std::exception &err) {
         syslog(LOG_ERR, "%s\n", err.what());
         ret = EXIT_FAILURE;
     }
 
-    if (f_log) {
-        fclose(f_log);
-        f_log = NULL;
-    }
     closelog();
     return ret;
 }
-- 
2.17.1

_______________________________________________
Spice-devel mailing list
Spice-devel@xxxxxxxxxxxxxxxxxxxxx
https://lists.freedesktop.org/mailman/listinfo/spice-devel




[Index of Archives]     [Linux Virtualization]     [Linux Virtualization]     [Linux ARM Kernel]     [Linux ARM]     [Linux Omap]     [Fedora ARM]     [IETF Annouce]     [Security]     [Bugtraq]     [Linux OMAP]     [Linux MIPS]     [ECOS]     [Asterisk Internet PBX]     [Linux API]     [Monitors]