Files
work-club-manager/backend/WorkClub.Tests.Integration/diag.host.26-03-18_15-19-46_58589_5.txt
T
2026-03-19 21:36:06 +01:00

343 lines
98 KiB
Plaintext

TpTrace Verbose: 0 : 54518, 1, 2026/03/18, 15:19:46.655, 236454094835333, testhost.dll, Version: 17.14.1 Current process architecture: ARM64
TpTrace Verbose: 0 : 54518, 1, 2026/03/18, 15:19:46.656, 236454096410875, testhost.dll, Runtime location: /usr/local/share/dotnet/shared/Microsoft.NETCore.App/10.0.0
TpTrace Information: 0 : 54518, 1, 2026/03/18, 15:19:46.657, 236454097544833, testhost.dll, DefaultEngineInvoker.Invoke: Testhost process started with args :[--port, 56513],[--endpoint, 127.0.0.1:056513],[--role, client],[--parentprocessid, 54517],[--diag, /Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/diag.host.26-03-18_15-19-46_58589_5.txt],[--tracelevel, 4],[--telemetryoptedin, false]
TpTrace Information: 0 : 54518, 1, 2026/03/18, 15:19:46.657, 236454097671833, testhost.dll, Setting up debug trace listener.
TpTrace Verbose: 0 : 54518, 1, 2026/03/18, 15:19:46.657, 236454097708791, testhost.dll, TestPlatformTraceListener.Setup: Replacing listener System.Diagnostics.DefaultTraceListener with TestHostTraceListener.
TpTrace Verbose: 0 : 54518, 1, 2026/03/18, 15:19:46.657, 236454097732583, testhost.dll, TestPlatformTraceListener.Setup: Added test platform trace listener.
TpTrace Information: 0 : 54518, 1, 2026/03/18, 15:19:46.658, 236454097850250, testhost.dll, DefaultEngineInvoker.SetParentProcessExitCallback: Monitoring parent process with id: '54517'
TpTrace Information: 0 : 54518, 1, 2026/03/18, 15:19:46.659, 236454099502666, testhost.dll, DefaultEngineInvoker.GetConnectionInfo: Initialize communication on endpoint address: '127.0.0.1:056513'
TpTrace Information: 0 : 54518, 1, 2026/03/18, 15:19:46.665, 236454105541958, testhost.dll, SocketClient.Start: connecting to server endpoint: 127.0.0.1:056513
TpTrace Information: 0 : 54518, 11, 2026/03/18, 15:19:46.667, 236454107709166, testhost.dll, SocketClient.OnServerConnected: connected to server endpoint: 127.0.0.1:056513
TpTrace Verbose: 0 : 54518, 11, 2026/03/18, 15:19:46.668, 236454108519208, testhost.dll, MulticastDelegateUtilities.SafeInvoke: SocketClient: ServerConnected: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CommunicationUtilities.TestRequestHandler., took 0 ms.
TpTrace Verbose: 0 : 54518, 11, 2026/03/18, 15:19:46.668, 236454108536750, testhost.dll, Connected to server, and starting MessageLoopAsync
TpTrace Information: 0 : 54518, 1, 2026/03/18, 15:19:46.668, 236454108691916, testhost.dll, DefaultEngineInvoker.Invoke: Start Request Processing.
TpTrace Information: 0 : 54518, 12, 2026/03/18, 15:19:46.669, 236454108944791, testhost.dll, DefaultEngineInvoker.StartProcessingAsync: Connected to vstest.console, Starting process requests.
TpTrace Verbose: 0 : 54518, 11, 2026/03/18, 15:19:46.670, 236454110714500, testhost.dll, TcpClientExtensions.MessageLoopAsync: Polling on remoteEndPoint: [::ffff:127.0.0.1]:56513 localEndPoint: [::ffff:127.0.0.1]:56514 after 0 ms
TpTrace Verbose: 0 : 54518, 11, 2026/03/18, 15:19:46.681, 236454121405250, testhost.dll, TcpClientExtensions.MessageLoopAsync: NotifyDataAvailable remoteEndPoint: [::ffff:127.0.0.1]:56513 localEndPoint: [::ffff:127.0.0.1]:56514
TpTrace Information: 0 : 54518, 11, 2026/03/18, 15:19:46.682, 236454122697583, testhost.dll, TestRequestHandler.OnMessageReceived: received message: (ProtocolVersion) -> {"MessageType":"ProtocolVersion","Payload":7}
TpTrace Verbose: 0 : 54518, 11, 2026/03/18, 15:19:46.725, 236454164757416, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"Die TestHost-Diagnose wird in der Datei /Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/diag.host.26-03-18_15-19-46_58589_5.txt protokolliert."}}
TpTrace Verbose: 0 : 54518, 11, 2026/03/18, 15:19:46.725, 236454164860166, testhost.dll, MulticastDelegateUtilities.SafeInvoke: LengthPrefixCommunicationChannel: MessageReceived: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CommunicationUtilities.TestRequestHandler., took 43 ms.
TpTrace Verbose: 0 : 54518, 11, 2026/03/18, 15:19:46.725, 236454164875375, testhost.dll, TcpClientExtensions.MessageLoopAsync: Polling on remoteEndPoint: [::ffff:127.0.0.1]:56513 localEndPoint: [::ffff:127.0.0.1]:56514 after 54 ms
TpTrace Verbose: 0 : 54518, 11, 2026/03/18, 15:19:46.725, 236454164894666, testhost.dll, TcpClientExtensions.MessageLoopAsync: NotifyDataAvailable remoteEndPoint: [::ffff:127.0.0.1]:56513 localEndPoint: [::ffff:127.0.0.1]:56514
TpTrace Information: 0 : 54518, 11, 2026/03/18, 15:19:46.725, 236454165070375, testhost.dll, TestRequestHandler.OnMessageReceived: received message: (TestExecution.Initialize) -> {"Version":7,"MessageType":"TestExecution.Initialize","Payload":["/Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/xunit.runner.visualstudio.testadapter.dll"]}
TpTrace Verbose: 0 : 54518, 11, 2026/03/18, 15:19:46.727, 236454167630875, testhost.dll, MulticastDelegateUtilities.SafeInvoke: LengthPrefixCommunicationChannel: MessageReceived: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CommunicationUtilities.TestRequestHandler., took 2 ms.
TpTrace Verbose: 0 : 54518, 11, 2026/03/18, 15:19:46.727, 236454167648625, testhost.dll, TcpClientExtensions.MessageLoopAsync: Polling on remoteEndPoint: [::ffff:127.0.0.1]:56513 localEndPoint: [::ffff:127.0.0.1]:56514 after 2 ms
TpTrace Verbose: 0 : 54518, 11, 2026/03/18, 15:19:46.727, 236454167659125, testhost.dll, TcpClientExtensions.MessageLoopAsync: NotifyDataAvailable remoteEndPoint: [::ffff:127.0.0.1]:56513 localEndPoint: [::ffff:127.0.0.1]:56514
TpTrace Information: 0 : 54518, 11, 2026/03/18, 15:19:46.727, 236454167688125, testhost.dll, TestRequestHandler.OnMessageReceived: received message: (TestExecution.StartWithSources) -> {"Version":7,"MessageType":"TestExecution.StartWithSources","Payload":{"AdapterSourceMap":{"_none_":["/Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/WorkClub.Tests.Integration.dll"]},"RunSettings":"<RunSettings>\n <RunConfiguration>\n <ResultsDirectory>/Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/TestResults</ResultsDirectory>\n <TargetFrameworkVersion>.NETCoreApp,Version=v10.0</TargetFrameworkVersion>\n <TestAdaptersPaths>/Users/mastermito/.nuget/packages/coverlet.collector/6.0.4/build/netstandard2.0/</TestAdaptersPaths>\n <DesignMode>False</DesignMode>\n <CollectSourceInformation>False</CollectSourceInformation>\n </RunConfiguration>\n <LoggerRunSettings>\n <Loggers>\n <Logger friendlyName=\"console\" assemblyQualifiedName=\"Microsoft.VisualStudio.TestPlatform.CommandLine.Internal.ConsoleLogger, vstest.console, Version=15.0.0.0, Culture=neutral, PublicKeyToken=b03f5f7f11d50a3a\" codeBase=\"/usr/local/share/dotnet/sdk/10.0.100/vstest.console.dll\" enabled=\"True\">\n <Configuration>\n <verbosity>normal</verbosity>\n </Configuration>\n </Logger>\n <Logger friendlyName=\"Microsoft.TestPlatform.MSBuildLogger\" assemblyQualifiedName=\"Microsoft.VisualStudio.TestPlatform.CommandLine.Internal.MSBuildLogger, vstest.console, Version=15.0.0.0, Culture=neutral, PublicKeyToken=b03f5f7f11d50a3a\" codeBase=\"/usr/local/share/dotnet/sdk/10.0.100/vstest.console.dll\" enabled=\"True\">\n <Configuration>\n <Verbosity>minimal</Verbosity>\n </Configuration>\n </Logger>\n </Loggers>\n </LoggerRunSettings>\n</RunSettings>","TestExecutionContext":{"FrequencyOfRunStatsChangeEvent":10,"RunStatsChangeEventTimeout":"00:00:01.5000000","InIsolation":false,"KeepAlive":false,"AreTestCaseLevelEventsRequired":false,"IsDebug":false,"TestCaseFilter":"CreateClub_WithAdminRole_ReturnsCreated","FilterOptions":null},"Package":null}}
TpTrace Information: 0 : 54518, 4, 2026/03/18, 15:19:46.728, 236454167782916, testhost.dll, TestRequestHandler.OnMessageReceived: Running job 'TestExecution.Initialize'.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.728, 236454168418416, testhost.dll, TestExecutorService: Loading the extensions
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.729, 236454168892916, testhost.dll, TestPluginCache.DiscoverTestExtensions: finding test extensions in assemblies ends with: TestAdapter.dll TPluginInfo: Microsoft.VisualStudio.TestPlatform.Common.ExtensionFramework.Utilities.TestExecutorPluginInformation TExtension: Microsoft.VisualStudio.TestPlatform.ObjectModel.Adapter.ITestExecutor
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.729, 236454169429625, testhost.dll, TestPluginCache.GetExtensionPaths: Filtered extension paths:
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.729, 236454169518000, testhost.dll, TestPluginCache.GetExtensionPaths: Added default extension paths: /Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/xunit.runner.visualstudio.testadapter.dll
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.729, 236454169525333, testhost.dll, TestPluginCache.GetExtensionPaths: Added unfilterableExtensionPaths:
TpTrace Information: 0 : 54518, 4, 2026/03/18, 15:19:46.730, 236454169882666, testhost.dll, AssemblyResolver.ctor: Creating AssemblyResolver with searchDirectories /Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.730, 236454170152083, testhost.dll, TestPluginCache.DiscoverTestExtensions: Discovering the extensions using extension path.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.730, 236454170169458, testhost.dll, TestPluginCache.GetExtensionPaths: Filtered extension paths:
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.730, 236454170176041, testhost.dll, TestPluginCache.GetExtensionPaths: Added default extension paths: /Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/xunit.runner.visualstudio.testadapter.dll
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.730, 236454170181583, testhost.dll, TestPluginCache.GetExtensionPaths: Added unfilterableExtensionPaths:
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.730, 236454170192875, testhost.dll, TestPluginCache.DiscoverTestExtensions: Discovering the extensions using allExtensionPaths: /Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/xunit.runner.visualstudio.testadapter.dll
TpTrace Information: 0 : 54518, 4, 2026/03/18, 15:19:46.730, 236454170354541, testhost.dll, AssemblyResolver.AddSearchDirectories: Adding more searchDirectories /Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0
TpTrace Information: 0 : 54518, 4, 2026/03/18, 15:19:46.731, 236454171083291, testhost.dll, AssemblyResolver.OnResolve: xunit.runner.visualstudio.testadapter: Resolving assembly.
TpTrace Information: 0 : 54518, 4, 2026/03/18, 15:19:46.731, 236454171102416, testhost.dll, AssemblyResolver.OnResolve: xunit.runner.visualstudio.testadapter: Searching in: '/Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0'.
TpTrace Information: 0 : 54518, 4, 2026/03/18, 15:19:46.733, 236454173553958, testhost.dll, AssemblyResolver.OnResolve: xunit.runner.visualstudio.testadapter: Loading assembly '/Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/xunit.runner.visualstudio.testadapter.dll'.
TpTrace Information: 0 : 54518, 4, 2026/03/18, 15:19:46.734, 236454173830583, testhost.dll, AssemblyResolver.OnResolve: Resolved assembly: xunit.runner.visualstudio.testadapter, from path: /Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/xunit.runner.visualstudio.testadapter.dll
TpTrace Verbose: 0 : 54518, 11, 2026/03/18, 15:19:46.735, 236454175260000, testhost.dll, MulticastDelegateUtilities.SafeInvoke: LengthPrefixCommunicationChannel: MessageReceived: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CommunicationUtilities.TestRequestHandler., took 7 ms.
TpTrace Verbose: 0 : 54518, 11, 2026/03/18, 15:19:46.735, 236454175279291, testhost.dll, TcpClientExtensions.MessageLoopAsync: Polling on remoteEndPoint: [::ffff:127.0.0.1]:56513 localEndPoint: [::ffff:127.0.0.1]:56514 after 7 ms
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.736, 236454176216708, testhost.dll, MetadataReaderExtensionsHelper: Discovering extensions inside assembly 'xunit.runner.visualstudio.testadapter, Version=3.1.4.0, Culture=neutral, PublicKeyToken=null' file path '/Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/xunit.runner.visualstudio.testadapter.dll'
TpTrace Information: 0 : 54518, 4, 2026/03/18, 15:19:46.743, 236454183484375, testhost.dll, GetTestExtensionFromType: Register extension with identifier data 'executor://xunit/VsTestRunner3/netcore/' and type 'Xunit.Runner.VisualStudio.VsTestRunner, xunit.runner.visualstudio.testadapter, Version=3.1.4.0, Culture=neutral, PublicKeyToken=null' inside file '/Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/xunit.runner.visualstudio.testadapter.dll'
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.744, 236454184178541, testhost.dll, TestPluginCache: Discovered the extensions using extension path ''.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.744, 236454184369916, testhost.dll, TestPluginCache: Discoverers are ''.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.744, 236454184387083, testhost.dll, TestPluginCache: Executors are 'executor://xunit/VsTestRunner3/netcore/'.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.744, 236454184397875, testhost.dll, TestPluginCache: Executors2 are ''.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.744, 236454184408666, testhost.dll, TestPluginCache: Setting providers are ''.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.744, 236454184419333, testhost.dll, TestPluginCache: Loggers are ''.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.744, 236454184429416, testhost.dll, TestPluginCache: TestHosts are ''.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.744, 236454184440541, testhost.dll, TestPluginCache: DataCollectors are ''.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.745, 236454185045500, testhost.dll, TestPluginCache.DiscoverTestExtensions: finding test extensions in assemblies ends with: TestAdapter.dll TPluginInfo: Microsoft.VisualStudio.TestPlatform.Common.ExtensionFramework.Utilities.TestExecutorPluginInformation2 TExtension: Microsoft.VisualStudio.TestPlatform.ObjectModel.Adapter.ITestExecutor2
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.745, 236454185106166, testhost.dll, TestPluginCache.GetExtensionPaths: Filtered extension paths:
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.745, 236454185112875, testhost.dll, TestPluginCache.GetExtensionPaths: Added default extension paths: /Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/xunit.runner.visualstudio.testadapter.dll
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.745, 236454185119750, testhost.dll, TestPluginCache.GetExtensionPaths: Added unfilterableExtensionPaths:
TpTrace Information: 0 : 54518, 4, 2026/03/18, 15:19:46.745, 236454185165708, testhost.dll, AssemblyResolver.AddSearchDirectories: Adding more searchDirectories /Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.745, 236454185174000, testhost.dll, TestPluginCache.DiscoverTestExtensions: Discovering the extensions using extension path.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.745, 236454185180458, testhost.dll, TestPluginCache.GetExtensionPaths: Filtered extension paths:
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.745, 236454185185250, testhost.dll, TestPluginCache.GetExtensionPaths: Added default extension paths: /Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/xunit.runner.visualstudio.testadapter.dll
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.745, 236454185189541, testhost.dll, TestPluginCache.GetExtensionPaths: Added unfilterableExtensionPaths:
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.745, 236454185195041, testhost.dll, TestPluginCache.DiscoverTestExtensions: Discovering the extensions using allExtensionPaths: /Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/xunit.runner.visualstudio.testadapter.dll
TpTrace Information: 0 : 54518, 4, 2026/03/18, 15:19:46.745, 236454185212041, testhost.dll, AssemblyResolver.AddSearchDirectories: Adding more searchDirectories /Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.745, 236454185234875, testhost.dll, MetadataReaderExtensionsHelper: Discovering extensions inside assembly 'xunit.runner.visualstudio.testadapter, Version=3.1.4.0, Culture=neutral, PublicKeyToken=null' file path '/Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/xunit.runner.visualstudio.testadapter.dll'
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.754, 236454194077000, testhost.dll, TestPluginCache: Discovered the extensions using extension path ''.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.754, 236454194116208, testhost.dll, TestPluginCache: Discoverers are ''.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.754, 236454194131541, testhost.dll, TestPluginCache: Executors are 'executor://xunit/VsTestRunner3/netcore/'.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.754, 236454194143958, testhost.dll, TestPluginCache: Executors2 are ''.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.754, 236454194151875, testhost.dll, TestPluginCache: Setting providers are ''.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.754, 236454194156625, testhost.dll, TestPluginCache: Loggers are ''.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.754, 236454194160708, testhost.dll, TestPluginCache: TestHosts are ''.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.754, 236454194164500, testhost.dll, TestPluginCache: DataCollectors are ''.
TpTrace Information: 0 : 54518, 4, 2026/03/18, 15:19:46.756, 236454196147583, testhost.dll, TestPluginManager.CreateTestExtension: Attempting to load test extension: Xunit.Runner.VisualStudio.VsTestRunner
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.756, 236454196264166, testhost.dll, TestExecutorExtensionManager: Loading executor Microsoft.VisualStudio.TestPlatform.Common.ExtensionDecorators.SerialTestRunDecorator
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.756, 236454196272166, testhost.dll, TestExecutorService: Loaded the executors
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.756, 236454196436208, testhost.dll, TestPluginCache.DiscoverTestExtensions: finding test extensions in assemblies ends with: TestAdapter.dll TPluginInfo: Microsoft.VisualStudio.TestPlatform.Common.ExtensionFramework.Utilities.TestSettingsProviderPluginInformation TExtension: Microsoft.VisualStudio.TestPlatform.ObjectModel.Adapter.ISettingsProvider
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.756, 236454196458208, testhost.dll, TestPluginCache.GetExtensionPaths: Filtered extension paths:
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.756, 236454196465500, testhost.dll, TestPluginCache.GetExtensionPaths: Added default extension paths: /Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/xunit.runner.visualstudio.testadapter.dll
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.756, 236454196470750, testhost.dll, TestPluginCache.GetExtensionPaths: Added unfilterableExtensionPaths:
TpTrace Information: 0 : 54518, 4, 2026/03/18, 15:19:46.756, 236454196500916, testhost.dll, AssemblyResolver.AddSearchDirectories: Adding more searchDirectories /Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.756, 236454196509875, testhost.dll, TestPluginCache.DiscoverTestExtensions: Discovering the extensions using extension path.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.756, 236454196516166, testhost.dll, TestPluginCache.GetExtensionPaths: Filtered extension paths:
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.756, 236454196520625, testhost.dll, TestPluginCache.GetExtensionPaths: Added default extension paths: /Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/xunit.runner.visualstudio.testadapter.dll
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.756, 236454196531833, testhost.dll, TestPluginCache.GetExtensionPaths: Added unfilterableExtensionPaths:
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.756, 236454196537375, testhost.dll, TestPluginCache.DiscoverTestExtensions: Discovering the extensions using allExtensionPaths: /Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/xunit.runner.visualstudio.testadapter.dll
TpTrace Information: 0 : 54518, 4, 2026/03/18, 15:19:46.756, 236454196545166, testhost.dll, AssemblyResolver.AddSearchDirectories: Adding more searchDirectories /Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.756, 236454196560750, testhost.dll, MetadataReaderExtensionsHelper: Discovering extensions inside assembly 'xunit.runner.visualstudio.testadapter, Version=3.1.4.0, Culture=neutral, PublicKeyToken=null' file path '/Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/xunit.runner.visualstudio.testadapter.dll'
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.757, 236454196944916, testhost.dll, TestPluginCache: Discovered the extensions using extension path ''.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.757, 236454196953291, testhost.dll, TestPluginCache: Discoverers are ''.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.757, 236454196958375, testhost.dll, TestPluginCache: Executors are 'executor://xunit/VsTestRunner3/netcore/'.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.757, 236454196963000, testhost.dll, TestPluginCache: Executors2 are ''.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.757, 236454196969541, testhost.dll, TestPluginCache: Setting providers are ''.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.757, 236454196974416, testhost.dll, TestPluginCache: Loggers are ''.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.757, 236454196978833, testhost.dll, TestPluginCache: TestHosts are ''.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.757, 236454196982791, testhost.dll, TestPluginCache: DataCollectors are ''.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.757, 236454197151208, testhost.dll, TestExecutorService: Loaded the settings providers
TpTrace Information: 0 : 54518, 4, 2026/03/18, 15:19:46.757, 236454197161416, testhost.dll, TestExecutorService: Loaded the extensions
TpTrace Information: 0 : 54518, 4, 2026/03/18, 15:19:46.757, 236454197292208, testhost.dll, TestRequestHandler.OnMessageReceived: Running job 'TestExecution.StartWithSources'.
TpTrace Information: 0 : 54518, 4, 2026/03/18, 15:19:46.774, 236454214022000, testhost.dll, TestDiscoveryManager: Discovering tests from sources /Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/WorkClub.Tests.Integration.dll
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.774, 236454214583458, testhost.dll, TestPluginCache.DiscoverTestExtensions: finding test extensions in assemblies ends with: TestAdapter.dll TPluginInfo: Microsoft.VisualStudio.TestPlatform.Common.ExtensionFramework.Utilities.TestDiscovererPluginInformation TExtension: Microsoft.VisualStudio.TestPlatform.ObjectModel.Adapter.ITestDiscoverer
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.774, 236454214615416, testhost.dll, TestPluginCache.GetExtensionPaths: Filtered extension paths:
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.774, 236454214627083, testhost.dll, TestPluginCache.GetExtensionPaths: Added default extension paths: /Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/xunit.runner.visualstudio.testadapter.dll
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.774, 236454214633458, testhost.dll, TestPluginCache.GetExtensionPaths: Added unfilterableExtensionPaths:
TpTrace Information: 0 : 54518, 4, 2026/03/18, 15:19:46.774, 236454214658916, testhost.dll, AssemblyResolver.AddSearchDirectories: Adding more searchDirectories /Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.774, 236454214674666, testhost.dll, TestPluginCache.DiscoverTestExtensions: Discovering the extensions using extension path.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.774, 236454214681583, testhost.dll, TestPluginCache.GetExtensionPaths: Filtered extension paths:
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.774, 236454214689291, testhost.dll, TestPluginCache.GetExtensionPaths: Added default extension paths: /Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/xunit.runner.visualstudio.testadapter.dll
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.774, 236454214694166, testhost.dll, TestPluginCache.GetExtensionPaths: Added unfilterableExtensionPaths:
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.774, 236454214699958, testhost.dll, TestPluginCache.DiscoverTestExtensions: Discovering the extensions using allExtensionPaths: /Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/xunit.runner.visualstudio.testadapter.dll
TpTrace Information: 0 : 54518, 4, 2026/03/18, 15:19:46.774, 236454214709708, testhost.dll, AssemblyResolver.AddSearchDirectories: Adding more searchDirectories /Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.774, 236454214732833, testhost.dll, MetadataReaderExtensionsHelper: Discovering extensions inside assembly 'xunit.runner.visualstudio.testadapter, Version=3.1.4.0, Culture=neutral, PublicKeyToken=null' file path '/Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/xunit.runner.visualstudio.testadapter.dll'
TpTrace Information: 0 : 54518, 4, 2026/03/18, 15:19:46.776, 236454216649291, testhost.dll, GetTestExtensionFromType: Register extension with identifier data 'Xunit.Runner.VisualStudio.VsTestRunner, xunit.runner.visualstudio.testadapter, Version=3.1.4.0, Culture=neutral, PublicKeyToken=null' and type 'Xunit.Runner.VisualStudio.VsTestRunner, xunit.runner.visualstudio.testadapter, Version=3.1.4.0, Culture=neutral, PublicKeyToken=null' inside file '/Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/xunit.runner.visualstudio.testadapter.dll'
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.776, 236454216714125, testhost.dll, TestPluginCache: Discovered the extensions using extension path ''.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.776, 236454216725208, testhost.dll, TestPluginCache: Discoverers are 'Xunit.Runner.VisualStudio.VsTestRunner, xunit.runner.visualstudio.testadapter, Version=3.1.4.0, Culture=neutral, PublicKeyToken=null'.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.776, 236454216731666, testhost.dll, TestPluginCache: Executors are 'executor://xunit/VsTestRunner3/netcore/'.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.776, 236454216737375, testhost.dll, TestPluginCache: Executors2 are ''.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.776, 236454216742125, testhost.dll, TestPluginCache: Setting providers are ''.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.776, 236454216746458, testhost.dll, TestPluginCache: Loggers are ''.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.777, 236454216750625, testhost.dll, TestPluginCache: TestHosts are ''.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.777, 236454216754625, testhost.dll, TestPluginCache: DataCollectors are ''.
TpTrace Information: 0 : 54518, 4, 2026/03/18, 15:19:46.777, 236454217715875, testhost.dll, PEReaderHelper.GetAssemblyType: Determined assemblyType:'Managed' for source: '/Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/WorkClub.Tests.Integration.dll'
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.784, 236454223769041, testhost.dll, BaseRunTests.RunTestInternalWithExecutors: Running tests for executor://xunit/VsTestRunner3/netcore/
TpTrace Information: 0 : 54518, 4, 2026/03/18, 15:19:46.786, 236454226582916, testhost.dll, [xUnit.net 00:00:00.00] xUnit.net VSTest Adapter v3.1.4+50e68bbb8b (64-bit .NET 10.0.0)
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.786, 236454226646875, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:00.00] xUnit.net VSTest Adapter v3.1.4+50e68bbb8b (64-bit .NET 10.0.0)"}}
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:46.786, 236454226694583, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 5, 2026/03/18, 15:19:46.823, 236454262904458, testhost.dll, [xUnit.net 00:00:00.03] Discovering: WorkClub.Tests.Integration
TpTrace Verbose: 0 : 54518, 5, 2026/03/18, 15:19:46.823, 236454262987333, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:00.03] Discovering: WorkClub.Tests.Integration"}}
TpTrace Verbose: 0 : 54518, 5, 2026/03/18, 15:19:46.823, 236454263039250, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 5, 2026/03/18, 15:19:46.839, 236454278837208, testhost.dll, [xUnit.net 00:00:00.05] Discovered: WorkClub.Tests.Integration
TpTrace Verbose: 0 : 54518, 5, 2026/03/18, 15:19:46.839, 236454278921375, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:00.05] Discovered: WorkClub.Tests.Integration"}}
TpTrace Verbose: 0 : 54518, 5, 2026/03/18, 15:19:46.839, 236454278971833, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:46.848, 236454288104458, testhost.dll, [xUnit.net 00:00:00.06] Starting: WorkClub.Tests.Integration
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:46.848, 236454288176208, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:00.06] Starting: WorkClub.Tests.Integration"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:46.848, 236454288225666, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:46.909, 236454349434916, testhost.dll, TestExecutionRecorder.RecordStart: Starting test: WorkClub.Tests.Integration.Clubs.AdminClubEndpointsTests.CreateClub_WithAdminRole_ReturnsCreated.
TpTrace Verbose: 0 : 54518, 11, 2026/03/18, 15:19:47.736, 236455176271500, testhost.dll, TcpClientExtensions.MessageLoopAsync: Polling on remoteEndPoint: [::ffff:127.0.0.1]:56513 localEndPoint: [::ffff:127.0.0.1]:56514 after 1000 ms
TpTrace Information: 0 : 54518, 13, 2026/03/18, 15:19:48.261, 236455701412750, testhost.dll, Sending test run statistics
TpTrace Verbose: 0 : 54518, 13, 2026/03/18, 15:19:48.269, 236455709176750, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestExecution.StatsChange","Payload":{"NewTestResults":[],"TestRunStatistics":{"ExecutedTests":0,"Stats":{}},"ActiveTests":[{"Id":"a8c49312-90f7-774d-ef37-0a55d289cbae","FullyQualifiedName":"WorkClub.Tests.Integration.Clubs.AdminClubEndpointsTests.CreateClub_WithAdminRole_ReturnsCreated","DisplayName":"WorkClub.Tests.Integration.Clubs.AdminClubEndpointsTests.CreateClub_WithAdminRole_ReturnsCreated","ExecutorUri":"executor://xunit/VsTestRunner3/netcore/","Source":"/Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/WorkClub.Tests.Integration.dll","CodeFilePath":null,"LineNumber":0,"Properties":[{"Key":{"Id":"XunitTestCaseExplicit","Label":"xUnit.net Test Case Explicit Flag","Category":"","Description":"","Attributes":0,"ValueType":"System.Boolean"},"Value":false},{"Key":{"Id":"TestCase.ManagedType","Label":"ManagedType","Category":"","Description":"","Attributes":1,"ValueType":"System.String"},"Value":"WorkClub.Tests.Integration.Clubs.AdminClubEndpointsTests"},{"Key":{"Id":"TestCase.ManagedMethod","Label":"ManagedMethod","Category":"","Description":"","Attributes":1,"ValueType":"System.String"},"Value":"CreateClub_WithAdminRole_ReturnsCreated"},{"Key":{"Id":"XunitTestCaseUniqueID","Label":"xUnit.net Test Case Unique ID","Category":"","Description":"","Attributes":0,"ValueType":"System.String"},"Value":"d0865975d8177c51f513124eed31b3647a0ba8c3"}]}]}}
TpTrace Verbose: 0 : 54518, 13, 2026/03/18, 15:19:48.269, 236455709303333, testhost.dll, TestRunCache: OnNewTestResult: Notified the onCacheHit callback.
TpTrace Information: 0 : 54518, 16, 2026/03/18, 15:19:48.448, 236455888730333, testhost.dll, AssemblyResolver.OnResolve: Microsoft.EntityFrameworkCore.resources: Resolving assembly.
TpTrace Information: 0 : 54518, 16, 2026/03/18, 15:19:48.449, 236455888818416, testhost.dll, AssemblyResolver.OnResolve: Microsoft.EntityFrameworkCore.resources: Searching in: '/Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0'.
TpTrace Information: 0 : 54518, 16, 2026/03/18, 15:19:48.449, 236455888853458, testhost.dll, AssemblyResolver.OnResolve: Microsoft.EntityFrameworkCore.resources: Assembly path does not exist: '/Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/Microsoft.EntityFrameworkCore.resources.dll', returning.
TpTrace Information: 0 : 54518, 16, 2026/03/18, 15:19:48.449, 236455888870625, testhost.dll, AssemblyResolver.OnResolve: Microsoft.EntityFrameworkCore.resources: Assembly path does not exist: '/Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/Microsoft.EntityFrameworkCore.resources.exe', returning.
TpTrace Information: 0 : 54518, 16, 2026/03/18, 15:19:48.449, 236455888880041, testhost.dll, AssemblyResolver.OnResolve: Microsoft.EntityFrameworkCore.resources: Failed to load assembly.
TpTrace Information: 0 : 54518, 16, 2026/03/18, 15:19:48.449, 236455888924041, testhost.dll, AssemblyResolver.OnResolve: Microsoft.EntityFrameworkCore.resources: Resolving assembly.
TpTrace Information: 0 : 54518, 16, 2026/03/18, 15:19:48.449, 236455888932375, testhost.dll, AssemblyResolver.OnResolve: Microsoft.EntityFrameworkCore.resources: Resolved from cache.
TpTrace Information: 0 : 54518, 16, 2026/03/18, 15:19:48.625, 236456065336916, testhost.dll, AssemblyResolver.OnResolve: Microsoft.EntityFrameworkCore.Relational.resources: Resolving assembly.
TpTrace Information: 0 : 54518, 16, 2026/03/18, 15:19:48.625, 236456065416208, testhost.dll, AssemblyResolver.OnResolve: Microsoft.EntityFrameworkCore.Relational.resources: Searching in: '/Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0'.
TpTrace Information: 0 : 54518, 16, 2026/03/18, 15:19:48.625, 236456065442625, testhost.dll, AssemblyResolver.OnResolve: Microsoft.EntityFrameworkCore.Relational.resources: Assembly path does not exist: '/Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/Microsoft.EntityFrameworkCore.Relational.resources.dll', returning.
TpTrace Information: 0 : 54518, 16, 2026/03/18, 15:19:48.625, 236456065463666, testhost.dll, AssemblyResolver.OnResolve: Microsoft.EntityFrameworkCore.Relational.resources: Assembly path does not exist: '/Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/Microsoft.EntityFrameworkCore.Relational.resources.exe', returning.
TpTrace Information: 0 : 54518, 16, 2026/03/18, 15:19:48.625, 236456065478250, testhost.dll, AssemblyResolver.OnResolve: Microsoft.EntityFrameworkCore.Relational.resources: Failed to load assembly.
TpTrace Information: 0 : 54518, 16, 2026/03/18, 15:19:48.625, 236456065539833, testhost.dll, AssemblyResolver.OnResolve: Microsoft.EntityFrameworkCore.Relational.resources: Resolving assembly.
TpTrace Information: 0 : 54518, 16, 2026/03/18, 15:19:48.625, 236456065548333, testhost.dll, AssemblyResolver.OnResolve: Microsoft.EntityFrameworkCore.Relational.resources: Resolved from cache.
TpTrace Information: 0 : 54518, 16, 2026/03/18, 15:19:48.649, 236456088797666, testhost.dll, AssemblyResolver.OnResolve: System.Net.Security.resources: Resolving assembly.
TpTrace Information: 0 : 54518, 16, 2026/03/18, 15:19:48.649, 236456088864250, testhost.dll, AssemblyResolver.OnResolve: System.Net.Security.resources: Searching in: '/Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0'.
TpTrace Information: 0 : 54518, 16, 2026/03/18, 15:19:48.649, 236456088884041, testhost.dll, AssemblyResolver.OnResolve: System.Net.Security.resources: Assembly path does not exist: '/Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/System.Net.Security.resources.dll', returning.
TpTrace Information: 0 : 54518, 16, 2026/03/18, 15:19:48.649, 236456088898666, testhost.dll, AssemblyResolver.OnResolve: System.Net.Security.resources: Assembly path does not exist: '/Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/System.Net.Security.resources.exe', returning.
TpTrace Information: 0 : 54518, 16, 2026/03/18, 15:19:48.649, 236456088906708, testhost.dll, AssemblyResolver.OnResolve: System.Net.Security.resources: Failed to load assembly.
TpTrace Information: 0 : 54518, 16, 2026/03/18, 15:19:48.649, 236456088952583, testhost.dll, AssemblyResolver.OnResolve: System.Net.Security.resources: Resolving assembly.
TpTrace Information: 0 : 54518, 16, 2026/03/18, 15:19:48.649, 236456088960333, testhost.dll, AssemblyResolver.OnResolve: System.Net.Security.resources: Resolved from cache.
TpTrace Verbose: 0 : 54518, 11, 2026/03/18, 15:19:48.736, 236456176740541, testhost.dll, TcpClientExtensions.MessageLoopAsync: Polling on remoteEndPoint: [::ffff:127.0.0.1]:56513 localEndPoint: [::ffff:127.0.0.1]:56514 after 1000 ms
TpTrace Information: 0 : 54518, 19, 2026/03/18, 15:19:48.999, 236456439547708, testhost.dll, AssemblyResolver.OnResolve: Microsoft.EntityFrameworkCore.Relational.resources: Resolving assembly.
TpTrace Information: 0 : 54518, 19, 2026/03/18, 15:19:48.999, 236456439594750, testhost.dll, AssemblyResolver.OnResolve: Microsoft.EntityFrameworkCore.Relational.resources: Resolved from cache.
TpTrace Information: 0 : 54518, 19, 2026/03/18, 15:19:48.999, 236456439630333, testhost.dll, AssemblyResolver.OnResolve: Microsoft.EntityFrameworkCore.Relational.resources: Resolving assembly.
TpTrace Information: 0 : 54518, 19, 2026/03/18, 15:19:48.999, 236456439648958, testhost.dll, AssemblyResolver.OnResolve: Microsoft.EntityFrameworkCore.Relational.resources: Resolved from cache.
TpTrace Error: 0 : 54518, 17, 2026/03/18, 15:19:49.017, 236456456817750, testhost.dll, [xUnit.net 00:00:02.23] WorkClub.Tests.Integration.Clubs.AdminClubEndpointsTests.CreateClub_WithAdminRole_ReturnsCreated [FAIL]
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.017, 236456456882166, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":2,"Message":"[xUnit.net 00:00:02.23] WorkClub.Tests.Integration.Clubs.AdminClubEndpointsTests.CreateClub_WithAdminRole_ReturnsCreated [FAIL]"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.017, 236456456926125, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.017, 236456457214625, testhost.dll, [xUnit.net 00:00:02.23] Microsoft.EntityFrameworkCore.DbUpdateException : An error occurred while saving the entity changes. See the inner exception for details.
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.017, 236456457240708, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] Microsoft.EntityFrameworkCore.DbUpdateException : An error occurred while saving the entity changes. See the inner exception for details."}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.017, 236456457262708, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.017, 236456457276250, testhost.dll, [xUnit.net 00:00:02.23] ---- Npgsql.PostgresException : 42501: permission denied for table clubs
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.017, 236456457288583, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] ---- Npgsql.PostgresException : 42501: permission denied for table clubs"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.017, 236456457305041, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.017, 236456457424875, testhost.dll, [xUnit.net 00:00:02.23] Stack Trace:
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.017, 236456457440541, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] Stack Trace:"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.017, 236456457458083, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456457827791, testhost.dll, [xUnit.net 00:00:02.23] at Microsoft.EntityFrameworkCore.Update.ReaderModificationCommandBatch.ExecuteAsync(IRelationalConnection connection, CancellationToken cancellationToken)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456457862958, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Microsoft.EntityFrameworkCore.Update.ReaderModificationCommandBatch.ExecuteAsync(IRelationalConnection connection, CancellationToken cancellationToken)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456457885250, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456457902583, testhost.dll, [xUnit.net 00:00:02.23] at Microsoft.EntityFrameworkCore.Update.Internal.BatchExecutor.ExecuteAsync(IEnumerable`1 commandBatches, IRelationalConnection connection, CancellationToken cancellationToken)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456457919500, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Microsoft.EntityFrameworkCore.Update.Internal.BatchExecutor.ExecuteAsync(IEnumerable`1 commandBatches, IRelationalConnection connection, CancellationToken cancellationToken)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456457942041, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456457959625, testhost.dll, [xUnit.net 00:00:02.23] at Microsoft.EntityFrameworkCore.Update.Internal.BatchExecutor.ExecuteAsync(IEnumerable`1 commandBatches, IRelationalConnection connection, CancellationToken cancellationToken)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456457981875, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Microsoft.EntityFrameworkCore.Update.Internal.BatchExecutor.ExecuteAsync(IEnumerable`1 commandBatches, IRelationalConnection connection, CancellationToken cancellationToken)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458000083, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458016416, testhost.dll, [xUnit.net 00:00:02.23] at Microsoft.EntityFrameworkCore.Update.Internal.BatchExecutor.ExecuteAsync(IEnumerable`1 commandBatches, IRelationalConnection connection, CancellationToken cancellationToken)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458031500, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Microsoft.EntityFrameworkCore.Update.Internal.BatchExecutor.ExecuteAsync(IEnumerable`1 commandBatches, IRelationalConnection connection, CancellationToken cancellationToken)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458047458, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458061250, testhost.dll, [xUnit.net 00:00:02.23] at Microsoft.EntityFrameworkCore.Storage.RelationalDatabase.SaveChangesAsync(IList`1 entries, CancellationToken cancellationToken)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458078166, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Microsoft.EntityFrameworkCore.Storage.RelationalDatabase.SaveChangesAsync(IList`1 entries, CancellationToken cancellationToken)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458094833, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458108833, testhost.dll, [xUnit.net 00:00:02.23] at Microsoft.EntityFrameworkCore.ChangeTracking.Internal.StateManager.SaveChangesAsync(IList`1 entriesToSave, CancellationToken cancellationToken)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458131125, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Microsoft.EntityFrameworkCore.ChangeTracking.Internal.StateManager.SaveChangesAsync(IList`1 entriesToSave, CancellationToken cancellationToken)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458144583, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458165500, testhost.dll, [xUnit.net 00:00:02.23] at Microsoft.EntityFrameworkCore.ChangeTracking.Internal.StateManager.SaveChangesAsync(StateManager stateManager, Boolean acceptAllChangesOnSuccess, CancellationToken cancellationToken)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458177125, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Microsoft.EntityFrameworkCore.ChangeTracking.Internal.StateManager.SaveChangesAsync(StateManager stateManager, Boolean acceptAllChangesOnSuccess, CancellationToken cancellationToken)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458193416, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458206125, testhost.dll, [xUnit.net 00:00:02.23] at Npgsql.EntityFrameworkCore.PostgreSQL.Storage.Internal.NpgsqlExecutionStrategy.ExecuteAsync[TState,TResult](TState state, Func`4 operation, Func`4 verifySucceeded, CancellationToken cancellationToken)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458219625, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Npgsql.EntityFrameworkCore.PostgreSQL.Storage.Internal.NpgsqlExecutionStrategy.ExecuteAsync[TState,TResult](TState state, Func`4 operation, Func`4 verifySucceeded, CancellationToken cancellationToken)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458235041, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458249666, testhost.dll, [xUnit.net 00:00:02.23] at Microsoft.EntityFrameworkCore.DbContext.SaveChangesAsync(Boolean acceptAllChangesOnSuccess, CancellationToken cancellationToken)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458262125, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Microsoft.EntityFrameworkCore.DbContext.SaveChangesAsync(Boolean acceptAllChangesOnSuccess, CancellationToken cancellationToken)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458276500, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458291083, testhost.dll, [xUnit.net 00:00:02.23] at Microsoft.EntityFrameworkCore.DbContext.SaveChangesAsync(Boolean acceptAllChangesOnSuccess, CancellationToken cancellationToken)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458302375, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Microsoft.EntityFrameworkCore.DbContext.SaveChangesAsync(Boolean acceptAllChangesOnSuccess, CancellationToken cancellationToken)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458318666, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458341208, testhost.dll, [xUnit.net 00:00:02.23] /Users/mastermito/Dev/opencode/backend/WorkClub.Api/Services/AdminClubService.cs(54,0): at WorkClub.Api.Services.AdminClubService.<>c__DisplayClass3_0.<<CreateClubAsync>b__0>d.MoveNext()
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458354708, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] /Users/mastermito/Dev/opencode/backend/WorkClub.Api/Services/AdminClubService.cs(54,0): at WorkClub.Api.Services.AdminClubService.<>c__DisplayClass3_0.<<CreateClubAsync>b__0>d.MoveNext()"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458369541, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458380625, testhost.dll, [xUnit.net 00:00:02.23] --- End of stack trace from previous location ---
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458391333, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] --- End of stack trace from previous location ---"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458406625, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458421541, testhost.dll, [xUnit.net 00:00:02.23] /Users/mastermito/Dev/opencode/backend/WorkClub.Api/Services/AdminClubService.cs(56,0): at WorkClub.Api.Services.AdminClubService.<>c__DisplayClass3_0.<<CreateClubAsync>b__0>d.MoveNext()
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458433875, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] /Users/mastermito/Dev/opencode/backend/WorkClub.Api/Services/AdminClubService.cs(56,0): at WorkClub.Api.Services.AdminClubService.<>c__DisplayClass3_0.<<CreateClubAsync>b__0>d.MoveNext()"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458450791, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458461416, testhost.dll, [xUnit.net 00:00:02.23] --- End of stack trace from previous location ---
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458475791, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] --- End of stack trace from previous location ---"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458488000, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458500458, testhost.dll, [xUnit.net 00:00:02.23] at Microsoft.EntityFrameworkCore.ExecutionStrategyExtensions.<>c.<<ExecuteAsync>b__3_0>d.MoveNext()
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458516250, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Microsoft.EntityFrameworkCore.ExecutionStrategyExtensions.<>c.<<ExecuteAsync>b__3_0>d.MoveNext()"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458530750, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458542916, testhost.dll, [xUnit.net 00:00:02.23] --- End of stack trace from previous location ---
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458552750, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] --- End of stack trace from previous location ---"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458570083, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458583708, testhost.dll, [xUnit.net 00:00:02.23] at Npgsql.EntityFrameworkCore.PostgreSQL.Storage.Internal.NpgsqlExecutionStrategy.ExecuteAsync[TState,TResult](TState state, Func`4 operation, Func`4 verifySucceeded, CancellationToken cancellationToken)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458598708, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Npgsql.EntityFrameworkCore.PostgreSQL.Storage.Internal.NpgsqlExecutionStrategy.ExecuteAsync[TState,TResult](TState state, Func`4 operation, Func`4 verifySucceeded, CancellationToken cancellationToken)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458614500, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458626083, testhost.dll, [xUnit.net 00:00:02.23] /Users/mastermito/Dev/opencode/backend/WorkClub.Api/Services/AdminClubService.cs(49,0): at WorkClub.Api.Services.AdminClubService.CreateClubAsync(CreateClubRequest request)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458637916, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] /Users/mastermito/Dev/opencode/backend/WorkClub.Api/Services/AdminClubService.cs(49,0): at WorkClub.Api.Services.AdminClubService.CreateClubAsync(CreateClubRequest request)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458653125, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458665416, testhost.dll, [xUnit.net 00:00:02.23] /Users/mastermito/Dev/opencode/backend/WorkClub.Api/Endpoints/Clubs/AdminClubEndpoints.cs(39,0): at WorkClub.Api.Endpoints.Clubs.AdminClubEndpoints.CreateClub(CreateClubRequest request, AdminClubService adminClubService)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458675416, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] /Users/mastermito/Dev/opencode/backend/WorkClub.Api/Endpoints/Clubs/AdminClubEndpoints.cs(39,0): at WorkClub.Api.Endpoints.Clubs.AdminClubEndpoints.CreateClub(CreateClubRequest request, AdminClubService adminClubService)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458691000, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458701416, testhost.dll, [xUnit.net 00:00:02.23] at Microsoft.AspNetCore.Http.RequestDelegateFactory.ExecuteTaskResult[T](Task`1 task, HttpContext httpContext)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458710541, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Microsoft.AspNetCore.Http.RequestDelegateFactory.ExecuteTaskResult[T](Task`1 task, HttpContext httpContext)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458723541, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458735625, testhost.dll, [xUnit.net 00:00:02.23] at Microsoft.AspNetCore.Http.RequestDelegateFactory.<>c__DisplayClass102_2.<<HandleRequestBodyAndCompileRequestDelegateForJson>b__2>d.MoveNext()
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.018, 236456458745250, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Microsoft.AspNetCore.Http.RequestDelegateFactory.<>c__DisplayClass102_2.<<HandleRequestBodyAndCompileRequestDelegateForJson>b__2>d.MoveNext()"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456458756791, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456458764458, testhost.dll, [xUnit.net 00:00:02.23] --- End of stack trace from previous location ---
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456458775500, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] --- End of stack trace from previous location ---"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456458790833, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456458802250, testhost.dll, [xUnit.net 00:00:02.23] /Users/mastermito/Dev/opencode/backend/WorkClub.Api/Middleware/MemberSyncMiddleware.cs(24,0): at WorkClub.Api.Middleware.MemberSyncMiddleware.InvokeAsync(HttpContext context, MemberSyncService memberSyncService)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456458815625, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] /Users/mastermito/Dev/opencode/backend/WorkClub.Api/Middleware/MemberSyncMiddleware.cs(24,0): at WorkClub.Api.Middleware.MemberSyncMiddleware.InvokeAsync(HttpContext context, MemberSyncService memberSyncService)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456458831625, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456458845333, testhost.dll, [xUnit.net 00:00:02.23] /Users/mastermito/Dev/opencode/backend/WorkClub.Api/Middleware/TenantValidationMiddleware.cs(30,0): at WorkClub.Api.Middleware.TenantValidationMiddleware.InvokeAsync(HttpContext context)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456458855833, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] /Users/mastermito/Dev/opencode/backend/WorkClub.Api/Middleware/TenantValidationMiddleware.cs(30,0): at WorkClub.Api.Middleware.TenantValidationMiddleware.InvokeAsync(HttpContext context)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456458870291, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456458882666, testhost.dll, [xUnit.net 00:00:02.23] at Microsoft.AspNetCore.Authorization.AuthorizationMiddleware.Invoke(HttpContext context)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456458904125, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Microsoft.AspNetCore.Authorization.AuthorizationMiddleware.Invoke(HttpContext context)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456458918083, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456458932416, testhost.dll, [xUnit.net 00:00:02.23] at Microsoft.AspNetCore.Authentication.AuthenticationMiddleware.Invoke(HttpContext context)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456458943291, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Microsoft.AspNetCore.Authentication.AuthenticationMiddleware.Invoke(HttpContext context)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456458955583, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456458966875, testhost.dll, [xUnit.net 00:00:02.23] at Microsoft.AspNetCore.TestHost.HttpContextBuilder.<>c__DisplayClass23_0.<<SendAsync>g__RunRequestAsync|0>d.MoveNext()
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456458980208, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Microsoft.AspNetCore.TestHost.HttpContextBuilder.<>c__DisplayClass23_0.<<SendAsync>g__RunRequestAsync|0>d.MoveNext()"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456458996791, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459008708, testhost.dll, [xUnit.net 00:00:02.23] --- End of stack trace from previous location ---
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459023541, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] --- End of stack trace from previous location ---"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459037250, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459048083, testhost.dll, [xUnit.net 00:00:02.23] at Microsoft.AspNetCore.TestHost.ClientHandler.SendAsync(HttpRequestMessage request, CancellationToken cancellationToken)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459061500, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Microsoft.AspNetCore.TestHost.ClientHandler.SendAsync(HttpRequestMessage request, CancellationToken cancellationToken)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459075041, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459086000, testhost.dll, [xUnit.net 00:00:02.23] at Microsoft.AspNetCore.Mvc.Testing.Handlers.CookieContainerHandler.SendAsync(HttpRequestMessage request, CancellationToken cancellationToken)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459096000, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Microsoft.AspNetCore.Mvc.Testing.Handlers.CookieContainerHandler.SendAsync(HttpRequestMessage request, CancellationToken cancellationToken)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459109791, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459122125, testhost.dll, [xUnit.net 00:00:02.23] at Microsoft.AspNetCore.Mvc.Testing.Handlers.RedirectHandler.SendAsync(HttpRequestMessage request, CancellationToken cancellationToken)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459132083, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Microsoft.AspNetCore.Mvc.Testing.Handlers.RedirectHandler.SendAsync(HttpRequestMessage request, CancellationToken cancellationToken)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459146375, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459167625, testhost.dll, [xUnit.net 00:00:02.23] at System.Net.Http.HttpClient.<SendAsync>g__Core|83_0(HttpRequestMessage request, HttpCompletionOption completionOption, CancellationTokenSource cts, Boolean disposeCts, CancellationTokenSource pendingRequestsCts, CancellationToken originalCancellationToken)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459182000, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at System.Net.Http.HttpClient.<SendAsync>g__Core|83_0(HttpRequestMessage request, HttpCompletionOption completionOption, CancellationTokenSource cts, Boolean disposeCts, CancellationTokenSource pendingRequestsCts, CancellationToken originalCancellationToken)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459198541, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459212791, testhost.dll, [xUnit.net 00:00:02.23] /Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/Clubs/AdminClubEndpointsTests.cs(24,0): at WorkClub.Tests.Integration.Clubs.AdminClubEndpointsTests.CreateClub_WithAdminRole_ReturnsCreated()
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459226375, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] /Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/Clubs/AdminClubEndpointsTests.cs(24,0): at WorkClub.Tests.Integration.Clubs.AdminClubEndpointsTests.CreateClub_WithAdminRole_ReturnsCreated()"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459242250, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459252541, testhost.dll, [xUnit.net 00:00:02.23] --- End of stack trace from previous location ---
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459264416, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] --- End of stack trace from previous location ---"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459277416, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459287333, testhost.dll, [xUnit.net 00:00:02.23] ----- Inner Stack Trace -----
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459299750, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] ----- Inner Stack Trace -----"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459313375, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459327666, testhost.dll, [xUnit.net 00:00:02.23] at Npgsql.Internal.NpgsqlConnector.ReadMessageLong(Boolean async, DataRowLoadingMode dataRowLoadingMode, Boolean readingNotifications, Boolean isReadingPrependedMessage)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459341083, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Npgsql.Internal.NpgsqlConnector.ReadMessageLong(Boolean async, DataRowLoadingMode dataRowLoadingMode, Boolean readingNotifications, Boolean isReadingPrependedMessage)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459354500, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459370750, testhost.dll, [xUnit.net 00:00:02.23] at System.Runtime.CompilerServices.PoolingAsyncValueTaskMethodBuilder`1.StateMachineBox`1.System.Threading.Tasks.Sources.IValueTaskSource<TResult>.GetResult(Int16 token)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459383125, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at System.Runtime.CompilerServices.PoolingAsyncValueTaskMethodBuilder`1.StateMachineBox`1.System.Threading.Tasks.Sources.IValueTaskSource<TResult>.GetResult(Int16 token)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459396625, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459408333, testhost.dll, [xUnit.net 00:00:02.23] at Npgsql.NpgsqlDataReader.NextResult(Boolean async, Boolean isConsuming, CancellationToken cancellationToken)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459420458, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Npgsql.NpgsqlDataReader.NextResult(Boolean async, Boolean isConsuming, CancellationToken cancellationToken)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459435500, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459448000, testhost.dll, [xUnit.net 00:00:02.23] at Npgsql.NpgsqlDataReader.NextResult(Boolean async, Boolean isConsuming, CancellationToken cancellationToken)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459460250, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Npgsql.NpgsqlDataReader.NextResult(Boolean async, Boolean isConsuming, CancellationToken cancellationToken)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459476708, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459488583, testhost.dll, [xUnit.net 00:00:02.23] at Npgsql.NpgsqlCommand.ExecuteReader(Boolean async, CommandBehavior behavior, CancellationToken cancellationToken)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459501250, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Npgsql.NpgsqlCommand.ExecuteReader(Boolean async, CommandBehavior behavior, CancellationToken cancellationToken)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459514666, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459526916, testhost.dll, [xUnit.net 00:00:02.23] at Npgsql.NpgsqlCommand.ExecuteReader(Boolean async, CommandBehavior behavior, CancellationToken cancellationToken)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459540875, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Npgsql.NpgsqlCommand.ExecuteReader(Boolean async, CommandBehavior behavior, CancellationToken cancellationToken)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459555458, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459567458, testhost.dll, [xUnit.net 00:00:02.23] at Npgsql.NpgsqlCommand.ExecuteDbDataReaderAsync(CommandBehavior behavior, CancellationToken cancellationToken)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.019, 236456459663625, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Npgsql.NpgsqlCommand.ExecuteDbDataReaderAsync(CommandBehavior behavior, CancellationToken cancellationToken)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.020, 236456459811500, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.020, 236456459854041, testhost.dll, [xUnit.net 00:00:02.23] at Microsoft.EntityFrameworkCore.Storage.RelationalCommand.ExecuteReaderAsync(RelationalCommandParameterObject parameterObject, CancellationToken cancellationToken)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.020, 236456459880625, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Microsoft.EntityFrameworkCore.Storage.RelationalCommand.ExecuteReaderAsync(RelationalCommandParameterObject parameterObject, CancellationToken cancellationToken)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.020, 236456459920208, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.020, 236456459944375, testhost.dll, [xUnit.net 00:00:02.23] at Microsoft.EntityFrameworkCore.Storage.RelationalCommand.ExecuteReaderAsync(RelationalCommandParameterObject parameterObject, CancellationToken cancellationToken)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.020, 236456459964583, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Microsoft.EntityFrameworkCore.Storage.RelationalCommand.ExecuteReaderAsync(RelationalCommandParameterObject parameterObject, CancellationToken cancellationToken)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.020, 236456459980833, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.020, 236456459998208, testhost.dll, [xUnit.net 00:00:02.23] at Microsoft.EntityFrameworkCore.Update.ReaderModificationCommandBatch.ExecuteAsync(IRelationalConnection connection, CancellationToken cancellationToken)
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.020, 236456460014958, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.23] at Microsoft.EntityFrameworkCore.Update.ReaderModificationCommandBatch.ExecuteAsync(IRelationalConnection connection, CancellationToken cancellationToken)"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.020, 236456460032000, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.022, 236456462286500, testhost.dll, TestExecutionRecorder.RecordResult: Received result for test: WorkClub.Tests.Integration.Clubs.AdminClubEndpointsTests.CreateClub_WithAdminRole_ReturnsCreated.
TpTrace Warning: 0 : 54518, 17, 2026/03/18, 15:19:49.023, 236456463033958, testhost.dll, TestRunCache: InProgressTests is null
TpTrace Warning: 0 : 54518, 17, 2026/03/18, 15:19:49.023, 236456463070958, testhost.dll, TestRunCache: No test found corresponding to testResult 'WorkClub.Tests.Integration.Clubs.AdminClubEndpointsTests.CreateClub_WithAdminRole_ReturnsCreated' in inProgress list.
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.023, 236456463545958, testhost.dll, TestExecutionRecorder.RecordEnd: test: WorkClub.Tests.Integration.Clubs.AdminClubEndpointsTests.CreateClub_WithAdminRole_ReturnsCreated execution completed.
TpTrace Warning: 0 : 54518, 17, 2026/03/18, 15:19:49.023, 236456463559250, testhost.dll, TestRunCache: InProgressTests is null
TpTrace Information: 0 : 54518, 17, 2026/03/18, 15:19:49.233, 236456673498750, testhost.dll, [xUnit.net 00:00:02.44] Finished: WorkClub.Tests.Integration
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.233, 236456673568000, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestSession.Message","Payload":{"MessageLevel":0,"Message":"[xUnit.net 00:00:02.44] Finished: WorkClub.Tests.Integration"}}
TpTrace Verbose: 0 : 54518, 17, 2026/03/18, 15:19:49.233, 236456673612750, testhost.dll, MulticastDelegateUtilities.SafeInvoke: TestRunMessageLoggerProxy.SendMessage: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CrossPlatEngine.Execution.RunTestsWithSources., took 0 ms.
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:49.235, 236456675726125, testhost.dll, BaseRunTests.RunTestInternalWithExecutors: Completed running tests for executor://xunit/VsTestRunner3/netcore/
TpTrace Information: 0 : 54518, 4, 2026/03/18, 15:19:49.237, 236456676892208, testhost.dll, Sending test run complete
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:49.242, 236456681792208, testhost.dll, TestRequestHandler.SendData: sending data from testhost: {"Version":7,"MessageType":"TestExecution.Completed","Payload":{"TestRunCompleteArgs":{"TestRunStatistics":{"ExecutedTests":1,"Stats":{"Failed":1}},"IsCanceled":false,"IsAborted":false,"Error":null,"AttachmentSets":[],"InvokedDataCollectors":[],"ElapsedTimeInRunningTests":"00:00:02.4530676","Metrics":{},"DiscoveredExtensions":{"TestDiscoverers":["Xunit.Runner.VisualStudio.VsTestRunner, xunit.runner.visualstudio.testadapter, Version=3.1.4.0, Culture=neutral, PublicKeyToken=null"],"TestExecutors":["executor://xunit/VsTestRunner3/netcore/"],"TestExecutors2":[],"TestSettingsProviders":[]}},"LastRunTests":{"NewTestResults":[{"TestCase":{"Id":"a8c49312-90f7-774d-ef37-0a55d289cbae","FullyQualifiedName":"WorkClub.Tests.Integration.Clubs.AdminClubEndpointsTests.CreateClub_WithAdminRole_ReturnsCreated","DisplayName":"WorkClub.Tests.Integration.Clubs.AdminClubEndpointsTests.CreateClub_WithAdminRole_ReturnsCreated","ExecutorUri":"executor://xunit/VsTestRunner3/netcore/","Source":"/Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/bin/Debug/net10.0/WorkClub.Tests.Integration.dll","CodeFilePath":null,"LineNumber":0,"Properties":[{"Key":{"Id":"XunitTestCaseExplicit","Label":"xUnit.net Test Case Explicit Flag","Category":"","Description":"","Attributes":0,"ValueType":"System.Boolean"},"Value":false},{"Key":{"Id":"TestCase.ManagedType","Label":"ManagedType","Category":"","Description":"","Attributes":1,"ValueType":"System.String"},"Value":"WorkClub.Tests.Integration.Clubs.AdminClubEndpointsTests"},{"Key":{"Id":"TestCase.ManagedMethod","Label":"ManagedMethod","Category":"","Description":"","Attributes":1,"ValueType":"System.String"},"Value":"CreateClub_WithAdminRole_ReturnsCreated"},{"Key":{"Id":"XunitTestCaseUniqueID","Label":"xUnit.net Test Case Unique ID","Category":"","Description":"","Attributes":0,"ValueType":"System.String"},"Value":"d0865975d8177c51f513124eed31b3647a0ba8c3"}]},"Attachments":[],"Outcome":2,"ErrorMessage":"Microsoft.EntityFrameworkCore.DbUpdateException : An error occurred while saving the entity changes. See the inner exception for details.\n---- Npgsql.PostgresException : 42501: permission denied for table clubs","ErrorStackTrace":" at Microsoft.EntityFrameworkCore.Update.ReaderModificationCommandBatch.ExecuteAsync(IRelationalConnection connection, CancellationToken cancellationToken)\n at Microsoft.EntityFrameworkCore.Update.Internal.BatchExecutor.ExecuteAsync(IEnumerable`1 commandBatches, IRelationalConnection connection, CancellationToken cancellationToken)\n at Microsoft.EntityFrameworkCore.Update.Internal.BatchExecutor.ExecuteAsync(IEnumerable`1 commandBatches, IRelationalConnection connection, CancellationToken cancellationToken)\n at Microsoft.EntityFrameworkCore.Update.Internal.BatchExecutor.ExecuteAsync(IEnumerable`1 commandBatches, IRelationalConnection connection, CancellationToken cancellationToken)\n at Microsoft.EntityFrameworkCore.Storage.RelationalDatabase.SaveChangesAsync(IList`1 entries, CancellationToken cancellationToken)\n at Microsoft.EntityFrameworkCore.ChangeTracking.Internal.StateManager.SaveChangesAsync(IList`1 entriesToSave, CancellationToken cancellationToken)\n at Microsoft.EntityFrameworkCore.ChangeTracking.Internal.StateManager.SaveChangesAsync(StateManager stateManager, Boolean acceptAllChangesOnSuccess, CancellationToken cancellationToken)\n at Npgsql.EntityFrameworkCore.PostgreSQL.Storage.Internal.NpgsqlExecutionStrategy.ExecuteAsync[TState,TResult](TState state, Func`4 operation, Func`4 verifySucceeded, CancellationToken cancellationToken)\n at Microsoft.EntityFrameworkCore.DbContext.SaveChangesAsync(Boolean acceptAllChangesOnSuccess, CancellationToken cancellationToken)\n at Microsoft.EntityFrameworkCore.DbContext.SaveChangesAsync(Boolean acceptAllChangesOnSuccess, CancellationToken cancellationToken)\n at WorkClub.Api.Services.AdminClubService.<>c__DisplayClass3_0.<<CreateClubAsync>b__0>d.MoveNext() in /Users/mastermito/Dev/opencode/backend/WorkClub.Api/Services/AdminClubService.cs:line 54\n--- End of stack trace from previous location ---\n at WorkClub.Api.Services.AdminClubService.<>c__DisplayClass3_0.<<CreateClubAsync>b__0>d.MoveNext() in /Users/mastermito/Dev/opencode/backend/WorkClub.Api/Services/AdminClubService.cs:line 56\n--- End of stack trace from previous location ---\n at Microsoft.EntityFrameworkCore.ExecutionStrategyExtensions.<>c.<<ExecuteAsync>b__3_0>d.MoveNext()\n--- End of stack trace from previous location ---\n at Npgsql.EntityFrameworkCore.PostgreSQL.Storage.Internal.NpgsqlExecutionStrategy.ExecuteAsync[TState,TResult](TState state, Func`4 operation, Func`4 verifySucceeded, CancellationToken cancellationToken)\n at WorkClub.Api.Services.AdminClubService.CreateClubAsync(CreateClubRequest request) in /Users/mastermito/Dev/opencode/backend/WorkClub.Api/Services/AdminClubService.cs:line 49\n at WorkClub.Api.Endpoints.Clubs.AdminClubEndpoints.CreateClub(CreateClubRequest request, AdminClubService adminClubService) in /Users/mastermito/Dev/opencode/backend/WorkClub.Api/Endpoints/Clubs/AdminClubEndpoints.cs:line 39\n at Microsoft.AspNetCore.Http.RequestDelegateFactory.ExecuteTaskResult[T](Task`1 task, HttpContext httpContext)\n at Microsoft.AspNetCore.Http.RequestDelegateFactory.<>c__DisplayClass102_2.<<HandleRequestBodyAndCompileRequestDelegateForJson>b__2>d.MoveNext()\n--- End of stack trace from previous location ---\n at WorkClub.Api.Middleware.MemberSyncMiddleware.InvokeAsync(HttpContext context, MemberSyncService memberSyncService) in /Users/mastermito/Dev/opencode/backend/WorkClub.Api/Middleware/MemberSyncMiddleware.cs:line 24\n at WorkClub.Api.Middleware.TenantValidationMiddleware.InvokeAsync(HttpContext context) in /Users/mastermito/Dev/opencode/backend/WorkClub.Api/Middleware/TenantValidationMiddleware.cs:line 30\n at Microsoft.AspNetCore.Authorization.AuthorizationMiddleware.Invoke(HttpContext context)\n at Microsoft.AspNetCore.Authentication.AuthenticationMiddleware.Invoke(HttpContext context)\n at Microsoft.AspNetCore.TestHost.HttpContextBuilder.<>c__DisplayClass23_0.<<SendAsync>g__RunRequestAsync|0>d.MoveNext()\n--- End of stack trace from previous location ---\n at Microsoft.AspNetCore.TestHost.ClientHandler.SendAsync(HttpRequestMessage request, CancellationToken cancellationToken)\n at Microsoft.AspNetCore.Mvc.Testing.Handlers.CookieContainerHandler.SendAsync(HttpRequestMessage request, CancellationToken cancellationToken)\n at Microsoft.AspNetCore.Mvc.Testing.Handlers.RedirectHandler.SendAsync(HttpRequestMessage request, CancellationToken cancellationToken)\n at System.Net.Http.HttpClient.<SendAsync>g__Core|83_0(HttpRequestMessage request, HttpCompletionOption completionOption, CancellationTokenSource cts, Boolean disposeCts, CancellationTokenSource pendingRequestsCts, CancellationToken originalCancellationToken)\n at WorkClub.Tests.Integration.Clubs.AdminClubEndpointsTests.CreateClub_WithAdminRole_ReturnsCreated() in /Users/mastermito/Dev/opencode/backend/WorkClub.Tests.Integration/Clubs/AdminClubEndpointsTests.cs:line 24\n--- End of stack trace from previous location ---\n----- Inner Stack Trace -----\n at Npgsql.Internal.NpgsqlConnector.ReadMessageLong(Boolean async, DataRowLoadingMode dataRowLoadingMode, Boolean readingNotifications, Boolean isReadingPrependedMessage)\n at System.Runtime.CompilerServices.PoolingAsyncValueTaskMethodBuilder`1.StateMachineBox`1.System.Threading.Tasks.Sources.IValueTaskSource<TResult>.GetResult(Int16 token)\n at Npgsql.NpgsqlDataReader.NextResult(Boolean async, Boolean isConsuming, CancellationToken cancellationToken)\n at Npgsql.NpgsqlDataReader.NextResult(Boolean async, Boolean isConsuming, CancellationToken cancellationToken)\n at Npgsql.NpgsqlCommand.ExecuteReader(Boolean async, CommandBehavior behavior, CancellationToken cancellationToken)\n at Npgsql.NpgsqlCommand.ExecuteReader(Boolean async, CommandBehavior behavior, CancellationToken cancellationToken)\n at Npgsql.NpgsqlCommand.ExecuteDbDataReaderAsync(CommandBehavior behavior, CancellationToken cancellationToken)\n at Microsoft.EntityFrameworkCore.Storage.RelationalCommand.ExecuteReaderAsync(RelationalCommandParameterObject parameterObject, CancellationToken cancellationToken)\n at Microsoft.EntityFrameworkCore.Storage.RelationalCommand.ExecuteReaderAsync(RelationalCommandParameterObject parameterObject, CancellationToken cancellationToken)\n at Microsoft.EntityFrameworkCore.Update.ReaderModificationCommandBatch.ExecuteAsync(IRelationalConnection connection, CancellationToken cancellationToken)","DisplayName":"WorkClub.Tests.Integration.Clubs.AdminClubEndpointsTests.CreateClub_WithAdminRole_ReturnsCreated","Messages":[],"ComputerName":"MacBook-Pro-von-Denis","Duration":"00:00:02.0990329","StartTime":"2026-03-18T14:19:46.91042+00:00","EndTime":"2026-03-18T14:19:49.015933+00:00","Properties":[]}],"TestRunStatistics":{"ExecutedTests":1,"Stats":{"Failed":1}},"ActiveTests":[]},"RunAttachments":[],"ExecutorUris":["executor://xunit/VsTestRunner3/netcore/"]}}
TpTrace Verbose: 0 : 54518, 4, 2026/03/18, 15:19:49.242, 236456681919291, testhost.dll, BaseRunTests.RunTests: Run is complete.
TpTrace Verbose: 0 : 54518, 11, 2026/03/18, 15:19:49.242, 236456682244208, testhost.dll, TcpClientExtensions.MessageLoopAsync: NotifyDataAvailable remoteEndPoint: [::ffff:127.0.0.1]:56513 localEndPoint: [::ffff:127.0.0.1]:56514
TpTrace Information: 0 : 54518, 11, 2026/03/18, 15:19:49.242, 236456682334250, testhost.dll, TestRequestHandler.OnMessageReceived: received message: (TestSession.Terminate) -> {"MessageType":"TestSession.Terminate","Payload":null}
TpTrace Information: 0 : 54518, 11, 2026/03/18, 15:19:49.242, 236456682342125, testhost.dll, Session End message received from server. Closing the connection.
TpTrace Information: 0 : 54518, 11, 2026/03/18, 15:19:49.242, 236456682465458, testhost.dll, SocketClient.Stop: Stop communication from server endpoint: 127.0.0.1:056513
TpTrace Information: 0 : 54518, 11, 2026/03/18, 15:19:49.242, 236456682472875, testhost.dll, SocketClient: Stop: Cancellation requested. Stopping message loop.
TpTrace Information: 0 : 54518, 1, 2026/03/18, 15:19:49.242, 236456682470375, testhost.dll, SocketClient.Stop: Stop communication from server endpoint: 127.0.0.1:056513
TpTrace Information: 0 : 54518, 1, 2026/03/18, 15:19:49.242, 236456682496625, testhost.dll, SocketClient: Stop: Cancellation requested. Stopping message loop.
TpTrace Verbose: 0 : 54518, 11, 2026/03/18, 15:19:49.242, 236456682504833, testhost.dll, LengthPrefixCommunicationChannel.Dispose: Dispose reader and writer.
TpTrace Verbose: 0 : 54518, 1, 2026/03/18, 15:19:49.242, 236456682514625, testhost.dll, LengthPrefixCommunicationChannel.Dispose: Dispose reader and writer.
TpTrace Information: 0 : 54518, 11, 2026/03/18, 15:19:49.242, 236456682518750, testhost.dll, Closing the connection !
TpTrace Verbose: 0 : 54518, 11, 2026/03/18, 15:19:49.242, 236456682530416, testhost.dll, MulticastDelegateUtilities.SafeInvoke: LengthPrefixCommunicationChannel: MessageReceived: Invoking callback 1/1 for Microsoft.VisualStudio.TestPlatform.CommunicationUtilities.TestRequestHandler., took 0 ms.
TpTrace Information: 0 : 54518, 1, 2026/03/18, 15:19:49.242, 236456682545750, testhost.dll, Testhost process exiting.
TpTrace Information: 0 : 54518, 11, 2026/03/18, 15:19:49.242, 236456682594458, testhost.dll, SocketClient.PrivateStop: Stop communication from server endpoint: 127.0.0.1:056513, error:
TpTrace Verbose: 0 : 54518, 11, 2026/03/18, 15:19:49.242, 236456682631750, testhost.dll, LengthPrefixCommunicationChannel.Dispose: Dispose reader and writer.
TpTrace Verbose: 0 : 54518, 11, 2026/03/18, 15:19:49.242, 236456682638583, testhost.dll, TcpClientExtensions.MessageLoopAsync: exiting MessageLoopAsync remoteEndPoint: [::ffff:127.0.0.1]:56513 localEndPoint: [::ffff:127.0.0.1]:56514