Skip to content

[SLES-2826] Reproducing AAS Restart Named Pipe Overlap Issue with Logs [Do Not Merge]#8632

Draft
Lewis-E wants to merge 4 commits into
masterfrom
lewis.lewis/aas-repro-diagnostics-dotnet
Draft

[SLES-2826] Reproducing AAS Restart Named Pipe Overlap Issue with Logs [Do Not Merge]#8632
Lewis-E wants to merge 4 commits into
masterfrom
lewis.lewis/aas-repro-diagnostics-dotnet

Conversation

@Lewis-E

@Lewis-E Lewis-E commented May 13, 2026

Copy link
Copy Markdown
Contributor

Adds [aas-repro]-prefixed Information/Warning logs at every state transition:
init (IIS Worker Process PID, AppDomain, pipe names, agent path), per-iteration
7-retry NeverChecked outcomes, the bad path (never_checked_exhausted), steady-
state poll signals, spawned child PID + exit code, and SequentialFailures count.
Adds NamedPipeIsBoundDiagnostic/GetMatchingProcessesDiagnostic helpers that log
on the TRUE branch (production helpers only log FALSE) and emit full
PID@StartTime list from Process.GetProcessesByName so orphan agents are visible.

For repro only — not for customer release.## Summary of changes

Reason for change

Implementation details

Test coverage

Other details

Lewis-E added 2 commits May 13, 2026 15:28
…ssification

Adds [aas-repro]-prefixed Information/Warning logs at every state transition:
init (IIS Worker Process PID, AppDomain, pipe names, agent path), per-iteration
7-retry NeverChecked outcomes, the bad path (never_checked_exhausted), steady-
state poll signals, spawned child PID + exit code, and SequentialFailures count.
Adds NamedPipeIsBoundDiagnostic/GetMatchingProcessesDiagnostic helpers that log
on the TRUE branch (production helpers only log FALSE) and emit full
PID@StartTime list from Process.GetProcessesByName so orphan agents are visible.

For repro only — not for customer release.
- Wrap int args in new object[] on spawned/start_success log calls to
  resolve CS0121 (int disambiguates as CallerLineNumber otherwise)
- Add #pragma warning disable/restore CA1837 around
  Process.GetCurrentProcess().Id (warnings-as-errors on net6.0)
@github-actions github-actions Bot added the area:tracer The core tracer library (Datadog.Trace, does not include OpenTracing, native code, or integrations) label May 13, 2026
@Lewis-E Lewis-E changed the title [SLES-2826] Diagnosis Logs for AAS Restart Named Pipe Overlap Issue [Do Not Merge] [SLES-2826] Reproducing AAS Restart Named Pipe Overlap Issue with Logs [Do Not Merge] May 13, 2026
@dd-trace-dotnet-ci-bot

dd-trace-dotnet-ci-bot Bot commented May 13, 2026

Copy link
Copy Markdown

Execution-Time Benchmarks Report ⏱️

Execution-time results for samples comparing This PR (8632) and master.

✅ No regressions detected - check the details below

Full Metrics Comparison

FakeDbCommand

Metric Master (Mean ± 95% CI) Current (Mean ± 95% CI) Change Status
.NET Framework 4.8 - Baseline
duration72.33 ± (72.33 - 72.66) ms74.04 ± (74.01 - 74.68) ms+2.4%✅⬆️
.NET Framework 4.8 - Bailout
duration78.24 ± (78.17 - 78.72) ms78.37 ± (78.40 - 78.94) ms+0.2%✅⬆️
.NET Framework 4.8 - CallTarget+Inlining+NGEN
duration1100.25 ± (1098.34 - 1105.24) ms1097.90 ± (1098.45 - 1105.24) ms-0.2%
.NET Core 3.1 - Baseline
process.internal_duration_ms22.58 ± (22.53 - 22.64) ms22.88 ± (22.82 - 22.95) ms+1.3%✅⬆️
process.time_to_main_ms86.04 ± (85.72 - 86.36) ms87.35 ± (87.02 - 87.67) ms+1.5%✅⬆️
runtime.dotnet.exceptions.count0 ± (0 - 0)0 ± (0 - 0)+0.0%
runtime.dotnet.mem.committed10.90 ± (10.89 - 10.90) MB10.91 ± (10.90 - 10.91) MB+0.1%✅⬆️
runtime.dotnet.threads.count12 ± (12 - 12)12 ± (12 - 12)+0.0%
.NET Core 3.1 - Bailout
process.internal_duration_ms22.68 ± (22.63 - 22.74) ms22.34 ± (22.30 - 22.38) ms-1.5%
process.time_to_main_ms88.93 ± (88.57 - 89.29) ms85.70 ± (85.50 - 85.90) ms-3.6%
runtime.dotnet.exceptions.count0 ± (0 - 0)0 ± (0 - 0)+0.0%
runtime.dotnet.mem.committed10.95 ± (10.95 - 10.96) MB10.94 ± (10.94 - 10.94) MB-0.1%
runtime.dotnet.threads.count13 ± (13 - 13)13 ± (13 - 13)+0.0%
.NET Core 3.1 - CallTarget+Inlining+NGEN
process.internal_duration_ms212.89 ± (211.87 - 213.91) ms211.37 ± (210.45 - 212.30) ms-0.7%
process.time_to_main_ms539.67 ± (538.41 - 540.94) ms535.96 ± (534.79 - 537.13) ms-0.7%
runtime.dotnet.exceptions.count0 ± (0 - 0)0 ± (0 - 0)+0.0%
runtime.dotnet.mem.committed48.43 ± (48.40 - 48.46) MB48.49 ± (48.46 - 48.52) MB+0.1%✅⬆️
runtime.dotnet.threads.count28 ± (28 - 28)28 ± (28 - 28)+0.0%✅⬆️
.NET 6 - Baseline
process.internal_duration_ms21.28 ± (21.24 - 21.31) ms21.67 ± (21.60 - 21.74) ms+1.9%✅⬆️
process.time_to_main_ms73.30 ± (73.14 - 73.45) ms76.49 ± (76.21 - 76.76) ms+4.4%✅⬆️
runtime.dotnet.exceptions.count0 ± (0 - 0)0 ± (0 - 0)+0.0%
runtime.dotnet.mem.committed10.68 ± (10.68 - 10.68) MB10.63 ± (10.63 - 10.63) MB-0.5%
runtime.dotnet.threads.count10 ± (10 - 10)10 ± (10 - 10)+0.0%
.NET 6 - Bailout
process.internal_duration_ms21.59 ± (21.54 - 21.65) ms21.26 ± (21.22 - 21.29) ms-1.6%
process.time_to_main_ms76.61 ± (76.32 - 76.90) ms75.43 ± (75.23 - 75.63) ms-1.5%
runtime.dotnet.exceptions.count0 ± (0 - 0)0 ± (0 - 0)+0.0%
runtime.dotnet.mem.committed10.80 ± (10.80 - 10.80) MB10.75 ± (10.74 - 10.75) MB-0.5%
runtime.dotnet.threads.count11 ± (11 - 11)11 ± (11 - 11)+0.0%
.NET 6 - CallTarget+Inlining+NGEN
process.internal_duration_ms378.92 ± (376.57 - 381.27) ms376.02 ± (374.07 - 377.97) ms-0.8%
process.time_to_main_ms537.96 ± (536.71 - 539.20) ms540.84 ± (539.40 - 542.29) ms+0.5%✅⬆️
runtime.dotnet.exceptions.count0 ± (0 - 0)0 ± (0 - 0)+0.0%
runtime.dotnet.mem.committed49.86 ± (49.84 - 49.89) MB49.95 ± (49.93 - 49.97) MB+0.2%✅⬆️
runtime.dotnet.threads.count28 ± (28 - 28)28 ± (28 - 28)-0.0%
.NET 8 - Baseline
process.internal_duration_ms19.51 ± (19.46 - 19.56) ms19.58 ± (19.52 - 19.64) ms+0.4%✅⬆️
process.time_to_main_ms73.07 ± (72.82 - 73.31) ms73.71 ± (73.48 - 73.94) ms+0.9%✅⬆️
runtime.dotnet.exceptions.count0 ± (0 - 0)0 ± (0 - 0)+0.0%
runtime.dotnet.mem.committed7.67 ± (7.66 - 7.67) MB7.65 ± (7.65 - 7.66) MB-0.1%
runtime.dotnet.threads.count10 ± (10 - 10)10 ± (10 - 10)+0.0%
.NET 8 - Bailout
process.internal_duration_ms19.29 ± (19.25 - 19.33) ms19.62 ± (19.56 - 19.67) ms+1.7%✅⬆️
process.time_to_main_ms73.08 ± (72.92 - 73.24) ms75.76 ± (75.51 - 76.01) ms+3.7%✅⬆️
runtime.dotnet.exceptions.count0 ± (0 - 0)0 ± (0 - 0)+0.0%
runtime.dotnet.mem.committed7.72 ± (7.71 - 7.72) MB7.71 ± (7.71 - 7.72) MB-0.1%
runtime.dotnet.threads.count11 ± (11 - 11)11 ± (11 - 11)+0.0%
.NET 8 - CallTarget+Inlining+NGEN
process.internal_duration_ms297.39 ± (295.26 - 299.52) ms295.91 ± (293.87 - 297.95) ms-0.5%
process.time_to_main_ms497.06 ± (495.89 - 498.22) ms494.78 ± (493.44 - 496.12) ms-0.5%
runtime.dotnet.exceptions.count0 ± (0 - 0)0 ± (0 - 0)+0.0%
runtime.dotnet.mem.committed36.93 ± (36.90 - 36.96) MB36.92 ± (36.89 - 36.95) MB-0.0%
runtime.dotnet.threads.count27 ± (27 - 27)27 ± (27 - 27)+0.0%

