Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Test flakiness: HostActivation.NativeHosting.Comhost.ActivateClass #2320

Closed
dagood opened this issue Oct 22, 2019 · 3 comments · Fixed by #31762
Closed

Test flakiness: HostActivation.NativeHosting.Comhost.ActivateClass #2320

dagood opened this issue Oct 22, 2019 · 3 comments · Fixed by #31762
Labels
area-Host blocking-clean-ci Blocking PR or rolling runs of 'runtime' or 'runtime-extra-platforms'
Milestone
5.0.0

Comments

@dagood
Copy link
Member

dagood commented Oct 22, 2019

It looks like the output is truncated--a crash?

https://dev.azure.com/dnceng/internal/_build/results?buildId=396505&view=ms.vss-test-web.build-test-results-tab&runId=12373480&resultId=101463&paneView=debug

win-x64 Debug, master

Expected command to pass but it did not.\"
File Name: F:\\workspace\\_work\\1\\s\\artifacts\\tests\\Debug\\ha\\nativeHosting\\0\\nativehost.exe
Arguments: comhost synchronous 10 F:\\workspace\\_work\\1\\s\\artifacts\\tests\\Debug\\ha\\0\\ComLibrary\\bin\\ComLibrary.comhost.dll {438968CE-5950-4FBC-90B0-E64691350DF5}
Exit Code: -1073741819
StdOut:
New instance of Server created
Activation of {438968CE-5950-4FBC-90B0-E64691350DF5} succeeded. 1 of 10
New instance of Server created
Activation of {438968CE-5950-4FBC-90B0-E64691350DF5} succeeded. 2 of 10
New instance of Server created
Activation of {438968CE-5950-4FBC-90B0-E64691350DF5} succeeded. 3 of 10
New instance of Server created
Activation of {438968CE-5950-4FBC-90B0-E64691350DF5} succeeded. 4 of 10
New instance of Server created
Activation of {438968CE-5950-4FBC-90B0-E64691350DF5} succeeded. 5 of 10
New instance of Server created
Activation of {438968CE-5950-4FBC-90B0-E64691350DF5} succeeded. 6 of 10
New instance of Server created
Activation of {438968CE-5950-4FBC-90B0-E64691350DF5} succeeded. 7 of 10
New instance of Server created
Activation of {438968CE-5950-4FBC-90B0-E64691350DF5} succeeded. 8 of 10
New instance of Server created
Activation of {438968CE-5950-4FBC-90B0-E64691350DF5} succeeded. 9 of 10
New instance of Server created
Activation of {438968CE-5950-4FBC-90B0-E64691350DF5} succeeded. 10 of 10

StdErr:
Tracing enabled @ Tue Oct 22 22:12:57 2019 GMT
Using environment variable DOTNET_ROOT=[F:\\workspace\\_work\\1\\s\\artifacts\\obj\\win-x64.Debug\\sharedFrameworkPublish] as runtime location.
Reading fx resolver directory=[F:\\workspace\\_work\\1\\s\\artifacts\\obj\\win-x64.Debug\\sharedFrameworkPublish\\host\\fxr]
Considering fxr version=[5.0.0-alpha1.19522.10]...
Detected latest fxr version=[F:\\workspace\\_work\\1\\s\\artifacts\\obj\\win-x64.Debug\\sharedFrameworkPublish\\host\\fxr\\5.0.0-alpha1.19522.10]...
Resolved fxr [F:\\workspace\\_work\\1\\s\\artifacts\\obj\\win-x64.Debug\\sharedFrameworkPublish\\host\\fxr\\5.0.0-alpha1.19522.10\\hostfxr.dll]...
Loaded library from F:\\workspace\\_work\\1\\s\\artifacts\\obj\\win-x64.Debug\\sharedFrameworkPublish\\host\\fxr\\5.0.0-alpha1.19522.10\\hostfxr.dll
Tracing enabled @ Tue Oct 22 22:12:57 2019 GMT
--- Invoked hostfxr_initialize_for_runtime_config [commit hash: c1f5f8106b800c35d1b112cff11e3c79bac0170a]
Specified runtimeconfig.json from [F:\\workspace\\_work\\1\\s\\artifacts\\tests\\Debug\\ha\\0\\ComLibrary\\bin\\ComLibrary.runtimeconfig.json]
Runtime config is cfg=F:\\workspace\\_work\\1\\s\\artifacts\\tests\\Debug\\ha\\0\\ComLibrary\\bin\\ComLibrary.runtimeconfig.json dev=F:\\workspace\\_work\\1\\s\\artifacts\\tests\\Debug\\ha\\0\\ComLibrary\\bin\\ComLibrary.runtimeconfig.dev.json
Attempting to read runtime config: F:\\workspace\\_work\\1\\s\\artifacts\\tests\\Debug\\ha\\0\\ComLibrary\\bin\\ComLibrary.runtimeconfig.json
Attempting to read dev runtime config: F:\\workspace\\_work\\1\\s\\artifacts\\tests\\Debug\\ha\\0\\ComLibrary\\bin\\ComLibrary.runtimeconfig.dev.json
Runtime config [F:\\workspace\\_work\\1\\s\\artifacts\\tests\\Debug\\ha\\0\\ComLibrary\\bin\\ComLibrary.runtimeconfig.json] is valid=[1]
--- The specified framework 'Microsoft.NETCore.App', version '5.0.0-alpha1.19522.10', apply_patches=1, version_compatibility_range=minor is compatible with the previously referenced version '5.0.0-alpha1.19522.10'.
--- Resolving FX directory, name 'Microsoft.NETCore.App' version '5.0.0-alpha1.19522.10'
Searching FX directory in [F:\\workspace\\_work\\1\\s\\artifacts\\obj\\win-x64.Debug\\sharedFrameworkPublish]
Attempting FX roll forward starting from version='[5.0.0-alpha1.19522.10]', apply_patches=1, version_compatibility_range=minor, roll_to_highest_version=0, prefer_release=0
'Roll forward' enabl

