AV: Building EventMetadata When Writing a Trace File

[brianrob]

* thread dotnet/coreclr#1: tid = 37369, 0x00007ffff6e99410 libc.so.6??? + 352, name = 'dotnet', stop reason = invalid address (fault address: 0x3)

• frame #0: 0x00007ffff6e99410 libc.so.6??? + 352 frame dotnet/coreclr#1: 0x00007ffff60c49fe libcoreclr.soPAL_memcpy(dest=0x00000000007ba090, src=0x0000000000000003, count=16) + 414 at misc.cpp:312
  frame Merge changes from TFS coreclr#2: 0x00007ffff57b7bb4 libcoreclr.somemcpyNoGCRefs(dest=0x00000000007ba090, src=0x0000000000000003, len=16) + 52 at common.h:264 frame dotnet/coreclr#3: 0x00007ffff5858062 libcoreclr.soGCSafeMemCpy(dest=0x00000000007ba090, src=0x0000000000000003, len=16) + 226 at object.cpp:2935
  frame Changes to Miscellaneous test project and runtest coreclr#4: 0x00007ffff59a9784 libcoreclr.soEventPipeConfiguration::BuildEventMetadataEvent(this=0x000000000066da00, sourceInstance=0x00007fff0000d950) + 164 at eventpipeconfiguration.cpp:350 frame dotnet/coreclr#5: 0x00007ffff59ab714 libcoreclr.soEventPipeFile::WriteEvent(this=0x00000000007bd440, instance=0x00007fff0000d950) + 132 at eventpipefile.cpp:107
  frame Add build status badge coreclr#6: 0x00007ffff59af6de libcoreclr.soEventPipeBufferManager::WriteAllBuffersToFile(this=0x00000000006475d0, pFile=0x00000000007bd440, stopTimeStamp=LARGE_INTEGER at 0x00007fffffffb2c0) + 494 at eventpipebuffermanager.cpp:374 frame dotnet/coreclr#7: 0x00007ffff59a6292 libcoreclr.soEventPipe::Disable() + 194 at eventpipe.cpp:187
  frame Clean up runtest script coreclr#8: 0x00007ffff59a7140 libcoreclr.soEventPipeInternal::Disable() + 128 at eventpipe.cpp:514 frame dotnet/coreclr#9: 0x00007fff7c99afe3 frame dotnet/coreclr#10: 0x00007fff7ca9ea2c frame dotnet/coreclr#11: 0x00007ffff5b954df libcoreclr.soCallDescrWorkerInternal + 124 at calldescrworkeramd64.S:893
  frame Add release build badge for linux now that it's working coreclr#12: 0x00007ffff593e95a libcoreclr.soCallDescrWorkerWithHandler(pCallDescrData=0x00007fffffffc218, fCriticalCall=0) + 522 at callhelpers.cpp:78 frame dotnet/coreclr#13: 0x00007ffff5ab4ff4 libcoreclr.soCallDescrWorkerReflectionWrapper(this=0x00007fffffffb618, pParam=0x00007fffffffb628)::$_2::operator()(CallDescrWorkerReflectionWrapper(CallDescrData*, Frame*)::Param*) const + 36 at reflectioninvocation.cpp:825
  frame Merge changes from TFS coreclr#14: 0x00007ffff5ab4e5c libcoreclr.soCallDescrWorkerReflectionWrapper(pCallDescrData=0x00007fffffffc218, pFrame=0x00007fffffffbf50) + 124 at reflectioninvocation.cpp:827 frame dotnet/coreclr#15: 0x00007ffff5ab6c67 libcoreclr.soRuntimeMethodHandle::InvokeMethod(target=0x0000000000000000, objs=0x0000000000000000, pSigUNSAFE=0x00007fff5401fb68, fConstructor=false) + 5959 at reflectioninvocation.cpp:1440
  frame Fix links to Linux build badge coreclr#16: 0x00007fff7c7a0132
  frame Change build badges to new names coreclr#17: 0x00007fff7c79ff9d
  frame Update job names coreclr#18: 0x00007fff7c77bbfe
  frame Update the CMake requirement message in build.cmd. coreclr#19: 0x00007fff7d12381d
  frame Fix mscorlib warnings. coreclr#20: 0x00007fff7d12099e
  frame Update copyright header coreclr#21: 0x00007ffff5b954df libcoreclr.soCallDescrWorkerInternal + 124 at calldescrworkeramd64.S:893 frame dotnet/coreclr#22: 0x00007ffff593e95a libcoreclr.soCallDescrWorkerWithHandler(pCallDescrData=0x00007fffffffc7e8, fCriticalCall=0) + 522 at callhelpers.cpp:78
  frame Correct typo and link to the correct license file coreclr#23: 0x00007ffff5940130 libcoreclr.soMethodDescCallSite::CallTargetWorker(this=0x00007fffffffc950, pArguments=0x00007fffffffc8e0, pReturnValue=0x0000000000000000, cbReturnValue=0) + 2960 at callhelpers.cpp:645 frame dotnet/coreclr#24: 0x00007ffff5778c9c libcoreclr.soMethodDescCallSite::Call(this=0x00007fffffffc950, pArguments=0x00007fffffffc8e0) + 44 at callhelpers.h:433
  frame NullReferenceException - Completely devoid of details #3858: 0x00007ffff5bddf87 libcoreclr.soRunMain(this=0x00007fffffffcaa8, pParam=0x00007fffffffcba0)::$_1::operator()(RunMain(MethodDesc*, short, int*, REF<PtrArray>*)::Param*) const::{lambda(RunMain(MethodDesc*, short, int*, REF<PtrArray>*)::Param*)#1}::operator()(RunMain(MethodDesc*, short, int*, REF<PtrArray>*)::Param*) const + 743 at assembly.cpp:1847 frame dotnet/runtime#3859: 0x00007ffff5bdaf09 libcoreclr.soRunMain(this=0x00007fffffffcb90, __EXparam=0x00007fffffffcba0)::$_1::operator()(RunMain(MethodDesc*, short, int*, REF)::Param) const + 89 at assembly.cpp:1862
  frame Update PATENTS.TXT coreclr#27: 0x00007ffff5bdad1e libcoreclr.soRunMain(pFD=0x00007fff7bac5678, numSkipArgs=1, piRetVal=0x00007fffffffcc9c, stringArgs=0x00007fffffffd0f8) + 510 at assembly.cpp:1862 frame dotnet/runtime#3860: 0x00007ffff5bdb19d libcoreclr.soAssembly::ExecuteMainMethod(this=0x0000000000754e20, stringArgs=0x00007fffffffd0f8, waitForOtherThreads=1) + 333 at assembly.cpp:1944
  frame DirectoryInfo.Exists returns incorrect results when it is cast from FileSystemInfo #3861: 0x00007ffff576e17a libcoreclr.soCorHost2::ExecuteAssembly(this=0x0000000000676d90, dwAppDomainId=1, pwzAssemblyPath=0x0000000000752a50, argc=1, argv=0x0000000000653300, pReturnValue=0x00007fffffffd4fc) + 1322 at corhost.cpp:501 frame dotnet/runtime#3862: 0x00007ffff5705222 libcoreclr.socoreclr_execute_assembly(hostHandle=0x0000000000676d90, domainId=1, argc=1, argv=0x000000000066e770, managedAssemblyPath=0x0000000000752990, exitCode=0x00007fffffffd4fc) + 354 at unixinterface.cpp:407
  frame System.Security.Cryptography.X509Certificates Namespace missing from this repro and the need to validate its security? #3863: 0x00007ffff68647d3 libhostpolicy.socoreclr::execute_assembly(host_handle=0x0000000000676d90, domain_id=1, argc=1, argv=0x000000000066e770, managed_assembly_path=0x0000000000752990, exit_code=0x00007fffffffd4fc) + 131 at coreclr.cpp:104 frame dotnet/coreclr#32: 0x00007ffff68594c5 libhostpolicy.sorun(args=0x00007fffffffda58) + 5973 at hostpolicy.cpp:236
  frame Can't built on Ubuntu 14.04  #3864: 0x00007ffff6859b62 libhostpolicy.socorehost_main(argc=3, argv=0x00007fffffffe578) + 610 at hostpolicy.cpp:322 frame dotnet/runtime#3865: 0x00007ffff6b191c4 libhostfxr.soexecute_app(impl_dll_dir=0x00007fffffffde98, init=0x00007fffffffdd38, argc=3, argv=0x00007fffffffe578) + 212 at hostfxr.cpp:73
  frame Fix error locating llvm-ar during build on Linux coreclr#35: 0x00007ffff6b22034 libhostfxr.sofx_muxer_t::read_config_and_execute(own_dir=0x00007fffffffe370, app_candidate=0x00007fffffffe1c0, opts=0x00007fffffffe208, new_argc=3, new_argv=0x00007fffffffe578, mode=muxer) + 3940 at fx_muxer.cpp:963 frame dotnet/coreclr#36: 0x00007ffff6b21007 libhostfxr.sofx_muxer_t::parse_args_and_execute(own_dir=0x00007fffffffe370, own_dll=0x00007fffffffe358, argoff=1, argc=3, argv=0x00007fffffffe578, exec_mode=false, mode=muxer, is_an_app=0x00007fffffffe357) + 1975 at fx_muxer.cpp:862
  frame Missing projects in AllTestProjects.sln #3866: 0x00007ffff6b22663 libhostfxr.sofx_muxer_t::execute(argc=3, argv=0x00007fffffffe578) + 947 at fx_muxer.cpp:1026 frame dotnet/coreclr#38: 0x00007ffff6b19245 libhostfxr.sohostfxr_main(argc=3, argv=0x00007fffffffe578) + 53 at hostfxr.cpp:99
  frame Two versions of mscorlib.txt? #3867: 0x000000000040c4ca dotnetrun(argc=3, argv=0x00007fffffffe578) + 970 at corehost.cpp:199 frame dotnet/runtime#3868: 0x000000000040c637 dotnetmain(argc=3, argv=0x00007fffffffe578) + 167 at corehost.cpp:233
  frame Merge changes from TFS coreclr#41: 0x00007ffff6d6c830 libc.so.6__libc_start_main + 240 frame dotnet/coreclr#42: 0x000000000040a425 dotnet_start + 41`

[brianrob]

This happens when we're building metadata for the event, meaning that this is the first time that this event has been written to the file.

The EventPipeEventInstance appears to be OK - with a debug build, the start and end markers are intact.

If we follow the EventPipeEvent pointer, we find the corruption. Something is likely overwriting the EventPipeEvent.

[brianrob]

Unable to reproduce this after further changes in this area. Will re-open if it appears again.