Skip to content

Test failure BasicEventSourceTests.TestsManifestGeneration.Test_EventSource_EtwManifestGenerationRollover #82021

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
Closed
v-wenyuxu opened this issue Feb 13, 2023 · 4 comments
Closed

Test failure BasicEventSourceTests.TestsManifestGeneration.Test_EventSource_EtwManifestGenerationRollover #82021

v-wenyuxu opened this issue Feb 13, 2023 · 4 comments
Labels
arch-x64 area-Tracing-coreclr os-windows

Comments

@v-wenyuxu
Copy link

Run: runtime-coreclr libraries-jitstress 20230211.2

Failed tests:

net8.0-windows-Release-x64-CoreCLR_checked-no_tiered_compilation-Windows.10.Amd64.Open

- BasicEventSourceTests.TestsManifestGeneration.Test_EventSource_EtwManifestGenerationRollover

Error message:

Half-way through waiting for remote process.
Memory load: 14

Image Name                     PID Services                                    
========================= ======== ============================================
svchost.exe                    764 BrokerInfrastructure, DcomLaunch, LSM,      
                                  PlugPlay, Power, SystemEventsBroker         
svchost.exe                    828 RpcEptMapper, RpcSs                         
svchost.exe                    964 Appinfo, CertPropSvc, DsmSvc, gpsvc,        
                                  iphlpsvc, lfsvc, ProfSvc, sacsvr, Schedule, 
                                  SENS, SessionEnv, ShellHWDetection, Themes, 
                                  UserManager, Winmgmt, WpnService, wuauserv  
svchost.exe                    972 TermService                                 
svchost.exe                    396 Dhcp, EventLog, lmhosts, NgcCtnrSvc,        
                                  TimeBrokerSvc, vmictimesync                 
svchost.exe                    476 NcbService, PcaSvc, TrkWks, UALSVC,         
                                  UmRdpService, vmickvpexchange,              
                                  vmicshutdown, WdiSystemHost                 
svchost.exe                   1032 BFE, CoreMessagingRegistrar, DPS, MpsSvc,   
                                  pla                                         
svchost.exe                   1112 EventSystem, FontCache, netprofm, nsi,      
                                  RemoteRegistry, W32Time, WinHttpAutoProxySv 
svchost.exe                   1164 vmicheartbeat                               
svchost.exe                   1348 CryptSvc, Dnscache, LanmanWorkstation,      
                                  NlaSvc, WinRM                               
svchost.exe                   1496 Wcmsvc                                      
svchost.exe                   1696 AppHostSvc                                  
svchost.exe                   2004 DiagTrack                                   
svchost.exe                   2144 LanmanServer                                
svchost.exe                   2156 W3SVC, WAS                                  
svchost.exe                   2200 StateRepository, tiledatamodelsvc           
svchost.exe                   3912 CDPUserSvc_4b448, OneSyncSvc_4b448          
svchost.exe                   3844 AppReadiness                                
Timed out at 2/12/2023 8:21:29 AM after 60000ms waiting for remote process.
Wrote mini dump to: C:\h\w\A9CB0917\w\C97C0AF9\uploads\5408.hvbc3zhv.c1b.dmp
   Process ID: 5408
   Handle: 1072
   Name: dotnet
   MainModule: C:\h\w\A9CB0917\p\dotnet.exe
   StartTime: 2/12/2023 8:20:29 AM
   TotalProcessorTime: 00:00:03.9531250
   Threads:
   	Thread #1 (OS 0xBBC)   [MTA]
   		[HelperMethodFrame] (System.Threading.Thread.SleepInternal)
   		System.Threading.Thread.Sleep(Int32)
   		BasicEventSourceTests.TestsManifestGeneration.<Test_EventSource_EtwManifestGenerationRollover>b__3_0()
   		[HelperMethodFrame_PROTECTOBJ] (System.RuntimeMethodHandle.InvokeMethod)
   		System.Reflection.MethodInvoker.Invoke(System.Object, IntPtr*, System.Reflection.BindingFlags)
   		System.Reflection.RuntimeMethodInfo.Invoke(System.Object, System.Reflection.BindingFlags, System.Reflection.Binder, System.Object[], System.Globalization.CultureInfo)
   		Microsoft.DotNet.RemoteExecutor.Program.Main(System.String[])
   	Thread #2 (OS 0x16B4) [Finalizer] [Background] 
   		[DebuggerU2MCatchHandlerFrame]