at FluentAssertions.Execution.XUnit2TestFramework.Throw(String message)
at FluentAssertions.Execution.TestFrameworkProvider.Throw(String message)
at FluentAssertions.Execution.DefaultAssertionStrategy.HandleFailure(String message)
at FluentAssertions.Execution.AssertionScope.FailWith(String message, Object[] args)
at Microsoft.DotNet.CoreSetup.Test.CommandResultAssertions.Pass() in /_/src/test/TestUtils/Assertions/CommandResultAssertions.cs:line 31
at Microsoft.DotNet.CoreSetup.Test.HostActivation.NativeHosting.Comhost.ActivateClass(Int32 count, Boolean synchronous) in /_/src/test/HostActivation.Tests/NativeHosting/Comhost.cs:line 44

Seen initially in PR validation for dotnet/core-setup#8641, but the above is an exact repro from an official build.

It's interesting that the truncation is the same for both: 'Roll forward' enabl is the last line.

@vitek-karas @elinor-fung
@dagood
Copy link
Member Author

dagood commented Oct 22, 2019

Another repro, different truncation

https://dev.azure.com/dnceng/internal/_build/results?buildId=393286&view=ms.vss-test-web.build-test-results-tab&runId=12224106&resultId=100375&paneView=debug

Expected command to pass but it did not.\"
File Name: F:\\workspace\\_work\\1\\s\\artifacts\\tests\\Debug\\ha\\nativeHosting\\0\\nativehost.exe
Arguments: comhost concurrent 10 F:\\workspace\\_work\\1\\s\\artifacts\\tests\\Debug\\ha\\0\\ComLibrary\\bin\\ComLibrary.comhost.dll {438968CE-5950-4FBC-90B0-E64691350DF5}
Exit Code: -1073741819
StdOut:
New instance of Server created
New instance of Server created
New instance of Server created
New instance of Server created
New instance of Server created
New instance of Server created
New instance of Server created
New instance of Server created
New instance of Server created
New instance of Server created
Activation of {438968CE-5950-4FBC-90B0-E64691350DF5} succeeded. 1 of 10
Activation of {438968CE-5950-4FBC-90B0-E64691350DF5} succeeded. 2 of 10
Activation of {438968CE-5950-4FBC-90B0-E64691350DF5} succeeded. 3 of 10
Activation of {438968CE-5950-4FBC-90B0-E64691350DF5} succeeded. 4 of 10
Activation of {438968CE-5950-4FBC-90B0-E64691350DF5} succeeded. 5 of 10
Activation of {438968CE-5950-4FBC-90B0-E64691350DF5} succeeded. 6 of 10
Activation of {438968CE-5950-4FBC-90B0-E64691350DF5} succeeded. 7 of 10
Activation of {438968CE-5950-4FBC-90B0-E64691350DF5} succeeded. 8 of 10
Activation of {438968CE-5950-4FBC-90B0-E64691350DF5} succeeded. 9 of 10
Activation of {438968CE-5950-4FBC-90B0-E64691350DF5} succeeded. 10 of 10

