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.

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

[XrdAdaptor] Modifications for xrootd-5.3 #34700

Merged

Conversation

osschar
Copy link
Contributor

@osschar osschar commented Jul 29, 2021

  1. Replace usage of XrdSys::LinuxSemaphore with XrdSysSemaphore. This goes along with [XROOTD] Update top version 5.3.1 cmsdist#7180.
  2. When opening additional files for multi-source include triedrc=rese. This addresses [Utilities/XrdAdaptor] Multi-source open requests should specify triedrc=resel #28716.

There is one issue and a possible improvement ... I'll add those as separate comments.

@cmsbuild cmsbuild changed the base branch from CMSSW_12_0_X to master July 29, 2021 23:57
@cmsbuild
Copy link
Contributor

@osschar, CMSSW_12_0_X branch is closed for direct updates. cms-bot is going to move this PR to master branch.
In future, please use cmssw master branch to submit your changes.

@cmsbuild
Copy link
Contributor

-code-checks

Logs: https://cmssdt.cern.ch/SDT/code-checks/cms-sw-PR-34700/24329

  • This PR adds an extra 24KB to repository

Code check has found code style and quality issues which could be resolved by applying following patch(s)

@osschar
Copy link
Contributor Author

osschar commented Jul 30, 2021

Existing issue is a crash, presumably due to a race condition, at cmsRun startup while doing TFile::Open(). I was surprised TFile::Open() is called at all, I thought XrdAdaptor will get invoked immediately (the same happens with 11_3_2 and xrootd-4.12 -- TFile::Open, not the crash :) ).

See stack trace below. I'm assuming it is some sort or race condition as when I ran this in debugger and set breakpoint at TFile::Open(), the thing managed to initialize properly and then ran successfully.

@Dr15Jones @dan131riley @abh3 @simonmichal -- please take a look and tell me if anything rings a bell here.

A fatal system signal has occurred: segmentation violation
The following is the call stack containing the origin of the signal.

Fri Jul 30 02:01:44 CEST 2021
Thread 7 (Thread 0x7f20a2b2e700 (LWP 24924) "cmsRun"):
#0  0x00007f20c1cc4b3b in do_futex_wait.constprop () from /lib64/libpthread.so.0
#1  0x00007f20c1cc4bcf in __new_sem_wait_slow.constprop.0 () from /lib64/libpthread.so.0
#2  0x00007f20c1cc4c6b in sem_wait@@GLIBC_2.2.5 () from /lib64/libpthread.so.0
#3  0x00007f20bc15c186 in XrdCl::JobManager::RunJobs() () from /afs/cern.ch/user/m/matevz/CMSSW_12_0_X_2021-07-28-1100/external/slc7_amd64_gcc900/lib/libXrdCl.so.3
#4  0x00007f20bc15c239 in RunRunnerThread () from /afs/cern.ch/user/m/matevz/CMSSW_12_0_X_2021-07-28-1100/external/slc7_amd64_gcc900/lib/libXrdCl.so.3
#5  0x00007f20c1cbeea5 in start_thread () from /lib64/libpthread.so.0
#6  0x00007f20c19e79fd in clone () from /lib64/libc.so.6
Thread 6 (Thread 0x7f20a332f700 (LWP 24923) "cmsRun"):
#0  0x00007f20c1cc4b3b in do_futex_wait.constprop () from /lib64/libpthread.so.0
#1  0x00007f20c1cc4bcf in __new_sem_wait_slow.constprop.0 () from /lib64/libpthread.so.0
#2  0x00007f20c1cc4c6b in sem_wait@@GLIBC_2.2.5 () from /lib64/libpthread.so.0
#3  0x00007f20bc15c186 in XrdCl::JobManager::RunJobs() () from /afs/cern.ch/user/m/matevz/CMSSW_12_0_X_2021-07-28-1100/external/slc7_amd64_gcc900/lib/libXrdCl.so.3
#4  0x00007f20bc15c239 in RunRunnerThread () from /afs/cern.ch/user/m/matevz/CMSSW_12_0_X_2021-07-28-1100/external/slc7_amd64_gcc900/lib/libXrdCl.so.3
#5  0x00007f20c1cbeea5 in start_thread () from /lib64/libpthread.so.0
#6  0x00007f20c19e79fd in clone () from /lib64/libc.so.6
Thread 5 (Thread 0x7f20a3b30700 (LWP 24922) "cmsRun"):
#0  0x00007f20c1cc554d in __lll_lock_wait () from /lib64/libpthread.so.0
#1  0x00007f20c1cc0eb6 in _L_lock_941 () from /lib64/libpthread.so.0
#2  0x00007f20c1cc0daf in pthread_mutex_lock () from /lib64/libpthread.so.0
#3  0x00007f20bc0e6ab2 in XrdCl::AssignLastURLHandler::HandleResponseWithHosts(XrdCl::XRootDStatus*, XrdCl::AnyObject*, std::vector<XrdCl::HostInfo, std::allocator<XrdCl::HostInfo> >*) () from /afs/cern.ch/user/m/matevz/CMSSW_12_0_X_2021-07-28-1100/external/slc7_amd64_gcc900/lib/libXrdCl.so.3
#4  0x00007f20bc0e67a1 in XrdCl::AssignLBHandler::HandleResponseWithHosts(XrdCl::XRootDStatus*, XrdCl::AnyObject*, std::vector<XrdCl::HostInfo, std::allocator<XrdCl::HostInfo> >*) () from /afs/cern.ch/user/m/matevz/CMSSW_12_0_X_2021-07-28-1100/external/slc7_amd64_gcc900/lib/libXrdCl.so.3
#5  0x00007f20bc0f592a in XrdCl::XRootDMsgHandler::HandleResponse() () from /afs/cern.ch/user/m/matevz/CMSSW_12_0_X_2021-07-28-1100/external/slc7_amd64_gcc900/lib/libXrdCl.so.3
#6  0x00007f20bc0fa046 in XrdCl::XRootDMsgHandler::Process(XrdCl::Message*) () from /afs/cern.ch/user/m/matevz/CMSSW_12_0_X_2021-07-28-1100/external/slc7_amd64_gcc900/lib/libXrdCl.so.3
#7  0x00007f20bc0cf752 in XrdCl::Stream::HandleIncMsgJob::Run(void*) () from /afs/cern.ch/user/m/matevz/CMSSW_12_0_X_2021-07-28-1100/external/slc7_amd64_gcc900/lib/libXrdCl.so.3
#8  0x00007f20bc15c1dd in XrdCl::JobManager::RunJobs() () from /afs/cern.ch/user/m/matevz/CMSSW_12_0_X_2021-07-28-1100/external/slc7_amd64_gcc900/lib/libXrdCl.so.3
#9  0x00007f20bc15c239 in RunRunnerThread () from /afs/cern.ch/user/m/matevz/CMSSW_12_0_X_2021-07-28-1100/external/slc7_amd64_gcc900/lib/libXrdCl.so.3
#10 0x00007f20c1cbeea5 in start_thread () from /lib64/libpthread.so.0
#11 0x00007f20c19e79fd in clone () from /lib64/libc.so.6
Thread 4 (Thread 0x7f20a4331700 (LWP 24921) "cmsRun"):
#0  0x00007f20c1cc5e9d in nanosleep () from /lib64/libpthread.so.0
#1  0x00007f20bbe79b6f in XrdSysTimer::Wait(int) () from /afs/cern.ch/user/m/matevz/CMSSW_12_0_X_2021-07-28-1100/external/slc7_amd64_gcc900/lib/libXrdUtils.so.3
#2  0x00007f20bc0dd1ff in XrdCl::TaskManager::RunTasks() () from /afs/cern.ch/user/m/matevz/CMSSW_12_0_X_2021-07-28-1100/external/slc7_amd64_gcc900/lib/libXrdCl.so.3
#3  0x00007f20bc0dd359 in RunRunnerThread () from /afs/cern.ch/user/m/matevz/CMSSW_12_0_X_2021-07-28-1100/external/slc7_amd64_gcc900/lib/libXrdCl.so.3
#4  0x00007f20c1cbeea5 in start_thread () from /lib64/libpthread.so.0
#5  0x00007f20c19e79fd in clone () from /lib64/libc.so.6
Thread 3 (Thread 0x7f20a4b32700 (LWP 24920) "cmsRun"):
#0  0x00007f20c19e7fd3 in epoll_wait () from /lib64/libc.so.6
#1  0x00007f20bbe740d2 in XrdSys::IOEvents::PollE::Begin(XrdSysSemaphore*, int&, char const**) () from /afs/cern.ch/user/m/matevz/CMSSW_12_0_X_2021-07-28-1100/external/slc7_amd64_gcc900/lib/libXrdUtils.so.3
#2  0x00007f20bbe709bd in XrdSys::IOEvents::BootStrap::Start(void*) () from /afs/cern.ch/user/m/matevz/CMSSW_12_0_X_2021-07-28-1100/external/slc7_amd64_gcc900/lib/libXrdUtils.so.3
#3  0x00007f20bbe79288 in XrdSysThread_Xeq () from /afs/cern.ch/user/m/matevz/CMSSW_12_0_X_2021-07-28-1100/external/slc7_amd64_gcc900/lib/libXrdUtils.so.3
#4  0x00007f20c1cbeea5 in start_thread () from /lib64/libpthread.so.0
#5  0x00007f20c19e79fd in clone () from /lib64/libc.so.6
Thread 2 (Thread 0x7f20a56f2700 (LWP 24913) "cmsRun"):
#0  0x00007f20c1cc61d9 in waitpid () from /lib64/libpthread.so.0
#1  0x00007f20bbbd8777 in edm::service::cmssw_stacktrace_fork() () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_0_X_2021-07-28-1100/lib/slc7_amd64_gcc900/pluginFWCoreServicesPlugins.so
#2  0x00007f20bbbd940a in edm::service::InitRootHandlers::stacktraceHelperThread() () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_0_X_2021-07-28-1100/lib/slc7_amd64_gcc900/pluginFWCoreServicesPlugins.so
#3  0x00007f20c22bfaf0 in std::execute_native_thread_routine (__p=0x7f20a5a5d090) at ../../../../../libstdc++-v3/src/c++11/thread.cc:80
#4  0x00007f20c1cbeea5 in start_thread () from /lib64/libpthread.so.0
#5  0x00007f20c19e79fd in clone () from /lib64/libc.so.6
Thread 1 (Thread 0x7f20bfb42540 (LWP 24877) "cmsRun"):
#0  0x00007f20c19dcccd in poll () from /lib64/libc.so.6
#1  0x00007f20bbbd8ba7 in full_read.constprop () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_0_X_2021-07-28-1100/lib/slc7_amd64_gcc900/pluginFWCoreServicesPlugins.so
#2  0x00007f20bbbd94dc in edm::service::InitRootHandlers::stacktraceFromThread() () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_0_X_2021-07-28-1100/lib/slc7_amd64_gcc900/pluginFWCoreServicesPlugins.so
#3  0x00007f20bbbdc98b in sig_dostack_then_abort () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_0_X_2021-07-28-1100/lib/slc7_amd64_gcc900/pluginFWCoreServicesPlugins.so
#4  <signal handler called>
#5  0x00007f20c3cbb807 in TMutex::UnLock() () from /afs/cern.ch/user/m/matevz/CMSSW_12_0_X_2021-07-28-1100/external/slc7_amd64_gcc900/lib/libThread.so
#6  0x00007f20c338f395 in TPluginHandler::CheckForExecPlugin(int) () from /afs/cern.ch/user/m/matevz/CMSSW_12_0_X_2021-07-28-1100/external/slc7_amd64_gcc900/lib/libCore.so
#7  0x00007f20c33c9bee in TSystem::FindHelper(char const*, void*) () from /afs/cern.ch/user/m/matevz/CMSSW_12_0_X_2021-07-28-1100/external/slc7_amd64_gcc900/lib/libCore.so
#8  0x00007f20c34a4244 in TUnixSystem::IsPathLocal(char const*) () from /afs/cern.ch/user/m/matevz/CMSSW_12_0_X_2021-07-28-1100/external/slc7_amd64_gcc900/lib/libCore.so
#9  0x00007f20c37f3dfe in TFile::GetType(char const*, char const*, TString*) () from /afs/cern.ch/user/m/matevz/CMSSW_12_0_X_2021-07-28-1100/external/slc7_amd64_gcc900/lib/libRIO.so
#10 0x00007f20c37f5577 in TFile::Open(char const*, char const*, char const*, int, int) () from /afs/cern.ch/user/m/matevz/CMSSW_12_0_X_2021-07-28-1100/external/slc7_amd64_gcc900/lib/libRIO.so
#11 0x00007f20a4bab30d in edm::InputFile::InputFile(char const*, char const*, edm::InputType) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_0_X_2021-07-28-1100/lib/slc7_amd64_gcc900/pluginIOPoolInput.so
#12 0x00007f20a4beaa4d in edm::RootInputFileSequence::initTheFile(bool, bool, edm::InputSource*, char const*, edm::InputType) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_0_X_2021-07-28-1100/lib/slc7_amd64_gcc900/pluginIOPoolInput.so
#13 0x00007f20a4bede7c in edm::RootPrimaryFileSequence::RootPrimaryFileSequence(edm::ParameterSet const&, edm::PoolSource&, edm::InputFileCatalog const&) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_0_X_2021-07-28-1100/lib/slc7_amd64_gcc900/pluginIOPoolInput.so
#14 0x00007f20a4baf72e in edm::PoolSource::PoolSource(edm::ParameterSet const&, edm::InputSourceDescription const&) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_0_X_2021-07-28-1100/lib/slc7_amd64_gcc900/pluginIOPoolInput.so
#15 0x00007f20a4bad29f in edmplugin::PluginFactory<edm::InputSource* (edm::ParameterSet const&, edm::InputSourceDescription const&)>::PMaker<edm::PoolSource>::create(edm::ParameterSet const&, edm::InputSourceDescription const&) const () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_0_X_2021-07-28-1100/lib/slc7_amd64_gcc900/pluginIOPoolInput.so
#16 0x00007f20c438d3f3 in edm::InputSourceFactory::makeInputSource(edm::ParameterSet const&, edm::InputSourceDescription const&) const () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_0_X_2021-07-28-1100/lib/slc7_amd64_gcc900/libFWCoreFramework.so
#17 0x00007f20c4319d5a in edm::makeInput(edm::ParameterSet&, edm::CommonParams const&, std::shared_ptr<edm::ProductRegistry>, std::shared_ptr<edm::BranchIDListHelper>, std::shared_ptr<edm::ProcessBlockHelper> const&, std::shared_ptr<edm::ThinnedAssociationsHelper>, std::shared_ptr<edm::ActivityRegistry>, std::shared_ptr<edm::ProcessConfiguration const>, edm::PreallocationConfiguration const&) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_0_X_2021-07-28-1100/lib/slc7_amd64_gcc900/libFWCoreFramework.so
#18 0x00007f20c431f590 in edm::EventProcessor::init(std::shared_ptr<edm::ProcessDesc>&, edm::ServiceToken const&, edm::serviceregistry::ServiceLegacy) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_0_X_2021-07-28-1100/lib/slc7_amd64_gcc900/libFWCoreFramework.so
#19 0x00007f20c43215e6 in edm::EventProcessor::EventProcessor(std::shared_ptr<edm::ProcessDesc>, edm::ServiceToken const&, edm::serviceregistry::ServiceLegacy) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_0_X_2021-07-28-1100/lib/slc7_amd64_gcc900/libFWCoreFramework.so
#20 0x000000000040ba11 in tbb::detail::d1::task_arena_function<main::{lambda()#1}::operator()() const::{lambda()#1}, void>::operator()() const ()
#21 0x00007f20c2ad7970 in tbb::detail::r1::task_arena_impl::execute (ta=<optimized out>, d=@0x7ffe4aab8e40: {_vptr.delegate_base = 0x41cfd8 <vtable for tbb::detail::d1::task_arena_function<main::{lambda()#1}::operator()() const::{lambda()#1}, void>+16>}) at /build/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/tbb/v2021.2.0-15857f9184bdf4083e1451d2e283f5ae/tbb-v2021.2.0/src/tbb/arena.cpp:674
#22 0x000000000040ca58 in main::{lambda()#1}::operator()() const ()
#23 0x000000000040b62c in main ()

