dotnet / aspnetcore

ASP.NET Core is a cross-platform .NET framework for building modern cloud-based web applications on Windows, Mac, or Linux.
https://asp.net
MIT License
35.28k stars 9.96k forks source link

Quarantine CheckStdoutWithLargeWrites_LogFile #58108

Open amcasey opened 1 week ago

amcasey commented 1 week ago

Failing Test(s)

Error Message

No entries matched by 'Application '/LM/W3SVC/1/ROOT' with physical root 'C:\h\w\B63B09D7\t\dbd36293f0a045f498e41d57fde49f50' has exited from Program.Main with exit code = '12'. First 30KB characters of captured stdout and stderr logs:
aaaa[SNIP]'

Stacktrace

```text at Microsoft.AspNetCore.Server.IIS.FunctionalTests.EventLogHelpers.<>c__DisplayClass3_0.g__AssertEntries|0() in /_/src/Servers/IIS/IIS/test/Common.FunctionalTests/Infrastructure/EventLogHelpers.cs:line 86 at Microsoft.AspNetCore.Server.IIS.FunctionalTests.EventLogHelpers.AssertEntryAsync(String regexString, IISDeploymentResult deploymentResult, Boolean allowMultiple) in /_/src/Servers/IIS/IIS/test/Common.FunctionalTests/Infrastructure/EventLogHelpers.cs:line 81 at Microsoft.AspNetCore.Server.IIS.FunctionalTests.EventLogHelpers.VerifyEventLogEventAsync(IISDeploymentResult deploymentResult, String expectedRegexMatchString, ILogger logger, Boolean allowMultiple) in /_/src/Servers/IIS/IIS/test/Common.FunctionalTests/Infrastructure/EventLogHelpers.cs:line 24 at Microsoft.AspNetCore.Server.IIS.IISExpress.FunctionalTests.StartupTests.CheckStdoutWithLargeWrites_LogFile(String mode) in /_/src/Servers/IIS/IIS/test/Common.LongTests/StartupTests.cs:line 1035 --- End of stack trace from previous location --- ```

Logs

