Именно так текущая версия MiniProfilerExtensions.RenderPlainText()
отображает пользовательскую информацию о времени. Пользовательские тайминги создаются с использованием CustomTiming()
, а не Step()
, они обычно являются своего рода конечными измерениями в иерархии MiniProfiler, такими как взаимодействие с базой данных или HTTP-запросы.
Вы можете легко настроить процесс рендеринга и предоставить подробную информацию о пользовательских таймингах:
SERVER at 23.11.2018 09:00:00
MiniProfiler = 48,3[ms]
> Foo = 35,6ms (sql = 24,8[ms] in 1 cmd) (http = 4,7[ms] in 1 cmd)
sql 24,8[ms] +16,9[ms] SELECT * FROM Foo
http 4,7[ms] +41,8[ms] GET http://foo.bar
Пример реализации:
using StackExchange.Profiling;
using StackExchange.Profiling.Internal;
...
public static string CustomRenderPlainText(this MiniProfiler profiler, bool htmlEncode = false)
{
if (profiler == null) return string.Empty;
var text = StringBuilderCache.Get()
.Append(htmlEncode ? WebUtility.HtmlEncode(Environment.MachineName) : Environment.MachineName)
.Append(" at ")
.Append(DateTime.UtcNow)
.AppendLine();
var timings = new Stack<Timing>();
timings.Push(profiler.Root);
while (timings.Count > 0)
{
var timing = timings.Pop();
text.AppendFormat("{0} {1} = {2:###,##0.##}[ms]",
new string('>', timing.Depth),
htmlEncode ? WebUtility.HtmlEncode(timing.Name) : timing.Name,
timing.DurationMilliseconds);
if (timing.HasCustomTimings)
{
// TODO: Customize this code block.
// Custom timings grouped by category. Collect all custom timings in a list.
var customTimingsFlat = new List<KeyValuePair<string, CustomTiming>>(capacity: timing.CustomTimings.Sum(ct => ct.Value.Count));
foreach (var pair in timing.CustomTimings)
{
var type = pair.Key;
var customTimings = pair.Value;
customTimingsFlat.AddRange(pair.Value.Select(ct => KeyValuePair.Create(type, ct)));
text.AppendFormat(" ({0} = {1:###,##0.##}[ms] in {2} cmd{3})",
type,
customTimings.Sum(ct => ct.DurationMilliseconds),
customTimings.Count,
customTimings.Count == 1 ? string.Empty : "s");
}
foreach (var pair in customTimingsFlat.OrderBy(kvp => kvp.Value.StartMilliseconds))
{
var type = pair.Key;
var ct = pair.Value;
text.AppendLine();
var mainPart = string.Format("{0}{1} {2:###,##0.##}[ms] +{3:###,##0.##}[ms] ",
new string(' ', timing.Depth + 2),
type,
ct.DurationMilliseconds,
ct.StartMilliseconds);
text.Append(mainPart);
// Shift command text to closer to the command for better readability.
var prefix = new string(' ', mainPart.Length);
string cmdLine = null;
using (var reader = new StringReader(ct.CommandString))
{
while ((cmdLine = reader.ReadLine()) != null)
{
text.Append(cmdLine);
if (reader.Peek() == -1 && profiler.Options.ExcludeStackTraceSnippetFromCustomTimings)
{
break;
}
text.AppendLine();
text.Append(prefix);
}
}
if (profiler.Options.ExcludeStackTraceSnippetFromCustomTimings)
{
continue;
}
text.Append(ct.StackTraceSnippet);
}
}
text.AppendLine();
if (timing.HasChildren)
{
var children = timing.Children;
for (var i = children.Count - 1; i >= 0; i--) timings.Push(children[i]);
}
}
return text.ToStringRecycle();
}
Также обратите внимание, что по умолчанию для отображения отчета MiniProfiler со всеми таймингами сначала необходимо вызвать Stop()
. Вы также можете настроить это, рассчитав время в отчете.