Stack trace:

  at Microsoft.DotNet.RemoteExecutor.RemoteInvokeHandle.Dispose(Boolean disposing) in /_/src/Microsoft.DotNet.RemoteExecutor/src/RemoteInvokeHandle.cs:line 224
  at System.RuntimeMethodHandle.InvokeMethod(Object target, Void** arguments, Signature sig, Boolean isConstructor)
  at System.Reflection.MethodInvoker.Invoke(Object obj, IntPtr* args, BindingFlags invokeAttr) in /_/src/libraries/System.Private.CoreLib/src/System/Reflection/MethodInvoker.cs:line 59
@v-wenyuxu v-wenyuxu added os-windows JitStress CLR JIT issues involving JIT internal stress modes arch-x64 labels Feb 13, 2023
@ghost
Copy link

ghost commented Feb 13, 2023

I couldn't figure out the best area label to add to this issue. If you have write-permissions please help me learn by adding exactly one area label.

@ghost ghost added the untriaged New issue has not been triaged by the area owner label Feb 13, 2023
@BruceForstall
Copy link
Contributor

@davmason Is this an diag/tracing test failure?

@hoyosjs
Copy link
Member

hoyosjs commented Feb 14, 2023

@BruceForstall nothing in the stacks hints at this being anything but "this is running slow":

Stacks 
*** WARNING: Unable to verify checksum for System.Private.CoreLib.dll
 # Child-SP          RetAddr               Call Site
00 000000be`62d7d358 00007ff8`83b64f57     ntdll!ZwDelayExecution+0x14 [d:\rs1.obj.amd64fre\minkernel\ntdll\daytona\objfre\amd64\usrstubs.asm @ 595] 
01 000000be`62d7d360 00007ff8`594e6043     KERNELBASE!SleepEx+0xa7 [d:\rs1\minkernel\kernelbase\thread.c @ 2247] 
02 (Inline Function) --------`--------     coreclr!VolatileLoad+0x15 [D:\a\_work\1\s\src\coreclr\inc\volatile.h @ 188] 
03 (Inline Function) --------`--------     coreclr!Volatile<enum Thread::ThreadState>::Load+0x15 [D:\a\_work\1\s\src\coreclr\inc\volatile.h @ 373] 
04 (Inline Function) --------`--------     coreclr!Volatile<enum Thread::ThreadState>::operator enum Thread::ThreadState+0x15 [D:\a\_work\1\s\src\coreclr\inc\volatile.h @ 427] 
05 000000be`62d7d400 00007ff8`59577de4     coreclr!Thread::UserSleep+0x253 [D:\a\_work\1\s\src\coreclr\vm\threads.cpp @ 4208] 
06 000000be`62d7d560 00007ff8`55e26671     coreclr!ThreadNative::Sleep+0x204 [D:\a\_work\1\s\src\coreclr\vm\comsynchronizable.cpp @ 472] 
07 000000be`62d7d780 00007ff7`fa112711     System_Private_CoreLib!System.Threading.Thread.Sleep+0x11
08 000000be`62d7d7b0 0000024e`5d00a328     System_Diagnostics_Tracing_Tests!BasicEventSourceTests.TestsManifestGeneration.<Test_EventSource_EtwManifestGenerationRollover>b__3_0+0x1f1
09 000000be`62d7d7b8 0000028e`ef4a3310     0x0000024e`5d00a328
0a 000000be`62d7d7c0 00007ff8`59d598e8     0x0000028e`ef4a3310
0b 000000be`62d7d7c8 00007ff8`59d595f8     coreclr!`string'
0c 000000be`62d7d7d0 00000000`00000000     coreclr!`string'

   1  Id: 1520.4d0 Suspend: 0 Teb: 000000be`62aae000 Unfrozen
 # Child-SP          RetAddr               Call Site
