Switch gdb_stdlog to use timestamped_file
authorTom Tromey <tom@tromey.com>
Fri, 31 Dec 2021 19:00:11 +0000 (12:00 -0700)
committerTom Tromey <tom@tromey.com>
Mon, 28 Mar 2022 20:13:28 +0000 (14:13 -0600)
Currently, timestamps for logging are done by looking for the use of
gdb_stdlog in vfprintf_unfiltered.  This seems potentially buggy, in
that during logging or other redirects (like execute_fn_to_ui_file) we
might have gdb_stdout==gdb_stdlog and so, conceivably, wind up with
timestamps in a log when they were not desired.

It seems better, instead, for timestamps to be a property of the
ui_file itself.

This patch changes gdb to use the new timestamped_file for gdb_stdlog
where appropriate, and removes the special case from
vfprintf_unfiltered.

Note that this may somewhat change the output in some cases -- in
particular, when going through execute_fn_to_ui_file (or the _string
variant), timestamps won't be emitted.  This could be fixed in those
functions, but it wasn't clear to me whether this is really desirable.

Note also that this changes the TUI to send gdb_stdlog to gdb_stderr.
I imagine that the previous use of gdb_stdout here was inadvertent.
(And in any case it probably doesn't matter.)

gdb/cli/cli-interp.c
gdb/event-top.c
gdb/tui/tui-io.c
gdb/utils.c

index d36715d1d8fd289a6db781e4b5afc883d86f3966..fe9e4b43f1453b4b22c1e7a2ba92310853445c4f 100644 (file)
@@ -397,6 +397,7 @@ struct saved_output_files
   ui_file *targ;
   ui_file *targerr;
   ui_file_up file_to_delete;
+  ui_file_up log_to_delete;
 };
 static std::unique_ptr<saved_output_files> saved_output;
 
@@ -427,8 +428,11 @@ cli_interp_base::set_logging (ui_file_up logfile, bool logging_redirect,
       else
        saved_output->file_to_delete = std::move (logfile);
 
+      saved_output->log_to_delete.reset
+       (new timestamped_file (debug_redirect ? logfile_p : tee));
+
       gdb_stdout = logging_redirect ? logfile_p : tee;
-      gdb_stdlog = debug_redirect ? logfile_p : tee;
+      gdb_stdlog = saved_output->log_to_delete.get ();
       gdb_stderr = logging_redirect ? logfile_p : tee;
       gdb_stdtarg = logging_redirect ? logfile_p : tee;
       gdb_stdtargerr = logging_redirect ? logfile_p : tee;
index c1a95a4b748fffb667f105a0af9f13c57a67d027..3ba7239518e7630527233977c05f146833b28b8d 100644 (file)
@@ -1306,7 +1306,7 @@ gdb_setup_readline (int editing)
   if (!batch_silent)
     gdb_stdout = new stdio_file (ui->outstream);
   gdb_stderr = new stderr_file (ui->errstream);
-  gdb_stdlog = gdb_stderr;  /* for moment */
+  gdb_stdlog = new timestamped_file (gdb_stderr);
   gdb_stdtarg = gdb_stderr; /* for moment */
   gdb_stdtargerr = gdb_stderr; /* for moment */
 
index 8cac1c40f1346d1ede7faeea2d82d99ec1917a39..01300d8b74b02323d500b75b39b02f5ed0ef0499 100644 (file)
@@ -108,11 +108,13 @@ key_is_start_sequence (int ch)
 /* TUI output files.  */
 static struct ui_file *tui_stdout;
 static struct ui_file *tui_stderr;
+static struct ui_file *tui_stdlog;
 struct ui_out *tui_out;
 
 /* GDB output files in non-curses mode.  */
 static struct ui_file *tui_old_stdout;
 static struct ui_file *tui_old_stderr;
+static struct ui_file *tui_old_stdlog;
 cli_ui_out *tui_old_uiout;
 
 /* Readline previous hooks.  */
@@ -828,13 +830,14 @@ tui_setup_io (int mode)
       /* Keep track of previous gdb output.  */
       tui_old_stdout = gdb_stdout;
       tui_old_stderr = gdb_stderr;
+      tui_old_stdlog = gdb_stdlog;
       tui_old_uiout = dynamic_cast<cli_ui_out *> (current_uiout);
       gdb_assert (tui_old_uiout != nullptr);
 
       /* Reconfigure gdb output.  */
       gdb_stdout = tui_stdout;
       gdb_stderr = tui_stderr;
-      gdb_stdlog = gdb_stdout; /* for moment */
+      gdb_stdlog = tui_stdlog;
       gdb_stdtarg = gdb_stderr;        /* for moment */
       gdb_stdtargerr = gdb_stderr;     /* for moment */
       current_uiout = tui_out;
@@ -847,7 +850,7 @@ tui_setup_io (int mode)
       /* Restore gdb output.  */
       gdb_stdout = tui_old_stdout;
       gdb_stderr = tui_old_stderr;
-      gdb_stdlog = gdb_stdout; /* for moment */
+      gdb_stdlog = tui_old_stdlog;
       gdb_stdtarg = gdb_stderr;        /* for moment */
       gdb_stdtargerr = gdb_stderr;     /* for moment */
       current_uiout = tui_old_uiout;
@@ -902,6 +905,7 @@ tui_initialize_io (void)
   /* Create tui output streams.  */
   tui_stdout = new tui_file (stdout);
   tui_stderr = new tui_file (stderr);
+  tui_stdlog = new timestamped_file (tui_stderr);
   tui_out = tui_out_new (tui_stdout);
 
   /* Create the default UI.  */
index 8dd70087d0c4539aacb99091daa37001a68ce7a1..48aedb034b990198e26a2b143b54b21a4952a9c1 100644 (file)
@@ -1938,35 +1938,7 @@ vfprintf_filtered (struct ui_file *stream, const char *format, va_list args)
 void
 vfprintf_unfiltered (struct ui_file *stream, const char *format, va_list args)
 {
-  if (debug_timestamp && stream == gdb_stdlog)
-    {
-      static bool needs_timestamp = true;
-
-      /* Print timestamp if previous print ended with a \n.  */
-      if (needs_timestamp)
-       {
-         using namespace std::chrono;
-
-         steady_clock::time_point now = steady_clock::now ();
-         seconds s = duration_cast<seconds> (now.time_since_epoch ());
-         microseconds us = duration_cast<microseconds> (now.time_since_epoch () - s);
-         std::string timestamp = string_printf ("%ld.%06ld ",
-                                                (long) s.count (),
-                                                (long) us.count ());
-         fputs_unfiltered (timestamp.c_str (), stream);
-       }
-
-      /* Print the message.  */
-      string_file sfile;
-      cli_ui_out (&sfile, 0).vmessage (ui_file_style (), format, args);
-      const std::string &linebuffer = sfile.string ();
-      fputs_unfiltered (linebuffer.c_str (), stream);
-
-      size_t len = linebuffer.length ();
-      needs_timestamp = (len > 0 && linebuffer[len - 1] == '\n');
-    }
-  else
-    vfprintf_maybe_filtered (stream, format, args, false);
+  vfprintf_maybe_filtered (stream, format, args, false);
 }
 
 void