@osschar
Copy link
Contributor Author

osschar commented Jul 30, 2021

@bbockelm please review the change for multi-source. There is a question for you in the code if we should handle redirect-limit differently as this will happen on XCache clusters all the time and with current implementation the manager will go for a new file every 5 seconds (which we are seeing at SoCal XCache):
https://github.com/cms-sw/cmssw/pull/34700/files#diff-05b98bf16a8b7f884b79b8a34a4f0ddee3bbfd3b225f153f4d632b726974e8e1R1029

@cmsbuild
Copy link
Contributor

+code-checks

Logs: https://cmssdt.cern.ch/SDT/code-checks/cms-sw-PR-34700/24330

  • This PR adds an extra 24KB to repository

@cmsbuild
Copy link
Contributor

A new Pull Request was created by @osschar (Matevž Tadel) for master.

It involves the following packages:

  • Utilities/XrdAdaptor (core)

@makortel, @smuzaffar, @cmsbuild, @Dr15Jones can you please review it and eventually sign? Thanks.
@wddgit this is something you requested to watch as well.
@silviodonato, @dpiparo, @qliphy, @perrotta you are the release manager for this.

cms-bot commands are listed here

@smuzaffar
Copy link
Contributor

please test with cms-sw/cmsdist#7180

@smuzaffar
Copy link
Contributor

please test with cms-sw/cmsdist#7180

@smuzaffar
Copy link
Contributor

@osschar , I do not think you need any rebase. There are no conflicting changes. But if you then you can do something like

scram p CMSSW_12_1_X_2021-08-19-2300
cd CMSSW_12_1_X_2021-08-19-2300/
cmsenv
git cms-rebase-topic 34700

and this should rebase on top of existing master branch. After that you can push changes to your branch

@cmsbuild
Copy link
Contributor

+1

Summary: https://cmssdt.cern.ch/SDT/jenkins-artifacts/pull-request-integration/PR-bc0314/17919/summary.html
COMMIT: b2fbf83
CMSSW: CMSSW_12_1_X_2021-08-19-2300/slc7_amd64_gcc900
Additional Tests: THREADING
User test area: For local testing, you can use /cvmfs/cms-ci.cern.ch/week0/cms-sw/cmssw/34700/17919/install.sh to create a dev area with all the needed externals and cmssw changes.

The following merge commits were also included on top of IB + this PR after doing git cms-merge-topic:

You can see more details here:
https://cmssdt.cern.ch/SDT/jenkins-artifacts/pull-request-integration/PR-bc0314/17919/git-recent-commits.json
https://cmssdt.cern.ch/SDT/jenkins-artifacts/pull-request-integration/PR-bc0314/17919/git-merge-result

Comparison Summary

Summary:

  • No significant changes to the logs found
  • Reco comparison results: 3 differences found in the comparisons
  • DQMHistoTests: Total files compared: 39
  • DQMHistoTests: Total histograms compared: 3000352
  • DQMHistoTests: Total failures: 6
  • DQMHistoTests: Total nulls: 0
  • DQMHistoTests: Total successes: 3000324
  • DQMHistoTests: Total skipped: 22
  • DQMHistoTests: Total Missing objects: 0
  • DQMHistoSizes: Histogram memory added: 0.0 KiB( 38 files compared)
  • Checked 165 log files, 37 edm output root files, 39 DQM output files
  • TriggerResults: no differences found

@smuzaffar
Copy link
Contributor

smuzaffar commented Aug 23, 2021

this looks good @osschar
@makortel , should we try to integrate it in DEVEL IBs for full scale testing?

@makortel
Copy link
Contributor

should we try to integrate it in DEVEL IBs for full scale testing?

That could be useful, so fine for me. There is still a question to @bbockelm

// Brian, should we do something like this:
// if (status.status == XrdCl::errRedirectLimit) {
// // The following method does not exist (yet), would probaly need a multiplier for OPEN_DELAY.
// // Note that with XCache cluster one will never get multiple sources.
// manager->increaseMultiSourceInterval();
// }

but I would not let that prevent testing in DEVEL.

@smuzaffar smuzaffar changed the base branch from master to CMSSW_12_1_DEVEL_X August 23, 2021 13:01
@smuzaffar
Copy link
Contributor

so lets get it in DEVEL

@smuzaffar smuzaffar merged commit 4f37f92 into cms-sw:CMSSW_12_1_DEVEL_X Aug 23, 2021
@osschar
Copy link
Contributor Author

osschar commented Aug 23, 2021

thank you ... I also think it's important to get this moving. i'll follow up with Brian and eventually open a new PR if needed.

@smuzaffar
Copy link
Contributor

couple of workflows in DEVEL IBs are failed/timed out (after 9000s) and at the end I see messages like
https://cmssdt.cern.ch/SDT/cgi-bin/logreader/slc7_amd64_gcc900/CMSSW_12_1_DEVEL_X_2021-08-23-2300/pyRelValMatrixLogs/run/13992501.0_ZMM_13_HS+ZMM_13_HSINPUT+DIGIUP15_PU25HS+RECOUP15_PU25HS+HARVESTUP15_PU25/step2_ZMM_13_HS+ZMM_13_HSINPUT+DIGIUP15_PU25HS+RECOUP15_PU25HS+HARVESTUP15_PU25.log#/

[2021-08-24 04:28:47.202997 +0200][Error  ][PostMaster        ][11825] [st-096-gg50030g.cern.ch:1095] Forcing error on disconnect: [ERROR] Operation interrupted.
[2021-08-24 04:28:47.203259 +0200][Error  ][PostMaster        ][11825] [st-096-ee857a70.cern.ch:1095] Forcing error on disconnect: [ERROR] Operation interrupted.
[2021-08-24 04:29:03.220491 +0200][Error  ][PostMaster        ][11825] [p06636710u09390.cern.ch:1095] Forcing error on disconnect: [ERROR] Operation interrupted.
[2021-08-24 04:29:07.236372 +0200][Error  ][PostMaster        ][11825] [st-096-dd904234.cern.ch:1095] Forcing error on disconnect: [ERROR] Operation interrupted.
[2021-08-24 04:30:33.325676 +0200][Error  ][PostMaster        ][11825] [st-048-019593bf.cern.ch:1095] Forcing error on disconnect: [ERROR] Operation interrupted.
[2021-08-24 04:30:33.325885 +0200][Error  ][PostMaster        ][11825] [st-096-gg5614ly.cern.ch:1095] Forcing error on disconnect: [ERROR] Operation interrupted.
[2021-08-24 04:30:33.325940 +0200][Error  ][PostMaster        ][11825] [st-096-dd905bc9.cern.ch:1095] Forcing error on disconnect: [ERROR] Operation interrupted.
[2021-08-24 04:30:33.325985 +0200][Error  ][PostMaster        ][11825] [st-096-gg5005ps.cern.ch:1095] Forcing error on disconnect: [ERROR] Operation interrupted.
[2021-08-24 04:30:33.326161 +0200][Error  ][PostMaster        ][11825] [p06636710e89093.cern.ch:1095] Forcing error on disconnect: [ERROR] Operation interrupted.
[2021-08-24 04:44:04.241565 +0200][Error  ][PostMaster        ][11825] [eoscms.cern.ch:1094] Forcing error on disconnect: [ERROR] Operation interrupted.

looks like the job was finished with in few minutes but xrootd was hanging causing it to be killed after 9000s.

FYI, @osschar , @makortel

@osschar
Copy link
Contributor Author

osschar commented Aug 24, 2021