00 000000be`6337f558 00007ff8`83b64d7f     ntdll!ZwWaitForMultipleObjects+0x14 [d:\rs1.obj.amd64fre\minkernel\ntdll\daytona\objfre\amd64\usrstubs.asm @ 907] 
01 000000be`6337f560 00007ff8`83b64c7e     KERNELBASE!WaitForMultipleObjectsEx+0xef [d:\rs1\minkernel\kernelbase\synch.c @ 1551] 
02 000000be`6337f860 00007ff8`59a72cbc     KERNELBASE!WaitForMultipleObjects+0xe [d:\rs1\minkernel\kernelbase\synch.c @ 1403] 
03 000000be`6337f8a0 00007ff8`59b5c4f7     coreclr!ds_ipc_poll+0x16c [D:\a\_work\1\s\src\native\eventpipe\ds-ipc-pal-namedpipe.c @ 239] 
04 000000be`6337fb30 00007ff8`59b60e0c     coreclr!ds_ipc_stream_factory_get_next_available_stream+0x3d7 [D:\a\_work\1\s\src\native\eventpipe\ds-ipc.c @ 404] 
05 000000be`6337fe80 00007ff8`874384d4     coreclr!server_thread+0x11c [D:\a\_work\1\s\src\native\eventpipe\ds-server.c @ 129] 
06 000000be`6337ff00 00007ff8`876a1791     kernel32!BaseThreadInitThunk+0x14 [d:\rs1\base\win32\client\thread.c @ 64] 
07 000000be`6337ff30 00000000`00000000     ntdll!RtlUserThreadStart+0x21 [d:\rs1\minkernel\ntdll\rtlstrt.c @ 997] 

   2  Id: 1520.3dc Suspend: 0 Teb: 000000be`62ab0000 Unfrozen
 # Child-SP          RetAddr               Call Site
00 000000be`634ff388 00007ff8`83b64d7f     ntdll!ZwWaitForMultipleObjects+0x14 [d:\rs1.obj.amd64fre\minkernel\ntdll\daytona\objfre\amd64\usrstubs.asm @ 907] 
01 000000be`634ff390 00007ff8`59a694c4     KERNELBASE!WaitForMultipleObjectsEx+0xef [d:\rs1\minkernel\kernelbase\synch.c @ 1551] 
02 000000be`634ff690 00007ff8`59a6b9ab     coreclr!DebuggerRCThread::MainLoop+0x5a4 [D:\a\_work\1\s\src\coreclr\debug\ee\rcthread.cpp @ 927] 
03 000000be`634ff990 00007ff8`59a6bb19     coreclr!DebuggerRCThread::ThreadProc+0x4bb [D:\a\_work\1\s\src\coreclr\debug\ee\rcthread.cpp @ 730] 
04 000000be`634ffad0 00007ff8`874384d4     coreclr!DebuggerRCThread::ThreadProcStatic+0x79 [D:\a\_work\1\s\src\coreclr\debug\ee\rcthread.cpp @ 1321] 
05 000000be`634ffb00 00007ff8`876a1791     kernel32!BaseThreadInitThunk+0x14 [d:\rs1\base\win32\client\thread.c @ 64] 
06 000000be`634ffb30 00000000`00000000     ntdll!RtlUserThreadStart+0x21 [d:\rs1\minkernel\ntdll\rtlstrt.c @ 997] 

   3  Id: 1520.16b4 Suspend: 0 Teb: 000000be`62ab2000 Unfrozen
 # Child-SP          RetAddr               Call Site
