Files
b409714731 Client: acknowledgement provider model and subscription acknowledgement fixes (#4899)
# Description

Fixes client subscription acknowledgement defects and replaces the
mutable event-based acknowledgement policy with an injectable,
asynchronous provider model. The latest changes in `7be912614` add
opt-in **whole-message delivery**, harden lifecycle/concurrency
behavior, and simplify acknowledgement state and wire-array
construction. Existing features and all deprecations remain in this PR.

The acknowledgement unit is one OPC UA `NotificationMessage`, not one
data change, event, downstream message, or group of Publish responses
indicated by `MoreNotifications`.

### Protocol and lifecycle fixes

- Ensure acknowledgements make progress when fewer acknowledgements are
queued than there are Publish workers.
- Honor legacy deferral on V2 and preserve deferred/in-flight
acknowledgements across retries. A throwing legacy callback restores the
original lists; a throwing provider defers the batch.
- Validate ownership before sending and after provider decisions,
including subscription removal, recreation, changed IDs and server ID
reuse. Reject detected responses from the previous owner before they
advance the replacement subscription's sequence cursor.
- Prune acknowledgements no longer retained by the server, including
servers without a retransmission queue.
- Retire one subscription's acknowledgement state without quiescing
publishing for the whole session.
- Reserve the classic engine's provider-decision slot before invoking
application code. Concurrent Publish calls cannot overwrite pending
decisions; asynchronous failures are observed and logged.
- Preserve the original outstanding lifecycle when a cancelled queue
attempt can still be queued. Retries do not create an additional
terminal outcome.
- Retire internal confirmation state synchronously, independently of
application observer progress. Observer callbacks remain asynchronous
and outside SDK locks.

### Public API and whole-message delivery

| API | Purpose |
|---|---|
| `AcknowledgementHandle` | Process-local acknowledgement identity
scoped to a subscription lifetime; avoids correlating messages solely by
subscription ID and sequence number. |
| `ISubscriptionAcknowledgementProvider` | Asynchronous, fail-closed
send/defer decisions over `ArrayOf<AcknowledgementHandle>`. |
| `ISubscriptionAcknowledgementObserver` | Terminal outcomes:
`Acknowledged`, `NotRetained`, `OwnerRetired`, or `Abandoned`, subject
to the cross-session limitation below. |
| `AcknowledgementMode.AfterConfirmation` /
`ISessionAcknowledgements.Confirm` | Do not acknowledge until the
application explicitly confirms processing of the complete message. |
| `ISubscriptionNotificationMessageHandler` /
`SubscriptionNotificationMessage` | Opt-in delivery of all typed
payloads in one envelope, preserving payload order, physical-partition
identity, publish time and diagnostic string table. |

- Provider configuration is available through `ManagedSessionOptions`,
fluent builder methods and DI registration.
- Whole-message handlers are registered through the V2 subscription APIs
or `Subscription.NotificationMessageHandler` on the classic engine.
Existing load/restore factories can return handlers implementing both
notification interfaces.
- Whole-message handling replaces data/event callbacks only for the
opted-in subscription; keep-alive and lifecycle handling remain
available. Returning from the handler does not implicitly confirm
delivery.
- Projection arrays do not borrow pooled wire notification containers.
Monitored-item references remain live SDK objects.
- Whole-message handlers receive shutdown cancellation before
subscription retirement waits for their dispatch to finish.
- Managed model-change tracking owns a dedicated whole-message
subscription instead of sharing application streaming acknowledgement
ownership. It confirms only after all events succeed; namespace-refresh,
cache-invalidation and subscriber failures remain logged but do not
produce a success confirmation.

### Compatibility and deprecations

The following deprecations remain, with compatibility behavior
preserved:

- `ISession.PublishSequenceNumbersToAcknowledge`: honored when no
provider is configured; not raised when a provider owns the policy.
- Classic `FastDataChangeCallback`, `FastEventCallback`,
`FastKeepAliveCallback` and their delegate types.
- `ISession.DefaultSubscription` and its implementations.

The lifetime proposal from the closed PR #4901 is incorporated through
the provider/handle model rather than additional lifecycle events.

### Simplification and performance scope

- Pending acknowledgements derive owner and generation from their scope
rather than storing redundant copies.
- Wire acknowledgements are projected directly into the final array,
eliminating the intermediate converted list and its extra copy.
- Whole-message envelopes are constructed only for opted-in handlers.
The existing payload-callback path remains available.
- Handles reuse cached subscription-lifetime scopes. Provider callbacks
execute outside SDK locks.

This is not a benchmarked throughput or allocation-parity claim. Broader
lock/contention work, provider-path allocations and benchmark evidence
remain tracked by #4912.

### Known limitations and non-goals

- **#4929 remains open:** classic subscriptions served by the default V2
compatibility bridge do not yet participate in normal acknowledgement
tracking. Supporting the classic engine is not the same as fixing that
bridge.
- **#4930 remains open:** transferring a classic subscription between
different `Session` objects does not yet move tracked
acknowledgements/confirmations between engines. Duplicate terminal
reports or lost confirmations remain possible on that path. In-place
managed-session recreation is a different, supported path.
- Delaying protocol acknowledgement is not itself downstream retry or
durable storage. Applications still own downstream retry/buffering;
server retransmission queues are finite.
- External observer delivery is buffered. Slow observers can grow their
notification backlog, although they no longer retain internal
confirmation state. Disposal waits up to five seconds for callbacks; an
unresponsive observer can outlive disposal.
- HA takeover/session-continuation redesign and server-side
acknowledgement defects are not addressed here.

Documentation: [Subscriptions](docs/Subscriptions.md), [Migration
guide](docs/MigrationGuide.md), and [Model-change
tracking](docs/ModelChangeTracking.md).

### Validation

Local validation of the changes included in `7be912614`:

| Check | Result |
|---|---|
| Expanded net10 client regression selection | **389 passed, 0 failed, 0
skipped** |
| Final API-registration and whole-message-routing selection | **3
passed**; two overlap the regression selection, one is additional (**390
distinct client cases across the runs**) |
| Acknowledgement integration tests | **4 passed**: classic/V2, each
with legacy payload callbacks and whole-message handling |
| `Opc.Ua.Client` net48 build | **0 warnings, 0 errors** |
| Scoped whitespace, style and analyzer verification | Passed, including
informational severity for style/analyzers |
| Negative/revert controls | Tests reproduced the provider race, missing
whole-message routing, observer-dependent cleanup, cancelled-queue
lifecycle loss, shutdown deadlock and false model-change confirmation;
corrections were restored and positive cases passed |

<details>
<summary>Exact local test/build commands and results</summary>

Run from the repository root. Framework-specific assets must be restored
before commands using `--no-restore`; perform the net48 build last
because changing `CustomTestTarget` replaces restored assets.

```powershell
dotnet test tests\Opc.Ua.Client.Tests\Opc.Ua.Client.Tests.csproj -p:CustomTestTarget=net10.0 --framework net10.0 --no-restore --filter "FullyQualifiedName~AcknowledgementProviderTests|FullyQualifiedName~SubscriptionManagerTests|FullyQualifiedName~ClassicSubscriptionEngineTests|FullyQualifiedName~ManagedSessionAcknowledgementForwardingTests|FullyQualifiedName~AcknowledgementOptionsTests|FullyQualifiedName~SubscriptionTests|FullyQualifiedName~ModelChangeTrackerTests|FullyQualifiedName~PartitionForwardingHandlerTests|FullyQualifiedName~SessionEngineContextTests|FullyQualifiedName~DefaultSubscriptionEngineTests|FullyQualifiedName~MonitoredItemManagerTests|FullyQualifiedName~MessageProcessorTests" --logger "console;verbosity=minimal" -v quiet -nologo
# Passed: 389; failed: 0; skipped: 0.

dotnet test tests\Opc.Ua.Client.Tests\Opc.Ua.Client.Tests.csproj -p:CustomTestTarget=net10.0 --framework net10.0 --no-restore --filter "FullyQualifiedName~WholeMessageRegistrationRejectsMissingInputs|FullyQualifiedName~WholeMessageDeliveryPreservesMixedPayloadsAsync" --logger "console;verbosity=minimal" -v quiet -nologo
# Passed: 3; failed: 0; skipped: 0. Two cases overlap the previous selection.

dotnet test tests\Opc.Ua.Subscriptions.Tests\Opc.Ua.Subscriptions.Tests.csproj -p:CustomTestTarget=net10.0 --framework net10.0 --no-restore --filter "FullyQualifiedName~AcknowledgementProviderIntegrationTests" --logger "console;verbosity=minimal" -v quiet -nologo
# Passed: 4; failed: 0; skipped: 0.

dotnet build src\Opc.Ua.Client\Opc.Ua.Client.csproj -p:CustomTestTarget=net48 -p:RestoreSources=https://www.nuget.org/api/v2/ -p:NuGetAudit=false -v quiet -nologo
# Build succeeded: 0 warnings, 0 errors.
```

The v2 feed and disabled NuGet audit above were local restore
workarounds only; repository settings were not changed. CI dependency
auditing remains required.

</details>

The full `UA.slnx` net48/net10 test matrix, NativeAOT publishing/runtime
validation, fresh coverage measurements and performance benchmarks were
**not run locally for this revision**. CI and maintainer API review
remain outstanding. Historical results on `a28c12252` are not presented
as validation of the latest head.

## Related Issues

_If this is a relatively large or complex change, a design must have
been discussed in the related tracking issue and signed off (which
becomes the Architectural Decision Record (ADR))._

- Fixes #4894: acknowledgement progress, deferral/retry behavior and
ownership validation.
- Fixes #4898: injectable fail-closed decision API, with legacy
precedence preserved.
- Fixes #4913: admission of detected old-owner responses after
subscription ID reuse.

Non-closing references:

| Issue | Title / scope | Disposition |
|---|---|---|
| [#4897](https://github.com/OPCFoundation/UA-.NETStandard/issues/4897)
| Stable notification identity and terminal acknowledgement state | Core
functionality is implemented via handles/providers, with whole-message
delivery added. Keep this link non-closing until the cross-session
exception in #4930 is resolved or the issue's accepted scope is
explicitly narrowed. |
| [#4912](https://github.com/OPCFoundation/UA-.NETStandard/issues/4912)
| Reduce acknowledgement-path lock contention and allocations |
Partially advanced by state/projection simplification; broader locking
changes and benchmarks remain. |
| [#4929](https://github.com/OPCFoundation/UA-.NETStandard/issues/4929)
| Classic subscriptions on the V2 compatibility bridge | Not fixed;
separate follow-up. |
| [#4930](https://github.com/OPCFoundation/UA-.NETStandard/issues/4930)
| Cross-session classic acknowledgement handover | Not fixed; separate
follow-up and explicit limitation on terminal-outcome guarantees. |

Design rationale: [maintainer request for injectable providers and
session
facets](https://github.com/OPCFoundation/UA-.NETStandard/pull/4899#discussion_r4366515418).
The new whole-message API is submitted for maintainer review; this
description does not claim that its final API shape or an ADR has been
signed off.

## Checklist

- [x] I have signed the
[CLA](https://opcfoundation.org/license/cla/ContributorLicenseAgreementv1.0.pdf)
and read the
[CONTRIBUTING](https://github.com/OPCFoundation/UA-.NETStandard/blob/master/CONTRIBUTING.md)
doc.
- [x] I have added tests that prove my fix is effective or that my
feature works and increased code coverage.
- [x] I have added all necessary documentation.
- [x] I have verified that my changes do not introduce (new) build or
analyzer warnings.
- [ ] I ran **all** tests locally using the **UA.slnx** solution against
at least .net **framework** and .net **10**, and all passed.
- [ ] I fixed **all** failing and flaky tests in the CI pipelines and
**all** CodeQL warnings.
- [ ] I have addressed **all** PR feedback received.

Regression tests were added and passed; the combined tests/coverage
checkbox is left open because a fresh coverage increase has not yet been
verified.

---------

Co-authored-by: Copilot <223556219+Copilot@users.noreply.github.com>
Co-authored-by: Marc Schier <marcschier@users.noreply.github.com>
Co-authored-by: Marc <marcschier@hotmail.com>
2026-10-28 13:55:20 +00:00

498 lines
21 KiB
C#

/* ========================================================================
* Copyright (c) 2005-2025 The OPC Foundation, Inc. All rights reserved.
*
* OPC Foundation MIT License 1.00
*
* Permission is hereby granted, free of charge, to any person
* obtaining a copy of this software and associated documentation
* files (the "Software"), to deal in the Software without
* restriction, including without limitation the rights to use,
* copy, modify, merge, publish, distribute, sublicense, and/or sell
* copies of the Software, and to permit persons to whom the
* Software is furnished to do so, subject to the following
* conditions:
*
* The above copyright notice and this permission notice shall be
* included in all copies or substantial portions of the Software.
* THE SOFTWARE IS PROVIDED "AS IS", WITHOUT WARRANTY OF ANY KIND,
* EXPRESS OR IMPLIED, INCLUDING BUT NOT LIMITED TO THE WARRANTIES
* OF MERCHANTABILITY, FITNESS FOR A PARTICULAR PURPOSE AND
* NONINFRINGEMENT. IN NO EVENT SHALL THE AUTHORS OR COPYRIGHT
* HOLDERS BE LIABLE FOR ANY CLAIM, DAMAGES OR OTHER LIABILITY,
* WHETHER IN AN ACTION OF CONTRACT, TORT OR OTHERWISE, ARISING
* FROM, OUT OF OR IN CONNECTION WITH THE SOFTWARE OR THE USE OR
* OTHER DEALINGS IN THE SOFTWARE.
*
* The complete license agreement can be found here:
* http://opcfoundation.org/License/MIT/1.00/
* ======================================================================*/
using System;
using System.Collections.Concurrent;
using System.Collections.Generic;
using System.Globalization;
using System.Linq;
using System.Threading;
using System.Threading.Tasks;
using NUnit.Framework;
using Opc.Ua.Client;
using Opc.Ua.Client.TestFramework;
using ISession = Opc.Ua.Client.ISession;
using Subscription = Opc.Ua.Client.Subscription;
#pragma warning disable CS0618 // tests exercise the obsolete classic API
namespace Opc.Ua.Sessions.Tests
{
/// <summary>
/// Long-running connection stability test.
/// </summary>
[TestFixture]
[SetCulture("en-us")]
[SetUICulture("en-us")]
[Category("Client")]
public class ConnectionStabilityTest : ClientTestFramework
{
/// <summary>
/// 5 minutes for CI
/// </summary>
private const int kSecurityTokenLifetimeCIMs = 5 * 60 * 1000;
/// <summary>
/// 10 seconds for local testing
/// </summary>
private const int kSecurityTokenLifetimeLocalMs = 10 * 1000;
/// <summary>
/// Report status every 60 seconds
/// </summary>
private const int kStatusReportIntervalSeconds = 60;
/// <summary>
/// Accept 95% of expected notifications (5% tolerance)
/// </summary>
private const double kNotificationToleranceRatio = 0.95;
public ConnectionStabilityTest()
: base(Utils.UriSchemeOpcTcp)
{
SupportsExternalServerUrl = true;
}
[Test]
[Explicit]
[Category("ConnectionStability")]
public async Task ShortHaulStabilityTestAsync()
{
try
{
SecurityTokenLifetime = kSecurityTokenLifetimeLocalMs;
await OneTimeSetUpAsync().ConfigureAwait(false);
// 2 minutes for local testing
await RunStabilityTestAsync(2).ConfigureAwait(false);
}
finally
{
await OneTimeTearDownAsync().ConfigureAwait(false);
}
}
[Test]
[Explicit]
[Category("ConnectionStability")]
public async Task LongHaulStabilityTestAsync()
{
try
{
SecurityTokenLifetime = kSecurityTokenLifetimeCIMs;
await OneTimeSetUpAsync().ConfigureAwait(false);
// Configurable duration for CI testing
string envValue = Environment.GetEnvironmentVariable("TEST_DURATION_MINUTES")!;
if (string.IsNullOrEmpty(envValue) ||
!int.TryParse(envValue, out int minutes) ||
minutes <= 0)
{
minutes = 90; // Default to 90 minutes for CI
}
await RunStabilityTestAsync(minutes).ConfigureAwait(false);
}
finally
{
await OneTimeTearDownAsync().ConfigureAwait(false);
}
}
/// <summary>
/// Long-running test that verifies connection stability over a configurable duration.
/// Tests that:
/// - Connection remains stable over extended period
/// - Subscriptions deliver all expected values (no message loss)
/// - Security token renewals happen correctly
/// </summary>
private async Task RunStabilityTestAsync(int testDurationMinutes)
{
// Get test duration from environment variable or use default
int testDurationSeconds = testDurationMinutes * 60;
int tokenLifetimeMs = SecurityTokenLifetime;
TestContext.Out.WriteLine(
$"Starting connection stability test for {testDurationMinutes} minutes ({testDurationSeconds} seconds)");
TestContext.Out.WriteLine(
$"Security token lifetime: {tokenLifetimeMs / 1000} seconds ({tokenLifetimeMs / 60000.0:F1} minutes)");
const int publishingInterval = 1000; // 1 second
const int writerInterval = 2000; // 2 seconds
const int samplingInterval = 500; // 500 ms
var valueChanges = new ConcurrentDictionary<NodeId, int>();
var clientHandles = new ConcurrentDictionary<uint, NodeId>();
var errors = new ConcurrentBag<string>();
ISession? session = null;
Subscription? subscription = null;
try
{
// Get nodes for subscription
IDictionary<NodeId, Type> nodeIds = GetTestSetStaticMassNumeric(Session.NamespaceUris);
if (nodeIds.Count == 0)
{
Assert.Ignore("No nodes for simulation found, ignoring test.");
}
TestContext.Out.WriteLine($"Subscribing to {nodeIds.Count} nodes.");
// Create session
session = await ClientFixture.ConnectAsync(
ServerUrl,
SecurityPolicies.Basic256Sha256).ConfigureAwait(false);
Assert.That(session, Is.Not.Null, "Failed to create session");
// Create subscription
subscription = new Subscription(session.DefaultSubscription)
{
PublishingInterval = publishingInterval,
PublishingEnabled = true,
KeepAliveCount = 10,
LifetimeCount = 100,
MaxNotificationsPerPublish = 1000,
Priority = 100
};
// Add monitored items
foreach (NodeId nodeId in nodeIds.Keys)
{
var item = new MonitoredItem(subscription.DefaultItem)
{
StartNodeId = nodeId,
AttributeId = Attributes.Value,
MonitoringMode = MonitoringMode.Reporting,
SamplingInterval = samplingInterval,
QueueSize = 10,
DiscardOldest = true
};
valueChanges.TryAdd(nodeId, 0);
clientHandles.TryAdd(item.ClientHandle, nodeId);
subscription.AddItem(item);
}
// Set up notification callback
subscription.FastDataChangeCallback = (sub, item, value) =>
{
try
{
foreach (MonitoredItemNotification notification in item.MonitoredItems)
{
if (!StatusCode.IsGood(notification.Value.StatusCode))
{
string error = $"Bad status code received: {notification.Value.StatusCode} for client handle {notification.ClientHandle}";
errors.Add(error);
TestContext.Out.WriteLine($"ERROR: {error}");
}
else if (clientHandles.TryGetValue(notification.ClientHandle, out NodeId nodeId))
{
valueChanges.AddOrUpdate(nodeId, 1, (key, count) => count + 1);
}
}
}
catch (Exception ex)
{
string error = $"Exception in data change callback: {ex.Message}";
errors.Add(error);
TestContext.Out.WriteLine($"ERROR: {error}");
}
};
// Create subscription on server
session.AddSubscription(subscription);
await subscription.CreateAsync().ConfigureAwait(false);
TestContext.Out.WriteLine($"Subscription created with {subscription.MonitoredItemCount} monitored items");
// Wait for the subscription to deliver initial values for all nodes before
// starting writes. This prevents the first few writes from being missed when
// the CI machine is under load and the subscription is still starting up.
TestContext.Out.WriteLine("Waiting for subscription to deliver initial values...");
DateTime settleDeadline = DateTime.UtcNow.AddSeconds(15);
while (valueChanges.Values.Sum() < nodeIds.Count && DateTime.UtcNow < settleDeadline)
{
await Task.Delay(200).ConfigureAwait(false);
}
int settledCount = valueChanges.Values.Sum();
TestContext.Out.WriteLine($"Subscription settled: {settledCount}/{nodeIds.Count} initial notifications received");
// Reset counters so the measurement period starts from when the subscription
// is confirmed active (initial-value notifications don't count as write-triggered).
foreach (NodeId nodeId in nodeIds.Keys)
{
valueChanges[nodeId] = 0;
}
// Create writer session
ISession writerSession = await ClientFixture.ConnectAsync(
ServerUrl,
SecurityPolicies.Basic256Sha256).ConfigureAwait(false);
Assert.That(writerSession, Is.Not.Null, "Failed to create writer session");
// Writer task - continuously write values
int writeCount = 0;
using var writerCts = new CancellationTokenSource();
var writerTask = Task.Run(async () =>
{
while (!writerCts.IsCancellationRequested)
{
writeCount++;
var nodesToWrite = new List<WriteValue>();
foreach (KeyValuePair<NodeId, Type> node in nodeIds)
{
nodesToWrite.Add(new WriteValue
{
NodeId = node.Key,
AttributeId = Attributes.Value,
Value = new DataValue(
new Variant(
Convert.ChangeType(writeCount, node.Value, CultureInfo.InvariantCulture)
)
)
});
}
try
{
await writerSession.WriteAsync(null, nodesToWrite, writerCts.Token).ConfigureAwait(false);
}
catch (ServiceResultException sre)
when (sre.StatusCode == StatusCodes.BadRequestInterrupted)
{
// BadRequestInterrupted is expected when a write is in-flight during a
// secure channel renewal. The channel renewal briefly interrupts the old
// channel before the new one activates, so this is not a test failure.
TestContext.Out.WriteLine(
$"INFO: Write interrupted during channel renewal (expected): {sre.Message}");
}
catch (Exception ex)
{
string error = $"Writer session error: {ex.Message}";
errors.Add(error);
TestContext.Out.WriteLine($"ERROR: {error}");
}
try
{
await Task.Delay(writerInterval, writerCts.Token).ConfigureAwait(false);
}
catch (OperationCanceledException)
{
break;
}
}
TestContext.Out.WriteLine($"Writer task completed. Total writes: {writeCount}");
}, writerCts.Token);
// Status reporting task
using var statusReportingCts = new CancellationTokenSource();
var statusTask = Task.Run(async () =>
{
int reportCount = 0;
while (!statusReportingCts.IsCancellationRequested)
{
try
{
await Task.Delay(
TimeSpan.FromSeconds(kStatusReportIntervalSeconds),
statusReportingCts.Token).ConfigureAwait(false);
}
catch (OperationCanceledException)
{
break;
}
reportCount++;
int totalNotifications = valueChanges.Values.Sum();
int elapsedMinutes = reportCount * kStatusReportIntervalSeconds / 60;
TestContext.Out.WriteLine(
$"[Status Report {reportCount}] Elapsed: {elapsedMinutes} minutes, " +
$"Total notifications: {totalNotifications}, Write count: {writeCount}, Errors: {errors.Count}");
#if DEBUG
// Report per-node statistics
if (reportCount % 5 == 0) // Every 5 minutes
{
TestContext.Out.WriteLine("Per-node notification counts:");
foreach (KeyValuePair<NodeId, int> kvp in valueChanges.OrderBy(x => x.Key.ToString()))
{
TestContext.Out.WriteLine($" {kvp.Key}: {kvp.Value} notifications");
}
}
#endif
}
}, statusReportingCts.Token);
// Run test for the specified duration
TestContext.Out.WriteLine($"Test running... will complete at {DateTime.UtcNow.AddSeconds(testDurationSeconds):yyyy-MM-dd HH:mm:ss} UTC");
await Task.Delay(TimeSpan.FromSeconds(testDurationSeconds)).ConfigureAwait(false);
// Stop tasks
TestContext.Out.WriteLine("Test duration elapsed. Stopping writer and status tasks...");
await writerCts.CancelAsync().ConfigureAwait(false);
await statusReportingCts.CancelAsync().ConfigureAwait(false);
try
{
await writerTask.ConfigureAwait(false);
}
catch (OperationCanceledException)
{
/* expected */
}
try
{
await statusTask.ConfigureAwait(false);
}
catch (OperationCanceledException)
{
/* expected */
}
// Wait for final notifications to be processed
TestContext.Out.WriteLine("Waiting for final notifications to be processed...");
await Task.Delay(publishingInterval * 5).ConfigureAwait(false);
// Verification
TestContext.Out.WriteLine("=== Final Results ===");
TestContext.Out.WriteLine($"Test duration: {testDurationMinutes} minutes");
TestContext.Out.WriteLine($"Security token lifetime: {tokenLifetimeMs / 1000} seconds ({tokenLifetimeMs / 60000.0:F1} minutes)");
TestContext.Out.WriteLine($"Expected token renewals: ~{testDurationMinutes * 60000 / tokenLifetimeMs} times");
TestContext.Out.WriteLine($"Total write operations: {writeCount}");
TestContext.Out.WriteLine($"Total errors: {errors.Count}");
// Calculate expected and received notifications
int totalNotifications = valueChanges.Values.Sum();
int expectedMinNotifications = (writeCount - 1) * nodeIds.Count; // Allow for some timing variance
TestContext.Out.WriteLine($"Total notifications received: {totalNotifications}");
TestContext.Out.WriteLine($"Expected minimum notifications: {expectedMinNotifications}");
// Per-node verification
TestContext.Out.WriteLine("Per-node results:");
bool allNodesReceivedData = true;
foreach (NodeId nodeId in nodeIds.Keys)
{
if (valueChanges.TryGetValue(nodeId, out int changes))
{
#if DEBUG
TestContext.Out.WriteLine($" {nodeId}: {changes} notifications");
#endif
double expected = Math.Max(0, writeCount - 1) * kNotificationToleranceRatio;
if (changes < expected)
{
allNodesReceivedData = false;
TestContext.Out.WriteLine(
$" WARNING: Expected at least {expected:F0} but got {changes} on {nodeId}");
}
}
else
{
allNodesReceivedData = false;
TestContext.Out.WriteLine($" {nodeId}: 0 notifications (ERROR)");
}
}
// List all errors
if (!errors.IsEmpty)
{
TestContext.Out.WriteLine($"Errors encountered ({errors.Count}):");
foreach (string error in errors.Take(20)) // Show first 20 errors
{
TestContext.Out.WriteLine($" - {error}");
}
if (errors.Count > 20)
{
TestContext.Out.WriteLine($" ... and {errors.Count - 20} more errors");
}
}
// Cleanup writer session
try
{
await writerSession.CloseAsync().ConfigureAwait(false);
writerSession.Dispose();
}
catch (Exception ex)
{
TestContext.Out.WriteLine($"Failed to close writer session: {ex.Message}");
}
// Assertions
Assert.That(allNodesReceivedData, Is.True, "Not all nodes received expected data");
Assert.That(errors, Is.Empty, $"Test encountered {errors.Count} errors");
Assert.That(
totalNotifications,
Is.GreaterThanOrEqualTo(expectedMinNotifications),
"Total notifications received is less than expected minimum");
TestContext.Out.WriteLine("Connection stability test PASSED");
}
finally
{
// Cleanup
if (subscription != null)
{
try
{
await subscription.DeleteAsync(true).ConfigureAwait(false);
}
catch (Exception ex)
{
TestContext.Out.WriteLine($"Failed to delete subscription: {ex.Message}");
}
subscription.Dispose();
}
if (session != null)
{
try
{
await session.CloseAsync().ConfigureAwait(false);
session.Dispose();
}
catch (Exception ex)
{
TestContext.Out.WriteLine($"Failed to close session: {ex.Message}");
}
}
}
}
}
}