HttpMessageHandler

Metric Master (Mean ± 95% CI) Current (Mean ± 95% CI) Change Status
.NET Framework 4.8 - Baseline
duration199.54 ± (199.18 - 199.95) ms198.27 ± (198.11 - 199.00) ms-0.6%
.NET Framework 4.8 - Bailout
duration203.83 ± (203.54 - 204.32) ms202.93 ± (202.42 - 203.43) ms-0.4%
.NET Framework 4.8 - CallTarget+Inlining+NGEN
duration1192.17 ± (1192.73 - 1198.61) ms1198.68 ± (1200.27 - 1207.79) ms+0.5%✅⬆️
.NET Core 3.1 - Baseline
process.internal_duration_ms194.46 ± (193.96 - 194.96) ms194.76 ± (194.30 - 195.22) ms+0.2%✅⬆️
process.time_to_main_ms84.05 ± (83.73 - 84.36) ms84.36 ± (84.08 - 84.63) ms+0.4%✅⬆️
runtime.dotnet.exceptions.count3 ± (3 - 3)3 ± (3 - 3)+0.0%
runtime.dotnet.mem.committed16.09 ± (16.07 - 16.12) MB16.05 ± (16.03 - 16.08) MB-0.3%
runtime.dotnet.threads.count20 ± (20 - 20)20 ± (20 - 20)-0.0%
.NET Core 3.1 - Bailout
process.internal_duration_ms194.35 ± (193.88 - 194.82) ms194.96 ± (194.54 - 195.38) ms+0.3%✅⬆️
process.time_to_main_ms84.95 ± (84.68 - 85.23) ms86.08 ± (85.82 - 86.34) ms+1.3%✅⬆️
runtime.dotnet.exceptions.count3 ± (3 - 3)3 ± (3 - 3)+0.0%
runtime.dotnet.mem.committed16.07 ± (16.04 - 16.09) MB16.09 ± (16.07 - 16.12) MB+0.2%✅⬆️
runtime.dotnet.threads.count21 ± (21 - 21)21 ± (21 - 21)-0.2%
.NET Core 3.1 - CallTarget+Inlining+NGEN
process.internal_duration_ms386.21 ± (385.16 - 387.26) ms390.46 ± (389.11 - 391.80) ms+1.1%✅⬆️
process.time_to_main_ms532.74 ± (531.60 - 533.89) ms537.24 ± (535.96 - 538.52) ms+0.8%✅⬆️
runtime.dotnet.exceptions.count3 ± (3 - 3)3 ± (3 - 3)+0.0%
runtime.dotnet.mem.committed57.76 ± (57.53 - 57.98) MB58.36 ± (58.15 - 58.57) MB+1.0%✅⬆️
runtime.dotnet.threads.count30 ± (30 - 30)30 ± (30 - 30)+0.4%✅⬆️
.NET 6 - Baseline
process.internal_duration_ms197.95 ± (197.54 - 198.35) ms199.46 ± (198.99 - 199.93) ms+0.8%✅⬆️
process.time_to_main_ms72.43 ± (72.16 - 72.69) ms73.30 ± (73.05 - 73.54) ms+1.2%✅⬆️
runtime.dotnet.exceptions.count4 ± (4 - 4)4 ± (4 - 4)+0.0%
runtime.dotnet.mem.committed16.33 ± (16.30 - 16.36) MB16.33 ± (16.31 - 16.35) MB-0.0%
runtime.dotnet.threads.count19 ± (19 - 19)19 ± (19 - 19)-1.2%
.NET 6 - Bailout
process.internal_duration_ms196.57 ± (196.10 - 197.05) ms197.87 ± (197.35 - 198.40) ms+0.7%✅⬆️
process.time_to_main_ms72.95 ± (72.71 - 73.20) ms73.56 ± (73.30 - 73.82) ms+0.8%✅⬆️
runtime.dotnet.exceptions.count4 ± (4 - 4)4 ± (4 - 4)+0.0%
runtime.dotnet.mem.committed16.39 ± (16.33 - 16.45) MB16.41 ± (16.38 - 16.43) MB+0.1%✅⬆️
runtime.dotnet.threads.count20 ± (20 - 20)20 ± (20 - 20)+1.5%✅⬆️
.NET 6 - CallTarget+Inlining+NGEN
process.internal_duration_ms591.73 ± (589.02 - 594.44) ms592.16 ± (589.58 - 594.75) ms+0.1%✅⬆️
process.time_to_main_ms532.83 ± (531.98 - 533.67) ms536.48 ± (535.65 - 537.32) ms+0.7%✅⬆️
runtime.dotnet.exceptions.count4 ± (4 - 4)4 ± (4 - 4)+0.0%
runtime.dotnet.mem.committed61.25 ± (61.16 - 61.35) MB61.12 ± (61.02 - 61.21) MB-0.2%
runtime.dotnet.threads.count31 ± (31 - 31)31 ± (31 - 31)-0.0%
.NET 8 - Baseline
process.internal_duration_ms194.58 ± (194.11 - 195.05) ms196.25 ± (195.85 - 196.65) ms+0.9%✅⬆️
process.time_to_main_ms71.44 ± (71.22 - 71.66) ms72.06 ± (71.81 - 72.31) ms+0.9%✅⬆️
runtime.dotnet.exceptions.count4 ± (4 - 4)4 ± (4 - 4)+0.0%
runtime.dotnet.mem.committed11.73 ± (11.71 - 11.74) MB11.70 ± (11.68 - 11.72) MB-0.2%
runtime.dotnet.threads.count18 ± (18 - 18)18 ± (18 - 18)-0.2%
.NET 8 - Bailout
process.internal_duration_ms193.96 ± (193.54 - 194.37) ms196.25 ± (195.74 - 196.77) ms+1.2%✅⬆️
process.time_to_main_ms72.58 ± (72.37 - 72.79) ms72.94 ± (72.73 - 73.15) ms+0.5%✅⬆️
runtime.dotnet.exceptions.count4 ± (4 - 4)4 ± (4 - 4)+0.0%
runtime.dotnet.mem.committed11.76 ± (11.74 - 11.78) MB11.78 ± (11.77 - 11.80) MB+0.2%✅⬆️
runtime.dotnet.threads.count19 ± (19 - 19)19 ± (19 - 19)+0.1%✅⬆️
.NET 8 - CallTarget+Inlining+NGEN
process.internal_duration_ms515.55 ± (512.72 - 518.38) ms513.43 ± (510.54 - 516.31) ms-0.4%
process.time_to_main_ms490.96 ± (490.20 - 491.72) ms493.48 ± (492.65 - 494.30) ms+0.5%✅⬆️
runtime.dotnet.exceptions.count4 ± (4 - 4)4 ± (4 - 4)+0.0%
runtime.dotnet.mem.committed50.58 ± (50.55 - 50.61) MB50.61 ± (50.57 - 50.65) MB+0.1%✅⬆️
runtime.dotnet.threads.count30 ± (29 - 30)30 ± (30 - 30)+1.1%✅⬆️
Comparison explanation