00 000000be`6367f048 00007ff8`83b64d7f     ntdll!ZwWaitForMultipleObjects+0x14 [d:\rs1.obj.amd64fre\minkernel\ntdll\daytona\objfre\amd64\usrstubs.asm @ 907] 
01 000000be`6367f050 00007ff8`595ec68b     KERNELBASE!WaitForMultipleObjectsEx+0xef [d:\rs1\minkernel\kernelbase\synch.c @ 1551] 
02 000000be`6367f350 00007ff8`595ebec3     coreclr!FinalizerThread::WaitForFinalizerEvent+0xdb [D:\a\_work\1\s\src\coreclr\vm\finalizerthread.cpp @ 173] 
03 000000be`6367f3b0 00007ff8`594ddc94     coreclr!FinalizerThread::FinalizerThreadWorker+0x293 [D:\a\_work\1\s\src\coreclr\vm\finalizerthread.cpp @ 274] 
04 000000be`6367f6c0 00007ff8`594ddd96     coreclr!ManagedThreadBase_DispatchInner+0xb4 [D:\a\_work\1\s\src\coreclr\vm\threads.cpp @ 7245] 
05 000000be`6367f780 00007ff8`594e052b     coreclr!ManagedThreadBase_DispatchMiddle+0xb6 [D:\a\_work\1\s\src\coreclr\vm\threads.cpp @ 7289] 
06 000000be`6367f910 00007ff8`594e0823     coreclr!``ManagedThreadBase_DispatchOuter'::`11'::__Body::Run'::`5'::__Body::Run+0x7b [D:\a\_work\1\s\src\coreclr\vm\threads.cpp @ 7447] 
07 000000be`6367f960 00007ff8`594ddead     coreclr!`ManagedThreadBase_DispatchOuter'::`11'::__Body::Run+0x93 [D:\a\_work\1\s\src\coreclr\vm\threads.cpp @ 7449] 
08 000000be`6367f9e0 00007ff8`594de0db     coreclr!ManagedThreadBase_DispatchOuter+0xdd [D:\a\_work\1\s\src\coreclr\vm\threads.cpp @ 7469] 
09 000000be`6367fa60 00007ff8`595eb95c     coreclr!ManagedThreadBase_NoADTransition+0xcb [D:\a\_work\1\s\src\coreclr\vm\threads.cpp @ 7517] 
0a 000000be`6367fb40 00007ff8`874384d4     coreclr!FinalizerThread::FinalizerThreadStart+0x19c [D:\a\_work\1\s\src\coreclr\vm\finalizerthread.cpp @ 394] 
0b 000000be`6367fb70 00007ff8`876a1791     kernel32!BaseThreadInitThunk+0x14 [d:\rs1\base\win32\client\thread.c @ 64] 
0c 000000be`6367fba0 00000000`00000000     ntdll!RtlUserThreadStart+0x21 [d:\rs1\minkernel\ntdll\rtlstrt.c @ 997] 

   4  Id: 1520.894 Suspend: 0 Teb: 000000be`62ab6000 Unfrozen
 # Child-SP          RetAddr               Call Site
00 000000be`6397f508 00007ff8`8766eb5e     ntdll!ZwWaitForWorkViaWorkerFactory+0x14 [d:\rs1.obj.amd64fre\minkernel\ntdll\daytona\objfre\amd64\usrstubs.asm @ 3755] 
01 000000be`6397f510 00007ff8`874384d4     ntdll!TppWorkerThread+0x76e [d:\rs1\minkernel\threadpool\ntdll\worker.c @ 876] 
02 000000be`6397f910 00007ff8`876a1791     kernel32!BaseThreadInitThunk+0x14 [d:\rs1\base\win32\client\thread.c @ 64] 
03 000000be`6397f940 00000000`00000000     ntdll!RtlUserThreadStart+0x21 [d:\rs1\minkernel\ntdll\rtlstrt.c @ 997] 

   5  Id: 1520.574 Suspend: 0 Teb: 000000be`62ab8000 Unfrozen
 # Child-SP          RetAddr               Call Site