StdErr:
Tracing enabled @ Fri Oct 18 15:17:56 2019 GMT
Using environment variable DOTNET_ROOT(x86)=[F:\\workspace\\_work\\1\\s\\artifacts\\obj\\win-x86.Debug\\sharedFrameworkPublish] as runtime location.
Using environment variable DOTNET_ROOT(x86)=[F:\\workspace\\_work\\1\\s\\artifacts\\obj\\win-x86.Debug\\sharedFrameworkPublish] as runtime location.
Using environment variable DOTNET_ROOT(x86)=[F:\\workspace\\_work\\1\\s\\artifacts\\obj\\win-x86.Debug\\sharedFrameworkPublish] as runtime location.
Using environment variable DOTNET_ROOT(x86)=[F:\\workspace\\_work\\1\\s\\artifacts\\obj\\win-x86.Debug\\sharedFrameworkPublish] as runtime location.
Using environment variable DOTNET_ROOT(x86)=[F:\\workspace\\_work\\1\\s\\artifacts\\obj\\win-x86.Debug\\sharedFrameworkPublish] as runtime location.
Reading fx resolver directory=[F:\\workspace\\_work\\1\\s\\artifacts\\obj\\win-x86.Debug\\sharedFrameworkPublish\\host\\fxr]
Reading fx resolver directory=[F:\\workspace\\_work\\1\\s\\artifacts\\obj\\win-x86.Debug\\sharedFrameworkPublish\\host\\fxr]
Reading fx resolver directory=[F:\\workspace\\_work\\1\\s\\artifacts\\obj\\win-x86.Debug\\sharedFrameworkPublish\\host\\fxr]
Reading fx resolver directory=[F:\\workspace\\_work\\1\\s\\artifacts\\obj\\win-x86.Debug\\sharedFrameworkPublish\\host\\fxr]
Reading fx resolver directory=[F:\\workspace\\_work\\1\\s\\artifacts\\obj\\win-x86.Debug\\sharedFrameworkPublish\\host\\fxr]
Considering fxr version=[5.0.0-alpha1.19518.4]...
Considering fxr version=[5.0.0-alpha1.19518.4]...
Considering fxr version=[5.0.0-alpha1.19518.4]...
Considering fxr version=[5.0.0-alpha1.19518.4]...
Considering fxr version=[5.0.0-alpha1.19518.4]...
Detected latest fxr version=[F:\\workspace\\_work\\1\\s\\artifacts\\obj\\win-x86.Debug\\sharedFrameworkPublish\\host\\fxr\\5.0.0-alpha1.19518.4]...
Detected latest fxr version=[F:\\workspace\\_work\\1\\s\\artifacts\\obj\\win-x86.Debug\\sharedFrameworkPublish\\host\\fxr\\5.0.0-alpha1.19518.4]...
Detected latest fxr version=[F:\\workspace\\_work\\1\\s\\artifacts\\obj\\win-x86.Debug\\sharedFrameworkPublish\\host\\fxr\\5.0.0-alpha1.19518.4]...
Detected latest fxr version=[F:\\workspace\\_work\\1\\s\\artifacts\\obj\\win-x86.Debug\\sharedFrameworkPublish\\host\\fxr\\5.0.0-alpha1.19518.4]...
Detected latest fxr version=[F:\\workspace\\_work\\1\\s\\artifacts\\obj\\win-x86.Debug\\sharedFrameworkPublish\\host\\f

at FluentAssertions.Execution.XUnit2TestFramework.Throw(String message)
at FluentAssertions.Execution.TestFrameworkProvider.Throw(String message)
at FluentAssertions.Execution.DefaultAssertionStrategy.HandleFailure(String message)
at FluentAssertions.Execution.AssertionScope.FailWith(String message, Object[] args)
at Microsoft.DotNet.CoreSetup.Test.CommandResultAssertions.Pass() in /_/src/test/TestUtils/Assertions/CommandResultAssertions.cs:line 31
at Microsoft.DotNet.CoreSetup.Test.HostActivation.NativeHosting.Comhost.ActivateClass(Int32 count, Boolean synchronous) in /_/src/test/HostActivation.Tests/NativeHosting/Comhost.cs:line 44

@elinor-fung
Copy link
Member

Looks like a crash - AV based on the exit code. On shutting down? Since it printed out all the activations successfully.

@jkoritzinsky jkoritzinsky transferred this issue from dotnet/core-setup Jan 29, 2020
@Dotnet-GitSync-Bot Dotnet-GitSync-Bot added area-Host untriaged New issue has not been triaged by the area owner labels Jan 29, 2020
@jashook jashook mentioned this issue Jan 29, 2020
Closed
@jkoritzinsky jkoritzinsky mentioned this issue Jan 29, 2020
Merged
@jeffschwMSFT jeffschwMSFT added this to the 5.0 milestone Jan 30, 2020
@jeffschwMSFT jeffschwMSFT removed the untriaged New issue has not been triaged by the area owner label Jan 30, 2020
@jkotas
Copy link
Member

jkotas commented Feb 4, 2020

Hit in #31705

@jkotas jkotas added the blocking-clean-ci Blocking PR or rolling runs of 'runtime' or 'runtime-extra-platforms' label Feb 4, 2020
@elinor-fung elinor-fung mentioned this issue Feb 4, 2020
Merged
@dagood dagood mentioned this issue Feb 4, 2020
Merged
@jkotas jkotas mentioned this issue Feb 5, 2020
Merged
@elinor-fung elinor-fung mentioned this issue Feb 5, 2020
Merged
@elinor-fung elinor-fung mentioned this issue Apr 9, 2020
Closed
@ghost ghost locked as resolved and limited conversation to collaborators Dec 11, 2020
Sign up for free to subscribe to this conversation on GitHub. Already have an account? Sign in.
Assignees
No one assigned
Labels
area-Host blocking-clean-ci Blocking PR or rolling runs of 'runtime' or 'runtime-extra-platforms'
Projects
None yet
Milestone
5.0.0
Development

Successfully merging a pull request may close this issue.

Fix intermittent crash in comhost tests elinor-fung/runtime
5 participants
@jkotas @jeffschwMSFT @dagood @Dotnet-GitSync-Bot @elinor-fung