I see five files were closed at the end of the job.
XrdCl would keep the connections to servers and redirectors open for quite a long while (default it's 5 min for data servers, 20 min for redirectors). I don't think this is a (or the) problem -- but of course something else with XrdCl could be.

This job then went on for another 3 hours, right? I assume this doesn't happen otherwise :)

How could I run this to reproduce it and attach gdb to see what "main" is waiting for? Do we have debug on (or available) for these external/cmssw builds?

[ An aside: another thing I added in XrdAdaptor in this PR is that it advertises when it is doing additional open for multi-source reading (which happens here). This is really bad for XCache, and I dare guess it is annoying EOS people a bit as well. The servers/redirectors already support limiting number of opened "replicas" if so configured ... this could be enabled on CMS EOS once this all gets through. ]

@smuzaffar
Copy link
Contributor

smuzaffar commented Aug 30, 2021

This job then went on for another 3 hours, right? I assume this doesn't happen otherwise :)

correct. Note that this is not happening a lot. We run over 900 workflows and only 1 or 2 fail with this type of errors.

How could I run this to reproduce it and attach gdb to see what "main" is waiting for? Do we have debug on (or available) for these external/cmssw builds?

No xrootd and other externals are not build in debug mode but for DEVEL IBs I can build xrootd in debug mode. In order to re-produce you ca do some thing like

scram p CMSSW_12_1_DEVEL_X_2021-08-29-2300
cd CMSSW_12_1_DEVEL_X_2021-08-29-2300
export CMS_PATH=/cvmfs/cms-ib.cern.ch
runTheMatrix.py -i all -l 25214.0 -t 4 --job-reports --ibeos --maxSteps 2

Hopefully this will run and generate 25214.0_TTbarLepton_13+TTbarLepton_13INPUT+DIGIUP15_PU25+RECOUP15_PU25+HARVESTUP15_PU25/step2_DIGI_L1_DIGI2RAW_HLT_PU.py file. Now you can run it under gdb

gdb --args cmsRun  25214.0_TTbarLepton_13+TTbarLepton_13INPUT+DIGIUP15_PU25+RECOUP15_PU25+HARVESTUP15_PU25/step2_DIGI_L1_DIGI2RAW_HLT_PU.py

as I wrote that frequency of the failure is low so you might have to run it many time in order to get this type of failure.

Note that CMSSW_12_1_DEVEL_X_2021-08-29-2300 is without debug symbols, I will build CMSSW_12_1_DEVEL_X_2021-08-30-1100 with xrootd in debug mode

@osschar
Copy link
Contributor Author

osschar commented Aug 30, 2021

Thank you! I'm running the test in 10 terminals on various lxpluses, will keep running them over the day.

@osschar
Copy link
Contributor Author

osschar commented Aug 31, 2021

I suddenly got the hangups in all 10 terminals at the same time, the processes that I managed to attach to were all stuck in main thread:

(gdb) info thr
  Id   Target Id                                 Frame
* 1    Thread 0x7efe01252540 (LWP 3468) "cmsRun" 0x00007efe030eec6d in fdatasync () from /lib64/libc.so.6
  2    Thread 0x7efde462d700 (LWP 3515) "cmsRun" 0x00007efe033d575d in read () from /lib64/libpthread.so.0
  3    Thread 0x7efdc55dd700 (LWP 3601) "cmsRun" 0x00007efe030f7fd3 in epoll_wait () from /lib64/libc.so.6
  4    Thread 0x7efdc4ddc700 (LWP 3602) "cmsRun" 0x00007efe033d5e9d in nanosleep ()   from /lib64/libpthread.so.0
  5    Thread 0x7efdc45db700 (LWP 3603) "cmsRun" 0x00007efe033d4b3b in do_futex_wait.constprop ()   from /lib64/libpthread.so.0
  6    Thread 0x7efdc3dda700 (LWP 3604) "cmsRun" 0x00007efe033d4b3b in do_futex_wait.constprop ()   from /lib64/libpthread.so.0
  7    Thread 0x7efdc35d9700 (LWP 3605) "cmsRun" 0x00007efe033d4b3b in do_futex_wait.constprop ()   from /lib64/libpthread.so.0
  8    Thread 0x7efdbb9ff700 (LWP 3615) "cmsRun" 0x00007efe030f1d19 in syscall () from /lib64/libc.so.6
  9    Thread 0x7efdbaffe700 (LWP 3616) "cmsRun" 0x00007efe030f1d19 in syscall () from /lib64/libc.so.6
  10   Thread 0x7efdb9fff700 (LWP 3617) "cmsRun" 0x00007efe030f1d19 in syscall () from /lib64/libc.so.6
  11   Thread 0x7efcb01ff700 (LWP 3839) "cmsRun" 0x00007efe033d2a35 in pthread_cond_wait@@GLIBC_2.3.2 ()   from /lib64/libpthread.so.0
  12   Thread 0x7efcaf3ff700 (LWP 3840) "cmsRun" 0x00007efe033d2a35 in pthread_cond_wait@@GLIBC_2.3.2 ()   from /lib64/libpthread.so.0
  13   Thread 0x7efcae5ff700 (LWP 3841) "cmsRun" 0x00007efe033d2a35 in pthread_cond_wait@@GLIBC_2.3.2 ()   from /lib64/libpthread.so.0
(gdb) bt
#0  0x00007efe030eec6d in fdatasync () from /lib64/libc.so.6
#1  0x00007efdfd762cd6 in File::flush() () from /cvmfs/cms-ib.cern.ch/week0/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libUtilitiesStorageFactory.so
#2  0x00007efdfd75edee in StorageAccountProxy::flush() () from /cvmfs/cms-ib.cern.ch/week0/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libUtilitiesStorageFactory.so
#3  0x00007efdfd363efe in TStorageFactoryFile::SysSync(int) () from /cvmfs/cms-ib.cern.ch/week0/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libIOPoolTFileAdaptor.so
#4  0x00007efe04f1109f in TFile::Flush() () from /cvmfs/cms-ib.cern.ch/week0/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/external/slc7_amd64_gcc900/lib/libRIO.so
#5  0x00007efe04f1d276 in TFile::WriteHeader() () from /cvmfs/cms-ib.cern.ch/week0/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/external/slc7_amd64_gcc900/lib/libRIO.so
#6  0x00007efe04f1c402 in TFile::Close(char const*) () from /cvmfs/cms-ib.cern.ch/week0/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/external/slc7_amd64_gcc900/lib/libRIO.so
#7  0x00007efdb6f961ee in edm::RootOutputFile::finishEndFile() () from /cvmfs/cms-ib.cern.ch/week0/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libIOPoolOutput.so
#8  0x00007efdb6f738bd in edm::PoolOutputModule::finishEndFile() () from /cvmfs/cms-ib.cern.ch/week0/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libIOPoolOutput.so
#9  0x00007efdb6f757bb in edm::PoolOutputModule::reallyCloseFile() () from /cvmfs/cms-ib.cern.ch/week0/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libIOPoolOutput.so
#10 0x00007efe05b16515 in edm::Schedule::closeOutputFiles() () from /cvmfs/cms-ib.cern.ch/week0/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libFWCoreFramework.so
#11 0x00007efe05a3d4bd in edm::EventProcessor::closeOutputFiles() ()
   from /cvmfs/cms-ib.cern.ch/week0/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libFWCoreFramework.so
#12 0x00007efe05a4a81a in edm::EventProcessor::runToCompletion() ()
   from /cvmfs/cms-ib.cern.ch/week0/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libFWCoreFramework.so
#13 0x000000000040bae6 in tbb::detail::d1::task_arena_function<main::{lambda()#1}::operator()() const::{lambda()#1}, void>::operator()() const ()
#14 0x00007efe041e2302 in tbb::detail::r1::task_arena_impl::execute (ta=<optimized out>, d=warning: RTTI symbol not found for class 'tbb::detail::d1::task_arena_function<main::{lambda()#1}::operator()() const::{lambda()#1}, void>'
      @0x7fffd3218680: {_vptr.delegate_base = 0x41cfd8 <vtable for tbb::detail::d1::task_arena_function<main::{lambda()#1}::operator()() const::{lambda()#1}, void>+16>})
    at /build/cmsbld/jenkins/workspace/auto-builds/CMSSW_12_1_0_pre1-slc7_amd64_gcc900/build/CMSSW_12_1_0_pre1-build/BUILD/slc7_amd64_gcc900/external/tbb/v2021.3.0/tbb-v2021.3.0/src/tbb/arena.cpp:696
#15 0x000000000040ca31 in main::{lambda()#1}::operator()() const ()
#16 0x000000000040b62c in main ()

[ I say managed to attach to as fdatasync seems to be blocking all signals so gdb only managed to attach itself after the call has completed. ]
XrdCl::PostMaster massages did show up, as expected, with 5 min delay.
All of the processes succeeded after about 10 minutes, I was able to reproduce it on the next run as well, so whatever it was, it wasn't a one time glitch.

I was running off my AFS home directory (in different tmp dirs so step2.root was different for each process). I assume AFS got busy at this point.

Now, I sort of assume IB tests are not run off AFS so this might or might not be the same thing. What kind of FS did the IB tests run on? Or was writing also done via xroot?

@smuzaffar
Copy link
Contributor

IB/PR tests run on local SSD disk

@makortel
Copy link
Contributor

Also the printouts in #34700 (comment) came some time after the edm::EventProcessor::runToCompletion() (stack frame 11 in #34700 (comment)) had returned.

@osschar
Copy link
Contributor Author

osschar commented Aug 31, 2021

There are several usages of deleted XrdCl::FileSystem in CMS XrdCl response handlers coming from a local variable being used during open:
https://github.com/cms-sw/cmssw/blob/CMSSW_12_1_DEVEL_X/Utilities/XrdAdaptor/src/XrdSource.cc#L332

Class QueryAttrHandler could in principle hold the FileSystem object ... but the whole thing looks over-engineered 10-times over: https://github.com/cms-sw/cmssw/blob/CMSSW_12_1_DEVEL_X/Utilities/XrdAdaptor/src/XrdSource.cc#L82

XrdCl::FileSystem provides a sync version of Query() where one can pass in timeout directly.

@simonmichal @bbockelm Can you please comment?

==29562==    at 0xFAD5859: std::enable_if<std::__and_<std::__not_<std::__is_tuple_like<XrdCl::URL*> >, std::is_move_constructible<XrdCl::URL*>, std::is_move_assignable<XrdCl::URL*> >::value, void>::type std::swap<XrdCl::URL*>(XrdCl::URL*&, XrdCl::URL*&) (move.h:194)
==29562==    by 0xFAD2986: std::unique_ptr<XrdCl::URL, std::default_delete<XrdCl::URL> >::reset(XrdCl::URL*) (unique_ptr.h:400)
==29562==    by 0xFAD1DFA: XrdCl::FileSystemImpl::AssignLastURL(XrdCl::URL const&) (XrdClFileSystem.cc:1000)
==29562==    by 0xFAC677A: XrdCl::AssignLastURLHandler::HandleResponseWithHosts(XrdCl::XRootDStatus*, XrdCl::AnyObject*, std::vector<XrdCl::HostInfo, std::allocator<XrdCl::HostInfo> >*) (XrdClFileSystem.cc:1050)
==29562==    by 0xFAC66B8: XrdCl::AssignLBHandler::HandleResponseWithHosts(XrdCl::XRootDStatus*, XrdCl::AnyObject*, std::vector<XrdCl::HostInfo, std::allocator<XrdCl::HostInfo> >*) (XrdClFileSystem.cc:1032)
==29562==    by 0xFAE01E9: XrdCl::XRootDMsgHandler::HandleResponse() (XrdClXRootDMsgHandler.cc:1603)
==29562==    by 0xFADA780: XrdCl::XRootDMsgHandler::Process(XrdCl::Message*) (XrdClXRootDMsgHandler.cc:540)
==29562==    by 0xFA9D597: XrdCl::Stream::HandleIncMsgJob::Run(void*) (XrdClStream.hh:323)
==29562==    by 0xFB77EAF: XrdCl::JobManager::RunJobs() (XrdClJobManager.cc:153)
==29562==    by 0xFB77A16: RunRunnerThread (XrdClJobManager.cc:34)
==29562==    by 0x70A1EA4: start_thread (in /usr/lib64/libpthread-2.17.so)
==29562==    by 0x73B59FC: clone (in /usr/lib64/libc-2.17.so)
==29562==  Address 0x522d5d88 is 56 bytes inside a block of size 64 free'd
==29562==    at 0x402EF9E: operator delete(void*, unsigned long) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/external/valgrind/3.15.0-cms/lib/valgrind/vgpreload_memcheck-amd64-linux.so)
==29562==    by 0xFAC6A7E: XrdCl::FileSystem::~FileSystem() (XrdClFileSystem.cc:1108)
==29562==    by 0xEC3569D: XrdAdaptor::Source::getXrootdSiteFromURL(std::__cxx11::basic_string<char, std::char_traits<char>, std::allocator<char> >, std::__cxx11::basic_string<char, std::char_traits<char>, std::allocator<char> >&) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libUtilitiesXrdAdaptor.so)
==29562==    by 0xEC2CB4D: XrdAdaptor::RequestManager::initialize(std::weak_ptr<XrdAdaptor::RequestManager>) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libUtilitiesXrdAdaptor.so)
==29562==    by 0xEC1E14B: XrdFile::open(char const*, int, int) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libUtilitiesXrdAdaptor.so)
==29562==    by 0xEC1F46B: XrdFile::XrdFile(std::__cxx11::basic_string<char, std::char_traits<char>, std::allocator<char> > const&, int, int) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libUtilitiesXrdAdaptor.so)
==29562==    by 0xEB06783: XrdStorageMaker::open(std::__cxx11::basic_string<char, std::char_traits<char>, std::allocator<char> > const&, std::__cxx11::basic_string<char, std::char_traits<char>, std::allocator<char> > const&, int, StorageMaker::AuxSettings const&) const (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/pluginUtilitiesXrdAdaptorPlugin.so)
==29562==    by 0xEBA7153: StorageFactory::open(std::__cxx11::basic_string<char, std::char_traits<char>, std::allocator<char> > const&, int) const (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libUtilitiesStorageFactory.so)
==29562==    by 0xEEA13E2: TStorageFactoryFile::Initialize(char const*, char const*) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libIOPoolTFileAdaptor.so)
==29562==    by 0xEEA1BB5: TStorageFactoryFile::TStorageFactoryFile(char const*, char const*, char const*, int, int, bool) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libIOPoolTFileAdaptor.so)
==29562==    by 0xF33F0A3: ???
==29562==    by 0x1260FE80: TClingCallFunc::exec(void*, void*) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/lcg/root/6.22.08-7983f4c8c96f51204f239c2a03786bbb/lib/libCling.so)
==29562==    by 0x126104EE: TClingCallFunc::exec_with_valref_return(void*, cling::Value*) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/lcg/root/6.22.08-7983f4c8c96f51204f239c2a03786bbb/lib/libCling.so)
==29562==    by 0x12610D31: TClingCallFunc::ExecInt(void*) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/lcg/root/6.22.08-7983f4c8c96f51204f239c2a03786bbb/lib/libCling.so)
==29562==    by 0x5BDED0C: TMethodCall::Execute(void*, long&) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/lcg/root/6.22.08-7983f4c8c96f51204f239c2a03786bbb/lib/libCore.so)
==29562==    by 0x5641DF3: TFile::Open(char const*, char const*, char const*, int, int) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/lcg/root/6.22.08-7983f4c8c96f51204f239c2a03786bbb/lib/libRIO.so)
==29562==    by 0x47E7230C: edm::InputFile::InputFile(char const*, char const*, edm::InputType) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/pluginIOPoolInput.so)
==29562==    by 0x47EB1A4C: edm::RootInputFileSequence::initTheFile(bool, bool, edm::InputSource*, char const*, edm::InputType) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/pluginIOPoolInput.so)
==29562==    by 0x47E8C56D: edm::RootEmbeddedFileSequence::readOneRandom(edm::EventPrincipal&, unsigned long&, CLHEP::HepRandomEngine*, edm::EventID const*, bool) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/pluginIOPoolInput.so)
==29562==    by 0x54369FB9: void edm::PileUp::readPileUp<std::_Bind<bool (edm::MixingModule::*(std::reference_wrapper<edm::MixingModule>, std::_Placeholder<1>, edm::ModuleCallingContext const*, int, std::_Placeholder<2>, int, std::reference_wrapper<edm::EventSetup const>, edm::StreamID))(edm::EventPrincipal const&, edm::ModuleCallingContext const*, int, int, int&, edm::EventSetup const&, edm::StreamID const&)> >(edm::EventID const&, std::vector<edm::SecondaryEventIDAndFileInfo, std::allocator<edm::SecondaryEventIDAndFileInfo> >&, std::_Bind<bool (edm::MixingModule::*(std::reference_wrapper<edm::MixingModule>, std::_Placeholder<1>, edm::ModuleCallingContext const*, int, std::_Placeholder<2>, int, std::reference_wrapper<edm::EventSetup const>, edm::StreamID))(edm::EventPrincipal const&, edm::ModuleCallingContext const*, int, int, int&, edm::EventSetup const&, edm::StreamID const&)>, int, edm::StreamID const&) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/pluginSimGeneralMixingModulePlugins.so)
==29562==    by 0x5435FCF9: edm::MixingModule::doPileUp(edm::Event&, edm::EventSetup const&) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/pluginSimGeneralMixingModulePlugins.so)
==29562==    by 0x543F50E9: edm::BMixingModule::produce(edm::Event&, edm::EventSetup const&) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libMixingBase.so)
==29562==    by 0x4D2C86B: edm::stream::EDProducerAdaptorBase::doEvent(edm::EventTransitionInfo const&, edm::ActivityRegistry*, edm::ModuleCallingContext const*) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libFWCoreFramework.so)
==29562==    by 0x4D0DA5C: edm::WorkerT<edm::stream::EDProducerAdaptorBase>::implDo(edm::EventTransitionInfo const&, edm::ModuleCallingContext const*) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libFWCoreFramework.so)
==29562==    by 0x4C68544: decltype ({parm#1}()) edm::convertException::wrap<bool edm::Worker::runModule<edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1> >(edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::TransitionInfoType const&, edm::StreamID, edm::ParentContext const&, edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::Context const*)::{lambda()#1}>(bool edm::Worker::runModule<edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1> >(edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::TransitionInfoType const&, edm::StreamID, edm::ParentContext const&, edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::Context const*)::{lambda()#1}) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libFWCoreFramework.so)
==29562==    by 0x4C686FC: bool edm::Worker::runModule<edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1> >(edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::TransitionInfoType const&, edm::StreamID, edm::ParentContext const&, edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::Context const*) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libFWCoreFramework.so)
==29562==    by 0x4C68A05: std::__exception_ptr::exception_ptr edm::Worker::runModuleAfterAsyncPrefetch<edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1> >(std::__exception_ptr::exception_ptr const*, edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::TransitionInfoType const&, edm::StreamID, edm::ParentContext const&, edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::Context const*) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libFWCoreFramework.so)
==29562==    by 0x4C6AD95: edm::Worker::RunModuleTask<edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1> >::execute() (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libFWCoreFramework.so)
==29562==    by 0x41F4E04: tbb::detail::d1::function_task<edm::WaitingTaskWithArenaHolder::doneWaiting(std::__exception_ptr::exception_ptr)::{lambda()#1}::operator()() const::{lambda()#1}>::execute(tbb::detail::d1::execution_data&) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libFWCoreConcurrency.so)
==29562==    by 0x64823DA: tbb::detail::d1::task* tbb::detail::r1::task_dispatcher::local_wait_for_all<false, tbb::detail::r1::outermost_worker_waiter>(tbb::detail::d1::task*, tbb::detail::r1::outermost_worker_waiter&) (task_dispatcher.h:321)
==29562==  Block was alloc'd at
==29562==    at 0x402DDB2: operator new(unsigned long) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/external/valgrind/3.15.0-cms/lib/valgrind/vgpreload_memcheck-amd64-linux.so)
==29562==    by 0xFAC6891: XrdCl::FileSystem::FileSystem(XrdCl::URL const&, bool) (XrdClFileSystem.cc:1070)
==29562==    by 0xEC354AE: XrdAdaptor::Source::getXrootdSiteFromURL(std::__cxx11::basic_string<char, std::char_traits<char>, std::allocator<char> >, std::__cxx11::basic_string<char, std::char_traits<char>, std::allocator<char> >&) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libUtilitiesXrdAdaptor.so)
==29562==    by 0xEC2CB4D: XrdAdaptor::RequestManager::initialize(std::weak_ptr<XrdAdaptor::RequestManager>) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libUtilitiesXrdAdaptor.so)
==29562==    by 0xEC1E14B: XrdFile::open(char const*, int, int) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libUtilitiesXrdAdaptor.so)
==29562==    by 0xEC1F46B: XrdFile::XrdFile(std::__cxx11::basic_string<char, std::char_traits<char>, std::allocator<char> > const&, int, int) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libUtilitiesXrdAdaptor.so)
==29562==    by 0xEB06783: XrdStorageMaker::open(std::__cxx11::basic_string<char, std::char_traits<char>, std::allocator<char> > const&, std::__cxx11::basic_string<char, std::char_traits<char>, std::allocator<char> > const&, int, StorageMaker::AuxSettings const&) const (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/pluginUtilitiesXrdAdaptorPlugin.so)
==29562==    by 0xEBA7153: StorageFactory::open(std::__cxx11::basic_string<char, std::char_traits<char>, std::allocator<char> > const&, int) const (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libUtilitiesStorageFactory.so)
==29562==    by 0xEEA13E2: TStorageFactoryFile::Initialize(char const*, char const*) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libIOPoolTFileAdaptor.so)
==29562==    by 0xEEA1BB5: TStorageFactoryFile::TStorageFactoryFile(char const*, char const*, char const*, int, int, bool) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libIOPoolTFileAdaptor.so)
==29562==    by 0xF33F0A3: ???
==29562==    by 0x1260FE80: TClingCallFunc::exec(void*, void*) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/lcg/root/6.22.08-7983f4c8c96f51204f239c2a03786bbb/lib/libCling.so)
==29562==    by 0x126104EE: TClingCallFunc::exec_with_valref_return(void*, cling::Value*) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/lcg/root/6.22.08-7983f4c8c96f51204f239c2a03786bbb/lib/libCling.so)
==29562==    by 0x12610D31: TClingCallFunc::ExecInt(void*) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/lcg/root/6.22.08-7983f4c8c96f51204f239c2a03786bbb/lib/libCling.so)
==29562==    by 0x5BDED0C: TMethodCall::Execute(void*, long&) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/lcg/root/6.22.08-7983f4c8c96f51204f239c2a03786bbb/lib/libCore.so)
==29562==    by 0x5641DF3: TFile::Open(char const*, char const*, char const*, int, int) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/lcg/root/6.22.08-7983f4c8c96f51204f239c2a03786bbb/lib/libRIO.so)
==29562==    by 0x47E7230C: edm::InputFile::InputFile(char const*, char const*, edm::InputType) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/pluginIOPoolInput.so)
==29562==    by 0x47EB1A4C: edm::RootInputFileSequence::initTheFile(bool, bool, edm::InputSource*, char const*, edm::InputType) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/pluginIOPoolInput.so)
==29562==    by 0x47E8C56D: edm::RootEmbeddedFileSequence::readOneRandom(edm::EventPrincipal&, unsigned long&, CLHEP::HepRandomEngine*, edm::EventID const*, bool) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/pluginIOPoolInput.so)
==29562==    by 0x54369FB9: void edm::PileUp::readPileUp<std::_Bind<bool (edm::MixingModule::*(std::reference_wrapper<edm::MixingModule>, std::_Placeholder<1>, edm::ModuleCallingContext const*, int, std::_Placeholder<2>, int, std::reference_wrapper<edm::EventSetup const>, edm::StreamID))(edm::EventPrincipal const&, edm::ModuleCallingContext const*, int, int, int&, edm::EventSetup const&, edm::StreamID const&)> >(edm::EventID const&, std::vector<edm::SecondaryEventIDAndFileInfo, std::allocator<edm::SecondaryEventIDAndFileInfo> >&, std::_Bind<bool (edm::MixingModule::*(std::reference_wrapper<edm::MixingModule>, std::_Placeholder<1>, edm::ModuleCallingContext const*, int, std::_Placeholder<2>, int, std::reference_wrapper<edm::EventSetup const>, edm::StreamID))(edm::EventPrincipal const&, edm::ModuleCallingContext const*, int, int, int&, edm::EventSetup const&, edm::StreamID const&)>, int, edm::StreamID const&) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/pluginSimGeneralMixingModulePlugins.so)
==29562==    by 0x5435FCF9: edm::MixingModule::doPileUp(edm::Event&, edm::EventSetup const&) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/pluginSimGeneralMixingModulePlugins.so)
==29562==    by 0x543F50E9: edm::BMixingModule::produce(edm::Event&, edm::EventSetup const&) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libMixingBase.so)
==29562==    by 0x4D2C86B: edm::stream::EDProducerAdaptorBase::doEvent(edm::EventTransitionInfo const&, edm::ActivityRegistry*, edm::ModuleCallingContext const*) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libFWCoreFramework.so)
==29562==    by 0x4D0DA5C: edm::WorkerT<edm::stream::EDProducerAdaptorBase>::implDo(edm::EventTransitionInfo const&, edm::ModuleCallingContext const*) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libFWCoreFramework.so)
==29562==    by 0x4C68544: decltype ({parm#1}()) edm::convertException::wrap<bool edm::Worker::runModule<edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1> >(edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::TransitionInfoType const&, edm::StreamID, edm::ParentContext const&, edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::Context const*)::{lambda()#1}>(bool edm::Worker::runModule<edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1> >(edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::TransitionInfoType const&, edm::StreamID, edm::ParentContext const&, edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::Context const*)::{lambda()#1}) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libFWCoreFramework.so)
==29562==    by 0x4C686FC: bool edm::Worker::runModule<edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1> >(edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::TransitionInfoType const&, edm::StreamID, edm::ParentContext const&, edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::Context const*) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libFWCoreFramework.so)
==29562==    by 0x4C68A05: std::__exception_ptr::exception_ptr edm::Worker::runModuleAfterAsyncPrefetch<edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1> >(std::__exception_ptr::exception_ptr const*, edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::TransitionInfoType const&, edm::StreamID, edm::ParentContext const&, edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::Context const*) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libFWCoreFramework.so)
==29562==    by 0x4C6AD95: edm::Worker::RunModuleTask<edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1> >::execute() (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libFWCoreFramework.so)
==29562==    by 0x41F4E04: tbb::detail::d1::function_task<edm::WaitingTaskWithArenaHolder::doneWaiting(std::__exception_ptr::exception_ptr)::{lambda()#1}::operator()() const::{lambda()#1}>::execute(tbb::detail::d1::execution_data&) (in /cvmfs/cms-ib.cern.ch/nweek-02696/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-08-30-1100/lib/slc7_amd64_gcc900/libFWCoreConcurrency.so)
==29562==    by 0x64823DA: tbb::detail::d1::task* tbb::detail::r1::task_dispatcher::local_wait_for_all<false, tbb::detail::r1::outermost_worker_waiter>(tbb::detail::d1::task*, tbb::detail::r1::outermost_worker_waiter&) (task_dispatcher.h:321)

@dan131riley
Copy link

CMSSW_12_1_DEVEL_X_2021-09-05-2300 has a timeout with a stack trace that looks a lot like a deadlock.

https://cmssdt.cern.ch/SDT/cgi-bin/buildlogs/raw/slc7_amd64_gcc900/CMSSW_12_1_DEVEL_X_2021-09-05-2300/pyRelValMatrixLogs/run/250402.181_TTbar_13+FS_PREMIXUP18_PU50+FS_TTbar_13_PRMXLOCALUP18_PU50+HARVESTUP18FS/step1_TTbar_13+FS_PREMIXUP18_PU50+FS_TTbar_13_PRMXLOCALUP18_PU50+HARVESTUP18FS.log

06-Sep-2021 05:30:28 CEST  Initiating request to open file root://eoscms.cern.ch//eos/cms/store/user/cmsbuild/store/relval/CMSSW_10_6_0/RelValMinBiasFS_13_UP18_ForMixing/GEN-SIM-RECO/106X_upgrade2018_realistic_v4_FastSim-v1/10000/EA7E27CA-54E9-434D-B2D9-B59B2C2BADF5.root
%MSG-w XrdAdaptor:  MixingModule:mix@ctor 06-Sep-2021 05:30:30 CEST pre-events
Data is served from cern.ch instead of original site eoscms
%MSG
06-Sep-2021 05:30:30 CEST  Successfully opened file root://eoscms.cern.ch//eos/cms/store/user/cmsbuild/store/relval/CMSSW_10_6_0/RelValMinBiasFS_13_UP18_ForMixing/GEN-SIM-RECO/106X_upgrade2018_realistic_v4_FastSim-v1/10000/EA7E27CA-54E9-434D-B2D9-B59B2C2BADF5.root
06-Sep-2021 05:30:32 CEST  Initiating request to open file root://eoscms.cern.ch//eos/cms/store/user/cmsbuild/store/relval/CMSSW_10_6_0/RelValMinBiasFS_13_UP18_ForMixing/GEN-SIM-RECO/106X_upgrade2018_realistic_v4_FastSim-v1/10000/38EB9F33-FDC6-FE48-91D2-DB812E11766C.root
%MSG-w XrdAdaptor:  MixingModule:mix@ctor 06-Sep-2021 05:30:34 CEST pre-events
Data is served from cern.ch instead of original site eoscms
%MSG
06-Sep-2021 05:30:34 CEST  Successfully opened file root://eoscms.cern.ch//eos/cms/store/user/cmsbuild/store/relval/CMSSW_10_6_0/RelValMinBiasFS_13_UP18_ForMixing/GEN-SIM-RECO/106X_upgrade2018_realistic_v4_FastSim-v1/10000/38EB9F33-FDC6-FE48-91D2-DB812E11766C.root
06-Sep-2021 05:30:37 CEST  Initiating request to open file root://eoscms.cern.ch//eos/cms/store/user/cmsbuild/store/relval/CMSSW_10_6_0/RelValMinBiasFS_13_UP18_ForMixing/GEN-SIM-RECO/106X_upgrade2018_realistic_v4_FastSim-v1/10000/EA7E27CA-54E9-434D-B2D9-B59B2C2BADF5.root
%MSG-w XrdAdaptor:  MixingModule:mix@ctor 06-Sep-2021 05:30:39 CEST pre-events
Data is served from cern.ch instead of original site eoscms
%MSG
06-Sep-2021 05:30:39 CEST  Successfully opened file root://eoscms.cern.ch//eos/cms/store/user/cmsbuild/store/relval/CMSSW_10_6_0/RelValMinBiasFS_13_UP18_ForMixing/GEN-SIM-RECO/106X_upgrade2018_realistic_v4_FastSim-v1/10000/EA7E27CA-54E9-434D-B2D9-B59B2C2BADF5.root
06-Sep-2021 05:30:40 CEST  Initiating request to open file root://eoscms.cern.ch//eos/cms/store/user/cmsbuild/store/relval/CMSSW_10_6_0/RelValMinBiasFS_13_UP18_ForMixing/GEN-SIM-RECO/106X_upgrade2018_realistic_v4_FastSim-v1/10000/38EB9F33-FDC6-FE48-91D2-DB812E11766C.root
%MSG-w XrdAdaptor:  MixingModule:mix@ctor 06-Sep-2021 05:30:42 CEST pre-events
Data is served from cern.ch instead of original site eoscms
%MSG
06-Sep-2021 05:30:42 CEST  Successfully opened file root://eoscms.cern.ch//eos/cms/store/user/cmsbuild/store/relval/CMSSW_10_6_0/RelValMinBiasFS_13_UP18_ForMixing/GEN-SIM-RECO/106X_upgrade2018_realistic_v4_FastSim-v1/10000/38EB9F33-FDC6-FE48-91D2-DB812E11766C.root
Begin processing the 1st record. Run 1, Event 1, LumiSection 1 on stream 2 at 06-Sep-2021 05:31:45.391 CEST
Begin processing the 2nd record. Run 1, Event 2, LumiSection 1 on stream 0 at 06-Sep-2021 05:31:45.391 CEST
Begin processing the 3rd record. Run 1, Event 3, LumiSection 1 on stream 3 at 06-Sep-2021 05:31:45.391 CEST
Begin processing the 4th record. Run 1, Event 4, LumiSection 1 on stream 1 at 06-Sep-2021 05:31:45.391 CEST
%MSG-e TkDetLayers:  FastSimProducer:fastSimProducer 06-Sep-2021 05:31:45 CEST  Run: 1 Event: 1
 ForwardDiskSectorBuilderFromDet: Trying to build Petal Wedge from Dets at different z positions !! Delta_z = -1.03584
%MSG
06-Sep-2021 05:31:55 CEST  Closed file root://eoscms.cern.ch//eos/cms/store/user/cmsbuild/store/relval/CMSSW_10_6_0/RelValMinBiasFS_13_UP18_ForMixing/GEN-SIM-RECO/106X_upgrade2018_realistic_v4_FastSim-v1/10000/EA7E27CA-54E9-434D-B2D9-B59B2C2BADF5.root
06-Sep-2021 05:31:55 CEST  Initiating request to open file root://eoscms.cern.ch//eos/cms/store/user/cmsbuild/store/relval/CMSSW_10_6_0/RelValMinBiasFS_13_UP18_ForMixing/GEN-SIM-RECO/106X_upgrade2018_realistic_v4_FastSim-v1/10000/93D5FEC9-F061-2A48-809F-68BE5AA179C5.root


A fatal system signal has occurred: external termination request
The following is the call stack containing the origin of the signal.

Mon Sep  6 07:59:09 CEST 2021
Thread 10 (Thread 0x2ba2c7600700 (LWP 27773) "cmsRun"):
#0  0x00002ba24d2e88ed in nanosleep () from /lib64/libc.so.6
#1  0x00002ba24d2e8784 in sleep () from /lib64/libc.so.6
#2  0x00002ba253d823f0 in sig_pause_for_stacktrace () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/pluginFWCoreServicesPlugins.so
#3  <signal handler called>
#4  0x00002ba24d31bd19 in syscall () from /lib64/libc.so.6
#5  0x00002ba24cbddb69 in std::__atomic_futex_unsigned_base::_M_futex_wait_until (this=<optimized out>, __addr=0x2ba4bbeeda80, __val=2147483648, __has_timeout=<optimized out>, __s=..., __ns=...) at ../../../../../libstdc++-v3/src/c++11/futex.cc:55
#6  0x00002ba2520e94c0 in XrdFile::readv(IOPosBuffer*, unsigned long) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libUtilitiesXrdAdaptor.so
#7  0x00002ba251f70bc4 in StorageAccountProxy::readv(IOPosBuffer*, unsigned long) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libUtilitiesStorageFactory.so
#8  0x00002ba2521392e8 in TStorageFactoryFile::ReadBuffersSync(char*, long long*, int*, int) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libIOPoolTFileAdaptor.so
#9  0x00002ba25213ac89 in TStorageFactoryFile::ReadBuffers(char*, long long*, int*, int) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libIOPoolTFileAdaptor.so
#10 0x00002ba24b5af7e1 in TFileCacheRead::ReadBufferExtNormal(char*, long long, int, int&) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/external/slc7_amd64_gcc900/lib/libRIO.so
#11 0x00002ba24b5af2af in TFileCacheRead::ReadBuffer(char*, long long, int) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/external/slc7_amd64_gcc900/lib/libRIO.so
#12 0x00002ba24b0ae7a5 in TTreeCache::ReadBufferNormal(char*, long long, int) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/external/slc7_amd64_gcc900/lib/libTree.so
#13 0x00002ba24b045482 in TBasket::ReadBasketBuffers(long long, int, TFile*) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/external/slc7_amd64_gcc900/lib/libTree.so
#14 0x00002ba24b04f529 in TBranch::GetBasketImpl(int, TBuffer*) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/external/slc7_amd64_gcc900/lib/libTree.so
#15 0x00002ba24b04fba3 in TBranch::GetBasketAndFirst(TBasket*&, long long&, TBuffer*) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/external/slc7_amd64_gcc900/lib/libTree.so
#16 0x00002ba24b050257 in TBranch::GetEntry(long long, int) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/external/slc7_amd64_gcc900/lib/libTree.so
#17 0x00002ba24b061d08 in TBranchElement::GetEntry(long long, int) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/external/slc7_amd64_gcc900/lib/libTree.so
#18 0x00002ba2b9244c4b in edm::RootTree::getEntry(TBranch*, long long) const () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/pluginIOPoolInput.so
#19 0x00002ba2b922138d in edm::RootFile::fillThisEventAuxiliary() () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/pluginIOPoolInput.so
#20 0x00002ba2b922ea15 in edm::RootFile::readCurrentEvent(edm::EventPrincipal&, bool) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/pluginIOPoolInput.so
#21 0x00002ba2b9217792 in edm::RootEmbeddedFileSequence::readOneRandom(edm::EventPrincipal&, unsigned long&, CLHEP::HepRandomEngine*, edm::EventID const*, bool) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/pluginIOPoolInput.so
#22 0x00002ba2b90c768a in void edm::PileUp::readPileUp<std::_Bind<bool (edm::MixingModule::*(std::reference_wrapper<edm::MixingModule>, std::_Placeholder<1>, edm::ModuleCallingContext const*, int, std::_Placeholder<2>, int, std::reference_wrapper<edm::EventSetup const>, edm::StreamID))(edm::EventPrincipal const&, edm::ModuleCallingContext const*, int, int, int&, edm::EventSetup const&, edm::StreamID const&)> >(edm::EventID const&, std::vector<edm::SecondaryEventIDAndFileInfo, std::allocator<edm::SecondaryEventIDAndFileInfo> >&, std::_Bind<bool (edm::MixingModule::*(std::reference_wrapper<edm::MixingModule>, std::_Placeholder<1>, edm::ModuleCallingContext const*, int, std::_Placeholder<2>, int, std::reference_wrapper<edm::EventSetup const>, edm::StreamID))(edm::EventPrincipal const&, edm::ModuleCallingContext const*, int, int, int&, edm::EventSetup const&, edm::StreamID const&)>, int, edm::StreamID const&) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/pluginSimGeneralMixingModulePlugins.so
#23 0x00002ba2b90be02a in edm::MixingModule::doPileUp(edm::Event&, edm::EventSetup const&) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/pluginSimGeneralMixingModulePlugins.so
#24 0x00002ba2b91561fa in edm::BMixingModule::produce(edm::Event&, edm::EventSetup const&) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libMixingBase.so
#25 0x00002ba24acb48bc in edm::stream::EDProducerAdaptorBase::doEvent(edm::EventTransitionInfo const&, edm::ActivityRegistry*, edm::ModuleCallingContext const*) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libFWCoreFramework.so
#26 0x00002ba24ac95add in edm::WorkerT<edm::stream::EDProducerAdaptorBase>::implDo(edm::EventTransitionInfo const&, edm::ModuleCallingContext const*) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libFWCoreFramework.so
#27 0x00002ba24abf05c5 in decltype ({parm#1}()) edm::convertException::wrap<edm::Worker::runModule<edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1> >(edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::TransitionInfoType const&, edm::StreamID, edm::ParentContext const&, edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::Context const*)::{lambda()#1}>(edm::Worker::runModule<edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1> >(edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::TransitionInfoType const&, edm::StreamID, edm::ParentContext const&, edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::Context const*)::{lambda()#1}) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libFWCoreFramework.so
#28 0x00002ba24abf077d in bool edm::Worker::runModule<edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1> >(edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::TransitionInfoType const&, edm::StreamID, edm::ParentContext const&, edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::Context const*) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libFWCoreFramework.so
#29 0x00002ba24abf0a86 in std::__exception_ptr::exception_ptr edm::Worker::runModuleAfterAsyncPrefetch<edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1> >(std::__exception_ptr::exception_ptr const*, edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::TransitionInfoType const&, edm::StreamID, edm::ParentContext const&, edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::Context const*) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libFWCoreFramework.so
#30 0x00002ba24abf2e16 in edm::Worker::RunModuleTask<edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1> >::execute() () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libFWCoreFramework.so
#31 0x00002ba24a963e05 in tbb::detail::d1::function_task<edm::WaitingTaskWithArenaHolder::doneWaiting(std::__exception_ptr::exception_ptr)::{lambda()#1}::operator()() const::{lambda()#1}>::execute(tbb::detail::d1::execution_data&) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libFWCoreConcurrency.so
#32 0x00002ba24c3f33db in tbb::detail::r1::task_dispatcher::local_wait_for_all<false, tbb::detail::r1::outermost_worker_waiter> (this=<optimized out>, t=0x2ba24ff4b100, t@entry=0x0, waiter=...) at /build/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/tbb/v2021.3.0-13eaf94bcafc2deaec6244d3257cd1bc/tbb-v2021.3.0/src/tbb/task_dispatcher.h:321
#33 0x00002ba24c3ee637 in tbb::detail::r1::task_dispatcher::local_wait_for_all<tbb::detail::r1::outermost_worker_waiter> (waiter=..., t=0x0, this=<optimized out>) at /build/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/tbb/v2021.3.0-13eaf94bcafc2deaec6244d3257cd1bc/tbb-v2021.3.0/src/tbb/task_dispatcher.h:462
#34 tbb::detail::r1::arena::process (this=this@entry=0x2ba25003ed00, tls=...) at /build/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/tbb/v2021.3.0-13eaf94bcafc2deaec6244d3257cd1bc/tbb-v2021.3.0/src/tbb/arena.cpp:138
#35 0x00002ba24c40014b in tbb::detail::r1::market::process (this=0x2ba25003f580, j=...) at /build/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/tbb/v2021.3.0-13eaf94bcafc2deaec6244d3257cd1bc/tbb-v2021.3.0/src/tbb/market.cpp:596
#36 0x00002ba24c403c20 in tbb::detail::r1::rml::private_worker::run (this=0x2ba252494000) at /build/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/tbb/v2021.3.0-13eaf94bcafc2deaec6244d3257cd1bc/tbb-v2021.3.0/src/tbb/private_server.cpp:267
#37 0x00002ba24c403e09 in tbb::detail::r1::rml::private_worker::thread_routine (arg=<optimized out>) at /build/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/tbb/v2021.3.0-13eaf94bcafc2deaec6244d3257cd1bc/tbb-v2021.3.0/src/tbb/private_server.cpp:221
#38 0x00002ba24d00eea5 in start_thread () from /lib64/libpthread.so.0
#39 0x00002ba24d3219fd in clone () from /lib64/libc.so.6
Thread 9 (Thread 0x2ba2c6601700 (LWP 27772) "cmsRun"):
#0  0x00002ba24d2e88ed in nanosleep () from /lib64/libc.so.6
#1  0x00002ba24d2e8784 in sleep () from /lib64/libc.so.6
#2  0x00002ba253d823f0 in sig_pause_for_stacktrace () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/pluginFWCoreServicesPlugins.so
#3  <signal handler called>
#4  0x00002ba24d31bd19 in syscall () from /lib64/libc.so.6
#5  0x00002ba24cbddb69 in std::__atomic_futex_unsigned_base::_M_futex_wait_until (this=<optimized out>, __addr=0x2ba4c9be26d0, __val=2147483648, __has_timeout=<optimized out>, __s=..., __ns=...) at ../../../../../libstdc++-v3/src/c++11/futex.cc:55
#6  0x00002ba2520e94c0 in XrdFile::readv(IOPosBuffer*, unsigned long) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libUtilitiesXrdAdaptor.so
#7  0x00002ba251f70bc4 in StorageAccountProxy::readv(IOPosBuffer*, unsigned long) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libUtilitiesStorageFactory.so
#8  0x00002ba2521392e8 in TStorageFactoryFile::ReadBuffersSync(char*, long long*, int*, int) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libIOPoolTFileAdaptor.so
#9  0x00002ba25213ac89 in TStorageFactoryFile::ReadBuffers(char*, long long*, int*, int) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libIOPoolTFileAdaptor.so
#10 0x00002ba24b5af7e1 in TFileCacheRead::ReadBufferExtNormal(char*, long long, int, int&) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/external/slc7_amd64_gcc900/lib/libRIO.so
#11 0x00002ba24b5af2af in TFileCacheRead::ReadBuffer(char*, long long, int) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/external/slc7_amd64_gcc900/lib/libRIO.so
#12 0x00002ba24b0ae7a5 in TTreeCache::ReadBufferNormal(char*, long long, int) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/external/slc7_amd64_gcc900/lib/libTree.so
#13 0x00002ba24b045482 in TBasket::ReadBasketBuffers(long long, int, TFile*) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/external/slc7_amd64_gcc900/lib/libTree.so
#14 0x00002ba24b04f529 in TBranch::GetBasketImpl(int, TBuffer*) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/external/slc7_amd64_gcc900/lib/libTree.so
#15 0x00002ba24b04fba3 in TBranch::GetBasketAndFirst(TBasket*&, long long&, TBuffer*) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/external/slc7_amd64_gcc900/lib/libTree.so
#16 0x00002ba24b050257 in TBranch::GetEntry(long long, int) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/external/slc7_amd64_gcc900/lib/libTree.so
#17 0x00002ba24b061d08 in TBranchElement::GetEntry(long long, int) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/external/slc7_amd64_gcc900/lib/libTree.so
#18 0x00002ba2b9244c4b in edm::RootTree::getEntry(TBranch*, long long) const () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/pluginIOPoolInput.so
#19 0x00002ba2b922138d in edm::RootFile::fillThisEventAuxiliary() () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/pluginIOPoolInput.so
#20 0x00002ba2b922ea15 in edm::RootFile::readCurrentEvent(edm::EventPrincipal&, bool) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/pluginIOPoolInput.so
#21 0x00002ba2b9217792 in edm::RootEmbeddedFileSequence::readOneRandom(edm::EventPrincipal&, unsigned long&, CLHEP::HepRandomEngine*, edm::EventID const*, bool) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/pluginIOPoolInput.so
#22 0x00002ba2b90c768a in void edm::PileUp::readPileUp<std::_Bind<bool (edm::MixingModule::*(std::reference_wrapper<edm::MixingModule>, std::_Placeholder<1>, edm::ModuleCallingContext const*, int, std::_Placeholder<2>, int, std::reference_wrapper<edm::EventSetup const>, edm::StreamID))(edm::EventPrincipal const&, edm::ModuleCallingContext const*, int, int, int&, edm::EventSetup const&, edm::StreamID const&)> >(edm::EventID const&, std::vector<edm::SecondaryEventIDAndFileInfo, std::allocator<edm::SecondaryEventIDAndFileInfo> >&, std::_Bind<bool (edm::MixingModule::*(std::reference_wrapper<edm::MixingModule>, std::_Placeholder<1>, edm::ModuleCallingContext const*, int, std::_Placeholder<2>, int, std::reference_wrapper<edm::EventSetup const>, edm::StreamID))(edm::EventPrincipal const&, edm::ModuleCallingContext const*, int, int, int&, edm::EventSetup const&, edm::StreamID const&)>, int, edm::StreamID const&) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/pluginSimGeneralMixingModulePlugins.so
#23 0x00002ba2b90be02a in edm::MixingModule::doPileUp(edm::Event&, edm::EventSetup const&) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/pluginSimGeneralMixingModulePlugins.so
#24 0x00002ba2b91561fa in edm::BMixingModule::produce(edm::Event&, edm::EventSetup const&) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libMixingBase.so
#25 0x00002ba24acb48bc in edm::stream::EDProducerAdaptorBase::doEvent(edm::EventTransitionInfo const&, edm::ActivityRegistry*, edm::ModuleCallingContext const*) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libFWCoreFramework.so
#26 0x00002ba24ac95add in edm::WorkerT<edm::stream::EDProducerAdaptorBase>::implDo(edm::EventTransitionInfo const&, edm::ModuleCallingContext const*) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libFWCoreFramework.so
#27 0x00002ba24abf05c5 in decltype ({parm#1}()) edm::convertException::wrap<edm::Worker::runModule<edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1> >(edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::TransitionInfoType const&, edm::StreamID, edm::ParentContext const&, edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::Context const*)::{lambda()#1}>(edm::Worker::runModule<edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1> >(edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::TransitionInfoType const&, edm::StreamID, edm::ParentContext const&, edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::Context const*)::{lambda()#1}) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libFWCoreFramework.so
#28 0x00002ba24abf077d in bool edm::Worker::runModule<edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1> >(edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::TransitionInfoType const&, edm::StreamID, edm::ParentContext const&, edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::Context const*) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libFWCoreFramework.so
#29 0x00002ba24abf0a86 in std::__exception_ptr::exception_ptr edm::Worker::runModuleAfterAsyncPrefetch<edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1> >(std::__exception_ptr::exception_ptr const*, edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::TransitionInfoType const&, edm::StreamID, edm::ParentContext const&, edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::Context const*) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libFWCoreFramework.so
#30 0x00002ba24abf2e16 in edm::Worker::RunModuleTask<edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1> >::execute() () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libFWCoreFramework.so
#31 0x00002ba24a963e05 in tbb::detail::d1::function_task<edm::WaitingTaskWithArenaHolder::doneWaiting(std::__exception_ptr::exception_ptr)::{lambda()#1}::operator()() const::{lambda()#1}>::execute(tbb::detail::d1::execution_data&) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libFWCoreConcurrency.so
#32 0x00002ba24c3f33db in tbb::detail::r1::task_dispatcher::local_wait_for_all<false, tbb::detail::r1::outermost_worker_waiter> (this=<optimized out>, t=0x2ba24ff61c00, t@entry=0x0, waiter=...) at /build/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/tbb/v2021.3.0-13eaf94bcafc2deaec6244d3257cd1bc/tbb-v2021.3.0/src/tbb/task_dispatcher.h:321
#33 0x00002ba24c3ee637 in tbb::detail::r1::task_dispatcher::local_wait_for_all<tbb::detail::r1::outermost_worker_waiter> (waiter=..., t=0x0, this=<optimized out>) at /build/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/tbb/v2021.3.0-13eaf94bcafc2deaec6244d3257cd1bc/tbb-v2021.3.0/src/tbb/task_dispatcher.h:462
#34 tbb::detail::r1::arena::process (this=this@entry=0x2ba25003ed00, tls=...) at /build/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/tbb/v2021.3.0-13eaf94bcafc2deaec6244d3257cd1bc/tbb-v2021.3.0/src/tbb/arena.cpp:138
#35 0x00002ba24c40014b in tbb::detail::r1::market::process (this=0x2ba25003f580, j=...) at /build/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/tbb/v2021.3.0-13eaf94bcafc2deaec6244d3257cd1bc/tbb-v2021.3.0/src/tbb/market.cpp:596
#36 0x00002ba24c403c20 in tbb::detail::r1::rml::private_worker::run (this=0x2ba252494100) at /build/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/tbb/v2021.3.0-13eaf94bcafc2deaec6244d3257cd1bc/tbb-v2021.3.0/src/tbb/private_server.cpp:267
#37 0x00002ba24c403e09 in tbb::detail::r1::rml::private_worker::thread_routine (arg=<optimized out>) at /build/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/tbb/v2021.3.0-13eaf94bcafc2deaec6244d3257cd1bc/tbb-v2021.3.0/src/tbb/private_server.cpp:221
#38 0x00002ba24d00eea5 in start_thread () from /lib64/libpthread.so.0
#39 0x00002ba24d3219fd in clone () from /lib64/libc.so.6
Thread 8 (Thread 0x2ba2c5c00700 (LWP 27771) "cmsRun"):
#0  0x00002ba24d2e88ed in nanosleep () from /lib64/libc.so.6
#1  0x00002ba24d2e8784 in sleep () from /lib64/libc.so.6
#2  0x00002ba253d823f0 in sig_pause_for_stacktrace () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/pluginFWCoreServicesPlugins.so
#3  <signal handler called>
#4  0x00002ba24d31bd19 in syscall () from /lib64/libc.so.6
#5  0x00002ba24cbddb69 in std::__atomic_futex_unsigned_base::_M_futex_wait_until (this=<optimized out>, __addr=0x2ba2c7e588a0, __val=2147483648, __has_timeout=<optimized out>, __s=..., __ns=...) at ../../../../../libstdc++-v3/src/c++11/futex.cc:55
#6  0x00002ba2520e94c0 in XrdFile::readv(IOPosBuffer*, unsigned long) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libUtilitiesXrdAdaptor.so
#7  0x00002ba251f70bc4 in StorageAccountProxy::readv(IOPosBuffer*, unsigned long) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libUtilitiesStorageFactory.so
#8  0x00002ba2521392e8 in TStorageFactoryFile::ReadBuffersSync(char*, long long*, int*, int) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libIOPoolTFileAdaptor.so
#9  0x00002ba25213ac89 in TStorageFactoryFile::ReadBuffers(char*, long long*, int*, int) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libIOPoolTFileAdaptor.so
#10 0x00002ba24b5af7e1 in TFileCacheRead::ReadBufferExtNormal(char*, long long, int, int&) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/external/slc7_amd64_gcc900/lib/libRIO.so
#11 0x00002ba24b5af2af in TFileCacheRead::ReadBuffer(char*, long long, int) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/external/slc7_amd64_gcc900/lib/libRIO.so
#12 0x00002ba24b0ae7a5 in TTreeCache::ReadBufferNormal(char*, long long, int) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/external/slc7_amd64_gcc900/lib/libTree.so
#13 0x00002ba24b045482 in TBasket::ReadBasketBuffers(long long, int, TFile*) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/external/slc7_amd64_gcc900/lib/libTree.so
#14 0x00002ba24b04f529 in TBranch::GetBasketImpl(int, TBuffer*) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/external/slc7_amd64_gcc900/lib/libTree.so
#15 0x00002ba24b04fba3 in TBranch::GetBasketAndFirst(TBasket*&, long long&, TBuffer*) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/external/slc7_amd64_gcc900/lib/libTree.so
#16 0x00002ba24b050257 in TBranch::GetEntry(long long, int) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/external/slc7_amd64_gcc900/lib/libTree.so
#17 0x00002ba24b061d08 in TBranchElement::GetEntry(long long, int) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/external/slc7_amd64_gcc900/lib/libTree.so
#18 0x00002ba2b9244c4b in edm::RootTree::getEntry(TBranch*, long long) const () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/pluginIOPoolInput.so
#19 0x00002ba2b922138d in edm::RootFile::fillThisEventAuxiliary() () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/pluginIOPoolInput.so
#20 0x00002ba2b922ea15 in edm::RootFile::readCurrentEvent(edm::EventPrincipal&, bool) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/pluginIOPoolInput.so
#21 0x00002ba2b9217792 in edm::RootEmbeddedFileSequence::readOneRandom(edm::EventPrincipal&, unsigned long&, CLHEP::HepRandomEngine*, edm::EventID const*, bool) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/pluginIOPoolInput.so
#22 0x00002ba2b90c768a in void edm::PileUp::readPileUp<std::_Bind<bool (edm::MixingModule::*(std::reference_wrapper<edm::MixingModule>, std::_Placeholder<1>, edm::ModuleCallingContext const*, int, std::_Placeholder<2>, int, std::reference_wrapper<edm::EventSetup const>, edm::StreamID))(edm::EventPrincipal const&, edm::ModuleCallingContext const*, int, int, int&, edm::EventSetup const&, edm::StreamID const&)> >(edm::EventID const&, std::vector<edm::SecondaryEventIDAndFileInfo, std::allocator<edm::SecondaryEventIDAndFileInfo> >&, std::_Bind<bool (edm::MixingModule::*(std::reference_wrapper<edm::MixingModule>, std::_Placeholder<1>, edm::ModuleCallingContext const*, int, std::_Placeholder<2>, int, std::reference_wrapper<edm::EventSetup const>, edm::StreamID))(edm::EventPrincipal const&, edm::ModuleCallingContext const*, int, int, int&, edm::EventSetup const&, edm::StreamID const&)>, int, edm::StreamID const&) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/pluginSimGeneralMixingModulePlugins.so
#23 0x00002ba2b90be02a in edm::MixingModule::doPileUp(edm::Event&, edm::EventSetup const&) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/pluginSimGeneralMixingModulePlugins.so
#24 0x00002ba2b91561fa in edm::BMixingModule::produce(edm::Event&, edm::EventSetup const&) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libMixingBase.so
#25 0x00002ba24acb48bc in edm::stream::EDProducerAdaptorBase::doEvent(edm::EventTransitionInfo const&, edm::ActivityRegistry*, edm::ModuleCallingContext const*) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libFWCoreFramework.so
#26 0x00002ba24ac95add in edm::WorkerT<edm::stream::EDProducerAdaptorBase>::implDo(edm::EventTransitionInfo const&, edm::ModuleCallingContext const*) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libFWCoreFramework.so
#27 0x00002ba24abf05c5 in decltype ({parm#1}()) edm::convertException::wrap<edm::Worker::runModule<edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1> >(edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::TransitionInfoType const&, edm::StreamID, edm::ParentContext const&, edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::Context const*)::{lambda()#1}>(edm::Worker::runModule<edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1> >(edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::TransitionInfoType const&, edm::StreamID, edm::ParentContext const&, edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::Context const*)::{lambda()#1}) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libFWCoreFramework.so
#28 0x00002ba24abf077d in bool edm::Worker::runModule<edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1> >(edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::TransitionInfoType const&, edm::StreamID, edm::ParentContext const&, edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::Context const*) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libFWCoreFramework.so
#29 0x00002ba24abf0a86 in std::__exception_ptr::exception_ptr edm::Worker::runModuleAfterAsyncPrefetch<edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1> >(std::__exception_ptr::exception_ptr const*, edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::TransitionInfoType const&, edm::StreamID, edm::ParentContext const&, edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1>::Context const*) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libFWCoreFramework.so
#30 0x00002ba24abf2e16 in edm::Worker::RunModuleTask<edm::OccurrenceTraits<edm::EventPrincipal, (edm::BranchActionType)1> >::execute() () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libFWCoreFramework.so
#31 0x00002ba24a963e05 in tbb::detail::d1::function_task<edm::WaitingTaskWithArenaHolder::doneWaiting(std::__exception_ptr::exception_ptr)::{lambda()#1}::operator()() const::{lambda()#1}>::execute(tbb::detail::d1::execution_data&) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libFWCoreConcurrency.so
#32 0x00002ba24c3f33db in tbb::detail::r1::task_dispatcher::local_wait_for_all<false, tbb::detail::r1::outermost_worker_waiter> (this=<optimized out>, t=0x2ba24ff50d00, t@entry=0x0, waiter=...) at /build/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/tbb/v2021.3.0-13eaf94bcafc2deaec6244d3257cd1bc/tbb-v2021.3.0/src/tbb/task_dispatcher.h:321
#33 0x00002ba24c3ee637 in tbb::detail::r1::task_dispatcher::local_wait_for_all<tbb::detail::r1::outermost_worker_waiter> (waiter=..., t=0x0, this=<optimized out>) at /build/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/tbb/v2021.3.0-13eaf94bcafc2deaec6244d3257cd1bc/tbb-v2021.3.0/src/tbb/task_dispatcher.h:462
#34 tbb::detail::r1::arena::process (this=this@entry=0x2ba25003ed00, tls=...) at /build/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/tbb/v2021.3.0-13eaf94bcafc2deaec6244d3257cd1bc/tbb-v2021.3.0/src/tbb/arena.cpp:138
#35 0x00002ba24c40014b in tbb::detail::r1::market::process (this=0x2ba25003f580, j=...) at /build/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/tbb/v2021.3.0-13eaf94bcafc2deaec6244d3257cd1bc/tbb-v2021.3.0/src/tbb/market.cpp:596
#36 0x00002ba24c403c20 in tbb::detail::r1::rml::private_worker::run (this=0x2ba252494080) at /build/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/tbb/v2021.3.0-13eaf94bcafc2deaec6244d3257cd1bc/tbb-v2021.3.0/src/tbb/private_server.cpp:267
#37 0x00002ba24c403e09 in tbb::detail::r1::rml::private_worker::thread_routine (arg=<optimized out>) at /build/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/tbb/v2021.3.0-13eaf94bcafc2deaec6244d3257cd1bc/tbb-v2021.3.0/src/tbb/private_server.cpp:221
#38 0x00002ba24d00eea5 in start_thread () from /lib64/libpthread.so.0
#39 0x00002ba24d3219fd in clone () from /lib64/libc.so.6
Thread 7 (Thread 0x2ba2b9c71700 (LWP 27758) "cmsRun"):
#0  0x00002ba24d015f40 in __pause_nocancel () from /lib64/libpthread.so.0
#1  0x00002ba24d00cbcc in __pthread_mutex_lock_full () from /lib64/libpthread.so.0
#2  0x00002ba2533bf9b6 in XrdSysMutex::Lock (this=0x2ba2bd6b9880) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/./XrdSys/XrdSysPthread.hh:222
#3  0x00002ba2533c64c4 in XrdSysMutexHelper::XrdSysMutexHelper (this=0x2ba2b9c68728, mutex=...) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/./XrdSys/XrdSysPthread.hh:281
#4  0x00002ba253781d3a in XrdCl::FileSystemImpl::AssignLastURL (this=0x2ba2bd6b9880, url=...) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClFileSystem.cc:995
#5  0x00002ba25377677b in XrdCl::AssignLastURLHandler::HandleResponseWithHosts (this=0x2ba2bd810ba0, status=0x2ba2bf068830, response=0x2ba2d4dd8f60, hostList=0x2ba2bf03f600) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClFileSystem.cc:1050
#6  0x00002ba2537766b9 in XrdCl::AssignLBHandler::HandleResponseWithHosts (this=0x2ba2bf043f80, status=0x2ba2bf068830, response=0x2ba2d4dd8f60, hostList=0x2ba2bf03f600) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClFileSystem.cc:1032
#7  0x00002ba2537901ea in XrdCl::XRootDMsgHandler::HandleResponse (this=0x2ba2ba026d00) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClXRootDMsgHandler.cc:1603
#8  0x00002ba25378a781 in XrdCl::XRootDMsgHandler::Process (this=0x2ba2ba026d00, msg=0x2ba2ba0067d0) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClXRootDMsgHandler.cc:540
#9  0x00002ba25374d598 in XrdCl::Stream::HandleIncMsgJob::Run (this=0x2ba2ba0506a0, arg=0x2ba2ba0067d0) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/./XrdCl/XrdClStream.hh:323
#10 0x00002ba253827eb0 in XrdCl::JobManager::RunJobs (this=0x2ba2b4d0ad40) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClJobManager.cc:153
#11 0x00002ba253827a17 in RunRunnerThread (arg=0x2ba2b4d0ad40) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClJobManager.cc:34
#12 0x00002ba24d00eea5 in start_thread () from /lib64/libpthread.so.0
#13 0x00002ba24d3219fd in clone () from /lib64/libc.so.6
Thread 6 (Thread 0x2ba2b9a70700 (LWP 27757) "cmsRun"):
#0  0x00002ba24d015f40 in __pause_nocancel () from /lib64/libpthread.so.0
#1  0x00002ba24d00cbcc in __pthread_mutex_lock_full () from /lib64/libpthread.so.0
#2  0x00002ba2533bf9b6 in XrdSysMutex::Lock (this=0x2ba2bd6b9840) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/./XrdSys/XrdSysPthread.hh:222
#3  0x00002ba2533c64c4 in XrdSysMutexHelper::XrdSysMutexHelper (this=0x2ba2b9a67728, mutex=...) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/./XrdSys/XrdSysPthread.hh:281
#4  0x00002ba253781d3a in XrdCl::FileSystemImpl::AssignLastURL (this=0x2ba2bd6b9840, url=...) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClFileSystem.cc:995
#5  0x00002ba25377677b in XrdCl::AssignLastURLHandler::HandleResponseWithHosts (this=0x2ba2bf043ca0, status=0x2ba2befbc9e0, response=0x2ba4c7b66e00, hostList=0x2ba2c0674260) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClFileSystem.cc:1050
#6  0x00002ba2537766b9 in XrdCl::AssignLBHandler::HandleResponseWithHosts (this=0x2ba2c06741e0, status=0x2ba2befbc9e0, response=0x2ba4c7b66e00, hostList=0x2ba2c0674260) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClFileSystem.cc:1032
#7  0x00002ba2537901ea in XrdCl::XRootDMsgHandler::HandleResponse (this=0x2ba2bf09cd00) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClXRootDMsgHandler.cc:1603
#8  0x00002ba25378a781 in XrdCl::XRootDMsgHandler::Process (this=0x2ba2bf09cd00, msg=0x2ba2ba006780) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClXRootDMsgHandler.cc:540
#9  0x00002ba25374d598 in XrdCl::Stream::HandleIncMsgJob::Run (this=0x2ba2ba050660, arg=0x2ba2ba006780) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/./XrdCl/XrdClStream.hh:323
#10 0x00002ba253827eb0 in XrdCl::JobManager::RunJobs (this=0x2ba2b4d0ad40) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClJobManager.cc:153
#11 0x00002ba253827a17 in RunRunnerThread (arg=0x2ba2b4d0ad40) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClJobManager.cc:34
#12 0x00002ba24d00eea5 in start_thread () from /lib64/libpthread.so.0
#13 0x00002ba24d3219fd in clone () from /lib64/libc.so.6
Thread 5 (Thread 0x2ba2b986f700 (LWP 27756) "cmsRun"):
#0  0x00002ba24d015f40 in __pause_nocancel () from /lib64/libpthread.so.0
#1  0x00002ba24d00cbcc in __pthread_mutex_lock_full () from /lib64/libpthread.so.0
#2  0x00002ba2533bf9b6 in XrdSysMutex::Lock (this=0x2ba2bd6b9900) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/./XrdSys/XrdSysPthread.hh:222
#3  0x00002ba2533c64c4 in XrdSysMutexHelper::XrdSysMutexHelper (this=0x2ba2b9866728, mutex=...) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/./XrdSys/XrdSysPthread.hh:281
#4  0x00002ba253781d3a in XrdCl::FileSystemImpl::AssignLastURL (this=0x2ba2bd6b9900, url=...) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClFileSystem.cc:995
#5  0x00002ba25377677b in XrdCl::AssignLastURLHandler::HandleResponseWithHosts (this=0x2ba2bd8a8000, status=0x2ba2bf068590, response=0x2ba2bf03f6a0, hostList=0x2ba2bf093540) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClFileSystem.cc:1050
#6  0x00002ba2537766b9 in XrdCl::AssignLBHandler::HandleResponseWithHosts (this=0x2ba2c06746a0, status=0x2ba2bf068590, response=0x2ba2bf03f6a0, hostList=0x2ba2bf093540) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClFileSystem.cc:1032
#7  0x00002ba2537901ea in XrdCl::XRootDMsgHandler::HandleResponse (this=0x2ba2ba026800) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClXRootDMsgHandler.cc:1603
#8  0x00002ba25378a781 in XrdCl::XRootDMsgHandler::Process (this=0x2ba2ba026800, msg=0x2ba2ba006730) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClXRootDMsgHandler.cc:540
#9  0x00002ba25374d598 in XrdCl::Stream::HandleIncMsgJob::Run (this=0x2ba2ba050690, arg=0x2ba2ba006730) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/./XrdCl/XrdClStream.hh:323
#10 0x00002ba253827eb0 in XrdCl::JobManager::RunJobs (this=0x2ba2b4d0ad40) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClJobManager.cc:153
#11 0x00002ba253827a17 in RunRunnerThread (arg=0x2ba2b4d0ad40) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClJobManager.cc:34
#12 0x00002ba24d00eea5 in start_thread () from /lib64/libpthread.so.0
#13 0x00002ba24d3219fd in clone () from /lib64/libc.so.6
Thread 4 (Thread 0x2ba2b966e700 (LWP 27755) "cmsRun"):
#0  0x00002ba24d015e9d in nanosleep () from /lib64/libpthread.so.0
#1  0x00002ba2533cd56a in XrdSysTimer::Wait (mills=1000) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdSys/XrdSysTimer.cc:239
#2  0x00002ba25376a5ea in XrdCl::TaskManager::RunTasks (this=0x2ba2b4c7ff80) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClTaskManager.cc:246
#3  0x00002ba25376995b in RunRunnerThread (arg=0x2ba2b4c7ff80) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClTaskManager.cc:38
#4  0x00002ba24d00eea5 in start_thread () from /lib64/libpthread.so.0
#5  0x00002ba24d3219fd in clone () from /lib64/libc.so.6
Thread 3 (Thread 0x2ba2b946d700 (LWP 27754) "cmsRun"):
#0  0x00002ba24d321fd3 in epoll_wait () from /lib64/libc.so.6
#1  0x00002ba2533c5a70 in XrdSys::IOEvents::PollE::Begin (this=0x2ba2b4d0afe0, syncsem=0x2ba2b4c10dc0, retcode=@0x7fff0f08cf60: 1357673440, eTxt=0x7fff0f08cf58) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/./XrdSys/XrdSysIOEventsPollE.icc:212
#2  0x00002ba2533c26f5 in XrdSys::IOEvents::BootStrap::Start (parg=0x7fff0f08cf50) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdSys/XrdSysIOEvents.cc:133
#3  0x00002ba2533cc820 in XrdSysThread_Xeq (myargs=0x2ba2b4c618e0) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdSys/XrdSysPthread.cc:86
#4  0x00002ba24d00eea5 in start_thread () from /lib64/libpthread.so.0
#5  0x00002ba24d3219fd in clone () from /lib64/libc.so.6
Thread 2 (Thread 0x2ba26b441700 (LWP 26691) "cmsRun"):
#0  0x00002ba24d0161d9 in waitpid () from /lib64/libpthread.so.0
#1  0x00002ba253d825a7 in edm::service::cmssw_stacktrace_fork() () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/pluginFWCoreServicesPlugins.so
#2  0x00002ba253d8323a in edm::service::InitRootHandlers::stacktraceHelperThread() () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/pluginFWCoreServicesPlugins.so
#3  0x00002ba24cbdfaf0 in std::execute_native_thread_routine (__p=0x2ba26aaf41d0) at ../../../../../libstdc++-v3/src/c++11/thread.cc:80
#4  0x00002ba24d00eea5 in start_thread () from /lib64/libpthread.so.0
#5  0x00002ba24d3219fd in clone () from /lib64/libc.so.6
Thread 1 (Thread 0x2ba24f39d980 (LWP 26208) "cmsRun"):
#0  0x00002ba24d316ccd in poll () from /lib64/libc.so.6
#1  0x00002ba253d829d7 in full_read.constprop () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/pluginFWCoreServicesPlugins.so
#2  0x00002ba253d8330c in edm::service::InitRootHandlers::stacktraceFromThread() () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/pluginFWCoreServicesPlugins.so
#3  0x00002ba253d867bb in sig_dostack_then_abort () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/pluginFWCoreServicesPlugins.so
#4  <signal handler called>
#5  0x00002ba24d014b39 in do_futex_wait.constprop () from /lib64/libpthread.so.0
#6  0x00002ba24d014bcf in __new_sem_wait_slow.constprop.0 () from /lib64/libpthread.so.0
#7  0x00002ba24d014c6b in sem_wait@@GLIBC_2.2.5 () from /lib64/libpthread.so.0
#8  0x00002ba2520f8d9a in XrdAdaptor::RequestManager::initialize(std::weak_ptr<XrdAdaptor::RequestManager>) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libUtilitiesXrdAdaptor.so
#9  0x00002ba2520ea14c in XrdFile::open(char const*, int, int) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libUtilitiesXrdAdaptor.so
#10 0x00002ba2520eb46c in XrdFile::XrdFile(std::__cxx11::basic_string<char, std::char_traits<char>, std::allocator<char> > const&, int, int) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libUtilitiesXrdAdaptor.so
#11 0x00002ba251e41784 in XrdStorageMaker::open(std::__cxx11::basic_string<char, std::char_traits<char>, std::allocator<char> > const&, std::__cxx11::basic_string<char, std::char_traits<char>, std::allocator<char> > const&, int, StorageMaker::AuxSettings const&) const () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/pluginUtilitiesXrdAdaptorPlugin.so
#12 0x00002ba251f73154 in StorageFactory::open(std::__cxx11::basic_string<char, std::char_traits<char>, std::allocator<char> > const&, int) const () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libUtilitiesStorageFactory.so
#13 0x00002ba25213a3e3 in TStorageFactoryFile::Initialize(char const*, char const*) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libIOPoolTFileAdaptor.so
#14 0x00002ba25213abb6 in TStorageFactoryFile::TStorageFactoryFile(char const*, char const*, char const*, int, int, bool) () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/lib/slc7_amd64_gcc900/libIOPoolTFileAdaptor.so
#15 0x00002ba2b926b0a4 in ?? ()
#16 0x00002ba200000000 in ?? ()
#17 0x00002ba26a518c98 in ?? ()
#18 0x00002ba24b256c08 in vtable for (anonymous namespace)::TReentrantRWLockState<std::mutex, ROOT::Internal::RecurseCounts> () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/external/slc7_amd64_gcc900/lib/libThread.so
#19 0x00002ba24b23dbad in ROOT::TReentrantRWLock<std::mutex, ROOT::Internal::RecurseCounts>::GetStateBefore() () from /cvmfs/cms-ib.cern.ch/week1/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-05-2300/external/slc7_amd64_gcc900/lib/libThread.so
#20 0x00007fff0f08f8c0 in ?? ()
#21 0x00007fff0f08fad0 in ?? ()
#22 0x00007fff0f08f8f8 in ?? ()
#23 0x000000056adca908 in ?? ()
#24 0x0000000000000000 in ?? ()

Current Modules:

Module: MixingModule:mix (crashed)
Module: MixingModule:mix
Module: MixingModule:mix
Module: MixingModule:mix

A fatal system signal has occurred: external termination request

@makortel
Copy link
Contributor

Here is another crash from CMSSW_12_1_DEVEL_X_2021-09-13-2300

14-Sep-2021 06:01:36 CEST  Initiating request to open file root://eoscms.cern.ch//eos/cms/store/user/cmsbuild/store/hidata/HIRun2015/HITrackerVirginRaw/RAW/v1/000/263/400/00000/1C885AE1-49A3-E511-83E8-02163E014678.root


A fatal system signal has occurred: segmentation violation
The following is the call stack containing the origin of the signal.

Tue Sep 14 06:01:38 CEST 2021
Thread 7 (Thread 0x2ad697e26700 (LWP 30202) "cmsRun"):
#0  0x00002ad66c3beb3b in do_futex_wait.constprop () from /lib64/libpthread.so.0
#1  0x00002ad66c3bebcf in __new_sem_wait_slow.constprop.0 () from /lib64/libpthread.so.0
#2  0x00002ad66c3bec6b in sem_wait@@GLIBC_2.2.5 () from /lib64/libpthread.so.0
#3  0x00002ad672ab1562 in XrdSysSemaphore::Wait (this=0x2ad6935dabe0) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/./XrdSys/XrdSysPthread.hh:453
#4  0x00002ad672f15ef6 in XrdCl::SyncQueue<XrdCl::JobManager::JobHelper>::Get (this=0x2ad68bdd76d8) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/./XrdCl/XrdClSyncQueue.hh:66
#5  0x00002ad672f12e7b in XrdCl::JobManager::RunJobs (this=0x2ad68bdd76c0) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClJobManager.cc:151
#6  0x00002ad672f12a17 in RunRunnerThread (arg=0x2ad68bdd76c0) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClJobManager.cc:34
#7  0x00002ad66c3b8ea5 in start_thread () from /lib64/libpthread.so.0
#8  0x00002ad66c6cb9fd in clone () from /lib64/libc.so.6

Thread 6 (Thread 0x2ad697c25700 (LWP 30201) "cmsRun"):
#0  0x00002ad66c3beb3b in do_futex_wait.constprop () from /lib64/libpthread.so.0
#1  0x00002ad66c3bebcf in __new_sem_wait_slow.constprop.0 () from /lib64/libpthread.so.0
#2  0x00002ad66c3bec6b in sem_wait@@GLIBC_2.2.5 () from /lib64/libpthread.so.0
#3  0x00002ad672ab1562 in XrdSysSemaphore::Wait (this=0x2ad6935dabe0) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/./XrdSys/XrdSysPthread.hh:453
#4  0x00002ad672f15ef6 in XrdCl::SyncQueue<XrdCl::JobManager::JobHelper>::Get (this=0x2ad68bdd76d8) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/./XrdCl/XrdClSyncQueue.hh:66
#5  0x00002ad672f12e7b in XrdCl::JobManager::RunJobs (this=0x2ad68bdd76c0) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClJobManager.cc:151
#6  0x00002ad672f12a17 in RunRunnerThread (arg=0x2ad68bdd76c0) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClJobManager.cc:34
#7  0x00002ad66c3b8ea5 in start_thread () from /lib64/libpthread.so.0
#8  0x00002ad66c6cb9fd in clone () from /lib64/libc.so.6

Thread 5 (Thread 0x2ad697a24700 (LWP 30200) "cmsRun"):
#0  0x00002ad66c6c0ccd in poll () from /lib64/libc.so.6
#1  0x00002ad67346d9d7 in full_read.constprop () from /cvmfs/cms-ib.cern.ch/nweek-02698/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-12-2300/lib/slc7_amd64_gcc900/pluginFWCoreServicesPlugins.so
#2  0x00002ad67346e30c in edm::service::InitRootHandlers::stacktraceFromThread() () from /cvmfs/cms-ib.cern.ch/nweek-02698/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-12-2300/lib/slc7_amd64_gcc900/pluginFWCoreServicesPlugins.so
#3  0x00002ad6734717bb in sig_dostack_then_abort () from /cvmfs/cms-ib.cern.ch/nweek-02698/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-12-2300/lib/slc7_amd64_gcc900/pluginFWCoreServicesPlugins.so
#4  <signal handler called>
#5  0x00002ad66bff6234 in std::__cxx11::basic_string<char, std::char_traits<char>, std::allocator<char> >::basic_string (this=0x2ad697a1b750, __str=...) at /data/cmsbld/jenkins/workspace/auto-builds/CMSSW_11_1_0_pre6-slc7_amd64_gcc900/build/CMSSW_11_1_0_pre6-build/BUILD/slc7_amd64_gcc900/external/gcc/9.3.0/gcc-9.3.0/obj/x86_64-unknown-linux-gnu/libstdc++-v3/include/bits/basic_string.h:451
#6  0x00002ad672e24d05 in XrdCl::URL::GetHostId[abi:cxx11]() const (this=0x2ad600663565) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/./XrdCl/XrdClURL.hh:96
#7  0x00002ad672e6cd73 in XrdCl::FileSystemImpl::AssignLastURL (this=0x2ad698bc2040, url=...) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClFileSystem.cc:998
#8  0x00002ad672e6177b in XrdCl::AssignLastURLHandler::HandleResponseWithHosts (this=0x2ad6840c8940, status=0x2ad693586ce0, response=0x2ad693619160, hostList=0x2ad693bced20) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClFileSystem.cc:1050
#9  0x00002ad672e616b9 in XrdCl::AssignLBHandler::HandleResponseWithHosts (this=0x2ad693bce0e0, status=0x2ad693586ce0, response=0x2ad693619160, hostList=0x2ad693bced20) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClFileSystem.cc:1032
#10 0x00002ad672e7b1ea in XrdCl::XRootDMsgHandler::HandleResponse (this=0x2ad693614700) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClXRootDMsgHandler.cc:1603
#11 0x00002ad672e75781 in XrdCl::XRootDMsgHandler::Process (this=0x2ad693614700, msg=0x2ad6982066e0) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClXRootDMsgHandler.cc:540
#12 0x00002ad672e38598 in XrdCl::Stream::HandleIncMsgJob::Run (this=0x2ad698211450, arg=0x2ad6982066e0) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/./XrdCl/XrdClStream.hh:323
#13 0x00002ad672f12eb0 in XrdCl::JobManager::RunJobs (this=0x2ad68bdd76c0) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClJobManager.cc:153
#14 0x00002ad672f12a17 in RunRunnerThread (arg=0x2ad68bdd76c0) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClJobManager.cc:34
#15 0x00002ad66c3b8ea5 in start_thread () from /lib64/libpthread.so.0
#16 0x00002ad66c6cb9fd in clone () from /lib64/libc.so.6

Thread 4 (Thread 0x2ad697823700 (LWP 30199) "cmsRun"):
#0  0x00002ad66c3bfe9d in nanosleep () from /lib64/libpthread.so.0
#1  0x00002ad672ab856a in XrdSysTimer::Wait (mills=1000) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdSys/XrdSysTimer.cc:239
#2  0x00002ad672e555ea in XrdCl::TaskManager::RunTasks (this=0x2ad693584c40) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClTaskManager.cc:246
#3  0x00002ad672e5495b in RunRunnerThread (arg=0x2ad693584c40) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdCl/XrdClTaskManager.cc:38
#4  0x00002ad66c3b8ea5 in start_thread () from /lib64/libpthread.so.0
#5  0x00002ad66c6cb9fd in clone () from /lib64/libc.so.6

Thread 3 (Thread 0x2ad697622700 (LWP 30198) "cmsRun"):
#0  0x00002ad66c6cbfd3 in epoll_wait () from /lib64/libc.so.6
#1  0x00002ad672ab0a70 in XrdSys::IOEvents::PollE::Begin (this=0x2ad68bdd75e0, syncsem=0x2ad6935dac80, retcode=@0x7fff84ea6130: -2065014448, eTxt=0x7fff84ea6128) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/./XrdSys/XrdSysIOEventsPollE.icc:212
#2  0x00002ad672aad6f5 in XrdSys::IOEvents::BootStrap::Start (parg=0x7fff84ea6120) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdSys/XrdSysIOEvents.cc:133
#3  0x00002ad672ab7820 in XrdSysThread_Xeq (myargs=0x2ad6935daca0) at /data/cmsbld/jenkins/workspace/build-any-ib/w/BUILD/slc7_amd64_gcc900/external/xrootd/5.3.1-3b2da29751482f0753f2a8977b008a5a/xrootd-5.3.1/src/XrdSys/XrdSysPthread.cc:86
#4  0x00002ad66c3b8ea5 in start_thread () from /lib64/libpthread.so.0
#5  0x00002ad66c6cb9fd in clone () from /lib64/libc.so.6

Thread 2 (Thread 0x2ad68c0f0700 (LWP 28323) "cmsRun"):
#0  0x00002ad66c3c01d9 in waitpid () from /lib64/libpthread.so.0
#1  0x00002ad67346d5a7 in edm::service::cmssw_stacktrace_fork() () from /cvmfs/cms-ib.cern.ch/nweek-02698/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-12-2300/lib/slc7_amd64_gcc900/pluginFWCoreServicesPlugins.so
#2  0x00002ad67346e23a in edm::service::InitRootHandlers::stacktraceHelperThread() () from /cvmfs/cms-ib.cern.ch/nweek-02698/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-12-2300/lib/slc7_amd64_gcc900/pluginFWCoreServicesPlugins.so
#3  0x00002ad66bf8aaf0 in std::execute_native_thread_routine (__p=0x2ad68ad1e1e0) at ../../../../../libstdc++-v3/src/c++11/thread.cc:80
#4  0x00002ad66c3b8ea5 in start_thread () from /lib64/libpthread.so.0
#5  0x00002ad66c6cb9fd in clone () from /lib64/libc.so.6

Thread 1 (Thread 0x2ad66e745980 (LWP 23319) "cmsRun"):
#0  0x00002ad66c3bcde2 in pthread_cond_timedwait@@GLIBC_2.3.2 () from /lib64/libpthread.so.0
#1  0x00002ad67223081b in QueryAttrHandler::query(XrdCl::FileSystem&, std::__cxx11::basic_string<char, std::char_traits<char>, std::allocator<char> > const&, std::chrono::duration<long, std::ratio<1l, 1000l> >, std::__cxx11::basic_string<char, std::char_traits<char>, std::allocator<char> >&) () from /cvmfs/cms-ib.cern.ch/nweek-02698/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-12-2300/lib/slc7_amd64_gcc900/libUtilitiesXrdAdaptor.so
#2  0x00002ad67222c5fe in XrdAdaptor::Source::getXrootdSiteFromURL(std::__cxx11::basic_string<char, std::char_traits<char>, std::allocator<char> >, std::__cxx11::basic_string<char, std::char_traits<char>, std::allocator<char> >&) () from /cvmfs/cms-ib.cern.ch/nweek-02698/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-12-2300/lib/slc7_amd64_gcc900/libUtilitiesXrdAdaptor.so
#3  0x00002ad67222d6f8 in XrdAdaptor::Source::getXrootdSite(XrdCl::File&, std::__cxx11::basic_string<char, std::char_traits<char>, std::allocator<char> >&) () from /cvmfs/cms-ib.cern.ch/nweek-02698/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-12-2300/lib/slc7_amd64_gcc900/libUtilitiesXrdAdaptor.so
#4  0x00002ad67222d844 in XrdAdaptor::Source::setXrootdSite() () from /cvmfs/cms-ib.cern.ch/nweek-02698/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-12-2300/lib/slc7_amd64_gcc900/libUtilitiesXrdAdaptor.so
#5  0x00002ad67222e61e in XrdAdaptor::Source::Source(timespec, std::unique_ptr<XrdCl::File, std::default_delete<XrdCl::File> >, std::__cxx11::basic_string<char, std::char_traits<char>, std::allocator<char> > const&) () from /cvmfs/cms-ib.cern.ch/nweek-02698/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-12-2300/lib/slc7_amd64_gcc900/libUtilitiesXrdAdaptor.so
#6  0x00002ad672224fc4 in XrdAdaptor::RequestManager::initialize(std::weak_ptr<XrdAdaptor::RequestManager>) () from /cvmfs/cms-ib.cern.ch/nweek-02698/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-12-2300/lib/slc7_amd64_gcc900/libUtilitiesXrdAdaptor.so
#7  0x00002ad67221514c in XrdFile::open(char const*, int, int) () from /cvmfs/cms-ib.cern.ch/nweek-02698/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-12-2300/lib/slc7_amd64_gcc900/libUtilitiesXrdAdaptor.so
#8  0x00002ad67221646c in XrdFile::XrdFile(std::__cxx11::basic_string<char, std::char_traits<char>, std::allocator<char> > const&, int, int) () from /cvmfs/cms-ib.cern.ch/nweek-02698/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-12-2300/lib/slc7_amd64_gcc900/libUtilitiesXrdAdaptor.so
#9  0x00002ad67216c784 in XrdStorageMaker::open(std::__cxx11::basic_string<char, std::char_traits<char>, std::allocator<char> > const&, std::__cxx11::basic_string<char, std::char_traits<char>, std::allocator<char> > const&, int, StorageMaker::AuxSettings const&) const () from /cvmfs/cms-ib.cern.ch/nweek-02698/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-12-2300/lib/slc7_amd64_gcc900/pluginUtilitiesXrdAdaptorPlugin.so
#10 0x00002ad67226c154 in StorageFactory::open(std::__cxx11::basic_string<char, std::char_traits<char>, std::allocator<char> > const&, int) const () from /cvmfs/cms-ib.cern.ch/nweek-02698/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-12-2300/lib/slc7_amd64_gcc900/libUtilitiesStorageFactory.so
#11 0x00002ad6724613e3 in TStorageFactoryFile::Initialize(char const*, char const*) () from /cvmfs/cms-ib.cern.ch/nweek-02698/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-12-2300/lib/slc7_amd64_gcc900/libIOPoolTFileAdaptor.so
#12 0x00002ad672461bb6 in TStorageFactoryFile::TStorageFactoryFile(char const*, char const*, char const*, int, int, bool) () from /cvmfs/cms-ib.cern.ch/nweek-02698/slc7_amd64_gcc900/cms/cmssw/CMSSW_12_1_DEVEL_X_2021-09-12-2300/lib/slc7_amd64_gcc900/libIOPoolTFileAdaptor.so
#13 0x00002ad68daf50a4 in ?? ()
#14 0x00002ad600000000 in ?? ()
#15 0x00002ad6844571d8 in ?? ()
#16 0x00002ad66a5fcc08 in vtable for (anonymous namespace)::TReentrantRWLockState<std::mutex, ROOT::Internal::RecurseCounts> () from /cvmfs/cms-ib.cern.ch/nweek-02698/slc7_amd64_gcc900/cms/cmssw-patch/CMSSW_12_1_DEVEL_X_2021-09-13-2300/external/slc7_amd64_gcc900/lib/libThread.so
#17 0x00002ad66a5e3bad in ROOT::TReentrantRWLock<std::mutex, ROOT::Internal::RecurseCounts>::GetStateBefore() () from /cvmfs/cms-ib.cern.ch/nweek-02698/slc7_amd64_gcc900/cms/cmssw-patch/CMSSW_12_1_DEVEL_X_2021-09-13-2300/external/slc7_amd64_gcc900/lib/libThread.so
#18 0x00007fff84ea60b0 in ?? ()
#19 0x00007fff84ea62c0 in ?? ()
#20 0x00007fff84ea60e8 in ?? ()
#21 0x00000005937cbfe8 in ?? ()
#22 0x0000000000000000 in ?? ()

Current Modules:

Module: non-CMSSW (crashed)

https://cmssdt.cern.ch/SDT/cgi-bin/logreader/slc7_amd64_gcc900/CMSSW_12_1_DEVEL_X_2021-09-13-2300/pyRelValMatrixLogs/run/140.55_RunHI2015VR+RunHI2015VR+HYBRIDRepackHI2015VR+HYBRIDZSHI2015+RECOHID15+HARVESTDHI15/step2_RunHI2015VR+RunHI2015VR+HYBRIDRepackHI2015VR+HYBRIDZSHI2015+RECOHID15+HARVESTDHI15.log#/45-45

@makortel
Copy link
Contributor

Given the frequent crashes in DEVEL, should we consider reverting these changes until we have a fix for those? (assuming repeating the crashes has not value given the extracted stack traces above)

@osschar
Copy link
Contributor Author

osschar commented Sep 27, 2021

Sorry, I dropped the ball on this :( Let me fix the thing I've already figured out is wrong, another local variable XrdCl::FileSystem that gets deleted and later accessed from response handler.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Projects
None yet
Development

Successfully merging this pull request may close these issues.

7 participants