```text [0.001s] [TestLifetime] [Information] Starting test CheckStdoutWithLargeWrites_LogFile-CheckLargeStdOutWrites at 2024-09-26T13:02:31 [0.001s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] Deploying [Variation] :: ServerType=IISExpress, Runtime=CoreClr, Arch=x64, BaseUrlHint=, Publish=True [0.001s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] Microsoft Windows NT 10.0.20348.0 [0.002s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] Using prepublished application from C:\h\w\B63B09D7\w\B3A90963\e\InProcessWebSite-Portable [0.005s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Processing C:\h\w\B63B09D7\t\dbd36293f0a045f498e41d57fde49f50\ARM64 [0.005s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying aspnetcorev2_inprocess.dll [0.007s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Processing C:\h\w\B63B09D7\t\dbd36293f0a045f498e41d57fde49f50\runtimes\win\lib\net9.0 [0.007s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying System.Diagnostics.EventLog.dll [0.008s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying System.Diagnostics.EventLog.Messages.dll [0.009s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Processing C:\h\w\B63B09D7\t\dbd36293f0a045f498e41d57fde49f50\runtimes\win\lib [0.009s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Processing C:\h\w\B63B09D7\t\dbd36293f0a045f498e41d57fde49f50\runtimes\win [0.009s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Processing C:\h\w\B63B09D7\t\dbd36293f0a045f498e41d57fde49f50\runtimes [0.009s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Processing C:\h\w\B63B09D7\t\dbd36293f0a045f498e41d57fde49f50\wwwroot [0.009s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying static.txt [0.010s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying static.txt.br [0.010s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying static.txt.gz [0.011s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Processing C:\h\w\B63B09D7\t\dbd36293f0a045f498e41d57fde49f50\x64 [0.011s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying aspnetcorev2_inprocess.dll [0.012s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Processing C:\h\w\B63B09D7\t\dbd36293f0a045f498e41d57fde49f50\x86 [0.012s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying aspnetcorev2_inprocess.dll [0.013s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Processing C:\h\w\B63B09D7\t\dbd36293f0a045f498e41d57fde49f50 [0.013s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying InProcessWebSite.deps.json [0.017s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying InProcessWebSite.dll [0.017s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying InProcessWebSite.exe [0.018s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying InProcessWebSite.pdb [0.019s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying InProcessWebSite.runtimeconfig.json [0.019s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying InProcessWebSite.staticwebassets.endpoints.json [0.020s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Authentication.Abstractions.dll [0.020s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Authentication.Abstractions.pdb [0.021s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Authentication.Abstractions.xml [0.021s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Authentication.Core.dll [0.022s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Authentication.Core.pdb [0.022s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Authentication.Core.xml [0.023s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Connections.Abstractions.dll [0.026s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Connections.Abstractions.pdb [0.027s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Connections.Abstractions.xml [0.028s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Hosting.Abstractions.dll [0.028s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Hosting.Abstractions.pdb [0.029s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Hosting.Abstractions.xml [0.029s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Hosting.dll [0.030s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Hosting.pdb [0.030s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Hosting.Server.Abstractions.dll [0.031s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Hosting.Server.Abstractions.pdb [0.035s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Hosting.Server.Abstractions.xml [0.035s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Hosting.xml [0.036s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Http.Abstractions.dll [0.037s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Http.Abstractions.pdb [0.037s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Http.Abstractions.xml [0.038s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Http.dll [0.038s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Http.Extensions.dll [0.039s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Http.Extensions.pdb [0.040s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Http.Extensions.xml [0.040s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Http.Features.dll [0.041s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Http.Features.pdb [0.048s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Http.Features.xml [0.048s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Http.pdb [0.049s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Http.xml [0.049s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.HttpOverrides.dll [0.050s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.HttpOverrides.pdb [0.051s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.HttpOverrides.xml [0.054s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.HttpsPolicy.dll [0.055s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.HttpsPolicy.pdb [0.055s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.HttpsPolicy.xml [0.056s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.ResponseCompression.dll [0.056s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.ResponseCompression.pdb [0.057s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.ResponseCompression.xml [0.061s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Server.HttpSys.dll [0.062s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Server.HttpSys.pdb [0.062s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Server.HttpSys.xml [0.063s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Server.IIS.dll [0.064s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Server.IIS.pdb [0.064s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Server.IIS.xml [0.065s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Server.IISIntegration.dll [0.066s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Server.IISIntegration.pdb [0.066s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Server.IISIntegration.xml [0.067s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Server.Kestrel.Core.dll [0.068s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Server.Kestrel.Core.pdb [0.068s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Server.Kestrel.Core.xml [0.072s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Server.Kestrel.dll [0.072s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Server.Kestrel.pdb [0.073s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Server.Kestrel.Transport.NamedPipes.dll [0.073s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Server.Kestrel.Transport.NamedPipes.pdb [0.074s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Server.Kestrel.Transport.NamedPipes.xml [0.074s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Server.Kestrel.Transport.Quic.dll [0.078s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Server.Kestrel.Transport.Quic.pdb [0.078s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Server.Kestrel.Transport.Quic.xml [0.079s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Server.Kestrel.Transport.Sockets.dll [0.079s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Server.Kestrel.Transport.Sockets.pdb [0.080s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Server.Kestrel.Transport.Sockets.xml [0.080s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.Server.Kestrel.xml [0.081s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.WebUtilities.dll [0.081s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.WebUtilities.pdb [0.082s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.AspNetCore.WebUtilities.xml [0.083s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.Configuration.Abstractions.dll [0.083s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.Configuration.Binder.dll [0.084s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.Configuration.CommandLine.dll [0.084s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.Configuration.dll [0.085s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.Configuration.EnvironmentVariables.dll [0.085s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.Configuration.FileExtensions.dll [0.086s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.Configuration.Json.dll [0.087s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.Configuration.UserSecrets.dll [0.090s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.DependencyInjection.Abstractions.dll [0.090s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.DependencyInjection.dll [0.091s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.Diagnostics.Abstractions.dll [0.091s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.Diagnostics.dll [0.092s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.Features.dll [0.092s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.Features.pdb [0.093s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.Features.xml [0.093s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.FileProviders.Abstractions.dll [0.094s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.FileProviders.Composite.dll [0.094s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.FileProviders.Physical.dll [0.095s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.FileSystemGlobbing.dll [0.096s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.Hosting.Abstractions.dll [0.096s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.Hosting.dll [0.097s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.Logging.Abstractions.dll [0.097s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.Logging.Configuration.dll [0.098s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.Logging.Console.dll [0.099s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.Logging.Debug.dll [0.099s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.Logging.dll [0.100s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.Logging.EventLog.dll [0.100s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.Logging.EventSource.dll [0.101s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.ObjectPool.dll [0.101s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.ObjectPool.pdb [0.102s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.ObjectPool.xml [0.103s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.Options.ConfigurationExtensions.dll [0.103s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.Options.dll [0.104s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Extensions.Primitives.dll [0.199s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Net.Http.Headers.dll [0.202s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Net.Http.Headers.pdb [0.203s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying Microsoft.Net.Http.Headers.xml [0.203s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying System.Diagnostics.EventLog.dll [0.204s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying TestTasks.exe [0.205s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying TestTasks.runtimeconfig.json [0.205s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying web.config [0.206s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Copying xunit.assert.dll [0.207s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] Attempting to start IIS Express on port: 64181 [0.209s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Saving Config to C:\h\w\B63B09D7\t\tmpcx4kun.tmp [0.209s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] Executing command : C:\Program Files\IIS Express\iisexpress.exe /site:HttpTestSite /config:C:\h\w\B63B09D7\t\tmpcx4kun.tmp /trace:error /systray:false [0.209s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] Removing environment variable ASPNETCORE_ENVIRONMENT [0.209s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] SET ASPNETCORE_DETAILEDERRORS=true [0.209s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] SET ASPNETCORE_MODULE_DEBUG=console [0.214s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress Process 6980 started [0.298s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: Starting IIS Express ... [0.316s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: Initializing the W3 Server Started CTC = 847421 [0.321s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: W3 Server initializing WinSock. CTC = 847421 [0.321s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: W3 Server WinSock initialized. CTC = 847421 [0.322s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: W3 Server ThreadPool initialized (ipm has signalled). CTC = 847421 [0.351s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:31.906Z, PID: 6980] [aspnetcorev2.dll] Initializing logs for 'C:\h\w\B63B09D7\w\B3A90963\e\ANCM\x64\aspnetcorev2.dll'. Process Id: 6980. File Version: 20.0.24270.0. Description: IIS ASP.NET Core Module V2. Commit: . [0.352s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: Start listenerChannel http:0 [0.353s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: Successfully registered URL "http://localhost:64181/" for site "HttpTestSite" application "/" [0.353s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: Registration completed for site "HttpTestSite" [0.354s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: AppPool 'IISExpressAppPool' initialized [0.357s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: InitComplete event signalled [0.358s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] Started iisexpress successfully. Process Id : 6980, Port: 64181 [0.358s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: IIS Express is running. [0.358s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] Application ready at URL: http://localhost:64181/ [0.359s] [HttpTestSite] [Debug] Method: GET, RequestUri: 'http://localhost:64181/HelloWorld', Version: 1.1, Content: , Headers: { } [0.869s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: IncrementMessages called [0.871s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: Request started: "GET" http://localhost:64181/HelloWorld [0.874s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.430Z, PID: 6980] [aspnetcorev2.dll] Resolving hostfxr parameters for application: 'dotnet' arguments: '.\InProcessWebSite.dll CheckLargeStdOutWrites' path: 'C:\h\w\B63B09D7\t\dbd36293f0a045f498e41d57fde49f50\' [0.875s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.430Z, PID: 6980] [aspnetcorev2.dll] Known dotnet.exe location: '' [0.875s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.430Z, PID: 6980] [aspnetcorev2.dll] Process path 'dotnet.exe' is dotnet, treating application as portable [0.875s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.430Z, PID: 6980] [aspnetcorev2.dll] get_hostfxr_path skipped due to expandedProcessPath being dotnet.exe [0.876s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.431Z, PID: 6980] [aspnetcorev2.dll] Resolving absolute path to dotnet.exe from 'dotnet.exe' [0.876s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.432Z, PID: 6980] [aspnetcorev2.dll] Invoking where.exe to find dotnet.exe [0.968s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.523Z, PID: 6980] [aspnetcorev2.dll] where.exe invocation returned: 'C:\h\w\B63B09D7\p\dotnet-cli\dotnet.exe [0.968s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: C:\Program Files\dotnet\dotnet.exe [0.969s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: ' [0.969s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.524Z, PID: 6980] [aspnetcorev2.dll] Current process bitness type detected as isX64=1 [0.969s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.524Z, PID: 6980] [aspnetcorev2.dll] Processing entry 'C:\h\w\B63B09D7\p\dotnet-cli\dotnet.exe' [0.972s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.528Z, PID: 6980] [aspnetcorev2.dll] Binary type 6 [0.973s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.528Z, PID: 6980] [aspnetcorev2.dll] Found dotnet.exe via where.exe invocation at 'C:\h\w\B63B09D7\p\dotnet-cli\dotnet.exe' [0.973s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.528Z, PID: 6980] [aspnetcorev2.dll] Trying get_hostfxr_path with dotnet path as dotnet root [0.973s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.528Z, PID: 6980] [aspnetcorev2.dll] hostfxr.dotnet_root: 'C:\h\w\B63B09D7\p\dotnet-cli' [0.973s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.528Z, PID: 6980] [aspnetcorev2.dll] hostfxr.assembly_path: 'C:\h\w\B63B09D7\t\dbd36293f0a045f498e41d57fde49f50\' [0.973s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.528Z, PID: 6980] [aspnetcorev2.dll] dotnetExePath 'C:\h\w\B63B09D7\p\dotnet-cli\dotnet.exe' [0.973s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.528Z, PID: 6980] [aspnetcorev2.dll] hostFxrDllpath 'C:\h\w\B63B09D7\p\dotnet-cli\host\fxr\10.0.0-alpha.1.24474.2\hostfxr.dll' [0.973s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.529Z, PID: 6980] [aspnetcorev2.dll] Converted argument '.\InProcessWebSite.dll' to 'C:\h\w\B63B09D7\t\dbd36293f0a045f498e41d57fde49f50\.\InProcessWebSite.dll' [0.974s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.529Z, PID: 6980] [aspnetcorev2.dll] Parsed hostfxr options: dotnet location: 'C:\h\w\B63B09D7\p\dotnet-cli\dotnet.exe' hostfxr path: 'C:\h\w\B63B09D7\p\dotnet-cli\host\fxr\10.0.0-alpha.1.24474.2\hostfxr.dll' arguments: [0.974s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.529Z, PID: 6980] [aspnetcorev2.dll] Argument[0] = 'C:\h\w\B63B09D7\p\dotnet-cli\dotnet.exe' [0.974s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.529Z, PID: 6980] [aspnetcorev2.dll] Argument[1] = 'C:\h\w\B63B09D7\t\dbd36293f0a045f498e41d57fde49f50\.\InProcessWebSite.dll' [0.974s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.529Z, PID: 6980] [aspnetcorev2.dll] Argument[2] = 'CheckLargeStdOutWrites' [0.974s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.530Z, PID: 6980] [aspnetcorev2.dll] Loading hostfxr from location C:\h\w\B63B09D7\p\dotnet-cli\host\fxr\10.0.0-alpha.1.24474.2\hostfxr.dll [0.995s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.550Z, PID: 6980] [aspnetcorev2.dll] Canceling standard stream pipe reader [0.996s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.551Z, PID: 6980] [aspnetcorev2.dll] Loading request handler: 'C:\h\w\B63B09D7\t\dbd36293f0a045f498e41d57fde49f50\x64\aspnetcorev2_inprocess.dll' [1.013s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.568Z, PID: 6980] [aspnetcorev2_inprocess.dll] Initializing logs for 'C:\h\w\B63B09D7\t\dbd36293f0a045f498e41d57fde49f50\x64\aspnetcorev2_inprocess.dll'. Process Id: 6980. File Version: 20.0.24270.0. Description: IIS ASP.NET Core Module V2 Request Handler. Commit: . [1.013s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.568Z, PID: 6980] [aspnetcorev2.dll] Creating handler application [1.014s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.569Z, PID: 6980] [aspnetcorev2_inprocess.dll] Waiting for initialization [1.015s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.570Z, PID: 6980] [aspnetcorev2_inprocess.dll] Starting app_offline monitoring in application 'C:\h\w\B63B09D7\t\dbd36293f0a045f498e41d57fde49f50\' [1.019s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.571Z, PID: 6980] [aspnetcorev2_inprocess.dll] Starting file watcher thread [1.020s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.575Z, PID: 6980] [aspnetcorev2_inprocess.dll] Starting in-process worker thread [1.020s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.575Z, PID: 6980] [aspnetcorev2_inprocess.dll] Resolving hostfxr parameters for application: 'dotnet' arguments: '.\InProcessWebSite.dll CheckLargeStdOutWrites' path: 'C:\h\w\B63B09D7\t\dbd36293f0a045f498e41d57fde49f50\' [1.020s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.575Z, PID: 6980] [aspnetcorev2_inprocess.dll] Known dotnet.exe location: 'C:\h\w\B63B09D7\p\dotnet-cli\dotnet.exe' [1.020s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.575Z, PID: 6980] [aspnetcorev2_inprocess.dll] Process path 'dotnet.exe' is dotnet, treating application as portable [1.020s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.575Z, PID: 6980] [aspnetcorev2_inprocess.dll] Trying get_hostfxr_path with dotnet path as dotnet root [1.020s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.575Z, PID: 6980] [aspnetcorev2_inprocess.dll] hostfxr.dotnet_root: 'C:\h\w\B63B09D7\p\dotnet-cli' [1.020s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.575Z, PID: 6980] [aspnetcorev2_inprocess.dll] hostfxr.assembly_path: 'C:\h\w\B63B09D7\t\dbd36293f0a045f498e41d57fde49f50\' [1.020s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.576Z, PID: 6980] [aspnetcorev2_inprocess.dll] dotnetExePath 'C:\h\w\B63B09D7\p\dotnet-cli\dotnet.exe' [1.020s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.576Z, PID: 6980] [aspnetcorev2_inprocess.dll] hostFxrDllpath 'C:\h\w\B63B09D7\p\dotnet-cli\host\fxr\10.0.0-alpha.1.24474.2\hostfxr.dll' [1.021s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.576Z, PID: 6980] [aspnetcorev2_inprocess.dll] Converted argument '.\InProcessWebSite.dll' to 'C:\h\w\B63B09D7\t\dbd36293f0a045f498e41d57fde49f50\.\InProcessWebSite.dll' [1.021s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.576Z, PID: 6980] [aspnetcorev2_inprocess.dll] Parsed hostfxr options: dotnet location: 'C:\h\w\B63B09D7\p\dotnet-cli\dotnet.exe' hostfxr path: 'C:\h\w\B63B09D7\p\dotnet-cli\host\fxr\10.0.0-alpha.1.24474.2\hostfxr.dll' arguments: [1.021s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.576Z, PID: 6980] [aspnetcorev2_inprocess.dll] Argument[0] = 'C:\h\w\B63B09D7\p\dotnet-cli\dotnet.exe' [1.021s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.576Z, PID: 6980] [aspnetcorev2_inprocess.dll] Argument[1] = 'C:\h\w\B63B09D7\t\dbd36293f0a045f498e41d57fde49f50\.\InProcessWebSite.dll' [1.021s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.576Z, PID: 6980] [aspnetcorev2_inprocess.dll] Argument[2] = 'CheckLargeStdOutWrites' [1.021s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.576Z, PID: 6980] [aspnetcorev2_inprocess.dll] Setting environment variable ASPNETCORE_IIS_HTTPAUTH=windows;anonymous; [1.021s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.576Z, PID: 6980] [aspnetcorev2_inprocess.dll] Setting environment variable ASPNETCORE_IIS_PHYSICAL_PATH=C:\h\w\B63B09D7\t\dbd36293f0a045f498e41d57fde49f50\ [1.021s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.577Z, PID: 6980] [aspnetcorev2_inprocess.dll] Loading hostfxr from location C:\h\w\B63B09D7\p\dotnet-cli\host\fxr\10.0.0-alpha.1.24474.2\hostfxr.dll [1.021s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.577Z, PID: 6980] [aspnetcorev2_inprocess.dll] Initial Dll directory: 'C:\Program Files\IIS Express', current directory: 'C:\Program Files\IIS Express' [1.021s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:32.577Z, PID: 6980] [aspnetcorev2_inprocess.dll] Setting current directory to C:\h\w\B63B09D7\t\dbd36293f0a045f498e41d57fde49f50\ [1.564s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: aaa[SNIP] [2024-09-26T13:02:33.119Z, PID: 6980] [aspnetcorev2_inprocess.dll] Managed application exited with code 12 [1.565s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: aaaa[SNIP] [2024-09-26T13:02:33.120Z, PID: 6980] [aspnetcorev2_inprocess.dll] Starting shutdown sequence 1 [1.565s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:33.120Z, PID: 6980] [aspnetcorev2_inprocess.dll] Clr thread wait ended: clrThreadExited: 1 [1.566s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:33.121Z, PID: 6980] [aspnetcorev2_inprocess.dll] Event Log: 'Application '/LM/W3SVC/1/ROOT' with physical root 'C:\h\w\B63B09D7\t\dbd36293f0a045f498e41d57fde49f50\' has exited from Program.Main with exit code = '12'. First 30KB characters of captured stdout and stderr logs: [1.567s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: aaaa[SNIP]' [1.567s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: End Event Log Message. [1.567s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: aaaa[SNIP] [1.568s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:33.122Z, PID: 6980] [aspnetcorev2_inprocess.dll] Canceling standard stream pipe reader [1.568s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:33.124Z, PID: 6980] [aspnetcorev2_inprocess.dll] Stopping in-process worker thread [1.569s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:33.124Z, PID: 6980] [aspnetcorev2_inprocess.dll] Stopping CLR [1.569s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:33.124Z, PID: 6980] [aspnetcorev2_inprocess.dll] Event Log: 'Application '/LM/W3SVC/1/ROOT' with physical root 'C:\h\w\B63B09D7\t\dbd36293f0a045f498e41d57fde49f50\' failed to load coreclr. Exception message: [1.569s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: CLR worker thread exited prematurely' [1.569s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: End Event Log Message. [1.569s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:33.124Z, PID: 6980] [aspnetcorev2_inprocess.dll] InvalidOperationException 'CLR worker thread exited prematurely' caught at D:\a\_work\1\s\src\Servers\IIS\AspNetCoreModuleV2\InProcessRequestHandler\inprocessapplication.cpp:489 [1.569s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:33.124Z, PID: 6980] [aspnetcorev2_inprocess.dll] Failed HRESULT returned: 0x8007023e at D:\a\_work\1\s\src\Servers\IIS\AspNetCoreModuleV2\InProcessRequestHandler\dllmain.cpp:131 [1.569s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:33.125Z, PID: 6980] [aspnetcorev2_inprocess.dll] Starting app_offline monitoring in application 'C:\h\w\B63B09D7\t\dbd36293f0a045f498e41d57fde49f50\' [1.570s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: Request ended: http://localhost:64181/HelloWorld with HTTP status 500.30 [1.571s] [HttpTestSite] [Warning] StatusCode: 500, ReasonPhrase: 'Internal Server Error', Version: 1.1, Content: System.Net.Http.HttpConnectionResponseContent, Headers: { Server: Microsoft-IIS/10.0 X-SourceFiles: =?UTF-8?B?QzpcaFx3XEI2M0IwOUQ3XHRcZGJkMzYyOTNmMGEwNDVmNDk4ZTQxZDU3ZmRlNDlmNTBcSGVsbG9Xb3JsZA==?= X-Powered-By: ASP.NET Date: Thu, 26 Sep 2024 13:02:33 GMT Content-Type: text/html Content-Length: 2416 } [1.571s] [HttpTestSite] [Warning] HTTP Error 500.30 - ASP.NET Core app failed to start

HTTP Error 500.30 - ASP.NET Core app failed to start

Common solutions to this issue:

  • The app failed to start
  • The app started but then stopped
  • The app started but threw an exception during startup

Troubleshooting steps:

  • Check the system event log for error messages
  • Enable logging the application process' stdout messages
  • Attach a debugger to the application process and inspect

For more guidance on diagnosing and handling these errors, visit Troubleshoot ASP.NET Core on Azure App Service and IIS.

[1.571s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] Sending shutdown request to 6980 [1.574s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: Stopping IIS Express ... [1.574s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: Process Model Shutdown called [1.574s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:33.127Z, PID: 6980] [aspnetcorev2_inprocess.dll] Starting file watcher thread [1.675s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: Stop listenerChannel http:0 [1.675s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:33.230Z, PID: 6980] [aspnetcorev2.dll] ASPNET_CORE_GLOBAL_MODULE::OnGlobalStopListening [1.676s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: Terminating W3_SERVER object [1.676s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:33.231Z, PID: 6980] [aspnetcorev2.dll] Shutdown starting in 1000 ms. [1.676s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:33.231Z, PID: 6980] [aspnetcorev2.dll] ASPNET_CORE_GLOBAL_MODULE::OnGlobalApplicationStop [1.778s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:33.333Z, PID: 6980] [aspnetcorev2.dll] ASPNET_CORE_GLOBAL_MODULE::Terminate [1.876s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: Waiting for all LISTENER_CHANNELS to stop [2.077s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: Waiting for all LISTENER_CHANNELS to stop [2.278s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: Waiting for all LISTENER_CHANNELS to stop [2.482s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: Waiting for all LISTENER_CHANNELS to stop [2.676s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:34.231Z, PID: 6980] [aspnetcorev2.dll] Shutdown starting. [2.676s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:34.231Z, PID: 6980] [aspnetcorev2.dll] Stopping application '/LM/W3SVC/1/ROOT' [2.676s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:34.232Z, PID: 6980] [aspnetcorev2_inprocess.dll] Stopping file watching. [2.676s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:34.232Z, PID: 6980] [aspnetcorev2_inprocess.dll] Waiting for file watcher thread to exit. [2.676s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:34.232Z, PID: 6980] [aspnetcorev2_inprocess.dll] Stopping file watcher thread [2.677s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: [2024-09-26T13:02:34.232Z, PID: 6980] [aspnetcorev2_inprocess.dll] Waiting for file watcher thread to exit. [2.683s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: Waiting for all LISTENER_CHANNELS to stop [2.884s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: Waiting for all LISTENER_CHANNELS to stop [3.085s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: Waiting for all LISTENER_CHANNELS to stop [3.286s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: Waiting for all LISTENER_CHANNELS to stop [3.487s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: Waiting for all LISTENER_CHANNELS to stop [3.688s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: Waiting for all LISTENER_CHANNELS to stop [3.690s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress stdout: IIS Express stopped. [3.700s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] iisexpress Process 6980 shut down [3.705s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] Host process shutting down. [3.705s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Debug] Deleting applicationHost.config file from C:\h\w\B63B09D7\t\tmpcx4kun.tmp [3.742s] [Microsoft.AspNetCore.Server.IntegrationTesting.IIS.IISExpressDeployer] [Information] [Time]: Total time taken for this test variation '3.7402823' seconds [4.801s] [Microsoft.AspNetCore.Server.IIS.IISExpress.FunctionalTests.StartupTests] [Information] 'The description for Event ID '1007' in Source 'IIS Express AspNetCore Module V2' cannot be found. The local computer may not have the necessary registry information or message DLL files to display the message, or you may not have permission to access them. The following information is part of the event:'Application '/LM/W3SVC/1/ROOT' with physical root 'C:\h\w\B63B09D7\t\dbd36293f0a045f498e41d57fde49f50\' failed to load coreclr. Exception message: CLR worker thread exited prematurely', 'Process Id: 6980.', 'File Version: 20.0.24270.0. Description: IIS ASP.NET Core Module V2 Request Handler. Commit: '', generated 09/26/2024 13:02:33, written 09/26/2024 13:02:33 [4.803s] [Microsoft.AspNetCore.Server.IIS.IISExpress.FunctionalTests.StartupTests] [Information] 'The description for Event ID '1035' in Source 'IIS Express AspNetCore Module V2' cannot be found. The local computer may not have the necessary registry information or message DLL files to display the message, or you may not have permission to access them. The following information is part of the event:'Application '/LM/W3SVC/1/ROOT' with physical root 'C:\h\w\B63B09D7\t\dbd36293f0a045f498e41d57fde49f50\' has exited from Program.Main with exit code = '12'. First 30KB characters of captured stdout and stderr logs: aaaa[SNIP]', 'Process Id: 6980.', 'File Version: 20.0.24270.0. Description: IIS ASP.NET Core Module V2 Request Handler. Commit: '', generated 09/26/2024 13:02:33, written 09/26/2024 13:02:33 [4.810s] [Microsoft.AspNetCore.Server.IIS.IISExpress.FunctionalTests.StartupTests] [Error] Test threw an exception. Xunit.Sdk.TrueException: No entries matched by 'Application '/LM/W3SVC/1/ROOT' with physical root 'C:\\h\\w\\B63B09D7\\t\\dbd36293f0a045f498e41d57fde49f50\\' has exited from Program.Main with exit code = '12'. First 30KB characters of captured stdout and stderr logs: aaaa[SNIP]' at Xunit.Assert.True(Nullable`1 condition, String userMessage) in /_/src/xunit.assert/Asserts/BooleanAsserts.cs:line 146 at Xunit.Assert.True(Boolean condition, String userMessage) in /_/src/xunit.assert/Asserts/BooleanAsserts.cs:line 128 at Microsoft.AspNetCore.Server.IIS.FunctionalTests.EventLogHelpers.<>c__DisplayClass3_0.g__AssertEntries|0() in /_/src/Servers/IIS/IIS/test/Common.FunctionalTests/Infrastructure/EventLogHelpers.cs:line 86 at Microsoft.AspNetCore.Server.IIS.FunctionalTests.EventLogHelpers.AssertEntryAsync(String regexString, IISDeploymentResult deploymentResult, Boolean allowMultiple) in /_/src/Servers/IIS/IIS/test/Common.FunctionalTests/Infrastructure/EventLogHelpers.cs:line 81 at Microsoft.AspNetCore.Server.IIS.FunctionalTests.EventLogHelpers.VerifyEventLogEventAsync(IISDeploymentResult deploymentResult, String expectedRegexMatchString, ILogger logger, Boolean allowMultiple) in /_/src/Servers/IIS/IIS/test/Common.FunctionalTests/Infrastructure/EventLogHelpers.cs:line 24 at Microsoft.AspNetCore.Server.IIS.IISExpress.FunctionalTests.StartupTests.CheckStdoutWithLargeWrites_LogFile(String mode) in /_/src/Servers/IIS/IIS/test/Common.LongTests/StartupTests.cs:line 1035 at Xunit.Sdk.TestInvoker`1.<>c__DisplayClass46_0.<b__1>d.MoveNext() in /_/src/xunit.execution/Sdk/Frameworks/Runners/TestInvoker.cs:line 253 --- End of stack trace from previous location --- at Xunit.Sdk.ExecutionTimer.AggregateAsync(Func`1 asyncAction) in /_/src/xunit.execution/Sdk/Frameworks/ExecutionTimer.cs:line 48 at Xunit.Sdk.ExceptionAggregator.RunAsync(Func`1 code) in /_/src/xunit.core/Sdk/ExceptionAggregator.cs:line 90 ```

Build

https://dev.azure.com/dnceng-public/public/_build/results?buildId=818974

amcasey commented 1 week ago

StartupTests_CheckStdoutWithLargeWrites_LogFile-CheckLargeStdOutWrites.log

amcasey commented 1 week ago

Probably a dup of https://github.com/dotnet/aspnetcore/issues/52734.

BrennanConroy commented 1 week ago

The description for Event ID '1035' in Source 'IIS Express AspNetCore Module V2' cannot be found. The local computer may not have the necessary registry information or message DLL files to display the message, or you may not have permission to access them. The following information is part of the event

This looks suspect.