Added logging for how long processes spawned by uninstaller factories…

… run; #248
Klocman · Jan 23, 2020 · d8b4e78 · d8b4e78
1 parent 08c05d0
commit d8b4e78
Show file tree

Hide file tree

Showing 3 changed files with 15 additions and 2 deletions.
diff --git a/source/UninstallTools/Factory/ChocolateyFactory.cs b/source/UninstallTools/Factory/ChocolateyFactory.cs
@@ -188,7 +188,13 @@ private static string StartProcessAndReadOutput(string filename, string args)
                 RedirectStandardError = false,
                 CreateNoWindow = true,
                 StandardOutputEncoding = Encoding.Default
-            })) return process?.StandardOutput.ReadToEnd();
+            }))
+            {
+                var sw = Stopwatch.StartNew();
+                var output = process?.StandardOutput.ReadToEnd();
+                Console.WriteLine($"[Performance] Running command {filename} {args} took {sw.ElapsedMilliseconds}ms");
+                return output;
+            }
         }
     }
 }
diff --git a/source/UninstallTools/Factory/FactoryTools.cs b/source/UninstallTools/Factory/FactoryTools.cs
@@ -35,7 +35,9 @@ internal static string StartHelperAndReadOutput(string filename, string args)
             {
                 try
                 {
+                    var sw = Stopwatch.StartNew();
                     var output = process?.StandardOutput.ReadToEnd();
+                    Console.WriteLine($"[Performance] Running command {filename} {args} took {sw.ElapsedMilliseconds}ms");
                     return process?.ExitCode == 0 ? output : null;
                 }
                 catch (Win32Exception ex)

diff --git a/source/UninstallTools/Factory/ScoopFactory.cs b/source/UninstallTools/Factory/ScoopFactory.cs
@@ -136,7 +136,12 @@ private static string RunScoopCommand(string scoopArgs)
             startInfo.StandardOutputEncoding = Encoding.Default;
 
             using (var process = Process.Start(startInfo))
-                return process?.StandardOutput.ReadToEnd();
+            {
+                var sw = Stopwatch.StartNew();
+                var output = process?.StandardOutput.ReadToEnd();
+                Console.WriteLine($"[Performance] Running command {startInfo.FileName} {startInfo.Arguments} took {sw.ElapsedMilliseconds}ms");
+                return output;
+            }
         }
 
         private static ProcessStartCommand MakeScoopCommand(string scoopArgs)