Execution-time benchmarks measure the whole time it takes to execute a program, and are intended to measure the one-off costs. Cases where the execution time results for the PR are worse than latest master results are highlighted in **red**. The following thresholds were used for comparing the execution times:

  • Welch test with statistical test for significance of 5%
  • Only results indicating a difference greater than 5% and 5 ms are considered.

Note that these results are based on a single point-in-time result for each branch. For full results, see the dashboard.

Graphs show the p99 interval based on the mean and StdDev of the test run, as well as the mean value of the run (shown as a diamond below the graph).

Duration charts
FakeDbCommand (.NET Framework 4.8)
gantt
    title Execution time (ms) FakeDbCommand (.NET Framework 4.8)
    dateFormat  x
    axisFormat %Q
    todayMarker off
    section Baseline
    This PR (8632) - mean (74ms)  : 69, 79
    master - mean (72ms)  : 70, 75

    section Bailout
    This PR (8632) - mean (79ms)  : 75, 83
    master - mean (78ms)  : 74, 83

    section CallTarget+Inlining+NGEN
    This PR (8632) - mean (1,102ms)  : 1053, 1150
    master - mean (1,102ms)  : 1051, 1152

Loading
FakeDbCommand (.NET Core 3.1)
gantt
    title Execution time (ms) FakeDbCommand (.NET Core 3.1)
    dateFormat  x
    axisFormat %Q
    todayMarker off
    section Baseline
    This PR (8632) - mean (117ms)  : 110, 125
    master - mean (116ms)  : 110, 122

    section Bailout
    This PR (8632) - mean (115ms)  : 111, 119
    master - mean (119ms)  : 111, 126

    section CallTarget+Inlining+NGEN
    This PR (8632) - mean (786ms)  : 756, 817
    master - mean (791ms)  : 761, 822

Loading
FakeDbCommand (.NET 6)
gantt
    title Execution time (ms) FakeDbCommand (.NET 6)
    dateFormat  x
    axisFormat %Q
    todayMarker off
    section Baseline
    This PR (8632) - mean (105ms)  : 99, 111
    master - mean (101ms)  : 98, 104

    section Bailout
    This PR (8632) - mean (103ms)  : 99, 107
    master - mean (105ms)  : 99, 110

    section CallTarget+Inlining+NGEN
    This PR (8632) - mean (944ms)  : 909, 978
    master - mean (945ms)  : 902, 989

Loading
FakeDbCommand (.NET 8)
gantt
    title Execution time (ms) FakeDbCommand (.NET 8)
    dateFormat  x
    axisFormat %Q
    todayMarker off
    section Baseline
    This PR (8632) - mean (101ms)  : 97, 106
    master - mean (101ms)  : 95, 107

    section Bailout
    This PR (8632) - mean (104ms)  : 99, 108
    master - mean (100ms)  : 98, 102

    section CallTarget+Inlining+NGEN
    This PR (8632) - mean (821ms)  : 783, 859
    master - mean (825ms)  : 786, 863

Loading
HttpMessageHandler (.NET Framework 4.8)
gantt
    title Execution time (ms) HttpMessageHandler (.NET Framework 4.8)
    dateFormat  x
    axisFormat %Q
    todayMarker off
    section Baseline
    This PR (8632) - mean (199ms)  : 193, 204
    master - mean (200ms)  : 195, 204

    section Bailout
    This PR (8632) - mean (203ms)  : 198, 208
    master - mean (204ms)  : 200, 208

    section CallTarget+Inlining+NGEN
    This PR (8632) - mean (1,204ms)  : 1150, 1258
    master - mean (1,196ms)  : 1154, 1238

Loading
HttpMessageHandler (.NET Core 3.1)
gantt
    title Execution time (ms) HttpMessageHandler (.NET Core 3.1)
    dateFormat  x
    axisFormat %Q
    todayMarker off
    section Baseline
    This PR (8632) - mean (288ms)  : 281, 296
    master - mean (287ms)  : 280, 295

    section Bailout
    This PR (8632) - mean (290ms)  : 282, 298
    master - mean (288ms)  : 283, 293

    section CallTarget+Inlining+NGEN
    This PR (8632) - mean (965ms)  : 946, 984
    master - mean (959ms)  : 943, 976

Loading
HttpMessageHandler (.NET 6)
gantt
    title Execution time (ms) HttpMessageHandler (.NET 6)
    dateFormat  x
    axisFormat %Q
    todayMarker off
    section Baseline
    This PR (8632) - mean (281ms)  : 275, 287
    master - mean (279ms)  : 274, 284

    section Bailout
    This PR (8632) - mean (280ms)  : 274, 285
    master - mean (278ms)  : 272, 284

    section CallTarget+Inlining+NGEN
    This PR (8632) - mean (1,155ms)  : 1115, 1195
    master - mean (1,157ms)  : 1115, 1198

Loading
HttpMessageHandler (.NET 8)
gantt
    title Execution time (ms) HttpMessageHandler (.NET 8)
    dateFormat  x
    axisFormat %Q
    todayMarker off
    section Baseline
    This PR (8632) - mean (278ms)  : 273, 284
    master - mean (276ms)  : 269, 284

    section Bailout
    This PR (8632) - mean (279ms)  : 271, 287
    master - mean (276ms)  : 270, 282

    section CallTarget+Inlining+NGEN
    This PR (8632) - mean (1,039ms)  : 990, 1089
    master - mean (1,037ms)  : 988, 1086

Loading

When the IIS Worker Process exits, the OS closes its handles, the job
object's refcount drops to zero, and Windows kills datadog-trace-agent.exe
and dogstatsd.exe automatically. Prevents the orphan failure mode where
the agent survives its parent and holds the named pipe indefinitely,
locking new IIS Worker Processes out of starting their own agents.

Logs [aas-repro] job_object_create and job_object_assign so the behavior
is observable in the live repro and in production.

Co-Authored-By: Claude Opus 4.7 (1M context) <noreply@anthropic.com>
@pr-commenter

pr-commenter Bot commented May 14, 2026