00 000000be`63aff6c8 00007ff8`8766eb5e     ntdll!ZwWaitForWorkViaWorkerFactory+0x14 [d:\rs1.obj.amd64fre\minkernel\ntdll\daytona\objfre\amd64\usrstubs.asm @ 3755] 
01 000000be`63aff6d0 00007ff8`874384d4     ntdll!TppWorkerThread+0x76e [d:\rs1\minkernel\threadpool\ntdll\worker.c @ 876] 
02 000000be`63affad0 00007ff8`876a1791     kernel32!BaseThreadInitThunk+0x14 [d:\rs1\base\win32\client\thread.c @ 64] 
03 000000be`63affb00 00000000`00000000     ntdll!RtlUserThreadStart+0x21 [d:\rs1\minkernel\ntdll\rtlstrt.c @ 997] 

   6  Id: 1520.4cc Suspend: 0 Teb: 000000be`62aba000 Unfrozen
 # Child-SP          RetAddr               Call Site
00 000000be`63c7f698 00007ff8`83b64d7f     ntdll!ZwWaitForMultipleObjects+0x14 [d:\rs1.obj.amd64fre\minkernel\ntdll\daytona\objfre\amd64\usrstubs.asm @ 907] 
01 000000be`63c7f6a0 00007ff8`856e956f     KERNELBASE!WaitForMultipleObjectsEx+0xef [d:\rs1\minkernel\kernelbase\synch.c @ 1551] 
02 000000be`63c7f9a0 00007ff8`856cfad0     combase!WaitCoalesced+0xb3 [d:\rs1\onecore\com\published\comutils\coalescedwait.cxx @ 72] 
03 000000be`63c7fc30 00007ff8`856e9751     combase!CROIDTable::WorkerThreadLoop+0x50 [d:\rs1\onecore\com\combase\dcomrem\refcache.cxx @ 1619] 
04 000000be`63c7fc80 00007ff8`857671ac     combase!CRpcThread::WorkerLoop+0x161 [d:\rs1\onecore\com\combase\dcomrem\threads.cxx @ 269] 
05 000000be`63c7fce0 00007ff8`874384d4     combase!CRpcThreadCache::RpcWorkerThreadEntry+0x7c [d:\rs1\onecore\com\combase\dcomrem\threads.cxx @ 76] 
06 000000be`63c7fd10 00007ff8`876a1791     kernel32!BaseThreadInitThunk+0x14 [d:\rs1\base\win32\client\thread.c @ 64] 
07 000000be`63c7fd40 00000000`00000000     ntdll!RtlUserThreadStart+0x21 [d:\rs1\minkernel\ntdll\rtlstrt.c @ 997]

@hoyosjs hoyosjs mentioned this issue Feb 14, 2023
Closed
@ghost ghost added the in-pr There is an active PR which will close this issue when it is merged label Feb 14, 2023
@BruceForstall BruceForstall removed the JitStress CLR JIT issues involving JIT internal stress modes label Feb 14, 2023
@BruceForstall
Copy link
Contributor

Maybe a dup of #48798?

@hoyosjs hoyosjs closed this as completed Feb 14, 2023
@ghost ghost removed the untriaged New issue has not been triaged by the area owner label Feb 14, 2023
@BruceForstall BruceForstall mentioned this issue Feb 14, 2023
Closed
@ghost ghost removed the in-pr There is an active PR which will close this issue when it is merged label Feb 14, 2023
@ghost ghost locked as resolved and limited conversation to collaborators Mar 16, 2023
Sign up for free to subscribe to this conversation on GitHub. Already have an account? Sign in.
Assignees
No one assigned
Labels
arch-x64 area-Tracing-coreclr os-windows
Projects
None yet
Milestone
No milestone
Development

Successfully merging a pull request may close this issue.

Disable EtwManifest tests under jitstress dotnet/runtime
4 participants
@jeffschwMSFT @BruceForstall @hoyosjs @v-wenyuxu