生成进程的执行时间在几周后会增加

本文关键字:几周 增加 进程 执行时间 | 更新日期: 2023-09-27 18:08:09

当我使用System.Diagnostics.Process()创建进程时,我有一个奇怪的问题,即增加执行时间。我有一个"父"控制台应用程序,它周期性地(每隔几秒钟)创建其他"子"控制台应用程序。子进程完成一些工作(需要几百毫秒)然后退出。
一切正常运行大约4-12周。然后,子进程的执行时间开始缓慢增加。几周后,执行时间翻了一倍或三倍,越来越多的子进程被父应用程序杀死,父应用程序通过Process.WaitForExit(TimeOutValue)监视子进程的执行时间。现在我停止并重新启动"父"应用程序。之后,子进程的执行时间与开始时一样正常。
我监视了"父"应用程序的所有性能计数器。然而,没有增加的计数器。我无法理解"父"应用程序怎么会对"子"应用程序的执行时间产生如此大的影响。在下面的代码中,我剥离了不必要的部分,以专注于问题。有人知道这里出了什么问题吗?
OS为Windows Server 2008 R2 Standard

应用程序:
using System;
using System.Collections.Generic;
using System.Linq;
using System.Text;
using System.Threading.Tasks;
using System.Diagnostics;
using System.IO;
namespace Bss.CheckExecTimeScheduler
{
    class Program
    {
        static void Main(string[] args)
        {
            string Arg0 = "Bss.CheckTask.exe";
            string Args = "";
            int WaitForExit = 2000;
            int NumOfTimeOuts = 0;
            int NumOfNormalExits = 0;
            int NumOfExceptions = 0;
            long MinExecTime = 100000;
            long MaxExecTime = 0;
            Console.WriteLine("Press 'r' for a report ...");
            Console.WriteLine("Press 's' to start/stop execution ...");
            Console.WriteLine("Press 'q' to quit ...");
            Console.WriteLine("");
            while (true)
            {
                if (Console.KeyAvailable)
                {
                    ConsoleKeyInfo cki;
                    cki = Console.ReadKey();
                    if (cki.KeyChar == 'q')
                    {
                        return;
                    }
                    if (cki.KeyChar == 'r')
                    {
                        Console.WriteLine("");
                        Console.WriteLine("Normal Exits: " + NumOfNormalExits.ToString());
                        Console.WriteLine("Timeouts    : " + NumOfTimeOuts.ToString());
                        Console.WriteLine("Exceptions  : " + NumOfExceptions.ToString());
                        Console.WriteLine("Minimum execution time [ms]: " + MinExecTime.ToString());
                        Console.WriteLine("Maximum execution time [ms]: " + MaxExecTime.ToString());
                    }
                    if (cki.KeyChar == 's')
                    {
                        Console.WriteLine("Execution stopped. Press 's' to resume...");
                        while (true)
                        {
                            cki = Console.ReadKey();
                            if (cki.KeyChar == 's')
                            {
                                Console.WriteLine("Execution resumed...");
                                break;
                            }
                            else
                            {
                                Console.WriteLine("Illegal key. Execution stopped. Press 's' to resume...");
                            }
                        }
                    }
                }
                Stopwatch stopwatch = Stopwatch.StartNew();
                try
                {
                    System.Diagnostics.ProcessStartInfo procStartInfo = new System.Diagnostics.ProcessStartInfo(Arg0, Args);
                    procStartInfo.WindowStyle = ProcessWindowStyle.Hidden;
                    System.Diagnostics.Process proc = new System.Diagnostics.Process();
                    proc.StartInfo = procStartInfo;
                    proc.Start();
                    //AddMsg("Message: Command Thread launched. Arg0 = " + Arg0 + "; Args = " + Args + "; ProcessId = " + proc.Id.ToString());
                    if (proc.WaitForExit(WaitForExit) == false)
                    {
                        if (!proc.HasExited)
                        {
                            proc.Kill();
                            NumOfTimeOuts++;
                            AddExecTime("-1");
                        }
                        else
                        {
                            long elapsed = stopwatch.ElapsedMilliseconds;
                            NumOfNormalExits++;
                            if (elapsed < MinExecTime) MinExecTime = elapsed;
                            if (elapsed > MaxExecTime) MaxExecTime = elapsed;
                            AddExecTime(elapsed.ToString());
                        }
                    }
                    else
                    {
                        long elapsed = stopwatch.ElapsedMilliseconds;
                        NumOfNormalExits++;
                        if (elapsed < MinExecTime) MinExecTime = elapsed;
                        if (elapsed > MaxExecTime) MaxExecTime = elapsed;
                        AddExecTime(elapsed.ToString());
                    }
                }
                catch (Exception ex)
                {
                    NumOfExceptions++;
                    AddMsg("Exception catched: " + ex.Message);
                }
            }
        }
        public static void AddExecTime(string msg)
        {
            try
            {
                StreamWriter streamWriter = File.AppendText(DateTime.Now.ToString("yyyy.MM.dd") + "Bss.CheckExecTimeScheduler.ExecTimes.txt");
                streamWriter.WriteLine(msg);
                streamWriter.Close();
            }
            catch (Exception e)
            {
                Console.WriteLine("Error writing ExecTimes: Exception catched: " + e.ToString());
                Console.WriteLine(DateTime.Now.ToString("dd.MM.yyyy HH:mm:ss.fff ") + msg);
            }
        }
        public static void AddMsg(string msg)
        {
            try
            {
                StreamWriter streamWriter = File.AppendText(DateTime.Now.ToString("yyyy.MM.dd") + "Bss.CheckExecTimeScheduler.Logfile.txt");
                streamWriter.WriteLine(DateTime.Now.ToString("dd.MM.yyyy HH:mm:ss.fff ") + msg);
                streamWriter.Close();
            }
            catch (Exception e)
            {
                Console.WriteLine("Error writing logfile: Exception catched: " + e.ToString());
                Console.WriteLine(DateTime.Now.ToString("dd.MM.yyyy HH:mm:ss.fff ") + msg);
            }
        }
    }   
}
应用程序:
using System;
using System.Collections.Generic;
using System.Linq;
using System.Text;
using System.Threading.Tasks;
using System.Diagnostics;
using System.IO;
namespace Bss.CheckTask
{
    class Program
    {
        static void Main(string[] args)
        {
            Stopwatch stopwatch = Stopwatch.StartNew();
            Console.WriteLine("Hello World");
            long elapsed = stopwatch.ElapsedMilliseconds;
            try
            {
                StreamWriter streamWriter = File.AppendText(DateTime.Now.ToString("yyyy.MM.dd") + "Bss.CheckTask.ExecTimes.txt");
                streamWriter.WriteLine(elapsed.ToString());
                streamWriter.Close();
            }
            catch (Exception e)
            {
                Console.WriteLine("Error writing Bss.CheckTask.ExecTimes.txt: Exception catched: " + e.ToString());
            }
        }
    }
}

生成进程的执行时间在几周后会增加

我在一台虚拟机上运行了上面的例子(Win7 prof. 64bit, 4Gb RAM, Xeon at 2.27Ghz)。运行大约4个小时(大约88000个样本)后,我可以看到执行时间(从创建子进程的进程来看)缓慢增加。

不使用block的执行时间图表父视图

然而,从子进程的角度来看,执行时间似乎没有改变:

然后我按照bassfader的建议将System.Diagnotics.Process()的创建包含在using块中。我允许子进程在被父进程终止之前运行4000ms(而不是2000ms)。现在大约需要30个小时(这意味着大约550000个样本),直到执行时间开始增加:

使用block的执行时间图父视图

从子进程来看,执行时间似乎没有改变(我想上传这些图表,但我只允许在这里附加2张图片)

using块似乎改善了这种情况。然而,仍然有资源的损失。有人知道这里发生了什么,或者我可以在代码中做些什么来避免增加的执行时间吗?