Copy link
Copy Markdown

Benchmarks

Benchmark execution time: 2026-05-15 18:13:37

Comparing candidate commit b88ca09 in PR branch lewis.lewis/aas-repro-diagnostics-dotnet with baseline commit 856ceba in branch master.

Some scenarios are present only in baseline or only in candidate runs. If you didn't create or remove some scenarios in your branch, this maybe a sign of crashed benchmarks 💥💥💥
Check Gitlab CI job log to find if any benchmark has crashed.

Scenarios present only in baseline:

  • Benchmarks.OpenTelemetry.Api.Trace.ActivityBenchmark.StartSpan_SetStatus_Sampled netcoreapp3.1
  • Benchmarks.OpenTelemetry.Api.Trace.TelemetrySpanBenchmark.StartSpan_SetAttributes_Sampled netcoreapp3.1
  • Benchmarks.OpenTelemetry.Api.Trace.TelemetrySpanBenchmark.StartSpan_AddEvent_Sampled net472
  • Benchmarks.OpenTelemetry.Api.Trace.TelemetrySpanBenchmark.StartSpan_RecordException_Sampled net6.0
  • Benchmarks.OpenTelemetry.Api.Trace.TelemetrySpanBenchmark.StartSpan_RecordException_Sampled net472
  • Benchmarks.OpenTelemetry.Api.Trace.ActivityBenchmark.StartSpan_GetContext_Sampled net472
  • Benchmarks.OpenTelemetry.Api.Trace.TelemetrySpanBenchmark.StartSpan net6.0
  • Benchmarks.OpenTelemetry.Api.Trace.TelemetrySpanBenchmark.StartSpan_SetStatus_Sampled netcoreapp3.1
  • Benchmarks.OpenTelemetry.Api.Trace.ActivityBenchmark.StartSpan_SetStatus_Sampled net6.0
  • Benchmarks.OpenTelemetry.Api.Trace.TelemetrySpanBenchmark.StartSpan_GetContext_Sampled net6.0
  • Benchmarks.OpenTelemetry.Api.Trace.ActivityBenchmark.StartSpan_UpdateName_Sampled net472
  • Benchmarks.OpenTelemetry.Api.Trace.TelemetrySpanBenchmark.StartSpan net472
  • Benchmarks.OpenTelemetry.Api.Trace.ActivityBenchmark.StartSpan_AddEvent_Sampled net472
  • Benchmarks.OpenTelemetry.Api.Trace.TelemetrySpanBenchmark.StartSpan_AddEvent_Sampled netcoreapp3.1
  • Benchmarks.OpenTelemetry.Api.Trace.TelemetrySpanBenchmark.StartSpan_SetStatus_Sampled net472
  • Benchmarks.OpenTelemetry.Api.Trace.TelemetrySpanBenchmark.StartSpan_SetStatus_Sampled net6.0
  • Benchmarks.OpenTelemetry.Api.Trace.TelemetrySpanBenchmark.StartSpan_UpdateName_Sampled netcoreapp3.1
  • Benchmarks.OpenTelemetry.Api.Trace.ActivityBenchmark.StartSpan_SetAttributes_Sampled net472
  • Benchmarks.OpenTelemetry.Api.Trace.ActivityBenchmark.StartSpan_SetAttributes_Sampled netcoreapp3.1
  • Benchmarks.OpenTelemetry.Api.Trace.TelemetrySpanBenchmark.StartSpan_GetContext_Sampled netcoreapp3.1
  • Benchmarks.OpenTelemetry.Api.Trace.TelemetrySpanBenchmark.StartSpan_SetAttributes_Sampled net6.0
  • Benchmarks.OpenTelemetry.Api.Trace.ActivityBenchmark.StartSpan net6.0
  • Benchmarks.OpenTelemetry.Api.Trace.ActivityBenchmark.StartSpan_UpdateName_Sampled netcoreapp3.1
  • Benchmarks.OpenTelemetry.Api.Trace.ActivityBenchmark.StartSpan netcoreapp3.1
  • Benchmarks.OpenTelemetry.Api.Trace.ActivityBenchmark.StartSpan_GetContext_Sampled net6.0
  • Benchmarks.OpenTelemetry.Api.Trace.TelemetrySpanBenchmark.StartSpan netcoreapp3.1
  • Benchmarks.OpenTelemetry.Api.Trace.ActivityBenchmark.StartSpan_AddEvent_Sampled netcoreapp3.1
  • Benchmarks.OpenTelemetry.Api.Trace.ActivityBenchmark.StartSpan_AddEvent_Sampled net6.0
  • Benchmarks.OpenTelemetry.Api.Trace.ActivityBenchmark.StartSpan net472
  • Benchmarks.OpenTelemetry.Api.Trace.TelemetrySpanBenchmark.StartSpan_UpdateName_Sampled net472
  • Benchmarks.OpenTelemetry.Api.Trace.ActivityBenchmark.StartSpan_GetContext_Sampled netcoreapp3.1
  • Benchmarks.OpenTelemetry.Api.Trace.ActivityBenchmark.StartSpan_SetAttributes_Sampled net6.0
  • Benchmarks.OpenTelemetry.Api.Trace.TelemetrySpanBenchmark.StartSpan_UpdateName_Sampled net6.0
  • Benchmarks.OpenTelemetry.Api.Trace.ActivityBenchmark.StartSpan_SetStatus_Sampled net472
  • Benchmarks.OpenTelemetry.Api.Trace.TelemetrySpanBenchmark.StartSpan_SetAttributes_Sampled net472
  • Benchmarks.OpenTelemetry.Api.Trace.ActivityBenchmark.StartSpan_UpdateName_Sampled net6.0
  • Benchmarks.OpenTelemetry.Api.Trace.TelemetrySpanBenchmark.StartSpan_AddEvent_Sampled net6.0
  • Benchmarks.OpenTelemetry.Api.Trace.TelemetrySpanBenchmark.StartSpan_RecordException_Sampled netcoreapp3.1
  • Benchmarks.OpenTelemetry.Api.Trace.TelemetrySpanBenchmark.StartSpan_GetContext_Sampled net472

Found 4 performance improvements and 4 performance regressions! Performance is the same for 47 metrics, 17 unstable metrics, 88 known flaky benchmarks, 38 flaky benchmarks without significant changes.

Explanation

This is an A/B test comparing a candidate commit's performance against that of a baseline commit. Performance changes are noted in the tables below as:

  • 🟩 = significantly better candidate vs. baseline
  • 🟥 = significantly worse candidate vs. baseline

We compute a confidence interval (CI) over the relative difference of means between metrics from the candidate and baseline commits, considering the baseline as the reference.

If the CI is entirely outside the configured SIGNIFICANT_IMPACT_THRESHOLD (or the deprecated UNCONFIDENCE_THRESHOLD), the change is considered significant.

Feel free to reach out to #apm-benchmarking-platform on Slack if you have any questions.

More details about the CI and significant changes

You can imagine this CI as a range of values that is likely to contain the true difference of means between the candidate and baseline commits.

CIs of the difference of means are often centered around 0%, because often changes are not that big:

---------------------------------(------|---^--------)-------------------------------->
                              -0.6%    0%  0.3%     +1.2%
                                 |          |        |
         lower bound of the CI --'          |        |
sample mean (center of the CI) -------------'        |
         upper bound of the CI ----------------------'

As described above, a change is considered significant if the CI is entirely outside the configured SIGNIFICANT_IMPACT_THRESHOLD (or the deprecated UNCONFIDENCE_THRESHOLD).

For instance, for an execution time metric, this confidence interval indicates a significantly worse performance:

----------------------------------------|---------|---(---------^---------)---------->
                                       0%        1%  1.3%      2.2%      3.1%
                                                  |   |         |         |
       significant impact threshold --------------'   |         |         |
                      lower bound of CI --------------'         |         |
       sample mean (center of the CI) --------------------------'         |
                      upper bound of CI ----------------------------------'

scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.TracerBenchmark.StartActiveSpan net6.0

  • 🟥 allocated_mem [+143 bytes; +144 bytes] or [+10.108%; +10.117%]

scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.TracerBenchmark.StartRootSpan net6.0

  • 🟩 allocated_mem [-144 bytes; -143 bytes] or [-9.188%; -9.180%]

scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.TracerBenchmark.StartSpan_GetCurrentSpan net6.0

  • 🟥 allocated_mem [+143 bytes; +144 bytes] or [+10.108%; +10.117%]

scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.TracerBenchmark.StartSpan_SetActive net6.0

  • 🟩 allocated_mem [-144 bytes; -143 bytes] or [-7.321%; -7.312%]

scenario:Benchmarks.Trace.DbCommandBenchmark.ExecuteNonQuery net6.0

  • 🟩 execution_time [-117.558ms; -111.205ms] or [-58.921%; -55.737%]

scenario:Benchmarks.Trace.HttpClientBenchmark.SendAsync net6.0

  • 🟥 throughput [-55377.305op/s; -54572.180op/s] or [-37.619%; -37.072%]
  • 🟩 execution_time [-60.166ms; -57.773ms] or [-29.857%; -28.669%]

scenario:Benchmarks.Trace.NLogBenchmark.EnrichedLog net6.0

  • 🟥 throughput [-62097.163op/s; -45544.928op/s] or [-31.136%; -22.836%]

Known flaky benchmarks

These benchmarks are marked as flaky and will not trigger a failure. Modify FLAKY_BENCHMARKS_REGEX to control which benchmarks are marked as flaky.

scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.ActivityBenchmark.StartSpan net6.0

  • unstable execution_time [-30.959ms; -2.798ms] or [-20.223%; -1.828%]
  • 🟩 throughput [+8926.746op/s; +25587.205op/s] or [+5.055%; +14.490%]

scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.ActivityBenchmark.StartSpan netcoreapp3.1

  • unstable execution_time [-17901.553µs; +16578.617µs] or [-15.775%; +14.609%]

scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.ActivityBenchmark.StartSpan_AddEvent_Sampled net6.0

  • unstable execution_time [-21.120ms; +18.899ms] or [-13.689%; +12.250%]
  • unstable throughput [-3700.657op/s; +23998.666op/s] or [-2.646%; +17.157%]

scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.ActivityBenchmark.StartSpan_AddEvent_Sampled netcoreapp3.1

  • unstable execution_time [-34.380ms; -9.248ms] or [-30.876%; -8.305%]

scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.ActivityBenchmark.StartSpan_GetContext_Sampled net6.0

  • unstable execution_time [+12.034ms; +49.815ms] or [+7.736%; +32.024%]
  • unstable throughput [-35082.024op/s; -6976.450op/s] or [-20.326%; -4.042%]

scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.ActivityBenchmark.StartSpan_GetContext_Sampled netcoreapp3.1

  • unstable execution_time [-40.794ms; -2.031ms] or [-22.970%; -1.144%]

scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.ActivityBenchmark.StartSpan_SetAttributes_Sampled net6.0

  • unstable execution_time [+9.554ms; +43.570ms] or [+6.409%; +29.227%]
  • unstable throughput [-22847.742op/s; -2963.813op/s] or [-17.404%; -2.258%]

scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.ActivityBenchmark.StartSpan_SetAttributes_Sampled netcoreapp3.1

  • unstable execution_time [+49.786ms; +80.881ms] or [+53.973%; +87.682%]

scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.ActivityBenchmark.StartSpan_SetStatus_Sampled net6.0

  • unstable execution_time [-76.101ms; -43.650ms] or [-41.502%; -23.805%]
  • unstable throughput [+37022.098op/s; +61603.827op/s] or [+25.999%; +43.261%]

scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.ActivityBenchmark.StartSpan_SetStatus_Sampled netcoreapp3.1

  • unstable execution_time [+13.291ms; +38.825ms] or [+15.042%; +43.942%]

scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.ActivityBenchmark.StartSpan_UpdateName_Sampled net6.0

  • unstable execution_time [+10.144ms; +43.064ms] or [+8.388%; +35.610%]
  • unstable throughput [-15188.353op/s; +20643.500op/s] or [-7.810%; +10.616%]

scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.ActivityBenchmark.StartSpan_UpdateName_Sampled netcoreapp3.1

  • unstable execution_time [+8.820ms; +33.837ms] or [+9.730%; +37.328%]

scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.TelemetrySpanBenchmark.StartSpan net6.0

  • 🟥 allocated_mem [+143 bytes; +144 bytes] or [+10.108%; +10.117%]
  • unstable execution_time [+5.749ms; +52.764ms] or [+3.748%; +34.399%]
  • unstable throughput [-28003.344op/s; +2768.156op/s] or [-17.437%; +1.724%]

scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.TelemetrySpanBenchmark.StartSpan_AddEvent_Sampled net6.0

  • 🟥 allocated_mem [+143 bytes; +144 bytes] or [+8.332%; +8.340%]
  • unstable throughput [+4208.255op/s; +24378.287op/s] or [+2.764%; +16.012%]

scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.TelemetrySpanBenchmark.StartSpan_AddEvent_Sampled netcoreapp3.1

  • unstable execution_time [-20.493ms; +23.339ms] or [-15.670%; +17.845%]

scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.TelemetrySpanBenchmark.StartSpan_GetContext_Sampled net6.0

  • 🟥 allocated_mem [+143 bytes; +144 bytes] or [+10.108%; +10.117%]
  • unstable execution_time [+21.750ms; +64.374ms] or [+15.734%; +46.568%]
  • unstable throughput [-39672.252op/s; -8509.708op/s] or [-24.778%; -5.315%]

scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.TelemetrySpanBenchmark.StartSpan_RecordException_Sampled net6.0

  • unstable execution_time [-26.347ms; +10.397ms] or [-17.925%; +7.074%]
  • unstable throughput [-4305.773op/s; +21735.146op/s] or [-4.168%; +21.038%]

scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.TelemetrySpanBenchmark.StartSpan_RecordException_Sampled netcoreapp3.1

  • unstable execution_time [+25.939ms; +58.706ms] or [+29.130%; +65.927%]

scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.TelemetrySpanBenchmark.StartSpan_SetAttributes_Sampled net6.0

  • unstable execution_time [-57.696ms; -28.973ms] or [-32.159%; -16.149%]
  • unstable throughput [+17919.888op/s; +32205.540op/s] or [+16.722%; +30.053%]

scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.TelemetrySpanBenchmark.StartSpan_SetStatus_Sampled net6.0

  • unstable execution_time [+20.948ms; +41.005ms] or [+16.559%; +32.414%]

scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.TelemetrySpanBenchmark.StartSpan_SetStatus_Sampled netcoreapp3.1

  • unstable execution_time [+1.740ms; +43.215ms] or [+1.607%; +39.915%]

scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.TelemetrySpanBenchmark.StartSpan_UpdateName_Sampled net6.0

  • 🟩 allocated_mem [-144 bytes; -143 bytes] or [-9.188%; -9.180%]
  • unstable execution_time [-33.441ms; -6.596ms] or [-21.324%; -4.206%]
  • 🟩 throughput [+14771.861op/s; +30798.595op/s] or [+9.086%; +18.944%]

scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.TelemetrySpanBenchmark.StartSpan_UpdateName_Sampled netcoreapp3.1

  • unstable execution_time [-41.958ms; -3.669ms] or [-31.467%; -2.752%]

scenario:Benchmarks.Trace.ActivityBenchmark.StartStopWithChild net472

  • 🟥 throughput [-8742.136op/s; -8059.265op/s] or [-10.366%; -9.556%]

scenario:Benchmarks.Trace.ActivityBenchmark.StartStopWithChild net6.0

  • unstable execution_time [-75.081ms; -54.070ms] or [-37.458%; -26.976%]
  • unstable throughput [-40804.099op/s; -27792.074op/s] or [-34.297%; -23.360%]

scenario:Benchmarks.Trace.ActivityBenchmark.StartStopWithChild netcoreapp3.1

  • unstable execution_time [-72.041ms; -44.398ms] or [-36.234%; -22.331%]

scenario:Benchmarks.Trace.AgentWriterBenchmark.WriteAndFlushEnrichedTraces net472

  • 🟥 execution_time [+311.676ms; +327.618ms] or [+154.665%; +162.576%]
  • 🟥 throughput [-57.728op/s; -44.900op/s] or [-10.386%; -8.078%]

scenario:Benchmarks.Trace.AgentWriterBenchmark.WriteAndFlushEnrichedTraces net6.0

  • 🟥 execution_time [+99.449ms; +101.815ms] or [+78.571%; +80.440%]
  • 🟩 throughput [+82.603op/s; +91.149op/s] or [+10.891%; +12.018%]

scenario:Benchmarks.Trace.AgentWriterBenchmark.WriteAndFlushEnrichedTraces netcoreapp3.1

  • 🟥 execution_time [+84.569ms; +86.726ms] or [+74.840%; +76.749%]

scenario:Benchmarks.Trace.Asm.AppSecBodyBenchmark.AllCycleMoreComplexBody net472

  • 🟥 allocated_mem [+1.308KB; +1.308KB] or [+27.528%; +27.540%]

scenario:Benchmarks.Trace.Asm.AppSecBodyBenchmark.AllCycleMoreComplexBody net6.0

  • 🟥 allocated_mem [+439 bytes; +440 bytes] or [+9.299%; +9.310%]
  • unstable execution_time [-49.425ms; -26.852ms] or [-23.083%; -12.541%]
  • unstable throughput [-32721.253op/s; -18157.947op/s] or [-23.885%; -13.254%]

scenario:Benchmarks.Trace.Asm.AppSecBodyBenchmark.AllCycleMoreComplexBody netcoreapp3.1

  • 🟥 allocated_mem [+1.272KB; +1.272KB] or [+27.500%; +27.510%]
  • 🟩 execution_time [-47.428ms; -27.108ms] or [-22.585%; -12.909%]

scenario:Benchmarks.Trace.Asm.AppSecBodyBenchmark.AllCycleSimpleBody net472

  • 🟥 allocated_mem [+1.307KB; +1.307KB] or [+105.743%; +105.758%]
  • 🟥 throughput [-280541.045op/s; -273932.857op/s] or [-28.645%; -27.970%]

scenario:Benchmarks.Trace.Asm.AppSecBodyBenchmark.AllCycleSimpleBody net6.0

  • 🟥 allocated_mem [+439 bytes; +440 bytes] or [+35.945%; +35.954%]
  • unstable execution_time [-92.106ms; -66.897ms] or [-41.075%; -29.833%]
  • unstable throughput [-267940.457op/s; -158183.220op/s] or [-28.624%; -16.899%]

scenario:Benchmarks.Trace.Asm.AppSecBodyBenchmark.AllCycleSimpleBody netcoreapp3.1

  • 🟥 allocated_mem [+1.272KB; +1.272KB] or [+105.288%; +105.304%]
  • 🟩 execution_time [-89.248ms; -84.602ms] or [-44.549%; -42.230%]
  • 🟥 throughput [-145787.945op/s; -129565.369op/s] or [-20.947%; -18.616%]

scenario:Benchmarks.Trace.Asm.AppSecBodyBenchmark.ObjectExtractorMoreComplexBody net6.0

  • 🟩 execution_time [-51.447ms; -34.401ms] or [-25.958%; -17.357%]

scenario:Benchmarks.Trace.Asm.AppSecBodyBenchmark.ObjectExtractorMoreComplexBody netcoreapp3.1

  • 🟩 execution_time [-69.053ms; -65.068ms] or [-35.206%; -33.174%]
  • 🟩 throughput [+9825.181op/s; +12460.456op/s] or [+7.827%; +9.926%]

scenario:Benchmarks.Trace.Asm.AppSecBodyBenchmark.ObjectExtractorSimpleBody net6.0

  • 🟩 execution_time [-69.153ms; -52.571ms] or [-34.191%; -25.992%]

scenario:Benchmarks.Trace.Asm.AppSecBodyBenchmark.ObjectExtractorSimpleBody netcoreapp3.1

  • 🟩 execution_time [-45.125ms; -23.731ms] or [-20.801%; -10.939%]
  • 🟩 throughput [+157576.414op/s; +213899.204op/s] or [+6.255%; +8.490%]

scenario:Benchmarks.Trace.Asm.AppSecEncoderBenchmark.EncodeArgs net472

  • 🟥 execution_time [+301.683ms; +315.937ms] or [+150.741%; +157.863%]

scenario:Benchmarks.Trace.Asm.AppSecEncoderBenchmark.EncodeArgs net6.0

  • 🟥 execution_time [+128.425ms; +135.923ms] or [+64.765%; +68.546%]

scenario:Benchmarks.Trace.Asm.AppSecEncoderBenchmark.EncodeArgs netcoreapp3.1

  • unstable execution_time [+182.978ms; +228.778ms] or [+92.170%; +115.240%]

scenario:Benchmarks.Trace.Asm.AppSecEncoderBenchmark.EncodeLegacyArgs net472

  • 🟥 execution_time [+297.807ms; +311.486ms] or [+146.271%; +152.990%]

scenario:Benchmarks.Trace.Asm.AppSecEncoderBenchmark.EncodeLegacyArgs net6.0

  • 🟥 execution_time [+253.357ms; +272.861ms] or [+123.857%; +133.392%]

scenario:Benchmarks.Trace.Asm.AppSecEncoderBenchmark.EncodeLegacyArgs netcoreapp3.1

  • 🟥 execution_time [+302.855ms; +308.699ms] or [+151.366%; +154.287%]

scenario:Benchmarks.Trace.Asm.AppSecWafBenchmark.RunWafRealisticBenchmarkWithAttack net6.0

  • 🟥 allocated_mem [+24.632KB; +24.633KB] or [+1099.639%; +1099.708%]
  • 🟥 execution_time [+17.402µs; +41.015µs] or [+5.556%; +13.094%]
  • 🟥 throughput [-386.732op/s; -187.979op/s] or [-12.056%; -5.860%]

scenario:Benchmarks.Trace.AspNetCoreBenchmark.SendRequest net472

  • 🟥 execution_time [+300.287ms; +301.334ms] or [+149.874%; +150.396%]

scenario:Benchmarks.Trace.AspNetCoreBenchmark.SendRequest net6.0

  • unstable execution_time [+365.717ms; +390.727ms] or [+397.366%; +424.541%]
  • 🟥 throughput [-7012.747op/s; -6748.376op/s] or [-57.625%; -55.452%]

scenario:Benchmarks.Trace.AspNetCoreBenchmark.SendRequest netcoreapp3.1

  • unstable execution_time [+300.676ms; +348.839ms] or [+228.300%; +264.870%]
  • 🟥 throughput [-1202.166op/s; -985.917op/s] or [-11.638%; -9.544%]

scenario:Benchmarks.Trace.CIVisibilityProtocolWriterBenchmark.WriteAndFlushEnrichedTraces net472

  • 🟥 execution_time [+295.170ms; +309.574ms] or [+135.716%; +142.339%]
  • 🟥 throughput [-680.227op/s; -663.398op/s] or [-61.635%; -60.110%]

scenario:Benchmarks.Trace.CIVisibilityProtocolWriterBenchmark.WriteAndFlushEnrichedTraces net6.0

  • unstable execution_time [-40.546ms; +93.617ms] or [-17.279%; +39.896%]
  • 🟥 throughput [-729.650op/s; -633.653op/s] or [-48.668%; -42.265%]

scenario:Benchmarks.Trace.CIVisibilityProtocolWriterBenchmark.WriteAndFlushEnrichedTraces netcoreapp3.1

  • 🟥 allocated_mem [+2.305KB; +2.308KB] or [+5.442%; +5.450%]
  • 🟥 execution_time [+343.070ms; +351.411ms] or [+205.196%; +210.185%]
  • 🟥 throughput [-737.581op/s; -703.194op/s] or [-51.357%; -48.962%]

scenario:Benchmarks.Trace.CharSliceBenchmark.OptimizedCharSlice net472

  • 🟩 execution_time [-115.945µs; -100.792µs] or [-5.835%; -5.072%]
  • 🟩 throughput [+27.010op/s; +31.248op/s] or [+5.367%; +6.209%]

scenario:Benchmarks.Trace.CharSliceBenchmark.OriginalCharSlice net6.0

  • 🟩 execution_time [-213.836µs; -206.233µs] or [-10.832%; -10.447%]
  • 🟩 throughput [+59.157op/s; +61.527op/s] or [+11.678%; +12.146%]

scenario:Benchmarks.Trace.CharSliceBenchmark.OriginalCharSlice netcoreapp3.1

  • 🟩 execution_time [-238.346µs; -223.910µs] or [-6.044%; -5.678%]
  • 🟩 throughput [+15.284op/s; +16.317op/s] or [+6.027%; +6.434%]

scenario:Benchmarks.Trace.ElasticsearchBenchmark.CallElasticsearch net472

  • 🟥 execution_time [+306.468ms; +319.127ms] or [+154.331%; +160.706%]

scenario:Benchmarks.Trace.ElasticsearchBenchmark.CallElasticsearch net6.0

  • 🟥 execution_time [+225.661ms; +236.061ms] or [+113.079%; +118.290%]

scenario:Benchmarks.Trace.ElasticsearchBenchmark.CallElasticsearch netcoreapp3.1

  • 🟥 execution_time [+301.230ms; +308.102ms] or [+151.325%; +154.777%]

scenario:Benchmarks.Trace.ElasticsearchBenchmark.CallElasticsearchAsync net472

  • 🟥 execution_time [+303.990ms; +318.097ms] or [+152.654%; +159.737%]

scenario:Benchmarks.Trace.ElasticsearchBenchmark.CallElasticsearchAsync net6.0

  • unstable execution_time [+229.122ms; +257.614ms] or [+113.291%; +127.379%]

scenario:Benchmarks.Trace.ElasticsearchBenchmark.CallElasticsearchAsync netcoreapp3.1

  • 🟥 execution_time [+302.164ms; +309.418ms] or [+153.150%; +156.826%]

scenario:Benchmarks.Trace.GraphQLBenchmark.ExecuteAsync net472

  • 🟥 execution_time [+303.720ms; +314.893ms] or [+152.440%; +158.048%]

scenario:Benchmarks.Trace.GraphQLBenchmark.ExecuteAsync net6.0

  • 🟥 execution_time [+303.745ms; +311.738ms] or [+151.389%; +155.373%]
  • 🟩 throughput [+31580.363op/s; +46264.971op/s] or [+6.271%; +9.187%]

scenario:Benchmarks.Trace.GraphQLBenchmark.ExecuteAsync netcoreapp3.1

  • 🟥 execution_time [+299.181ms; +305.299ms] or [+148.840%; +151.884%]

scenario:Benchmarks.Trace.ILoggerBenchmark.EnrichedLog net6.0

  • unstable execution_time [-73.800ms; -44.127ms] or [-34.318%; -20.519%]
  • unstable throughput [-99059.121op/s; -49021.691op/s] or [-27.175%; -13.448%]

scenario:Benchmarks.Trace.ILoggerBenchmark.EnrichedLog netcoreapp3.1

  • unstable execution_time [-92.307ms; -68.821ms] or [-46.303%; -34.522%]

scenario:Benchmarks.Trace.Iast.StringAspectsBenchmark.StringConcatAspectBenchmark net6.0

  • 🟩 allocated_mem [-25.870KB; -25.847KB] or [-9.437%; -9.429%]
  • unstable execution_time [-64.054µs; -9.460µs] or [-12.660%; -1.870%]

scenario:Benchmarks.Trace.Iast.StringAspectsBenchmark.StringConcatAspectBenchmark netcoreapp3.1

  • 🟩 allocated_mem [-15.944KB; -15.922KB] or [-5.812%; -5.804%]
  • 🟩 throughput [+103.505op/s; +254.454op/s] or [+5.913%; +14.537%]

scenario:Benchmarks.Trace.Iast.StringAspectsBenchmark.StringConcatBenchmark net6.0

  • unstable execution_time [+1.833µs; +6.241µs] or [+4.333%; +14.753%]

scenario:Benchmarks.Trace.Iast.StringAspectsBenchmark.StringConcatBenchmark netcoreapp3.1

  • unstable execution_time [-14.476µs; -5.158µs] or [-22.459%; -8.002%]
  • unstable throughput [+1595.177op/s; +3572.956op/s] or [+9.787%; +21.921%]

scenario:Benchmarks.Trace.Log4netBenchmark.EnrichedLog net472

  • 🟥 execution_time [+302.139ms; +316.361ms] or [+152.718%; +159.906%]

scenario:Benchmarks.Trace.Log4netBenchmark.EnrichedLog net6.0

  • unstable execution_time [+261.922ms; +284.225ms] or [+133.317%; +144.669%]

scenario:Benchmarks.Trace.Log4netBenchmark.EnrichedLog netcoreapp3.1

  • 🟥 execution_time [+299.927ms; +305.797ms] or [+150.151%; +153.089%]

scenario:Benchmarks.Trace.RedisBenchmark.SendReceive net6.0

  • unstable execution_time [-82.874ms; -54.321ms] or [-41.424%; -27.152%]
  • unstable throughput [-152012.010op/s; -76875.603op/s] or [-28.773%; -14.551%]

scenario:Benchmarks.Trace.RedisBenchmark.SendReceive netcoreapp3.1

  • unstable execution_time [-30.438ms; -5.867ms] or [-15.429%; -2.974%]

scenario:Benchmarks.Trace.SerilogBenchmark.EnrichedLog net472

  • 🟥 execution_time [+298.935ms; +308.597ms] or [+148.992%; +153.808%]

scenario:Benchmarks.Trace.SerilogBenchmark.EnrichedLog net6.0

  • unstable execution_time [+196.834ms; +255.309ms] or [+98.841%; +128.204%]

scenario:Benchmarks.Trace.SerilogBenchmark.EnrichedLog netcoreapp3.1

  • 🟥 execution_time [+305.612ms; +311.968ms] or [+154.987%; +158.210%]

scenario:Benchmarks.Trace.SingleSpanAspNetCoreBenchmark.SingleSpanAspNetCore net472

  • 🟥 execution_time [+299.616ms; +300.452ms] or [+149.450%; +149.867%]
  • 🟩 throughput [+64757148.103op/s; +65074302.302op/s] or [+47.160%; +47.391%]

scenario:Benchmarks.Trace.SingleSpanAspNetCoreBenchmark.SingleSpanAspNetCore net6.0

  • unstable execution_time [+371.505ms; +383.265ms] or [+462.032%; +476.658%]
  • 🟥 throughput [-7387.755op/s; -7187.725op/s] or [-57.111%; -55.565%]

scenario:Benchmarks.Trace.SingleSpanAspNetCoreBenchmark.SingleSpanAspNetCore netcoreapp3.1

  • 🟥 execution_time [+297.704ms; +299.764ms] or [+148.488%; +149.515%]
  • 🟥 throughput [-18177857.695op/s; -16979788.629op/s] or [-8.052%; -7.521%]

scenario:Benchmarks.Trace.SpanBenchmark.StartFinishScope net6.0

  • 🟩 execution_time [-104.719ms; -103.490ms] or [-51.289%; -50.688%]
  • 🟩 throughput [+86392.524op/s; +94011.473op/s] or [+8.066%; +8.778%]

scenario:Benchmarks.Trace.SpanBenchmark.StartFinishScope netcoreapp3.1

  • unstable execution_time [-90.123ms; -68.731ms] or [-45.603%; -34.778%]

scenario:Benchmarks.Trace.SpanBenchmark.StartFinishSpan net6.0

  • unstable execution_time [-83.648ms; -63.095ms] or [-43.581%; -32.873%]
  • unstable throughput [-105613.870op/s; +43462.106op/s] or [-8.175%; +3.364%]

scenario:Benchmarks.Trace.SpanBenchmark.StartFinishSpan netcoreapp3.1

  • unstable execution_time [-76.646ms; -48.883ms] or [-37.658%; -24.017%]
  • 🟩 throughput [+81791.033op/s; +93331.712op/s] or [+8.123%; +9.269%]

scenario:Benchmarks.Trace.SpanBenchmark.StartFinishTwoScopes net6.0

  • unstable execution_time [-72.742ms; -45.915ms] or [-36.327%; -22.930%]
  • unstable throughput [-37018.218op/s; +26088.633op/s] or [-6.722%; +4.737%]

scenario:Benchmarks.Trace.SpanBenchmark.StartFinishTwoScopes netcoreapp3.1

  • unstable execution_time [-71.036ms; -43.476ms] or [-35.691%; -21.844%]

scenario:Benchmarks.Trace.TraceAnnotationsBenchmark.RunOnMethodBegin net6.0

  • unstable execution_time [-56.418ms; -19.803ms] or [-28.219%; -9.905%]
  • unstable throughput [-323117.695op/s; -164982.370op/s] or [-36.100%; -18.433%]

Known flaky benchmarks without significant changes:

  • scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.ActivityBenchmark.StartSpan net472
  • scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.ActivityBenchmark.StartSpan_AddEvent_Sampled net472
  • scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.ActivityBenchmark.StartSpan_GetContext_Sampled net472
  • scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.ActivityBenchmark.StartSpan_SetAttributes_Sampled net472
  • scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.ActivityBenchmark.StartSpan_SetStatus_Sampled net472
  • scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.ActivityBenchmark.StartSpan_UpdateName_Sampled net472
  • scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.TelemetrySpanBenchmark.StartSpan net472
  • scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.TelemetrySpanBenchmark.StartSpan netcoreapp3.1
  • scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.TelemetrySpanBenchmark.StartSpan_AddEvent_Sampled net472
  • scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.TelemetrySpanBenchmark.StartSpan_GetContext_Sampled net472
  • scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.TelemetrySpanBenchmark.StartSpan_GetContext_Sampled netcoreapp3.1
  • scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.TelemetrySpanBenchmark.StartSpan_RecordException_Sampled net472
  • scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.TelemetrySpanBenchmark.StartSpan_SetAttributes_Sampled net472
  • scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.TelemetrySpanBenchmark.StartSpan_SetAttributes_Sampled netcoreapp3.1
  • scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.TelemetrySpanBenchmark.StartSpan_SetStatus_Sampled net472
  • scenario:Benchmarks.OpenTelemetry.InstrumentedApi.Trace.TelemetrySpanBenchmark.StartSpan_UpdateName_Sampled net472
  • scenario:Benchmarks.Trace.Asm.AppSecBodyBenchmark.ObjectExtractorMoreComplexBody net472
  • scenario:Benchmarks.Trace.Asm.AppSecBodyBenchmark.ObjectExtractorSimpleBody net472
  • scenario:Benchmarks.Trace.Asm.AppSecWafBenchmark.RunWafRealisticBenchmark net472
  • scenario:Benchmarks.Trace.Asm.AppSecWafBenchmark.RunWafRealisticBenchmark net6.0
  • scenario:Benchmarks.Trace.Asm.AppSecWafBenchmark.RunWafRealisticBenchmark netcoreapp3.1
  • scenario:Benchmarks.Trace.Asm.AppSecWafBenchmark.RunWafRealisticBenchmarkWithAttack net472
  • scenario:Benchmarks.Trace.Asm.AppSecWafBenchmark.RunWafRealisticBenchmarkWithAttack netcoreapp3.1
  • scenario:Benchmarks.Trace.CharSliceBenchmark.OptimizedCharSlice net6.0
  • scenario:Benchmarks.Trace.CharSliceBenchmark.OptimizedCharSlice netcoreapp3.1
  • scenario:Benchmarks.Trace.CharSliceBenchmark.OptimizedCharSliceWithPool net472
  • scenario:Benchmarks.Trace.CharSliceBenchmark.OptimizedCharSliceWithPool net6.0
  • scenario:Benchmarks.Trace.CharSliceBenchmark.OptimizedCharSliceWithPool netcoreapp3.1
  • scenario:Benchmarks.Trace.CharSliceBenchmark.OriginalCharSlice net472
  • scenario:Benchmarks.Trace.ILoggerBenchmark.EnrichedLog net472
  • scenario:Benchmarks.Trace.Iast.StringAspectsBenchmark.StringConcatAspectBenchmark net472
  • scenario:Benchmarks.Trace.Iast.StringAspectsBenchmark.StringConcatBenchmark net472
  • scenario:Benchmarks.Trace.RedisBenchmark.SendReceive net472
  • scenario:Benchmarks.Trace.SpanBenchmark.StartFinishScope net472
  • scenario:Benchmarks.Trace.SpanBenchmark.StartFinishSpan net472
  • scenario:Benchmarks.Trace.SpanBenchmark.StartFinishTwoScopes net472
  • scenario:Benchmarks.Trace.TraceAnnotationsBenchmark.RunOnMethodBegin net472
  • scenario:Benchmarks.Trace.TraceAnnotationsBenchmark.RunOnMethodBegin netcoreapp3.1

Explicit [aas-repro]-tagged logs for the MaxFailures terminal state and
keep-alive task exit. Lets us grep for these signatures in H&R Block-style
incident logs to confirm or rule out the MaxFailures hypothesis.

Also threads the most-recent spawn exit code through ProcessMetadata so
sequential_failure and keep_alive_terminating include it.
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment

Labels

area:tracer The core tracer library (Datadog.Trace, does not include OpenTracing, native code, or integrations)

Projects

None yet

Development

Successfully merging this pull request may close these issues.

1 participant