From 25df583a1ab5a95618ce1b3beff2473ceedec5f1 Mon Sep 17 00:00:00 2001 From: Chris Jones Date: Thu, 7 Jul 2022 14:19:05 -0500 Subject: [PATCH] Add prefetching ActivityRegistry signals for more transitions All non-Event transitions now also have prefetching related signals. --- FWCore/Framework/interface/maker/Worker.h | 20 +- .../Framework/test/global_filter_t.cppunit.cc | 49 +- .../test/global_outputmodule_t.cppunit.cc | 31 +- .../test/global_producer_t.cppunit.cc | 50 +- .../test/limited_filter_t.cppunit.cc | 32 +- .../test/limited_outputmodule_t.cppunit.cc | 16 +- .../test/limited_producer_t.cppunit.cc | 32 +- .../test/one_outputmodule_t.cppunit.cc | 16 +- .../Framework/test/stream_filter_t.cppunit.cc | 32 +- .../test/stream_producer_t.cppunit.cc | 32 +- .../test/unit_test_outputs/testGetBy1.log | 176 ++++ .../testSubProcess.grep2.txt | 780 ++++++++++++++++++ .../interface/ActivityRegistry.h | 32 + .../ServiceRegistry/interface/GlobalContext.h | 4 + .../ServiceRegistry/interface/StreamContext.h | 3 + .../ServiceRegistry/src/ActivityRegistry.cc | 12 + FWCore/ServiceRegistry/src/GlobalContext.cc | 37 + FWCore/ServiceRegistry/src/StreamContext.cc | 22 + FWCore/Services/plugins/Tracer.cc | 76 ++ 19 files changed, 1370 insertions(+), 82 deletions(-) diff --git a/FWCore/Framework/interface/maker/Worker.h b/FWCore/Framework/interface/maker/Worker.h index 34703ee30d4df..8e6635316b2a3 100644 --- a/FWCore/Framework/interface/maker/Worker.h +++ b/FWCore/Framework/interface/maker/Worker.h @@ -351,6 +351,16 @@ namespace edm { actReg_->postModuleEventPrefetchingSignal_.emit(*moduleCallingContext_.getStreamContext(), moduleCallingContext_); } + void emitPostModuleStreamPrefetchingSignal() { + actReg_->postModuleStreamPrefetchingSignal_.emit(*moduleCallingContext_.getStreamContext(), + moduleCallingContext_); + } + + void emitPostModuleGlobalPrefetchingSignal() { + actReg_->postModuleGlobalPrefetchingSignal_.emit(*moduleCallingContext_.getGlobalContext(), + moduleCallingContext_); + } + virtual bool hasAcquire() const = 0; template @@ -422,6 +432,10 @@ namespace edm { } } } + } else if constexpr (std::is_same_v) { + m_worker->emitPostModuleStreamPrefetchingSignal(); + } else if constexpr (std::is_same_v) { + m_worker->emitPostModuleGlobalPrefetchingSignal(); } if (not excptr) { @@ -916,8 +930,12 @@ namespace edm { moduleCallingContext_.setContext(ModuleCallingContext::State::kPrefetching, parentContext, nullptr); - if (principal.branchType() == InEvent) { + if constexpr (T::isEvent_) { actReg_->preModuleEventPrefetchingSignal_.emit(*moduleCallingContext_.getStreamContext(), moduleCallingContext_); + } else if constexpr (std::is_same_v) { + actReg_->preModuleStreamPrefetchingSignal_.emit(*moduleCallingContext_.getStreamContext(), moduleCallingContext_); + } else if constexpr (std::is_same_v) { + actReg_->preModuleGlobalPrefetchingSignal_.emit(*moduleCallingContext_.getGlobalContext(), moduleCallingContext_); } workerhelper::CallImpl::esPrefetchAsync(this, iTask, token, transitionInfo, iTransition); diff --git a/FWCore/Framework/test/global_filter_t.cppunit.cc b/FWCore/Framework/test/global_filter_t.cppunit.cc index 9f183627872b5..a04e82ee10d8e 100644 --- a/FWCore/Framework/test/global_filter_t.cppunit.cc +++ b/FWCore/Framework/test/global_filter_t.cppunit.cc @@ -399,26 +399,34 @@ testGlobalFilter::testGlobalFilter() m_transToFunc[Trans::kGlobalBeginRun] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kBeginRun, nullptr); + edm::ParentContext nullParentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, nullParentContext); }; m_transToFunc[Trans::kStreamBeginRun] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::StreamContext streamContext(s_streamID0, nullptr); + edm::ParentContext nullParentContext(&streamContext); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, nullParentContext); }; m_transToFunc[Trans::kGlobalBeginLuminosityBlock] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kBeginLuminosityBlock, nullptr); + edm::ParentContext nullParentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, nullParentContext); }; m_transToFunc[Trans::kStreamBeginLuminosityBlock] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::StreamContext streamContext(s_streamID0, nullptr); + edm::ParentContext nullParentContext(&streamContext); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, nullParentContext); }; @@ -434,26 +442,34 @@ testGlobalFilter::testGlobalFilter() m_transToFunc[Trans::kStreamEndLuminosityBlock] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::StreamContext streamContext(s_streamID0, nullptr); + edm::ParentContext nullParentContext(&streamContext); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, nullParentContext); }; m_transToFunc[Trans::kGlobalEndLuminosityBlock] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kEndLuminosityBlock, nullptr); + edm::ParentContext nullParentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, nullParentContext); }; m_transToFunc[Trans::kStreamEndRun] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::StreamContext streamContext(s_streamID0, nullptr); + edm::ParentContext nullParentContext(&streamContext); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, nullParentContext); }; m_transToFunc[Trans::kGlobalEndRun] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kEndLuminosityBlock, nullptr); + edm::ParentContext nullParentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, nullParentContext); }; @@ -487,13 +503,16 @@ namespace { template void testGlobalFilter::testTransitions(std::shared_ptr iMod, Expectations const& iExpect) { oneapi::tbb::global_control control(oneapi::tbb::global_control::max_allowed_parallelism, 1); - edm::maker::ModuleHolderT h(iMod, nullptr); - h.preallocate(edm::PreallocationConfiguration{}); - - edm::WorkerT w{iMod, m_desc, nullptr}; - for (auto& keyVal : m_transToFunc) { - testTransition(iMod, &w, keyVal.first, iExpect, keyVal.second); - } + oneapi::tbb::task_arena arena(1); + arena.execute([&]() { + edm::maker::ModuleHolderT h(iMod, nullptr); + h.preallocate(edm::PreallocationConfiguration{}); + + edm::WorkerT w{iMod, m_desc, nullptr}; + for (auto& keyVal : m_transToFunc) { + testTransition(iMod, &w, keyVal.first, iExpect, keyVal.second); + } + }); } void testGlobalFilter::basicTest() { diff --git a/FWCore/Framework/test/global_outputmodule_t.cppunit.cc b/FWCore/Framework/test/global_outputmodule_t.cppunit.cc index f983c55c0d862..be1fcb24ded2c 100644 --- a/FWCore/Framework/test/global_outputmodule_t.cppunit.cc +++ b/FWCore/Framework/test/global_outputmodule_t.cppunit.cc @@ -194,14 +194,18 @@ testGlobalOutputModule::testGlobalOutputModule() m_transToFunc[Trans::kGlobalBeginRun] = [this](edm::Worker* iBase, edm::OutputModuleCommunicator*) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext parentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kBeginRun, nullptr); + edm::ParentContext parentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, edm::StreamID::invalidStreamID(), parentContext); }; m_transToFunc[Trans::kGlobalBeginLuminosityBlock] = [this](edm::Worker* iBase, edm::OutputModuleCommunicator*) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext parentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kBeginLuminosityBlock, nullptr); + edm::ParentContext parentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, edm::StreamID::invalidStreamID(), parentContext); }; @@ -217,7 +221,9 @@ testGlobalOutputModule::testGlobalOutputModule() m_transToFunc[Trans::kGlobalEndLuminosityBlock] = [this](edm::Worker* iBase, edm::OutputModuleCommunicator* iComm) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext parentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kEndLuminosityBlock, nullptr); + edm::ParentContext parentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, edm::StreamID::invalidStreamID(), parentContext); edm::FinalWaitingTask task; @@ -233,7 +239,9 @@ testGlobalOutputModule::testGlobalOutputModule() m_transToFunc[Trans::kGlobalEndRun] = [this](edm::Worker* iBase, edm::OutputModuleCommunicator* iComm) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext parentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kEndLuminosityBlock, nullptr); + edm::ParentContext parentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, edm::StreamID::invalidStreamID(), parentContext); edm::FinalWaitingTask task; @@ -300,12 +308,15 @@ template void testGlobalOutputModule::testTransitions(std::shared_ptr iMod, Expectations const& iExpect) { oneapi::tbb::global_control control(oneapi::tbb::global_control::max_allowed_parallelism, 1); - iMod->doPreallocate(m_preallocConfig); - edm::WorkerT w{iMod, m_desc, m_params.actions_}; - edm::OutputModuleCommunicatorT comm(iMod.get()); - for (auto& keyVal : m_transToFunc) { - testTransition(iMod, &w, &comm, keyVal.first, iExpect, keyVal.second); - } + oneapi::tbb::task_arena arena(1); + arena.execute([&]() { + iMod->doPreallocate(m_preallocConfig); + edm::WorkerT w{iMod, m_desc, m_params.actions_}; + edm::OutputModuleCommunicatorT comm(iMod.get()); + for (auto& keyVal : m_transToFunc) { + testTransition(iMod, &w, &comm, keyVal.first, iExpect, keyVal.second); + } + }); } void testGlobalOutputModule::basicTest() { diff --git a/FWCore/Framework/test/global_producer_t.cppunit.cc b/FWCore/Framework/test/global_producer_t.cppunit.cc index af25d193eb4fd..feb1e1b14d1dc 100644 --- a/FWCore/Framework/test/global_producer_t.cppunit.cc +++ b/FWCore/Framework/test/global_producer_t.cppunit.cc @@ -363,26 +363,34 @@ testGlobalProducer::testGlobalProducer() m_transToFunc[Trans::kGlobalBeginRun] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kBeginRun, nullptr); + edm::ParentContext nullParentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, nullParentContext); }; m_transToFunc[Trans::kStreamBeginRun] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::StreamContext streamContext(s_streamID0, nullptr); + edm::ParentContext nullParentContext(&streamContext); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, nullParentContext); }; m_transToFunc[Trans::kGlobalBeginLuminosityBlock] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kBeginLuminosityBlock, nullptr); + edm::ParentContext nullParentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, nullParentContext); }; m_transToFunc[Trans::kStreamBeginLuminosityBlock] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::StreamContext streamContext(s_streamID0, nullptr); + edm::ParentContext nullParentContext(&streamContext); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, nullParentContext); }; @@ -398,26 +406,34 @@ testGlobalProducer::testGlobalProducer() m_transToFunc[Trans::kStreamEndLuminosityBlock] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::StreamContext streamContext(s_streamID0, nullptr); + edm::ParentContext nullParentContext(&streamContext); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, nullParentContext); }; m_transToFunc[Trans::kGlobalEndLuminosityBlock] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kEndLuminosityBlock, nullptr); + edm::ParentContext nullParentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, nullParentContext); }; m_transToFunc[Trans::kStreamEndRun] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::StreamContext streamContext(s_streamID0, nullptr); + edm::ParentContext nullParentContext(&streamContext); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, nullParentContext); }; m_transToFunc[Trans::kGlobalEndRun] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kEndLuminosityBlock, nullptr); + edm::ParentContext nullParentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, nullParentContext); }; @@ -451,14 +467,16 @@ namespace { template void testGlobalProducer::testTransitions(std::shared_ptr iMod, Expectations const& iExpect) { oneapi::tbb::global_control control(oneapi::tbb::global_control::max_allowed_parallelism, 1); - - edm::maker::ModuleHolderT h(iMod, nullptr); - h.preallocate(edm::PreallocationConfiguration{}); - - edm::WorkerT w{iMod, m_desc, nullptr}; - for (auto& keyVal : m_transToFunc) { - testTransition(iMod, &w, keyVal.first, iExpect, keyVal.second); - } + oneapi::tbb::task_arena arena(1); + arena.execute([&]() { + edm::maker::ModuleHolderT h(iMod, nullptr); + h.preallocate(edm::PreallocationConfiguration{}); + + edm::WorkerT w{iMod, m_desc, nullptr}; + for (auto& keyVal : m_transToFunc) { + testTransition(iMod, &w, keyVal.first, iExpect, keyVal.second); + } + }); } void testGlobalProducer::basicTest() { diff --git a/FWCore/Framework/test/limited_filter_t.cppunit.cc b/FWCore/Framework/test/limited_filter_t.cppunit.cc index e8df26b06395e..3aa779e677e53 100644 --- a/FWCore/Framework/test/limited_filter_t.cppunit.cc +++ b/FWCore/Framework/test/limited_filter_t.cppunit.cc @@ -427,26 +427,34 @@ testLimitedFilter::testLimitedFilter() m_transToFunc[Trans::kGlobalBeginRun] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kBeginRun, nullptr); + edm::ParentContext nullParentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, nullParentContext); }; m_transToFunc[Trans::kStreamBeginRun] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::StreamContext streamContext(s_streamID0, nullptr); + edm::ParentContext nullParentContext(&streamContext); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, nullParentContext); }; m_transToFunc[Trans::kGlobalBeginLuminosityBlock] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kBeginLuminosityBlock, nullptr); + edm::ParentContext nullParentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, nullParentContext); }; m_transToFunc[Trans::kStreamBeginLuminosityBlock] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::StreamContext streamContext(s_streamID0, nullptr); + edm::ParentContext nullParentContext(&streamContext); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, nullParentContext); }; @@ -462,26 +470,34 @@ testLimitedFilter::testLimitedFilter() m_transToFunc[Trans::kStreamEndLuminosityBlock] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::StreamContext streamContext(s_streamID0, nullptr); + edm::ParentContext nullParentContext(&streamContext); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, nullParentContext); }; m_transToFunc[Trans::kGlobalEndLuminosityBlock] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kEndLuminosityBlock, nullptr); + edm::ParentContext nullParentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, nullParentContext); }; m_transToFunc[Trans::kStreamEndRun] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::StreamContext streamContext(s_streamID0, nullptr); + edm::ParentContext nullParentContext(&streamContext); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, nullParentContext); }; m_transToFunc[Trans::kGlobalEndRun] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kEndLuminosityBlock, nullptr); + edm::ParentContext nullParentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, nullParentContext); }; diff --git a/FWCore/Framework/test/limited_outputmodule_t.cppunit.cc b/FWCore/Framework/test/limited_outputmodule_t.cppunit.cc index ec36470f04e45..6ea75fd70f613 100644 --- a/FWCore/Framework/test/limited_outputmodule_t.cppunit.cc +++ b/FWCore/Framework/test/limited_outputmodule_t.cppunit.cc @@ -193,14 +193,18 @@ testLimitedOutputModule::testLimitedOutputModule() m_transToFunc[Trans::kGlobalBeginRun] = [this](edm::Worker* iBase, edm::OutputModuleCommunicator*) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext parentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kBeginRun, nullptr); + edm::ParentContext parentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, edm::StreamID::invalidStreamID(), parentContext); }; m_transToFunc[Trans::kGlobalBeginLuminosityBlock] = [this](edm::Worker* iBase, edm::OutputModuleCommunicator*) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext parentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kBeginLuminosityBlock, nullptr); + edm::ParentContext parentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, edm::StreamID::invalidStreamID(), parentContext); }; @@ -216,7 +220,9 @@ testLimitedOutputModule::testLimitedOutputModule() m_transToFunc[Trans::kGlobalEndLuminosityBlock] = [this](edm::Worker* iBase, edm::OutputModuleCommunicator* iComm) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext parentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kEndLuminosityBlock, nullptr); + edm::ParentContext parentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, edm::StreamID::invalidStreamID(), parentContext); edm::FinalWaitingTask task; @@ -232,7 +238,9 @@ testLimitedOutputModule::testLimitedOutputModule() m_transToFunc[Trans::kGlobalEndRun] = [this](edm::Worker* iBase, edm::OutputModuleCommunicator* iComm) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext parentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kEndLuminosityBlock, nullptr); + edm::ParentContext parentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, edm::StreamID::invalidStreamID(), parentContext); edm::FinalWaitingTask task; diff --git a/FWCore/Framework/test/limited_producer_t.cppunit.cc b/FWCore/Framework/test/limited_producer_t.cppunit.cc index aba2523683a1c..be800fa00d84b 100644 --- a/FWCore/Framework/test/limited_producer_t.cppunit.cc +++ b/FWCore/Framework/test/limited_producer_t.cppunit.cc @@ -394,26 +394,34 @@ testLimitedProducer::testLimitedProducer() m_transToFunc[Trans::kGlobalBeginRun] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kBeginRun, nullptr); + edm::ParentContext nullParentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, nullParentContext); }; m_transToFunc[Trans::kStreamBeginRun] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::StreamContext streamContext(s_streamID0, nullptr); + edm::ParentContext nullParentContext(&streamContext); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, nullParentContext); }; m_transToFunc[Trans::kGlobalBeginLuminosityBlock] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kBeginLuminosityBlock, nullptr); + edm::ParentContext nullParentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, nullParentContext); }; m_transToFunc[Trans::kStreamBeginLuminosityBlock] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::StreamContext streamContext(s_streamID0, nullptr); + edm::ParentContext nullParentContext(&streamContext); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, nullParentContext); }; @@ -429,26 +437,34 @@ testLimitedProducer::testLimitedProducer() m_transToFunc[Trans::kStreamEndLuminosityBlock] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::StreamContext streamContext(s_streamID0, nullptr); + edm::ParentContext nullParentContext(&streamContext); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, nullParentContext); }; m_transToFunc[Trans::kGlobalEndLuminosityBlock] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kEndLuminosityBlock, nullptr); + edm::ParentContext nullParentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, nullParentContext); }; m_transToFunc[Trans::kStreamEndRun] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::StreamContext streamContext(s_streamID0, nullptr); + edm::ParentContext nullParentContext(&streamContext); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, nullParentContext); }; m_transToFunc[Trans::kGlobalEndRun] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext nullParentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kEndLuminosityBlock, nullptr); + edm::ParentContext nullParentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, nullParentContext); }; diff --git a/FWCore/Framework/test/one_outputmodule_t.cppunit.cc b/FWCore/Framework/test/one_outputmodule_t.cppunit.cc index 3e30cc9db2b43..5917de7984ae0 100644 --- a/FWCore/Framework/test/one_outputmodule_t.cppunit.cc +++ b/FWCore/Framework/test/one_outputmodule_t.cppunit.cc @@ -288,14 +288,18 @@ testOneOutputModule::testOneOutputModule() m_transToFunc[Trans::kGlobalBeginRun] = [this](edm::Worker* iBase, edm::OutputModuleCommunicator*) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext parentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kBeginRun, nullptr); + edm::ParentContext parentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, edm::StreamID::invalidStreamID(), parentContext); }; m_transToFunc[Trans::kGlobalBeginLuminosityBlock] = [this](edm::Worker* iBase, edm::OutputModuleCommunicator*) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext parentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kBeginLuminosityBlock, nullptr); + edm::ParentContext parentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, edm::StreamID::invalidStreamID(), parentContext); }; @@ -311,7 +315,9 @@ testOneOutputModule::testOneOutputModule() m_transToFunc[Trans::kGlobalEndLuminosityBlock] = [this](edm::Worker* iBase, edm::OutputModuleCommunicator* iComm) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext parentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kEndLuminosityBlock, nullptr); + edm::ParentContext parentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, edm::StreamID::invalidStreamID(), parentContext); edm::FinalWaitingTask task; @@ -327,7 +333,9 @@ testOneOutputModule::testOneOutputModule() m_transToFunc[Trans::kGlobalEndRun] = [this](edm::Worker* iBase, edm::OutputModuleCommunicator* iComm) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext parentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kEndLuminosityBlock, nullptr); + edm::ParentContext parentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, edm::StreamID::invalidStreamID(), parentContext); edm::FinalWaitingTask task; diff --git a/FWCore/Framework/test/stream_filter_t.cppunit.cc b/FWCore/Framework/test/stream_filter_t.cppunit.cc index bfb2675601fef..20809c616cc71 100644 --- a/FWCore/Framework/test/stream_filter_t.cppunit.cc +++ b/FWCore/Framework/test/stream_filter_t.cppunit.cc @@ -477,26 +477,34 @@ testStreamFilter::testStreamFilter() m_transToFunc[Trans::kGlobalBeginRun] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext parentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kBeginRun, nullptr); + edm::ParentContext parentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, parentContext); }; m_transToFunc[Trans::kStreamBeginRun] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext parentContext; + edm::StreamContext streamContext(s_streamID0, nullptr); + edm::ParentContext parentContext(&streamContext); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, parentContext); }; m_transToFunc[Trans::kGlobalBeginLuminosityBlock] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext parentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kBeginLuminosityBlock, nullptr); + edm::ParentContext parentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, parentContext); }; m_transToFunc[Trans::kStreamBeginLuminosityBlock] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext parentContext; + edm::StreamContext streamContext(s_streamID0, nullptr); + edm::ParentContext parentContext(&streamContext); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, parentContext); }; @@ -512,26 +520,34 @@ testStreamFilter::testStreamFilter() m_transToFunc[Trans::kStreamEndLuminosityBlock] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext parentContext; + edm::StreamContext streamContext(s_streamID0, nullptr); + edm::ParentContext parentContext(&streamContext); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, parentContext); }; m_transToFunc[Trans::kGlobalEndLuminosityBlock] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext parentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kEndLuminosityBlock, nullptr); + edm::ParentContext parentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, parentContext); }; m_transToFunc[Trans::kStreamEndRun] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext parentContext; + edm::StreamContext streamContext(s_streamID0, nullptr); + edm::ParentContext parentContext(&streamContext); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, parentContext); }; m_transToFunc[Trans::kGlobalEndRun] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext parentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kEndLuminosityBlock, nullptr); + edm::ParentContext parentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, parentContext); }; diff --git a/FWCore/Framework/test/stream_producer_t.cppunit.cc b/FWCore/Framework/test/stream_producer_t.cppunit.cc index d41e18ddd5676..b707df3f61a0c 100644 --- a/FWCore/Framework/test/stream_producer_t.cppunit.cc +++ b/FWCore/Framework/test/stream_producer_t.cppunit.cc @@ -438,26 +438,34 @@ testStreamProducer::testStreamProducer() m_transToFunc[Trans::kGlobalBeginRun] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext parentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kBeginRun, nullptr); + edm::ParentContext parentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, parentContext); }; m_transToFunc[Trans::kStreamBeginRun] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext parentContext; + edm::StreamContext streamContext(s_streamID0, nullptr); + edm::ParentContext parentContext(&streamContext); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, parentContext); }; m_transToFunc[Trans::kGlobalBeginLuminosityBlock] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext parentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kBeginLuminosityBlock, nullptr); + edm::ParentContext parentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, parentContext); }; m_transToFunc[Trans::kStreamBeginLuminosityBlock] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext parentContext; + edm::StreamContext streamContext(s_streamID0, nullptr); + edm::ParentContext parentContext(&streamContext); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, parentContext); }; @@ -473,26 +481,34 @@ testStreamProducer::testStreamProducer() m_transToFunc[Trans::kStreamEndLuminosityBlock] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext parentContext; + edm::StreamContext streamContext(s_streamID0, nullptr); + edm::ParentContext parentContext(&streamContext); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, parentContext); }; m_transToFunc[Trans::kGlobalEndLuminosityBlock] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext parentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kEndLuminosityBlock, nullptr); + edm::ParentContext parentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::LumiTransitionInfo info(*m_lbp, *m_es); doWork(iBase, info, parentContext); }; m_transToFunc[Trans::kStreamEndRun] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext parentContext; + edm::StreamContext streamContext(s_streamID0, nullptr); + edm::ParentContext parentContext(&streamContext); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, parentContext); }; m_transToFunc[Trans::kGlobalEndRun] = [this](edm::Worker* iBase) { typedef edm::OccurrenceTraits Traits; - edm::ParentContext parentContext; + edm::GlobalContext gc(edm::GlobalContext::Transition::kEndLuminosityBlock, nullptr); + edm::ParentContext parentContext(&gc); + iBase->setActivityRegistry(m_actReg); edm::RunTransitionInfo info(*m_rp, *m_es); doWork(iBase, info, parentContext); }; diff --git a/FWCore/Integration/test/unit_test_outputs/testGetBy1.log b/FWCore/Integration/test/unit_test_outputs/testGetBy1.log index 4d0574f0133fb..eb5f0dd2937a4 100644 --- a/FWCore/Integration/test/unit_test_outputs/testGetBy1.log +++ b/FWCore/Integration/test/unit_test_outputs/testGetBy1.log @@ -148,8 +148,37 @@ GlobalContext: transition = BeginProcessBlock runIndex = 4294967295 luminosityBlockIndex = 4294967295 unixTime = 0 microsecondOffset = 0 ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac +++++++++ starting: prefetching before processing global begin ProcessBlock for module: label = 'a3' id = 7 +++++++++ starting: prefetching before processing global begin ProcessBlock for module: label = 'a2' id = 6 +++++++++ starting: prefetching before processing global begin ProcessBlock for module: label = 'a1' id = 5 +GlobalContext: transition = BeginProcessBlock + run: 0 luminosityBlock: 0 + runIndex = 4294967295 luminosityBlockIndex = 4294967295 unixTime = 0 microsecondOffset = 0 + ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac +ModuleCallingContext state = Prefetching + moduleDescription: Module type=TestFindProduct, Module label=a1, Parameter Set ID=73b313a2727141f62e12cd7cf1a5b8dc + GlobalContext: transition = BeginProcessBlock + run: 0 luminosityBlock: 0 + runIndex = 4294967295 luminosityBlockIndex = 4294967295 unixTime = 0 microsecondOffset = 0 + ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac + +++++++++ starting: prefetching before processing global begin ProcessBlock for module: label = 'intProducerEndProcessBlock' id = 12 +++++++++ starting: prefetching before processing global begin ProcessBlock for module: label = 'intProducerBeginProcessBlock' id = 11 +++++++++ finished: prefetching before processing global begin ProcessBlock for module: label = 'intProducerBeginProcessBlock' id = 11 ++++++ starting: begin process block for module: label = 'intProducerBeginProcessBlock' id = 11 ++++++ finished: begin process block for module: label = 'intProducerBeginProcessBlock' id = 11 +++++++++ finished: prefetching before processing global begin ProcessBlock for module: label = 'a1' id = 5 +GlobalContext: transition = BeginProcessBlock + run: 0 luminosityBlock: 0 + runIndex = 4294967295 luminosityBlockIndex = 4294967295 unixTime = 0 microsecondOffset = 0 + ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac +ModuleCallingContext state = Prefetching + moduleDescription: Module type=TestFindProduct, Module label=a1, Parameter Set ID=73b313a2727141f62e12cd7cf1a5b8dc + GlobalContext: transition = BeginProcessBlock + run: 0 luminosityBlock: 0 + runIndex = 4294967295 luminosityBlockIndex = 4294967295 unixTime = 0 microsecondOffset = 0 + ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac + ++++++ starting: begin process block for module: label = 'a1' id = 5 GlobalContext: transition = BeginProcessBlock run: 0 luminosityBlock: 0 @@ -174,10 +203,13 @@ ModuleCallingContext state = Running runIndex = 4294967295 luminosityBlockIndex = 4294967295 unixTime = 0 microsecondOffset = 0 ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac +++++++++ finished: prefetching before processing global begin ProcessBlock for module: label = 'intProducerEndProcessBlock' id = 12 ++++++ starting: begin process block for module: label = 'intProducerEndProcessBlock' id = 12 ++++++ finished: begin process block for module: label = 'intProducerEndProcessBlock' id = 12 +++++++++ finished: prefetching before processing global begin ProcessBlock for module: label = 'a2' id = 6 ++++++ starting: begin process block for module: label = 'a2' id = 6 ++++++ finished: begin process block for module: label = 'a2' id = 6 +++++++++ finished: prefetching before processing global begin ProcessBlock for module: label = 'a3' id = 7 ++++++ starting: begin process block for module: label = 'a3' id = 7 ++++++ finished: begin process block for module: label = 'a3' id = 7 ++++ finished: begin process block @@ -210,6 +242,32 @@ GlobalContext: transition = BeginRun runIndex = 0 luminosityBlockIndex = 4294967295 unixTime = 0 microsecondOffset = 1 ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac +++++++++ starting: prefetching before processing global global begin Run for module: label = 'a3' id = 7 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'a2' id = 6 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'a1' id = 5 +GlobalContext: transition = BeginRun + run: 1 luminosityBlock: 0 + runIndex = 0 luminosityBlockIndex = 4294967295 unixTime = 0 microsecondOffset = 1 + ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac +ModuleCallingContext state = Prefetching + moduleDescription: Module type=TestFindProduct, Module label=a1, Parameter Set ID=73b313a2727141f62e12cd7cf1a5b8dc + GlobalContext: transition = BeginRun + run: 1 luminosityBlock: 0 + runIndex = 0 luminosityBlockIndex = 4294967295 unixTime = 0 microsecondOffset = 1 + ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac + +++++++++ finished: prefetching before processing global global begin Run for module: label = 'a1' id = 5 +GlobalContext: transition = BeginRun + run: 1 luminosityBlock: 0 + runIndex = 0 luminosityBlockIndex = 4294967295 unixTime = 0 microsecondOffset = 1 + ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac +ModuleCallingContext state = Prefetching + moduleDescription: Module type=TestFindProduct, Module label=a1, Parameter Set ID=73b313a2727141f62e12cd7cf1a5b8dc + GlobalContext: transition = BeginRun + run: 1 luminosityBlock: 0 + runIndex = 0 luminosityBlockIndex = 4294967295 unixTime = 0 microsecondOffset = 1 + ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac + ++++++ starting: global begin run for module: label = 'a1' id = 5 GlobalContext: transition = BeginRun run: 1 luminosityBlock: 0 @@ -234,8 +292,10 @@ ModuleCallingContext state = Running runIndex = 0 luminosityBlockIndex = 4294967295 unixTime = 0 microsecondOffset = 1 ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac +++++++++ finished: prefetching before processing global global begin Run for module: label = 'a2' id = 6 ++++++ starting: global begin run for module: label = 'a2' id = 6 ++++++ finished: global begin run for module: label = 'a2' id = 6 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'a3' id = 7 ++++++ starting: global begin run for module: label = 'a3' id = 7 ++++++ finished: global begin run for module: label = 'a3' id = 7 ++++ finished: global begin run 1 : time = 1 @@ -325,6 +385,32 @@ GlobalContext: transition = BeginLuminosityBlock runIndex = 0 luminosityBlockIndex = 0 unixTime = 0 microsecondOffset = 1 ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'a3' id = 7 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'a2' id = 6 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'a1' id = 5 +GlobalContext: transition = BeginLuminosityBlock + run: 1 luminosityBlock: 1 + runIndex = 0 luminosityBlockIndex = 0 unixTime = 0 microsecondOffset = 1 + ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac +ModuleCallingContext state = Prefetching + moduleDescription: Module type=TestFindProduct, Module label=a1, Parameter Set ID=73b313a2727141f62e12cd7cf1a5b8dc + GlobalContext: transition = BeginLuminosityBlock + run: 1 luminosityBlock: 1 + runIndex = 0 luminosityBlockIndex = 0 unixTime = 0 microsecondOffset = 1 + ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac + +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'a1' id = 5 +GlobalContext: transition = BeginLuminosityBlock + run: 1 luminosityBlock: 1 + runIndex = 0 luminosityBlockIndex = 0 unixTime = 0 microsecondOffset = 1 + ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac +ModuleCallingContext state = Prefetching + moduleDescription: Module type=TestFindProduct, Module label=a1, Parameter Set ID=73b313a2727141f62e12cd7cf1a5b8dc + GlobalContext: transition = BeginLuminosityBlock + run: 1 luminosityBlock: 1 + runIndex = 0 luminosityBlockIndex = 0 unixTime = 0 microsecondOffset = 1 + ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac + ++++++ starting: global begin lumi for module: label = 'a1' id = 5 GlobalContext: transition = BeginLuminosityBlock run: 1 luminosityBlock: 1 @@ -349,8 +435,10 @@ ModuleCallingContext state = Running runIndex = 0 luminosityBlockIndex = 0 unixTime = 0 microsecondOffset = 1 ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'a2' id = 6 ++++++ starting: global begin lumi for module: label = 'a2' id = 6 ++++++ finished: global begin lumi for module: label = 'a2' id = 6 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'a3' id = 7 ++++++ starting: global begin lumi for module: label = 'a3' id = 7 ++++++ finished: global begin lumi for module: label = 'a3' id = 7 ++++ finished: global begin lumi: run = 1 lumi = 1 time = 1 @@ -1169,6 +1257,32 @@ GlobalContext: transition = EndLuminosityBlock runIndex = 0 luminosityBlockIndex = 0 unixTime = 0 microsecondOffset = 1 ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'a3' id = 7 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'a2' id = 6 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'a1' id = 5 +GlobalContext: transition = EndLuminosityBlock + run: 1 luminosityBlock: 1 + runIndex = 0 luminosityBlockIndex = 0 unixTime = 0 microsecondOffset = 1 + ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac +ModuleCallingContext state = Prefetching + moduleDescription: Module type=TestFindProduct, Module label=a1, Parameter Set ID=73b313a2727141f62e12cd7cf1a5b8dc + GlobalContext: transition = EndLuminosityBlock + run: 1 luminosityBlock: 1 + runIndex = 0 luminosityBlockIndex = 0 unixTime = 0 microsecondOffset = 1 + ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac + +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'a1' id = 5 +GlobalContext: transition = EndLuminosityBlock + run: 1 luminosityBlock: 1 + runIndex = 0 luminosityBlockIndex = 0 unixTime = 0 microsecondOffset = 1 + ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac +ModuleCallingContext state = Prefetching + moduleDescription: Module type=TestFindProduct, Module label=a1, Parameter Set ID=73b313a2727141f62e12cd7cf1a5b8dc + GlobalContext: transition = EndLuminosityBlock + run: 1 luminosityBlock: 1 + runIndex = 0 luminosityBlockIndex = 0 unixTime = 0 microsecondOffset = 1 + ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac + ++++++ starting: global end lumi for module: label = 'a1' id = 5 GlobalContext: transition = EndLuminosityBlock run: 1 luminosityBlock: 1 @@ -1193,8 +1307,10 @@ ModuleCallingContext state = Running runIndex = 0 luminosityBlockIndex = 0 unixTime = 0 microsecondOffset = 1 ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'a2' id = 6 ++++++ starting: global end lumi for module: label = 'a2' id = 6 ++++++ finished: global end lumi for module: label = 'a2' id = 6 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'a3' id = 7 ++++++ starting: global end lumi for module: label = 'a3' id = 7 ++++++ finished: global end lumi for module: label = 'a3' id = 7 ++++ finished: global end lumi: run = 1 lumi = 1 time = 1 @@ -1309,6 +1425,32 @@ GlobalContext: transition = EndRun runIndex = 0 luminosityBlockIndex = 4294967295 unixTime = 0 microsecondOffset = 15000001 ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac +++++++++ starting: prefetching before processing global global end Run for module: label = 'a3' id = 7 +++++++++ starting: prefetching before processing global global end Run for module: label = 'a2' id = 6 +++++++++ starting: prefetching before processing global global end Run for module: label = 'a1' id = 5 +GlobalContext: transition = EndRun + run: 1 luminosityBlock: 0 + runIndex = 0 luminosityBlockIndex = 4294967295 unixTime = 0 microsecondOffset = 15000001 + ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac +ModuleCallingContext state = Prefetching + moduleDescription: Module type=TestFindProduct, Module label=a1, Parameter Set ID=73b313a2727141f62e12cd7cf1a5b8dc + GlobalContext: transition = EndRun + run: 1 luminosityBlock: 0 + runIndex = 0 luminosityBlockIndex = 4294967295 unixTime = 0 microsecondOffset = 15000001 + ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac + +++++++++ finished: prefetching before processing global global end Run for module: label = 'a1' id = 5 +GlobalContext: transition = EndRun + run: 1 luminosityBlock: 0 + runIndex = 0 luminosityBlockIndex = 4294967295 unixTime = 0 microsecondOffset = 15000001 + ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac +ModuleCallingContext state = Prefetching + moduleDescription: Module type=TestFindProduct, Module label=a1, Parameter Set ID=73b313a2727141f62e12cd7cf1a5b8dc + GlobalContext: transition = EndRun + run: 1 luminosityBlock: 0 + runIndex = 0 luminosityBlockIndex = 4294967295 unixTime = 0 microsecondOffset = 15000001 + ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac + ++++++ starting: global end run for module: label = 'a1' id = 5 GlobalContext: transition = EndRun run: 1 luminosityBlock: 0 @@ -1333,8 +1475,10 @@ ModuleCallingContext state = Running runIndex = 0 luminosityBlockIndex = 4294967295 unixTime = 0 microsecondOffset = 15000001 ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac +++++++++ finished: prefetching before processing global global end Run for module: label = 'a2' id = 6 ++++++ starting: global end run for module: label = 'a2' id = 6 ++++++ finished: global end run for module: label = 'a2' id = 6 +++++++++ finished: prefetching before processing global global end Run for module: label = 'a3' id = 7 ++++++ starting: global end run for module: label = 'a3' id = 7 ++++++ finished: global end run for module: label = 'a3' id = 7 ++++ finished: global end run 1 : time = 15000001 @@ -1391,10 +1535,40 @@ GlobalContext: transition = EndProcessBlock runIndex = 4294967295 luminosityBlockIndex = 4294967295 unixTime = 0 microsecondOffset = 0 ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac +++++++++ starting: prefetching before processing global end ProcessBlock for module: label = 'a3' id = 7 +++++++++ starting: prefetching before processing global end ProcessBlock for module: label = 'a2' id = 6 +++++++++ starting: prefetching before processing global end ProcessBlock for module: label = 'a1' id = 5 +GlobalContext: transition = EndProcessBlock + run: 0 luminosityBlock: 0 + runIndex = 4294967295 luminosityBlockIndex = 4294967295 unixTime = 0 microsecondOffset = 0 + ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac +ModuleCallingContext state = Prefetching + moduleDescription: Module type=TestFindProduct, Module label=a1, Parameter Set ID=73b313a2727141f62e12cd7cf1a5b8dc + GlobalContext: transition = EndProcessBlock + run: 0 luminosityBlock: 0 + runIndex = 4294967295 luminosityBlockIndex = 4294967295 unixTime = 0 microsecondOffset = 0 + ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac + +++++++++ starting: prefetching before processing global end ProcessBlock for module: label = 'intProducerEndProcessBlock' id = 12 +++++++++ starting: prefetching before processing global end ProcessBlock for module: label = 'intProducerBeginProcessBlock' id = 11 +++++++++ finished: prefetching before processing global end ProcessBlock for module: label = 'intProducerBeginProcessBlock' id = 11 ++++++ starting: end process block for module: label = 'intProducerBeginProcessBlock' id = 11 ++++++ finished: end process block for module: label = 'intProducerBeginProcessBlock' id = 11 +++++++++ finished: prefetching before processing global end ProcessBlock for module: label = 'intProducerEndProcessBlock' id = 12 ++++++ starting: end process block for module: label = 'intProducerEndProcessBlock' id = 12 ++++++ finished: end process block for module: label = 'intProducerEndProcessBlock' id = 12 +++++++++ finished: prefetching before processing global end ProcessBlock for module: label = 'a1' id = 5 +GlobalContext: transition = EndProcessBlock + run: 0 luminosityBlock: 0 + runIndex = 4294967295 luminosityBlockIndex = 4294967295 unixTime = 0 microsecondOffset = 0 + ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac +ModuleCallingContext state = Prefetching + moduleDescription: Module type=TestFindProduct, Module label=a1, Parameter Set ID=73b313a2727141f62e12cd7cf1a5b8dc + GlobalContext: transition = EndProcessBlock + run: 0 luminosityBlock: 0 + runIndex = 4294967295 luminosityBlockIndex = 4294967295 unixTime = 0 microsecondOffset = 0 + ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac + ++++++ starting: end process block for module: label = 'a1' id = 5 GlobalContext: transition = EndProcessBlock run: 0 luminosityBlock: 0 @@ -1419,8 +1593,10 @@ ModuleCallingContext state = Running runIndex = 4294967295 luminosityBlockIndex = 4294967295 unixTime = 0 microsecondOffset = 0 ProcessContext: PROD1 be16549dc0c1f4b03231a8b98d235dac +++++++++ finished: prefetching before processing global end ProcessBlock for module: label = 'a2' id = 6 ++++++ starting: end process block for module: label = 'a2' id = 6 ++++++ finished: end process block for module: label = 'a2' id = 6 +++++++++ finished: prefetching before processing global end ProcessBlock for module: label = 'a3' id = 7 ++++++ starting: end process block for module: label = 'a3' id = 7 ++++++ finished: end process block for module: label = 'a3' id = 7 ++++ finished: end process block diff --git a/FWCore/Integration/test/unit_test_outputs/testSubProcess.grep2.txt b/FWCore/Integration/test/unit_test_outputs/testSubProcess.grep2.txt index 8a2b111ff1afc..99d9136f77c72 100644 --- a/FWCore/Integration/test/unit_test_outputs/testSubProcess.grep2.txt +++ b/FWCore/Integration/test/unit_test_outputs/testSubProcess.grep2.txt @@ -235,16 +235,22 @@ ++++ starting: begin process block ++++ finished: begin process block ++++ starting: begin process block +++++++++ starting: prefetching before processing global begin ProcessBlock for module: label = 'getInt' id = 10 +++++++++ finished: prefetching before processing global begin ProcessBlock for module: label = 'getInt' id = 10 ++++++ starting: begin process block for module: label = 'getInt' id = 10 ++++++ finished: begin process block for module: label = 'getInt' id = 10 ++++ finished: begin process block ++++ starting: begin process block ++++ finished: begin process block ++++ starting: begin process block +++++++++ starting: prefetching before processing global begin ProcessBlock for module: label = 'getInt' id = 22 ++++ starting: begin process block +++++++++ starting: prefetching before processing global begin ProcessBlock for module: label = 'getInt' id = 35 +++++++++ finished: prefetching before processing global begin ProcessBlock for module: label = 'getInt' id = 35 ++++++ starting: begin process block for module: label = 'getInt' id = 35 ++++++ finished: begin process block for module: label = 'getInt' id = 35 ++++ finished: begin process block +++++++++ finished: prefetching before processing global begin ProcessBlock for module: label = 'getInt' id = 22 ++++++ starting: begin process block for module: label = 'getInt' id = 22 ++++++ finished: begin process block for module: label = 'getInt' id = 22 ++++ finished: begin process block @@ -257,50 +263,82 @@ ++++ starting: global begin run 1 : time = 1 ++++ finished: global begin run 1 : time = 1 ++++ starting: global begin run 1 : time = 1 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'noPut' id = 11 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'getInt' id = 10 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'get' id = 6 ++++++++ starting: prefetching for esmodule: label = '' type = DoodadESSource in record = GadgetRcd +++++++++ starting: prefetching before processing global global begin Run for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'thingWithMergeProducer' id = 5 ++++++ starting: global begin run for module: label = 'thingWithMergeProducer' id = 5 ++++++ finished: global begin run for module: label = 'thingWithMergeProducer' id = 5 ++++++++ finished: prefetching for esmodule: label = '' type = DoodadESSource in record = GadgetRcd ++++++++ starting: processing esmodule: label = '' type = DoodadESSource in record = GadgetRcd ++++++++ finished: processing esmodule: label = '' type = DoodadESSource in record = GadgetRcd +++++++++ finished: prefetching before processing global global begin Run for module: label = 'get' id = 6 ++++++ starting: global begin run for module: label = 'get' id = 6 ++++++ finished: global begin run for module: label = 'get' id = 6 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'getInt' id = 10 ++++++ starting: global begin run for module: label = 'getInt' id = 10 ++++++ finished: global begin run for module: label = 'getInt' id = 10 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'noPut' id = 11 ++++++ starting: global begin run for module: label = 'noPut' id = 11 ++++++ finished: global begin run for module: label = 'noPut' id = 11 ++++ finished: global begin run 1 : time = 1 ++++ starting: global begin run 1 : time = 1 ++++ finished: global begin run 1 : time = 1 ++++ starting: global begin run 1 : time = 1 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'dependsOnNoPut' id = 23 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'getInt' id = 22 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'get' id = 21 ++++++++ starting: prefetching for esmodule: label = '' type = DoodadESSource in record = GadgetRcd +++++++++ starting: prefetching before processing global global begin Run for module: label = 'testmerge' id = 20 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'test' id = 19 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'thingWithMergeProducer' id = 18 ++++ starting: global begin run 1 : time = 1 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'dependsOnNoPut' id = 36 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'getInt' id = 35 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'get' id = 34 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'testmerge' id = 33 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'test' id = 32 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'thingWithMergeProducer' id = 31 ++++++ starting: global begin run for module: label = 'thingWithMergeProducer' id = 31 ++++++ finished: global begin run for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'test' id = 32 ++++++ starting: global begin run for module: label = 'test' id = 32 ++++++ finished: global begin run for module: label = 'test' id = 32 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'testmerge' id = 33 ++++++ starting: global begin run for module: label = 'testmerge' id = 33 ++++++ finished: global begin run for module: label = 'testmerge' id = 33 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'getInt' id = 35 ++++++ starting: global begin run for module: label = 'getInt' id = 35 ++++++ finished: global begin run for module: label = 'getInt' id = 35 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'dependsOnNoPut' id = 36 ++++++ starting: global begin run for module: label = 'dependsOnNoPut' id = 36 ++++++ finished: global begin run for module: label = 'dependsOnNoPut' id = 36 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'thingWithMergeProducer' id = 18 ++++++ starting: global begin run for module: label = 'thingWithMergeProducer' id = 18 ++++++ finished: global begin run for module: label = 'thingWithMergeProducer' id = 18 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'test' id = 19 ++++++ starting: global begin run for module: label = 'test' id = 19 ++++++ finished: global begin run for module: label = 'test' id = 19 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'testmerge' id = 20 ++++++ starting: global begin run for module: label = 'testmerge' id = 20 ++++++ finished: global begin run for module: label = 'testmerge' id = 20 ++++++++ finished: prefetching for esmodule: label = '' type = DoodadESSource in record = GadgetRcd ++++++++ starting: processing esmodule: label = '' type = DoodadESSource in record = GadgetRcd ++++++++ finished: processing esmodule: label = '' type = DoodadESSource in record = GadgetRcd +++++++++ finished: prefetching before processing global global begin Run for module: label = 'get' id = 21 ++++++ starting: global begin run for module: label = 'get' id = 21 ++++++ finished: global begin run for module: label = 'get' id = 21 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'get' id = 34 ++++++ starting: global begin run for module: label = 'get' id = 34 ++++++ finished: global begin run for module: label = 'get' id = 34 ++++ finished: global begin run 1 : time = 1 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'getInt' id = 22 ++++++ starting: global begin run for module: label = 'getInt' id = 22 ++++++ finished: global begin run for module: label = 'getInt' id = 22 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'dependsOnNoPut' id = 23 ++++++ starting: global begin run for module: label = 'dependsOnNoPut' id = 23 ++++++ finished: global begin run for module: label = 'dependsOnNoPut' id = 23 ++++ finished: global begin run 1 : time = 1 @@ -332,42 +370,74 @@ ++++ starting: global begin lumi: run = 1 lumi = 1 time = 1 ++++ finished: global begin lumi: run = 1 lumi = 1 time = 1 ++++ starting: global begin lumi: run = 1 lumi = 1 time = 1 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'noPut' id = 11 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 10 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 6 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 ++++++ starting: global begin lumi for module: label = 'thingWithMergeProducer' id = 5 ++++++ finished: global begin lumi for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 6 ++++++ starting: global begin lumi for module: label = 'get' id = 6 ++++++ finished: global begin lumi for module: label = 'get' id = 6 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 10 ++++++ starting: global begin lumi for module: label = 'getInt' id = 10 ++++++ finished: global begin lumi for module: label = 'getInt' id = 10 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'noPut' id = 11 ++++++ starting: global begin lumi for module: label = 'noPut' id = 11 ++++++ finished: global begin lumi for module: label = 'noPut' id = 11 ++++ finished: global begin lumi: run = 1 lumi = 1 time = 1 ++++ starting: global begin lumi: run = 1 lumi = 1 time = 1 ++++ finished: global begin lumi: run = 1 lumi = 1 time = 1 ++++ starting: global begin lumi: run = 1 lumi = 1 time = 1 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 22 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 21 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 20 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 19 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++ starting: global begin lumi: run = 1 lumi = 1 time = 1 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 35 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 34 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 33 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 32 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 ++++++ starting: global begin lumi for module: label = 'thingWithMergeProducer' id = 31 ++++++ finished: global begin lumi for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 32 ++++++ starting: global begin lumi for module: label = 'test' id = 32 ++++++ finished: global begin lumi for module: label = 'test' id = 32 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 33 ++++++ starting: global begin lumi for module: label = 'testmerge' id = 33 ++++++ finished: global begin lumi for module: label = 'testmerge' id = 33 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 34 ++++++ starting: global begin lumi for module: label = 'get' id = 34 ++++++ finished: global begin lumi for module: label = 'get' id = 34 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 35 ++++++ starting: global begin lumi for module: label = 'getInt' id = 35 ++++++ finished: global begin lumi for module: label = 'getInt' id = 35 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 ++++++ starting: global begin lumi for module: label = 'dependsOnNoPut' id = 36 ++++++ finished: global begin lumi for module: label = 'dependsOnNoPut' id = 36 ++++ finished: global begin lumi: run = 1 lumi = 1 time = 1 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++++ starting: global begin lumi for module: label = 'thingWithMergeProducer' id = 18 ++++++ finished: global begin lumi for module: label = 'thingWithMergeProducer' id = 18 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 19 ++++++ starting: global begin lumi for module: label = 'test' id = 19 ++++++ finished: global begin lumi for module: label = 'test' id = 19 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 20 ++++++ starting: global begin lumi for module: label = 'testmerge' id = 20 ++++++ finished: global begin lumi for module: label = 'testmerge' id = 20 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 21 ++++++ starting: global begin lumi for module: label = 'get' id = 21 ++++++ finished: global begin lumi for module: label = 'get' id = 21 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 22 ++++++ starting: global begin lumi for module: label = 'getInt' id = 22 ++++++ finished: global begin lumi for module: label = 'getInt' id = 22 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 ++++++ starting: global begin lumi for module: label = 'dependsOnNoPut' id = 23 ++++++ finished: global begin lumi for module: label = 'dependsOnNoPut' id = 23 ++++ finished: global begin lumi: run = 1 lumi = 1 time = 1 @@ -1038,42 +1108,74 @@ ++++ starting: global end lumi: run = 1 lumi = 1 time = 1 ++++ finished: global end lumi: run = 1 lumi = 1 time = 1 ++++ starting: global end lumi: run = 1 lumi = 1 time = 1 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'noPut' id = 11 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 10 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 6 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 ++++++ starting: global end lumi for module: label = 'thingWithMergeProducer' id = 5 ++++++ finished: global end lumi for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 6 ++++++ starting: global end lumi for module: label = 'get' id = 6 ++++++ finished: global end lumi for module: label = 'get' id = 6 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 10 ++++++ starting: global end lumi for module: label = 'getInt' id = 10 ++++++ finished: global end lumi for module: label = 'getInt' id = 10 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'noPut' id = 11 ++++++ starting: global end lumi for module: label = 'noPut' id = 11 ++++++ finished: global end lumi for module: label = 'noPut' id = 11 ++++ finished: global end lumi: run = 1 lumi = 1 time = 1 ++++ starting: global end lumi: run = 1 lumi = 1 time = 1 ++++ finished: global end lumi: run = 1 lumi = 1 time = 1 ++++ starting: global end lumi: run = 1 lumi = 1 time = 1 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 22 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 21 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 20 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 19 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++ starting: global end lumi: run = 1 lumi = 1 time = 1 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 35 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 34 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 33 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 32 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 ++++++ starting: global end lumi for module: label = 'thingWithMergeProducer' id = 31 ++++++ finished: global end lumi for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 33 ++++++ starting: global end lumi for module: label = 'testmerge' id = 33 ++++++ finished: global end lumi for module: label = 'testmerge' id = 33 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 32 ++++++ starting: global end lumi for module: label = 'test' id = 32 ++++++ finished: global end lumi for module: label = 'test' id = 32 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 34 ++++++ starting: global end lumi for module: label = 'get' id = 34 ++++++ finished: global end lumi for module: label = 'get' id = 34 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 35 ++++++ starting: global end lumi for module: label = 'getInt' id = 35 ++++++ finished: global end lumi for module: label = 'getInt' id = 35 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 ++++++ starting: global end lumi for module: label = 'dependsOnNoPut' id = 36 ++++++ finished: global end lumi for module: label = 'dependsOnNoPut' id = 36 ++++ finished: global end lumi: run = 1 lumi = 1 time = 1 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++++ starting: global end lumi for module: label = 'thingWithMergeProducer' id = 18 ++++++ finished: global end lumi for module: label = 'thingWithMergeProducer' id = 18 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 20 ++++++ starting: global end lumi for module: label = 'testmerge' id = 20 ++++++ finished: global end lumi for module: label = 'testmerge' id = 20 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 19 ++++++ starting: global end lumi for module: label = 'test' id = 19 ++++++ finished: global end lumi for module: label = 'test' id = 19 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 21 ++++++ starting: global end lumi for module: label = 'get' id = 21 ++++++ finished: global end lumi for module: label = 'get' id = 21 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 22 ++++++ starting: global end lumi for module: label = 'getInt' id = 22 ++++++ finished: global end lumi for module: label = 'getInt' id = 22 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 ++++++ starting: global end lumi for module: label = 'dependsOnNoPut' id = 23 ++++++ finished: global end lumi for module: label = 'dependsOnNoPut' id = 23 ++++ finished: global end lumi: run = 1 lumi = 1 time = 1 @@ -1101,42 +1203,74 @@ ++++ starting: global begin lumi: run = 1 lumi = 2 time = 25000001 ++++ finished: global begin lumi: run = 1 lumi = 2 time = 25000001 ++++ starting: global begin lumi: run = 1 lumi = 2 time = 25000001 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'noPut' id = 11 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 10 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 6 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 ++++++ starting: global begin lumi for module: label = 'thingWithMergeProducer' id = 5 ++++++ finished: global begin lumi for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 6 ++++++ starting: global begin lumi for module: label = 'get' id = 6 ++++++ finished: global begin lumi for module: label = 'get' id = 6 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 10 ++++++ starting: global begin lumi for module: label = 'getInt' id = 10 ++++++ finished: global begin lumi for module: label = 'getInt' id = 10 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'noPut' id = 11 ++++++ starting: global begin lumi for module: label = 'noPut' id = 11 ++++++ finished: global begin lumi for module: label = 'noPut' id = 11 ++++ finished: global begin lumi: run = 1 lumi = 2 time = 25000001 ++++ starting: global begin lumi: run = 1 lumi = 2 time = 25000001 ++++ finished: global begin lumi: run = 1 lumi = 2 time = 25000001 ++++ starting: global begin lumi: run = 1 lumi = 2 time = 25000001 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 22 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 21 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 20 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 19 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++ starting: global begin lumi: run = 1 lumi = 2 time = 25000001 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 35 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 34 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 33 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 32 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 ++++++ starting: global begin lumi for module: label = 'thingWithMergeProducer' id = 31 ++++++ finished: global begin lumi for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 32 ++++++ starting: global begin lumi for module: label = 'test' id = 32 ++++++ finished: global begin lumi for module: label = 'test' id = 32 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 33 ++++++ starting: global begin lumi for module: label = 'testmerge' id = 33 ++++++ finished: global begin lumi for module: label = 'testmerge' id = 33 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 34 ++++++ starting: global begin lumi for module: label = 'get' id = 34 ++++++ finished: global begin lumi for module: label = 'get' id = 34 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 35 ++++++ starting: global begin lumi for module: label = 'getInt' id = 35 ++++++ finished: global begin lumi for module: label = 'getInt' id = 35 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 ++++++ starting: global begin lumi for module: label = 'dependsOnNoPut' id = 36 ++++++ finished: global begin lumi for module: label = 'dependsOnNoPut' id = 36 ++++ finished: global begin lumi: run = 1 lumi = 2 time = 25000001 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++++ starting: global begin lumi for module: label = 'thingWithMergeProducer' id = 18 ++++++ finished: global begin lumi for module: label = 'thingWithMergeProducer' id = 18 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 19 ++++++ starting: global begin lumi for module: label = 'test' id = 19 ++++++ finished: global begin lumi for module: label = 'test' id = 19 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 20 ++++++ starting: global begin lumi for module: label = 'testmerge' id = 20 ++++++ finished: global begin lumi for module: label = 'testmerge' id = 20 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 21 ++++++ starting: global begin lumi for module: label = 'get' id = 21 ++++++ finished: global begin lumi for module: label = 'get' id = 21 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 22 ++++++ starting: global begin lumi for module: label = 'getInt' id = 22 ++++++ finished: global begin lumi for module: label = 'getInt' id = 22 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 ++++++ starting: global begin lumi for module: label = 'dependsOnNoPut' id = 23 ++++++ finished: global begin lumi for module: label = 'dependsOnNoPut' id = 23 ++++ finished: global begin lumi: run = 1 lumi = 2 time = 25000001 @@ -1807,42 +1941,74 @@ ++++ starting: global end lumi: run = 1 lumi = 2 time = 25000001 ++++ finished: global end lumi: run = 1 lumi = 2 time = 25000001 ++++ starting: global end lumi: run = 1 lumi = 2 time = 25000001 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'noPut' id = 11 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 10 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 6 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 ++++++ starting: global end lumi for module: label = 'thingWithMergeProducer' id = 5 ++++++ finished: global end lumi for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 6 ++++++ starting: global end lumi for module: label = 'get' id = 6 ++++++ finished: global end lumi for module: label = 'get' id = 6 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 10 ++++++ starting: global end lumi for module: label = 'getInt' id = 10 ++++++ finished: global end lumi for module: label = 'getInt' id = 10 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'noPut' id = 11 ++++++ starting: global end lumi for module: label = 'noPut' id = 11 ++++++ finished: global end lumi for module: label = 'noPut' id = 11 ++++ finished: global end lumi: run = 1 lumi = 2 time = 25000001 ++++ starting: global end lumi: run = 1 lumi = 2 time = 25000001 ++++ finished: global end lumi: run = 1 lumi = 2 time = 25000001 ++++ starting: global end lumi: run = 1 lumi = 2 time = 25000001 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 22 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 21 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 20 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 19 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++ starting: global end lumi: run = 1 lumi = 2 time = 25000001 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 35 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 34 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 33 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 32 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 ++++++ starting: global end lumi for module: label = 'thingWithMergeProducer' id = 31 ++++++ finished: global end lumi for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 33 ++++++ starting: global end lumi for module: label = 'testmerge' id = 33 ++++++ finished: global end lumi for module: label = 'testmerge' id = 33 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 32 ++++++ starting: global end lumi for module: label = 'test' id = 32 ++++++ finished: global end lumi for module: label = 'test' id = 32 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 34 ++++++ starting: global end lumi for module: label = 'get' id = 34 ++++++ finished: global end lumi for module: label = 'get' id = 34 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 35 ++++++ starting: global end lumi for module: label = 'getInt' id = 35 ++++++ finished: global end lumi for module: label = 'getInt' id = 35 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 ++++++ starting: global end lumi for module: label = 'dependsOnNoPut' id = 36 ++++++ finished: global end lumi for module: label = 'dependsOnNoPut' id = 36 ++++ finished: global end lumi: run = 1 lumi = 2 time = 25000001 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++++ starting: global end lumi for module: label = 'thingWithMergeProducer' id = 18 ++++++ finished: global end lumi for module: label = 'thingWithMergeProducer' id = 18 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 20 ++++++ starting: global end lumi for module: label = 'testmerge' id = 20 ++++++ finished: global end lumi for module: label = 'testmerge' id = 20 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 19 ++++++ starting: global end lumi for module: label = 'test' id = 19 ++++++ finished: global end lumi for module: label = 'test' id = 19 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 21 ++++++ starting: global end lumi for module: label = 'get' id = 21 ++++++ finished: global end lumi for module: label = 'get' id = 21 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 22 ++++++ starting: global end lumi for module: label = 'getInt' id = 22 ++++++ finished: global end lumi for module: label = 'getInt' id = 22 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 ++++++ starting: global end lumi for module: label = 'dependsOnNoPut' id = 23 ++++++ finished: global end lumi for module: label = 'dependsOnNoPut' id = 23 ++++ finished: global end lumi: run = 1 lumi = 2 time = 25000001 @@ -1870,42 +2036,74 @@ ++++ starting: global begin lumi: run = 1 lumi = 3 time = 45000001 ++++ finished: global begin lumi: run = 1 lumi = 3 time = 45000001 ++++ starting: global begin lumi: run = 1 lumi = 3 time = 45000001 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'noPut' id = 11 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 10 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 6 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 ++++++ starting: global begin lumi for module: label = 'thingWithMergeProducer' id = 5 ++++++ finished: global begin lumi for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 6 ++++++ starting: global begin lumi for module: label = 'get' id = 6 ++++++ finished: global begin lumi for module: label = 'get' id = 6 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 10 ++++++ starting: global begin lumi for module: label = 'getInt' id = 10 ++++++ finished: global begin lumi for module: label = 'getInt' id = 10 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'noPut' id = 11 ++++++ starting: global begin lumi for module: label = 'noPut' id = 11 ++++++ finished: global begin lumi for module: label = 'noPut' id = 11 ++++ finished: global begin lumi: run = 1 lumi = 3 time = 45000001 ++++ starting: global begin lumi: run = 1 lumi = 3 time = 45000001 ++++ finished: global begin lumi: run = 1 lumi = 3 time = 45000001 ++++ starting: global begin lumi: run = 1 lumi = 3 time = 45000001 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 22 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 21 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 20 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 19 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++ starting: global begin lumi: run = 1 lumi = 3 time = 45000001 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 35 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 34 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 33 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 32 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 ++++++ starting: global begin lumi for module: label = 'thingWithMergeProducer' id = 31 ++++++ finished: global begin lumi for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 32 ++++++ starting: global begin lumi for module: label = 'test' id = 32 ++++++ finished: global begin lumi for module: label = 'test' id = 32 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 33 ++++++ starting: global begin lumi for module: label = 'testmerge' id = 33 ++++++ finished: global begin lumi for module: label = 'testmerge' id = 33 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 34 ++++++ starting: global begin lumi for module: label = 'get' id = 34 ++++++ finished: global begin lumi for module: label = 'get' id = 34 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 35 ++++++ starting: global begin lumi for module: label = 'getInt' id = 35 ++++++ finished: global begin lumi for module: label = 'getInt' id = 35 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 ++++++ starting: global begin lumi for module: label = 'dependsOnNoPut' id = 36 ++++++ finished: global begin lumi for module: label = 'dependsOnNoPut' id = 36 ++++ finished: global begin lumi: run = 1 lumi = 3 time = 45000001 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++++ starting: global begin lumi for module: label = 'thingWithMergeProducer' id = 18 ++++++ finished: global begin lumi for module: label = 'thingWithMergeProducer' id = 18 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 19 ++++++ starting: global begin lumi for module: label = 'test' id = 19 ++++++ finished: global begin lumi for module: label = 'test' id = 19 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 20 ++++++ starting: global begin lumi for module: label = 'testmerge' id = 20 ++++++ finished: global begin lumi for module: label = 'testmerge' id = 20 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 21 ++++++ starting: global begin lumi for module: label = 'get' id = 21 ++++++ finished: global begin lumi for module: label = 'get' id = 21 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 22 ++++++ starting: global begin lumi for module: label = 'getInt' id = 22 ++++++ finished: global begin lumi for module: label = 'getInt' id = 22 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 ++++++ starting: global begin lumi for module: label = 'dependsOnNoPut' id = 23 ++++++ finished: global begin lumi for module: label = 'dependsOnNoPut' id = 23 ++++ finished: global begin lumi: run = 1 lumi = 3 time = 45000001 @@ -2262,42 +2460,74 @@ ++++ starting: global end lumi: run = 1 lumi = 3 time = 45000001 ++++ finished: global end lumi: run = 1 lumi = 3 time = 45000001 ++++ starting: global end lumi: run = 1 lumi = 3 time = 45000001 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'noPut' id = 11 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 10 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 6 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 ++++++ starting: global end lumi for module: label = 'thingWithMergeProducer' id = 5 ++++++ finished: global end lumi for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 6 ++++++ starting: global end lumi for module: label = 'get' id = 6 ++++++ finished: global end lumi for module: label = 'get' id = 6 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 10 ++++++ starting: global end lumi for module: label = 'getInt' id = 10 ++++++ finished: global end lumi for module: label = 'getInt' id = 10 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'noPut' id = 11 ++++++ starting: global end lumi for module: label = 'noPut' id = 11 ++++++ finished: global end lumi for module: label = 'noPut' id = 11 ++++ finished: global end lumi: run = 1 lumi = 3 time = 45000001 ++++ starting: global end lumi: run = 1 lumi = 3 time = 45000001 ++++ finished: global end lumi: run = 1 lumi = 3 time = 45000001 ++++ starting: global end lumi: run = 1 lumi = 3 time = 45000001 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 22 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 21 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 20 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 19 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++ starting: global end lumi: run = 1 lumi = 3 time = 45000001 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 35 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 34 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 33 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 32 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 ++++++ starting: global end lumi for module: label = 'thingWithMergeProducer' id = 31 ++++++ finished: global end lumi for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 33 ++++++ starting: global end lumi for module: label = 'testmerge' id = 33 ++++++ finished: global end lumi for module: label = 'testmerge' id = 33 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 32 ++++++ starting: global end lumi for module: label = 'test' id = 32 ++++++ finished: global end lumi for module: label = 'test' id = 32 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 34 ++++++ starting: global end lumi for module: label = 'get' id = 34 ++++++ finished: global end lumi for module: label = 'get' id = 34 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 35 ++++++ starting: global end lumi for module: label = 'getInt' id = 35 ++++++ finished: global end lumi for module: label = 'getInt' id = 35 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 ++++++ starting: global end lumi for module: label = 'dependsOnNoPut' id = 36 ++++++ finished: global end lumi for module: label = 'dependsOnNoPut' id = 36 ++++ finished: global end lumi: run = 1 lumi = 3 time = 45000001 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++++ starting: global end lumi for module: label = 'thingWithMergeProducer' id = 18 ++++++ finished: global end lumi for module: label = 'thingWithMergeProducer' id = 18 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 20 ++++++ starting: global end lumi for module: label = 'testmerge' id = 20 ++++++ finished: global end lumi for module: label = 'testmerge' id = 20 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 19 ++++++ starting: global end lumi for module: label = 'test' id = 19 ++++++ finished: global end lumi for module: label = 'test' id = 19 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 21 ++++++ starting: global end lumi for module: label = 'get' id = 21 ++++++ finished: global end lumi for module: label = 'get' id = 21 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 22 ++++++ starting: global end lumi for module: label = 'getInt' id = 22 ++++++ finished: global end lumi for module: label = 'getInt' id = 22 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 ++++++ starting: global end lumi for module: label = 'dependsOnNoPut' id = 23 ++++++ finished: global end lumi for module: label = 'dependsOnNoPut' id = 23 ++++ finished: global end lumi: run = 1 lumi = 3 time = 45000001 @@ -2342,42 +2572,74 @@ ++++ starting: global end run 1 : time = 0 ++++ finished: global end run 1 : time = 0 ++++ starting: global end run 1 : time = 0 +++++++++ starting: prefetching before processing global global end Run for module: label = 'noPut' id = 11 +++++++++ starting: prefetching before processing global global end Run for module: label = 'getInt' id = 10 +++++++++ starting: prefetching before processing global global end Run for module: label = 'get' id = 6 +++++++++ starting: prefetching before processing global global end Run for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global end Run for module: label = 'thingWithMergeProducer' id = 5 ++++++ starting: global end run for module: label = 'thingWithMergeProducer' id = 5 ++++++ finished: global end run for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global end Run for module: label = 'get' id = 6 ++++++ starting: global end run for module: label = 'get' id = 6 ++++++ finished: global end run for module: label = 'get' id = 6 +++++++++ finished: prefetching before processing global global end Run for module: label = 'getInt' id = 10 ++++++ starting: global end run for module: label = 'getInt' id = 10 ++++++ finished: global end run for module: label = 'getInt' id = 10 +++++++++ finished: prefetching before processing global global end Run for module: label = 'noPut' id = 11 ++++++ starting: global end run for module: label = 'noPut' id = 11 ++++++ finished: global end run for module: label = 'noPut' id = 11 ++++ finished: global end run 1 : time = 0 ++++ starting: global end run 1 : time = 0 ++++ finished: global end run 1 : time = 0 ++++ starting: global end run 1 : time = 0 +++++++++ starting: prefetching before processing global global end Run for module: label = 'dependsOnNoPut' id = 23 +++++++++ starting: prefetching before processing global global end Run for module: label = 'getInt' id = 22 +++++++++ starting: prefetching before processing global global end Run for module: label = 'get' id = 21 +++++++++ starting: prefetching before processing global global end Run for module: label = 'testmerge' id = 20 +++++++++ starting: prefetching before processing global global end Run for module: label = 'test' id = 19 +++++++++ starting: prefetching before processing global global end Run for module: label = 'thingWithMergeProducer' id = 18 ++++ starting: global end run 1 : time = 0 +++++++++ starting: prefetching before processing global global end Run for module: label = 'dependsOnNoPut' id = 36 +++++++++ starting: prefetching before processing global global end Run for module: label = 'getInt' id = 35 +++++++++ starting: prefetching before processing global global end Run for module: label = 'get' id = 34 +++++++++ starting: prefetching before processing global global end Run for module: label = 'testmerge' id = 33 +++++++++ starting: prefetching before processing global global end Run for module: label = 'test' id = 32 +++++++++ starting: prefetching before processing global global end Run for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global end Run for module: label = 'thingWithMergeProducer' id = 31 ++++++ starting: global end run for module: label = 'thingWithMergeProducer' id = 31 ++++++ finished: global end run for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global end Run for module: label = 'testmerge' id = 33 ++++++ starting: global end run for module: label = 'testmerge' id = 33 ++++++ finished: global end run for module: label = 'testmerge' id = 33 +++++++++ finished: prefetching before processing global global end Run for module: label = 'test' id = 32 ++++++ starting: global end run for module: label = 'test' id = 32 ++++++ finished: global end run for module: label = 'test' id = 32 +++++++++ finished: prefetching before processing global global end Run for module: label = 'get' id = 34 ++++++ starting: global end run for module: label = 'get' id = 34 ++++++ finished: global end run for module: label = 'get' id = 34 +++++++++ finished: prefetching before processing global global end Run for module: label = 'getInt' id = 35 ++++++ starting: global end run for module: label = 'getInt' id = 35 ++++++ finished: global end run for module: label = 'getInt' id = 35 +++++++++ finished: prefetching before processing global global end Run for module: label = 'dependsOnNoPut' id = 36 ++++++ starting: global end run for module: label = 'dependsOnNoPut' id = 36 ++++++ finished: global end run for module: label = 'dependsOnNoPut' id = 36 ++++ finished: global end run 1 : time = 0 +++++++++ finished: prefetching before processing global global end Run for module: label = 'thingWithMergeProducer' id = 18 ++++++ starting: global end run for module: label = 'thingWithMergeProducer' id = 18 ++++++ finished: global end run for module: label = 'thingWithMergeProducer' id = 18 +++++++++ finished: prefetching before processing global global end Run for module: label = 'testmerge' id = 20 ++++++ starting: global end run for module: label = 'testmerge' id = 20 ++++++ finished: global end run for module: label = 'testmerge' id = 20 +++++++++ finished: prefetching before processing global global end Run for module: label = 'test' id = 19 ++++++ starting: global end run for module: label = 'test' id = 19 ++++++ finished: global end run for module: label = 'test' id = 19 +++++++++ finished: prefetching before processing global global end Run for module: label = 'get' id = 21 ++++++ starting: global end run for module: label = 'get' id = 21 ++++++ finished: global end run for module: label = 'get' id = 21 +++++++++ finished: prefetching before processing global global end Run for module: label = 'getInt' id = 22 ++++++ starting: global end run for module: label = 'getInt' id = 22 ++++++ finished: global end run for module: label = 'getInt' id = 22 +++++++++ finished: prefetching before processing global global end Run for module: label = 'dependsOnNoPut' id = 23 ++++++ starting: global end run for module: label = 'dependsOnNoPut' id = 23 ++++++ finished: global end run for module: label = 'dependsOnNoPut' id = 23 ++++ finished: global end run 1 : time = 0 @@ -2406,42 +2668,74 @@ ++++ starting: global begin run 2 : time = 55000001 ++++ finished: global begin run 2 : time = 55000001 ++++ starting: global begin run 2 : time = 55000001 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'noPut' id = 11 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'getInt' id = 10 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'get' id = 6 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'thingWithMergeProducer' id = 5 ++++++ starting: global begin run for module: label = 'thingWithMergeProducer' id = 5 ++++++ finished: global begin run for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'get' id = 6 ++++++ starting: global begin run for module: label = 'get' id = 6 ++++++ finished: global begin run for module: label = 'get' id = 6 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'getInt' id = 10 ++++++ starting: global begin run for module: label = 'getInt' id = 10 ++++++ finished: global begin run for module: label = 'getInt' id = 10 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'noPut' id = 11 ++++++ starting: global begin run for module: label = 'noPut' id = 11 ++++++ finished: global begin run for module: label = 'noPut' id = 11 ++++ finished: global begin run 2 : time = 55000001 ++++ starting: global begin run 2 : time = 55000001 ++++ finished: global begin run 2 : time = 55000001 ++++ starting: global begin run 2 : time = 55000001 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'dependsOnNoPut' id = 23 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'getInt' id = 22 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'get' id = 21 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'testmerge' id = 20 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'test' id = 19 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'thingWithMergeProducer' id = 18 ++++ starting: global begin run 2 : time = 55000001 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'dependsOnNoPut' id = 36 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'getInt' id = 35 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'get' id = 34 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'testmerge' id = 33 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'test' id = 32 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'thingWithMergeProducer' id = 31 ++++++ starting: global begin run for module: label = 'thingWithMergeProducer' id = 31 ++++++ finished: global begin run for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'test' id = 32 ++++++ starting: global begin run for module: label = 'test' id = 32 ++++++ finished: global begin run for module: label = 'test' id = 32 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'testmerge' id = 33 ++++++ starting: global begin run for module: label = 'testmerge' id = 33 ++++++ finished: global begin run for module: label = 'testmerge' id = 33 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'get' id = 34 ++++++ starting: global begin run for module: label = 'get' id = 34 ++++++ finished: global begin run for module: label = 'get' id = 34 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'getInt' id = 35 ++++++ starting: global begin run for module: label = 'getInt' id = 35 ++++++ finished: global begin run for module: label = 'getInt' id = 35 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'dependsOnNoPut' id = 36 ++++++ starting: global begin run for module: label = 'dependsOnNoPut' id = 36 ++++++ finished: global begin run for module: label = 'dependsOnNoPut' id = 36 ++++ finished: global begin run 2 : time = 55000001 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'thingWithMergeProducer' id = 18 ++++++ starting: global begin run for module: label = 'thingWithMergeProducer' id = 18 ++++++ finished: global begin run for module: label = 'thingWithMergeProducer' id = 18 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'test' id = 19 ++++++ starting: global begin run for module: label = 'test' id = 19 ++++++ finished: global begin run for module: label = 'test' id = 19 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'testmerge' id = 20 ++++++ starting: global begin run for module: label = 'testmerge' id = 20 ++++++ finished: global begin run for module: label = 'testmerge' id = 20 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'get' id = 21 ++++++ starting: global begin run for module: label = 'get' id = 21 ++++++ finished: global begin run for module: label = 'get' id = 21 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'getInt' id = 22 ++++++ starting: global begin run for module: label = 'getInt' id = 22 ++++++ finished: global begin run for module: label = 'getInt' id = 22 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'dependsOnNoPut' id = 23 ++++++ starting: global begin run for module: label = 'dependsOnNoPut' id = 23 ++++++ finished: global begin run for module: label = 'dependsOnNoPut' id = 23 ++++ finished: global begin run 2 : time = 55000001 @@ -2473,42 +2767,74 @@ ++++ starting: global begin lumi: run = 2 lumi = 1 time = 55000001 ++++ finished: global begin lumi: run = 2 lumi = 1 time = 55000001 ++++ starting: global begin lumi: run = 2 lumi = 1 time = 55000001 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'noPut' id = 11 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 10 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 6 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 ++++++ starting: global begin lumi for module: label = 'thingWithMergeProducer' id = 5 ++++++ finished: global begin lumi for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 6 ++++++ starting: global begin lumi for module: label = 'get' id = 6 ++++++ finished: global begin lumi for module: label = 'get' id = 6 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 10 ++++++ starting: global begin lumi for module: label = 'getInt' id = 10 ++++++ finished: global begin lumi for module: label = 'getInt' id = 10 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'noPut' id = 11 ++++++ starting: global begin lumi for module: label = 'noPut' id = 11 ++++++ finished: global begin lumi for module: label = 'noPut' id = 11 ++++ finished: global begin lumi: run = 2 lumi = 1 time = 55000001 ++++ starting: global begin lumi: run = 2 lumi = 1 time = 55000001 ++++ finished: global begin lumi: run = 2 lumi = 1 time = 55000001 ++++ starting: global begin lumi: run = 2 lumi = 1 time = 55000001 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 22 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 21 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 20 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 19 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++ starting: global begin lumi: run = 2 lumi = 1 time = 55000001 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 35 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 34 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 33 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 32 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 ++++++ starting: global begin lumi for module: label = 'thingWithMergeProducer' id = 31 ++++++ finished: global begin lumi for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 32 ++++++ starting: global begin lumi for module: label = 'test' id = 32 ++++++ finished: global begin lumi for module: label = 'test' id = 32 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 33 ++++++ starting: global begin lumi for module: label = 'testmerge' id = 33 ++++++ finished: global begin lumi for module: label = 'testmerge' id = 33 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 34 ++++++ starting: global begin lumi for module: label = 'get' id = 34 ++++++ finished: global begin lumi for module: label = 'get' id = 34 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 35 ++++++ starting: global begin lumi for module: label = 'getInt' id = 35 ++++++ finished: global begin lumi for module: label = 'getInt' id = 35 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 ++++++ starting: global begin lumi for module: label = 'dependsOnNoPut' id = 36 ++++++ finished: global begin lumi for module: label = 'dependsOnNoPut' id = 36 ++++ finished: global begin lumi: run = 2 lumi = 1 time = 55000001 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++++ starting: global begin lumi for module: label = 'thingWithMergeProducer' id = 18 ++++++ finished: global begin lumi for module: label = 'thingWithMergeProducer' id = 18 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 19 ++++++ starting: global begin lumi for module: label = 'test' id = 19 ++++++ finished: global begin lumi for module: label = 'test' id = 19 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 20 ++++++ starting: global begin lumi for module: label = 'testmerge' id = 20 ++++++ finished: global begin lumi for module: label = 'testmerge' id = 20 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 21 ++++++ starting: global begin lumi for module: label = 'get' id = 21 ++++++ finished: global begin lumi for module: label = 'get' id = 21 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 22 ++++++ starting: global begin lumi for module: label = 'getInt' id = 22 ++++++ finished: global begin lumi for module: label = 'getInt' id = 22 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 ++++++ starting: global begin lumi for module: label = 'dependsOnNoPut' id = 23 ++++++ finished: global begin lumi for module: label = 'dependsOnNoPut' id = 23 ++++ finished: global begin lumi: run = 2 lumi = 1 time = 55000001 @@ -3179,42 +3505,74 @@ ++++ starting: global end lumi: run = 2 lumi = 1 time = 55000001 ++++ finished: global end lumi: run = 2 lumi = 1 time = 55000001 ++++ starting: global end lumi: run = 2 lumi = 1 time = 55000001 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'noPut' id = 11 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 10 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 6 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 ++++++ starting: global end lumi for module: label = 'thingWithMergeProducer' id = 5 ++++++ finished: global end lumi for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 6 ++++++ starting: global end lumi for module: label = 'get' id = 6 ++++++ finished: global end lumi for module: label = 'get' id = 6 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 10 ++++++ starting: global end lumi for module: label = 'getInt' id = 10 ++++++ finished: global end lumi for module: label = 'getInt' id = 10 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'noPut' id = 11 ++++++ starting: global end lumi for module: label = 'noPut' id = 11 ++++++ finished: global end lumi for module: label = 'noPut' id = 11 ++++ finished: global end lumi: run = 2 lumi = 1 time = 55000001 ++++ starting: global end lumi: run = 2 lumi = 1 time = 55000001 ++++ finished: global end lumi: run = 2 lumi = 1 time = 55000001 ++++ starting: global end lumi: run = 2 lumi = 1 time = 55000001 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 22 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 21 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 20 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 19 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++ starting: global end lumi: run = 2 lumi = 1 time = 55000001 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 35 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 34 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 33 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 32 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 ++++++ starting: global end lumi for module: label = 'thingWithMergeProducer' id = 31 ++++++ finished: global end lumi for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 33 ++++++ starting: global end lumi for module: label = 'testmerge' id = 33 ++++++ finished: global end lumi for module: label = 'testmerge' id = 33 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 32 ++++++ starting: global end lumi for module: label = 'test' id = 32 ++++++ finished: global end lumi for module: label = 'test' id = 32 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 34 ++++++ starting: global end lumi for module: label = 'get' id = 34 ++++++ finished: global end lumi for module: label = 'get' id = 34 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 35 ++++++ starting: global end lumi for module: label = 'getInt' id = 35 ++++++ finished: global end lumi for module: label = 'getInt' id = 35 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 ++++++ starting: global end lumi for module: label = 'dependsOnNoPut' id = 36 ++++++ finished: global end lumi for module: label = 'dependsOnNoPut' id = 36 ++++ finished: global end lumi: run = 2 lumi = 1 time = 55000001 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++++ starting: global end lumi for module: label = 'thingWithMergeProducer' id = 18 ++++++ finished: global end lumi for module: label = 'thingWithMergeProducer' id = 18 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 20 ++++++ starting: global end lumi for module: label = 'testmerge' id = 20 ++++++ finished: global end lumi for module: label = 'testmerge' id = 20 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 19 ++++++ starting: global end lumi for module: label = 'test' id = 19 ++++++ finished: global end lumi for module: label = 'test' id = 19 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 21 ++++++ starting: global end lumi for module: label = 'get' id = 21 ++++++ finished: global end lumi for module: label = 'get' id = 21 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 22 ++++++ starting: global end lumi for module: label = 'getInt' id = 22 ++++++ finished: global end lumi for module: label = 'getInt' id = 22 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 ++++++ starting: global end lumi for module: label = 'dependsOnNoPut' id = 23 ++++++ finished: global end lumi for module: label = 'dependsOnNoPut' id = 23 ++++ finished: global end lumi: run = 2 lumi = 1 time = 55000001 @@ -3242,42 +3600,74 @@ ++++ starting: global begin lumi: run = 2 lumi = 2 time = 75000001 ++++ finished: global begin lumi: run = 2 lumi = 2 time = 75000001 ++++ starting: global begin lumi: run = 2 lumi = 2 time = 75000001 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'noPut' id = 11 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 10 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 6 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 ++++++ starting: global begin lumi for module: label = 'thingWithMergeProducer' id = 5 ++++++ finished: global begin lumi for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 6 ++++++ starting: global begin lumi for module: label = 'get' id = 6 ++++++ finished: global begin lumi for module: label = 'get' id = 6 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 10 ++++++ starting: global begin lumi for module: label = 'getInt' id = 10 ++++++ finished: global begin lumi for module: label = 'getInt' id = 10 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'noPut' id = 11 ++++++ starting: global begin lumi for module: label = 'noPut' id = 11 ++++++ finished: global begin lumi for module: label = 'noPut' id = 11 ++++ finished: global begin lumi: run = 2 lumi = 2 time = 75000001 ++++ starting: global begin lumi: run = 2 lumi = 2 time = 75000001 ++++ finished: global begin lumi: run = 2 lumi = 2 time = 75000001 ++++ starting: global begin lumi: run = 2 lumi = 2 time = 75000001 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 22 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 21 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 20 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 19 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++ starting: global begin lumi: run = 2 lumi = 2 time = 75000001 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 35 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 34 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 33 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 32 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 ++++++ starting: global begin lumi for module: label = 'thingWithMergeProducer' id = 31 ++++++ finished: global begin lumi for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 32 ++++++ starting: global begin lumi for module: label = 'test' id = 32 ++++++ finished: global begin lumi for module: label = 'test' id = 32 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 33 ++++++ starting: global begin lumi for module: label = 'testmerge' id = 33 ++++++ finished: global begin lumi for module: label = 'testmerge' id = 33 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 34 ++++++ starting: global begin lumi for module: label = 'get' id = 34 ++++++ finished: global begin lumi for module: label = 'get' id = 34 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 35 ++++++ starting: global begin lumi for module: label = 'getInt' id = 35 ++++++ finished: global begin lumi for module: label = 'getInt' id = 35 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 ++++++ starting: global begin lumi for module: label = 'dependsOnNoPut' id = 36 ++++++ finished: global begin lumi for module: label = 'dependsOnNoPut' id = 36 ++++ finished: global begin lumi: run = 2 lumi = 2 time = 75000001 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++++ starting: global begin lumi for module: label = 'thingWithMergeProducer' id = 18 ++++++ finished: global begin lumi for module: label = 'thingWithMergeProducer' id = 18 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 19 ++++++ starting: global begin lumi for module: label = 'test' id = 19 ++++++ finished: global begin lumi for module: label = 'test' id = 19 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 20 ++++++ starting: global begin lumi for module: label = 'testmerge' id = 20 ++++++ finished: global begin lumi for module: label = 'testmerge' id = 20 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 21 ++++++ starting: global begin lumi for module: label = 'get' id = 21 ++++++ finished: global begin lumi for module: label = 'get' id = 21 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 22 ++++++ starting: global begin lumi for module: label = 'getInt' id = 22 ++++++ finished: global begin lumi for module: label = 'getInt' id = 22 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 ++++++ starting: global begin lumi for module: label = 'dependsOnNoPut' id = 23 ++++++ finished: global begin lumi for module: label = 'dependsOnNoPut' id = 23 ++++ finished: global begin lumi: run = 2 lumi = 2 time = 75000001 @@ -3948,42 +4338,74 @@ ++++ starting: global end lumi: run = 2 lumi = 2 time = 75000001 ++++ finished: global end lumi: run = 2 lumi = 2 time = 75000001 ++++ starting: global end lumi: run = 2 lumi = 2 time = 75000001 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'noPut' id = 11 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 10 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 6 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 ++++++ starting: global end lumi for module: label = 'thingWithMergeProducer' id = 5 ++++++ finished: global end lumi for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 6 ++++++ starting: global end lumi for module: label = 'get' id = 6 ++++++ finished: global end lumi for module: label = 'get' id = 6 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 10 ++++++ starting: global end lumi for module: label = 'getInt' id = 10 ++++++ finished: global end lumi for module: label = 'getInt' id = 10 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'noPut' id = 11 ++++++ starting: global end lumi for module: label = 'noPut' id = 11 ++++++ finished: global end lumi for module: label = 'noPut' id = 11 ++++ finished: global end lumi: run = 2 lumi = 2 time = 75000001 ++++ starting: global end lumi: run = 2 lumi = 2 time = 75000001 ++++ finished: global end lumi: run = 2 lumi = 2 time = 75000001 ++++ starting: global end lumi: run = 2 lumi = 2 time = 75000001 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 22 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 21 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 20 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 19 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++ starting: global end lumi: run = 2 lumi = 2 time = 75000001 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 35 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 34 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 33 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 32 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 ++++++ starting: global end lumi for module: label = 'thingWithMergeProducer' id = 31 ++++++ finished: global end lumi for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 33 ++++++ starting: global end lumi for module: label = 'testmerge' id = 33 ++++++ finished: global end lumi for module: label = 'testmerge' id = 33 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 32 ++++++ starting: global end lumi for module: label = 'test' id = 32 ++++++ finished: global end lumi for module: label = 'test' id = 32 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 34 ++++++ starting: global end lumi for module: label = 'get' id = 34 ++++++ finished: global end lumi for module: label = 'get' id = 34 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 35 ++++++ starting: global end lumi for module: label = 'getInt' id = 35 ++++++ finished: global end lumi for module: label = 'getInt' id = 35 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 ++++++ starting: global end lumi for module: label = 'dependsOnNoPut' id = 36 ++++++ finished: global end lumi for module: label = 'dependsOnNoPut' id = 36 ++++ finished: global end lumi: run = 2 lumi = 2 time = 75000001 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++++ starting: global end lumi for module: label = 'thingWithMergeProducer' id = 18 ++++++ finished: global end lumi for module: label = 'thingWithMergeProducer' id = 18 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 20 ++++++ starting: global end lumi for module: label = 'testmerge' id = 20 ++++++ finished: global end lumi for module: label = 'testmerge' id = 20 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 19 ++++++ starting: global end lumi for module: label = 'test' id = 19 ++++++ finished: global end lumi for module: label = 'test' id = 19 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 21 ++++++ starting: global end lumi for module: label = 'get' id = 21 ++++++ finished: global end lumi for module: label = 'get' id = 21 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 22 ++++++ starting: global end lumi for module: label = 'getInt' id = 22 ++++++ finished: global end lumi for module: label = 'getInt' id = 22 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 ++++++ starting: global end lumi for module: label = 'dependsOnNoPut' id = 23 ++++++ finished: global end lumi for module: label = 'dependsOnNoPut' id = 23 ++++ finished: global end lumi: run = 2 lumi = 2 time = 75000001 @@ -4011,42 +4433,74 @@ ++++ starting: global begin lumi: run = 2 lumi = 3 time = 95000001 ++++ finished: global begin lumi: run = 2 lumi = 3 time = 95000001 ++++ starting: global begin lumi: run = 2 lumi = 3 time = 95000001 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'noPut' id = 11 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 10 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 6 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 ++++++ starting: global begin lumi for module: label = 'thingWithMergeProducer' id = 5 ++++++ finished: global begin lumi for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 6 ++++++ starting: global begin lumi for module: label = 'get' id = 6 ++++++ finished: global begin lumi for module: label = 'get' id = 6 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 10 ++++++ starting: global begin lumi for module: label = 'getInt' id = 10 ++++++ finished: global begin lumi for module: label = 'getInt' id = 10 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'noPut' id = 11 ++++++ starting: global begin lumi for module: label = 'noPut' id = 11 ++++++ finished: global begin lumi for module: label = 'noPut' id = 11 ++++ finished: global begin lumi: run = 2 lumi = 3 time = 95000001 ++++ starting: global begin lumi: run = 2 lumi = 3 time = 95000001 ++++ finished: global begin lumi: run = 2 lumi = 3 time = 95000001 ++++ starting: global begin lumi: run = 2 lumi = 3 time = 95000001 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 22 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 21 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 20 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 19 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++ starting: global begin lumi: run = 2 lumi = 3 time = 95000001 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 35 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 34 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 33 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 32 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 ++++++ starting: global begin lumi for module: label = 'thingWithMergeProducer' id = 31 ++++++ finished: global begin lumi for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 32 ++++++ starting: global begin lumi for module: label = 'test' id = 32 ++++++ finished: global begin lumi for module: label = 'test' id = 32 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 33 ++++++ starting: global begin lumi for module: label = 'testmerge' id = 33 ++++++ finished: global begin lumi for module: label = 'testmerge' id = 33 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 34 ++++++ starting: global begin lumi for module: label = 'get' id = 34 ++++++ finished: global begin lumi for module: label = 'get' id = 34 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 35 ++++++ starting: global begin lumi for module: label = 'getInt' id = 35 ++++++ finished: global begin lumi for module: label = 'getInt' id = 35 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 ++++++ starting: global begin lumi for module: label = 'dependsOnNoPut' id = 36 ++++++ finished: global begin lumi for module: label = 'dependsOnNoPut' id = 36 ++++ finished: global begin lumi: run = 2 lumi = 3 time = 95000001 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++++ starting: global begin lumi for module: label = 'thingWithMergeProducer' id = 18 ++++++ finished: global begin lumi for module: label = 'thingWithMergeProducer' id = 18 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 19 ++++++ starting: global begin lumi for module: label = 'test' id = 19 ++++++ finished: global begin lumi for module: label = 'test' id = 19 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 20 ++++++ starting: global begin lumi for module: label = 'testmerge' id = 20 ++++++ finished: global begin lumi for module: label = 'testmerge' id = 20 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 21 ++++++ starting: global begin lumi for module: label = 'get' id = 21 ++++++ finished: global begin lumi for module: label = 'get' id = 21 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 22 ++++++ starting: global begin lumi for module: label = 'getInt' id = 22 ++++++ finished: global begin lumi for module: label = 'getInt' id = 22 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 ++++++ starting: global begin lumi for module: label = 'dependsOnNoPut' id = 23 ++++++ finished: global begin lumi for module: label = 'dependsOnNoPut' id = 23 ++++ finished: global begin lumi: run = 2 lumi = 3 time = 95000001 @@ -4403,42 +4857,74 @@ ++++ starting: global end lumi: run = 2 lumi = 3 time = 95000001 ++++ finished: global end lumi: run = 2 lumi = 3 time = 95000001 ++++ starting: global end lumi: run = 2 lumi = 3 time = 95000001 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'noPut' id = 11 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 10 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 6 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 ++++++ starting: global end lumi for module: label = 'thingWithMergeProducer' id = 5 ++++++ finished: global end lumi for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 6 ++++++ starting: global end lumi for module: label = 'get' id = 6 ++++++ finished: global end lumi for module: label = 'get' id = 6 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 10 ++++++ starting: global end lumi for module: label = 'getInt' id = 10 ++++++ finished: global end lumi for module: label = 'getInt' id = 10 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'noPut' id = 11 ++++++ starting: global end lumi for module: label = 'noPut' id = 11 ++++++ finished: global end lumi for module: label = 'noPut' id = 11 ++++ finished: global end lumi: run = 2 lumi = 3 time = 95000001 ++++ starting: global end lumi: run = 2 lumi = 3 time = 95000001 ++++ finished: global end lumi: run = 2 lumi = 3 time = 95000001 ++++ starting: global end lumi: run = 2 lumi = 3 time = 95000001 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 22 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 21 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 20 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 19 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++ starting: global end lumi: run = 2 lumi = 3 time = 95000001 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 35 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 34 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 33 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 32 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 ++++++ starting: global end lumi for module: label = 'thingWithMergeProducer' id = 31 ++++++ finished: global end lumi for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 33 ++++++ starting: global end lumi for module: label = 'testmerge' id = 33 ++++++ finished: global end lumi for module: label = 'testmerge' id = 33 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 32 ++++++ starting: global end lumi for module: label = 'test' id = 32 ++++++ finished: global end lumi for module: label = 'test' id = 32 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 34 ++++++ starting: global end lumi for module: label = 'get' id = 34 ++++++ finished: global end lumi for module: label = 'get' id = 34 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 35 ++++++ starting: global end lumi for module: label = 'getInt' id = 35 ++++++ finished: global end lumi for module: label = 'getInt' id = 35 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 ++++++ starting: global end lumi for module: label = 'dependsOnNoPut' id = 36 ++++++ finished: global end lumi for module: label = 'dependsOnNoPut' id = 36 ++++ finished: global end lumi: run = 2 lumi = 3 time = 95000001 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++++ starting: global end lumi for module: label = 'thingWithMergeProducer' id = 18 ++++++ finished: global end lumi for module: label = 'thingWithMergeProducer' id = 18 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 20 ++++++ starting: global end lumi for module: label = 'testmerge' id = 20 ++++++ finished: global end lumi for module: label = 'testmerge' id = 20 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 19 ++++++ starting: global end lumi for module: label = 'test' id = 19 ++++++ finished: global end lumi for module: label = 'test' id = 19 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 21 ++++++ starting: global end lumi for module: label = 'get' id = 21 ++++++ finished: global end lumi for module: label = 'get' id = 21 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 22 ++++++ starting: global end lumi for module: label = 'getInt' id = 22 ++++++ finished: global end lumi for module: label = 'getInt' id = 22 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 ++++++ starting: global end lumi for module: label = 'dependsOnNoPut' id = 23 ++++++ finished: global end lumi for module: label = 'dependsOnNoPut' id = 23 ++++ finished: global end lumi: run = 2 lumi = 3 time = 95000001 @@ -4483,42 +4969,74 @@ ++++ starting: global end run 2 : time = 0 ++++ finished: global end run 2 : time = 0 ++++ starting: global end run 2 : time = 0 +++++++++ starting: prefetching before processing global global end Run for module: label = 'noPut' id = 11 +++++++++ starting: prefetching before processing global global end Run for module: label = 'getInt' id = 10 +++++++++ starting: prefetching before processing global global end Run for module: label = 'get' id = 6 +++++++++ starting: prefetching before processing global global end Run for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global end Run for module: label = 'thingWithMergeProducer' id = 5 ++++++ starting: global end run for module: label = 'thingWithMergeProducer' id = 5 ++++++ finished: global end run for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global end Run for module: label = 'get' id = 6 ++++++ starting: global end run for module: label = 'get' id = 6 ++++++ finished: global end run for module: label = 'get' id = 6 +++++++++ finished: prefetching before processing global global end Run for module: label = 'getInt' id = 10 ++++++ starting: global end run for module: label = 'getInt' id = 10 ++++++ finished: global end run for module: label = 'getInt' id = 10 +++++++++ finished: prefetching before processing global global end Run for module: label = 'noPut' id = 11 ++++++ starting: global end run for module: label = 'noPut' id = 11 ++++++ finished: global end run for module: label = 'noPut' id = 11 ++++ finished: global end run 2 : time = 0 ++++ starting: global end run 2 : time = 0 ++++ finished: global end run 2 : time = 0 ++++ starting: global end run 2 : time = 0 +++++++++ starting: prefetching before processing global global end Run for module: label = 'dependsOnNoPut' id = 23 +++++++++ starting: prefetching before processing global global end Run for module: label = 'getInt' id = 22 +++++++++ starting: prefetching before processing global global end Run for module: label = 'get' id = 21 +++++++++ starting: prefetching before processing global global end Run for module: label = 'testmerge' id = 20 +++++++++ starting: prefetching before processing global global end Run for module: label = 'test' id = 19 +++++++++ starting: prefetching before processing global global end Run for module: label = 'thingWithMergeProducer' id = 18 ++++ starting: global end run 2 : time = 0 +++++++++ starting: prefetching before processing global global end Run for module: label = 'dependsOnNoPut' id = 36 +++++++++ starting: prefetching before processing global global end Run for module: label = 'getInt' id = 35 +++++++++ starting: prefetching before processing global global end Run for module: label = 'get' id = 34 +++++++++ starting: prefetching before processing global global end Run for module: label = 'testmerge' id = 33 +++++++++ starting: prefetching before processing global global end Run for module: label = 'test' id = 32 +++++++++ starting: prefetching before processing global global end Run for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global end Run for module: label = 'thingWithMergeProducer' id = 31 ++++++ starting: global end run for module: label = 'thingWithMergeProducer' id = 31 ++++++ finished: global end run for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global end Run for module: label = 'testmerge' id = 33 ++++++ starting: global end run for module: label = 'testmerge' id = 33 ++++++ finished: global end run for module: label = 'testmerge' id = 33 +++++++++ finished: prefetching before processing global global end Run for module: label = 'test' id = 32 ++++++ starting: global end run for module: label = 'test' id = 32 ++++++ finished: global end run for module: label = 'test' id = 32 +++++++++ finished: prefetching before processing global global end Run for module: label = 'get' id = 34 ++++++ starting: global end run for module: label = 'get' id = 34 ++++++ finished: global end run for module: label = 'get' id = 34 +++++++++ finished: prefetching before processing global global end Run for module: label = 'getInt' id = 35 ++++++ starting: global end run for module: label = 'getInt' id = 35 ++++++ finished: global end run for module: label = 'getInt' id = 35 +++++++++ finished: prefetching before processing global global end Run for module: label = 'dependsOnNoPut' id = 36 ++++++ starting: global end run for module: label = 'dependsOnNoPut' id = 36 ++++++ finished: global end run for module: label = 'dependsOnNoPut' id = 36 ++++ finished: global end run 2 : time = 0 +++++++++ finished: prefetching before processing global global end Run for module: label = 'thingWithMergeProducer' id = 18 ++++++ starting: global end run for module: label = 'thingWithMergeProducer' id = 18 ++++++ finished: global end run for module: label = 'thingWithMergeProducer' id = 18 +++++++++ finished: prefetching before processing global global end Run for module: label = 'testmerge' id = 20 ++++++ starting: global end run for module: label = 'testmerge' id = 20 ++++++ finished: global end run for module: label = 'testmerge' id = 20 +++++++++ finished: prefetching before processing global global end Run for module: label = 'test' id = 19 ++++++ starting: global end run for module: label = 'test' id = 19 ++++++ finished: global end run for module: label = 'test' id = 19 +++++++++ finished: prefetching before processing global global end Run for module: label = 'get' id = 21 ++++++ starting: global end run for module: label = 'get' id = 21 ++++++ finished: global end run for module: label = 'get' id = 21 +++++++++ finished: prefetching before processing global global end Run for module: label = 'getInt' id = 22 ++++++ starting: global end run for module: label = 'getInt' id = 22 ++++++ finished: global end run for module: label = 'getInt' id = 22 +++++++++ finished: prefetching before processing global global end Run for module: label = 'dependsOnNoPut' id = 23 ++++++ starting: global end run for module: label = 'dependsOnNoPut' id = 23 ++++++ finished: global end run for module: label = 'dependsOnNoPut' id = 23 ++++ finished: global end run 2 : time = 0 @@ -4547,42 +5065,74 @@ ++++ starting: global begin run 3 : time = 105000001 ++++ finished: global begin run 3 : time = 105000001 ++++ starting: global begin run 3 : time = 105000001 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'noPut' id = 11 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'getInt' id = 10 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'get' id = 6 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'thingWithMergeProducer' id = 5 ++++++ starting: global begin run for module: label = 'thingWithMergeProducer' id = 5 ++++++ finished: global begin run for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'get' id = 6 ++++++ starting: global begin run for module: label = 'get' id = 6 ++++++ finished: global begin run for module: label = 'get' id = 6 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'getInt' id = 10 ++++++ starting: global begin run for module: label = 'getInt' id = 10 ++++++ finished: global begin run for module: label = 'getInt' id = 10 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'noPut' id = 11 ++++++ starting: global begin run for module: label = 'noPut' id = 11 ++++++ finished: global begin run for module: label = 'noPut' id = 11 ++++ finished: global begin run 3 : time = 105000001 ++++ starting: global begin run 3 : time = 105000001 ++++ finished: global begin run 3 : time = 105000001 ++++ starting: global begin run 3 : time = 105000001 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'dependsOnNoPut' id = 23 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'getInt' id = 22 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'get' id = 21 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'testmerge' id = 20 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'test' id = 19 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'thingWithMergeProducer' id = 18 ++++ starting: global begin run 3 : time = 105000001 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'dependsOnNoPut' id = 36 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'getInt' id = 35 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'get' id = 34 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'testmerge' id = 33 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'test' id = 32 +++++++++ starting: prefetching before processing global global begin Run for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'thingWithMergeProducer' id = 31 ++++++ starting: global begin run for module: label = 'thingWithMergeProducer' id = 31 ++++++ finished: global begin run for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'test' id = 32 ++++++ starting: global begin run for module: label = 'test' id = 32 ++++++ finished: global begin run for module: label = 'test' id = 32 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'testmerge' id = 33 ++++++ starting: global begin run for module: label = 'testmerge' id = 33 ++++++ finished: global begin run for module: label = 'testmerge' id = 33 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'get' id = 34 ++++++ starting: global begin run for module: label = 'get' id = 34 ++++++ finished: global begin run for module: label = 'get' id = 34 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'getInt' id = 35 ++++++ starting: global begin run for module: label = 'getInt' id = 35 ++++++ finished: global begin run for module: label = 'getInt' id = 35 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'dependsOnNoPut' id = 36 ++++++ starting: global begin run for module: label = 'dependsOnNoPut' id = 36 ++++++ finished: global begin run for module: label = 'dependsOnNoPut' id = 36 ++++ finished: global begin run 3 : time = 105000001 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'thingWithMergeProducer' id = 18 ++++++ starting: global begin run for module: label = 'thingWithMergeProducer' id = 18 ++++++ finished: global begin run for module: label = 'thingWithMergeProducer' id = 18 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'test' id = 19 ++++++ starting: global begin run for module: label = 'test' id = 19 ++++++ finished: global begin run for module: label = 'test' id = 19 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'testmerge' id = 20 ++++++ starting: global begin run for module: label = 'testmerge' id = 20 ++++++ finished: global begin run for module: label = 'testmerge' id = 20 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'get' id = 21 ++++++ starting: global begin run for module: label = 'get' id = 21 ++++++ finished: global begin run for module: label = 'get' id = 21 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'getInt' id = 22 ++++++ starting: global begin run for module: label = 'getInt' id = 22 ++++++ finished: global begin run for module: label = 'getInt' id = 22 +++++++++ finished: prefetching before processing global global begin Run for module: label = 'dependsOnNoPut' id = 23 ++++++ starting: global begin run for module: label = 'dependsOnNoPut' id = 23 ++++++ finished: global begin run for module: label = 'dependsOnNoPut' id = 23 ++++ finished: global begin run 3 : time = 105000001 @@ -4614,42 +5164,74 @@ ++++ starting: global begin lumi: run = 3 lumi = 1 time = 105000001 ++++ finished: global begin lumi: run = 3 lumi = 1 time = 105000001 ++++ starting: global begin lumi: run = 3 lumi = 1 time = 105000001 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'noPut' id = 11 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 10 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 6 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 ++++++ starting: global begin lumi for module: label = 'thingWithMergeProducer' id = 5 ++++++ finished: global begin lumi for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 6 ++++++ starting: global begin lumi for module: label = 'get' id = 6 ++++++ finished: global begin lumi for module: label = 'get' id = 6 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 10 ++++++ starting: global begin lumi for module: label = 'getInt' id = 10 ++++++ finished: global begin lumi for module: label = 'getInt' id = 10 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'noPut' id = 11 ++++++ starting: global begin lumi for module: label = 'noPut' id = 11 ++++++ finished: global begin lumi for module: label = 'noPut' id = 11 ++++ finished: global begin lumi: run = 3 lumi = 1 time = 105000001 ++++ starting: global begin lumi: run = 3 lumi = 1 time = 105000001 ++++ finished: global begin lumi: run = 3 lumi = 1 time = 105000001 ++++ starting: global begin lumi: run = 3 lumi = 1 time = 105000001 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 22 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 21 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 20 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 19 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++ starting: global begin lumi: run = 3 lumi = 1 time = 105000001 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 35 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 34 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 33 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 32 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 ++++++ starting: global begin lumi for module: label = 'thingWithMergeProducer' id = 31 ++++++ finished: global begin lumi for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 32 ++++++ starting: global begin lumi for module: label = 'test' id = 32 ++++++ finished: global begin lumi for module: label = 'test' id = 32 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 33 ++++++ starting: global begin lumi for module: label = 'testmerge' id = 33 ++++++ finished: global begin lumi for module: label = 'testmerge' id = 33 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 34 ++++++ starting: global begin lumi for module: label = 'get' id = 34 ++++++ finished: global begin lumi for module: label = 'get' id = 34 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 35 ++++++ starting: global begin lumi for module: label = 'getInt' id = 35 ++++++ finished: global begin lumi for module: label = 'getInt' id = 35 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 ++++++ starting: global begin lumi for module: label = 'dependsOnNoPut' id = 36 ++++++ finished: global begin lumi for module: label = 'dependsOnNoPut' id = 36 ++++ finished: global begin lumi: run = 3 lumi = 1 time = 105000001 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++++ starting: global begin lumi for module: label = 'thingWithMergeProducer' id = 18 ++++++ finished: global begin lumi for module: label = 'thingWithMergeProducer' id = 18 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 19 ++++++ starting: global begin lumi for module: label = 'test' id = 19 ++++++ finished: global begin lumi for module: label = 'test' id = 19 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 20 ++++++ starting: global begin lumi for module: label = 'testmerge' id = 20 ++++++ finished: global begin lumi for module: label = 'testmerge' id = 20 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 21 ++++++ starting: global begin lumi for module: label = 'get' id = 21 ++++++ finished: global begin lumi for module: label = 'get' id = 21 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 22 ++++++ starting: global begin lumi for module: label = 'getInt' id = 22 ++++++ finished: global begin lumi for module: label = 'getInt' id = 22 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 ++++++ starting: global begin lumi for module: label = 'dependsOnNoPut' id = 23 ++++++ finished: global begin lumi for module: label = 'dependsOnNoPut' id = 23 ++++ finished: global begin lumi: run = 3 lumi = 1 time = 105000001 @@ -5319,42 +5901,74 @@ ++++ starting: global end lumi: run = 3 lumi = 1 time = 105000001 ++++ finished: global end lumi: run = 3 lumi = 1 time = 105000001 ++++ starting: global end lumi: run = 3 lumi = 1 time = 105000001 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'noPut' id = 11 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 10 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 6 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 ++++++ starting: global end lumi for module: label = 'thingWithMergeProducer' id = 5 ++++++ finished: global end lumi for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 6 ++++++ starting: global end lumi for module: label = 'get' id = 6 ++++++ finished: global end lumi for module: label = 'get' id = 6 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 10 ++++++ starting: global end lumi for module: label = 'getInt' id = 10 ++++++ finished: global end lumi for module: label = 'getInt' id = 10 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'noPut' id = 11 ++++++ starting: global end lumi for module: label = 'noPut' id = 11 ++++++ finished: global end lumi for module: label = 'noPut' id = 11 ++++ finished: global end lumi: run = 3 lumi = 1 time = 105000001 ++++ starting: global end lumi: run = 3 lumi = 1 time = 105000001 ++++ finished: global end lumi: run = 3 lumi = 1 time = 105000001 ++++ starting: global end lumi: run = 3 lumi = 1 time = 105000001 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 22 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 21 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 20 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 19 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++ starting: global end lumi: run = 3 lumi = 1 time = 105000001 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 35 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 34 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 33 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 32 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 ++++++ starting: global end lumi for module: label = 'thingWithMergeProducer' id = 31 ++++++ finished: global end lumi for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 33 ++++++ starting: global end lumi for module: label = 'testmerge' id = 33 ++++++ finished: global end lumi for module: label = 'testmerge' id = 33 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 32 ++++++ starting: global end lumi for module: label = 'test' id = 32 ++++++ finished: global end lumi for module: label = 'test' id = 32 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 34 ++++++ starting: global end lumi for module: label = 'get' id = 34 ++++++ finished: global end lumi for module: label = 'get' id = 34 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 35 ++++++ starting: global end lumi for module: label = 'getInt' id = 35 ++++++ finished: global end lumi for module: label = 'getInt' id = 35 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 ++++++ starting: global end lumi for module: label = 'dependsOnNoPut' id = 36 ++++++ finished: global end lumi for module: label = 'dependsOnNoPut' id = 36 ++++ finished: global end lumi: run = 3 lumi = 1 time = 105000001 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++++ starting: global end lumi for module: label = 'thingWithMergeProducer' id = 18 ++++++ finished: global end lumi for module: label = 'thingWithMergeProducer' id = 18 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 20 ++++++ starting: global end lumi for module: label = 'testmerge' id = 20 ++++++ finished: global end lumi for module: label = 'testmerge' id = 20 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 19 ++++++ starting: global end lumi for module: label = 'test' id = 19 ++++++ finished: global end lumi for module: label = 'test' id = 19 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 21 ++++++ starting: global end lumi for module: label = 'get' id = 21 ++++++ finished: global end lumi for module: label = 'get' id = 21 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 22 ++++++ starting: global end lumi for module: label = 'getInt' id = 22 ++++++ finished: global end lumi for module: label = 'getInt' id = 22 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 ++++++ starting: global end lumi for module: label = 'dependsOnNoPut' id = 23 ++++++ finished: global end lumi for module: label = 'dependsOnNoPut' id = 23 ++++ finished: global end lumi: run = 3 lumi = 1 time = 105000001 @@ -5383,42 +5997,74 @@ ++++ starting: global begin lumi: run = 3 lumi = 2 time = 125000001 ++++ finished: global begin lumi: run = 3 lumi = 2 time = 125000001 ++++ starting: global begin lumi: run = 3 lumi = 2 time = 125000001 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'noPut' id = 11 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 10 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 6 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 ++++++ starting: global begin lumi for module: label = 'thingWithMergeProducer' id = 5 ++++++ finished: global begin lumi for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 6 ++++++ starting: global begin lumi for module: label = 'get' id = 6 ++++++ finished: global begin lumi for module: label = 'get' id = 6 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 10 ++++++ starting: global begin lumi for module: label = 'getInt' id = 10 ++++++ finished: global begin lumi for module: label = 'getInt' id = 10 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'noPut' id = 11 ++++++ starting: global begin lumi for module: label = 'noPut' id = 11 ++++++ finished: global begin lumi for module: label = 'noPut' id = 11 ++++ finished: global begin lumi: run = 3 lumi = 2 time = 125000001 ++++ starting: global begin lumi: run = 3 lumi = 2 time = 125000001 ++++ finished: global begin lumi: run = 3 lumi = 2 time = 125000001 ++++ starting: global begin lumi: run = 3 lumi = 2 time = 125000001 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 22 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 21 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 20 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 19 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++ starting: global begin lumi: run = 3 lumi = 2 time = 125000001 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 35 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 34 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 33 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 32 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 ++++++ starting: global begin lumi for module: label = 'thingWithMergeProducer' id = 31 ++++++ finished: global begin lumi for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 32 ++++++ starting: global begin lumi for module: label = 'test' id = 32 ++++++ finished: global begin lumi for module: label = 'test' id = 32 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 33 ++++++ starting: global begin lumi for module: label = 'testmerge' id = 33 ++++++ finished: global begin lumi for module: label = 'testmerge' id = 33 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 34 ++++++ starting: global begin lumi for module: label = 'get' id = 34 ++++++ finished: global begin lumi for module: label = 'get' id = 34 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 35 ++++++ starting: global begin lumi for module: label = 'getInt' id = 35 ++++++ finished: global begin lumi for module: label = 'getInt' id = 35 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 ++++++ starting: global begin lumi for module: label = 'dependsOnNoPut' id = 36 ++++++ finished: global begin lumi for module: label = 'dependsOnNoPut' id = 36 ++++ finished: global begin lumi: run = 3 lumi = 2 time = 125000001 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++++ starting: global begin lumi for module: label = 'thingWithMergeProducer' id = 18 ++++++ finished: global begin lumi for module: label = 'thingWithMergeProducer' id = 18 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 19 ++++++ starting: global begin lumi for module: label = 'test' id = 19 ++++++ finished: global begin lumi for module: label = 'test' id = 19 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 20 ++++++ starting: global begin lumi for module: label = 'testmerge' id = 20 ++++++ finished: global begin lumi for module: label = 'testmerge' id = 20 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 21 ++++++ starting: global begin lumi for module: label = 'get' id = 21 ++++++ finished: global begin lumi for module: label = 'get' id = 21 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 22 ++++++ starting: global begin lumi for module: label = 'getInt' id = 22 ++++++ finished: global begin lumi for module: label = 'getInt' id = 22 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 ++++++ starting: global begin lumi for module: label = 'dependsOnNoPut' id = 23 ++++++ finished: global begin lumi for module: label = 'dependsOnNoPut' id = 23 ++++ finished: global begin lumi: run = 3 lumi = 2 time = 125000001 @@ -6088,42 +6734,74 @@ ++++ starting: global end lumi: run = 3 lumi = 2 time = 125000001 ++++ finished: global end lumi: run = 3 lumi = 2 time = 125000001 ++++ starting: global end lumi: run = 3 lumi = 2 time = 125000001 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'noPut' id = 11 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 10 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 6 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 ++++++ starting: global end lumi for module: label = 'thingWithMergeProducer' id = 5 ++++++ finished: global end lumi for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 6 ++++++ starting: global end lumi for module: label = 'get' id = 6 ++++++ finished: global end lumi for module: label = 'get' id = 6 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 10 ++++++ starting: global end lumi for module: label = 'getInt' id = 10 ++++++ finished: global end lumi for module: label = 'getInt' id = 10 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'noPut' id = 11 ++++++ starting: global end lumi for module: label = 'noPut' id = 11 ++++++ finished: global end lumi for module: label = 'noPut' id = 11 ++++ finished: global end lumi: run = 3 lumi = 2 time = 125000001 ++++ starting: global end lumi: run = 3 lumi = 2 time = 125000001 ++++ finished: global end lumi: run = 3 lumi = 2 time = 125000001 ++++ starting: global end lumi: run = 3 lumi = 2 time = 125000001 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 22 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 21 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 20 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 19 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++ starting: global end lumi: run = 3 lumi = 2 time = 125000001 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 35 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 34 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 33 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 32 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 ++++++ starting: global end lumi for module: label = 'thingWithMergeProducer' id = 31 ++++++ finished: global end lumi for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 33 ++++++ starting: global end lumi for module: label = 'testmerge' id = 33 ++++++ finished: global end lumi for module: label = 'testmerge' id = 33 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 32 ++++++ starting: global end lumi for module: label = 'test' id = 32 ++++++ finished: global end lumi for module: label = 'test' id = 32 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 34 ++++++ starting: global end lumi for module: label = 'get' id = 34 ++++++ finished: global end lumi for module: label = 'get' id = 34 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 35 ++++++ starting: global end lumi for module: label = 'getInt' id = 35 ++++++ finished: global end lumi for module: label = 'getInt' id = 35 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 ++++++ starting: global end lumi for module: label = 'dependsOnNoPut' id = 36 ++++++ finished: global end lumi for module: label = 'dependsOnNoPut' id = 36 ++++ finished: global end lumi: run = 3 lumi = 2 time = 125000001 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++++ starting: global end lumi for module: label = 'thingWithMergeProducer' id = 18 ++++++ finished: global end lumi for module: label = 'thingWithMergeProducer' id = 18 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 20 ++++++ starting: global end lumi for module: label = 'testmerge' id = 20 ++++++ finished: global end lumi for module: label = 'testmerge' id = 20 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 19 ++++++ starting: global end lumi for module: label = 'test' id = 19 ++++++ finished: global end lumi for module: label = 'test' id = 19 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 21 ++++++ starting: global end lumi for module: label = 'get' id = 21 ++++++ finished: global end lumi for module: label = 'get' id = 21 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 22 ++++++ starting: global end lumi for module: label = 'getInt' id = 22 ++++++ finished: global end lumi for module: label = 'getInt' id = 22 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 ++++++ starting: global end lumi for module: label = 'dependsOnNoPut' id = 23 ++++++ finished: global end lumi for module: label = 'dependsOnNoPut' id = 23 ++++ finished: global end lumi: run = 3 lumi = 2 time = 125000001 @@ -6152,42 +6830,74 @@ ++++ starting: global begin lumi: run = 3 lumi = 3 time = 145000001 ++++ finished: global begin lumi: run = 3 lumi = 3 time = 145000001 ++++ starting: global begin lumi: run = 3 lumi = 3 time = 145000001 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'noPut' id = 11 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 10 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 6 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 ++++++ starting: global begin lumi for module: label = 'thingWithMergeProducer' id = 5 ++++++ finished: global begin lumi for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 6 ++++++ starting: global begin lumi for module: label = 'get' id = 6 ++++++ finished: global begin lumi for module: label = 'get' id = 6 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 10 ++++++ starting: global begin lumi for module: label = 'getInt' id = 10 ++++++ finished: global begin lumi for module: label = 'getInt' id = 10 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'noPut' id = 11 ++++++ starting: global begin lumi for module: label = 'noPut' id = 11 ++++++ finished: global begin lumi for module: label = 'noPut' id = 11 ++++ finished: global begin lumi: run = 3 lumi = 3 time = 145000001 ++++ starting: global begin lumi: run = 3 lumi = 3 time = 145000001 ++++ finished: global begin lumi: run = 3 lumi = 3 time = 145000001 ++++ starting: global begin lumi: run = 3 lumi = 3 time = 145000001 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 22 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 21 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 20 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 19 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++ starting: global begin lumi: run = 3 lumi = 3 time = 145000001 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 35 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 34 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 33 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 32 +++++++++ starting: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 ++++++ starting: global begin lumi for module: label = 'thingWithMergeProducer' id = 31 ++++++ finished: global begin lumi for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 32 ++++++ starting: global begin lumi for module: label = 'test' id = 32 ++++++ finished: global begin lumi for module: label = 'test' id = 32 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 33 ++++++ starting: global begin lumi for module: label = 'testmerge' id = 33 ++++++ finished: global begin lumi for module: label = 'testmerge' id = 33 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 34 ++++++ starting: global begin lumi for module: label = 'get' id = 34 ++++++ finished: global begin lumi for module: label = 'get' id = 34 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 35 ++++++ starting: global begin lumi for module: label = 'getInt' id = 35 ++++++ finished: global begin lumi for module: label = 'getInt' id = 35 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 ++++++ starting: global begin lumi for module: label = 'dependsOnNoPut' id = 36 ++++++ finished: global begin lumi for module: label = 'dependsOnNoPut' id = 36 ++++ finished: global begin lumi: run = 3 lumi = 3 time = 145000001 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++++ starting: global begin lumi for module: label = 'thingWithMergeProducer' id = 18 ++++++ finished: global begin lumi for module: label = 'thingWithMergeProducer' id = 18 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'test' id = 19 ++++++ starting: global begin lumi for module: label = 'test' id = 19 ++++++ finished: global begin lumi for module: label = 'test' id = 19 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'testmerge' id = 20 ++++++ starting: global begin lumi for module: label = 'testmerge' id = 20 ++++++ finished: global begin lumi for module: label = 'testmerge' id = 20 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'get' id = 21 ++++++ starting: global begin lumi for module: label = 'get' id = 21 ++++++ finished: global begin lumi for module: label = 'get' id = 21 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'getInt' id = 22 ++++++ starting: global begin lumi for module: label = 'getInt' id = 22 ++++++ finished: global begin lumi for module: label = 'getInt' id = 22 +++++++++ finished: prefetching before processing global global begin LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 ++++++ starting: global begin lumi for module: label = 'dependsOnNoPut' id = 23 ++++++ finished: global begin lumi for module: label = 'dependsOnNoPut' id = 23 ++++ finished: global begin lumi: run = 3 lumi = 3 time = 145000001 @@ -6544,42 +7254,74 @@ ++++ starting: global end lumi: run = 3 lumi = 3 time = 145000001 ++++ finished: global end lumi: run = 3 lumi = 3 time = 145000001 ++++ starting: global end lumi: run = 3 lumi = 3 time = 145000001 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'noPut' id = 11 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 10 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 6 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 5 ++++++ starting: global end lumi for module: label = 'thingWithMergeProducer' id = 5 ++++++ finished: global end lumi for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 6 ++++++ starting: global end lumi for module: label = 'get' id = 6 ++++++ finished: global end lumi for module: label = 'get' id = 6 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 10 ++++++ starting: global end lumi for module: label = 'getInt' id = 10 ++++++ finished: global end lumi for module: label = 'getInt' id = 10 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'noPut' id = 11 ++++++ starting: global end lumi for module: label = 'noPut' id = 11 ++++++ finished: global end lumi for module: label = 'noPut' id = 11 ++++ finished: global end lumi: run = 3 lumi = 3 time = 145000001 ++++ starting: global end lumi: run = 3 lumi = 3 time = 145000001 ++++ finished: global end lumi: run = 3 lumi = 3 time = 145000001 ++++ starting: global end lumi: run = 3 lumi = 3 time = 145000001 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 22 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 21 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 20 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 19 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++ starting: global end lumi: run = 3 lumi = 3 time = 145000001 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 35 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 34 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 33 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 32 +++++++++ starting: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 31 ++++++ starting: global end lumi for module: label = 'thingWithMergeProducer' id = 31 ++++++ finished: global end lumi for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 33 ++++++ starting: global end lumi for module: label = 'testmerge' id = 33 ++++++ finished: global end lumi for module: label = 'testmerge' id = 33 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 32 ++++++ starting: global end lumi for module: label = 'test' id = 32 ++++++ finished: global end lumi for module: label = 'test' id = 32 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 34 ++++++ starting: global end lumi for module: label = 'get' id = 34 ++++++ finished: global end lumi for module: label = 'get' id = 34 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 35 ++++++ starting: global end lumi for module: label = 'getInt' id = 35 ++++++ finished: global end lumi for module: label = 'getInt' id = 35 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 36 ++++++ starting: global end lumi for module: label = 'dependsOnNoPut' id = 36 ++++++ finished: global end lumi for module: label = 'dependsOnNoPut' id = 36 ++++ finished: global end lumi: run = 3 lumi = 3 time = 145000001 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'thingWithMergeProducer' id = 18 ++++++ starting: global end lumi for module: label = 'thingWithMergeProducer' id = 18 ++++++ finished: global end lumi for module: label = 'thingWithMergeProducer' id = 18 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'testmerge' id = 20 ++++++ starting: global end lumi for module: label = 'testmerge' id = 20 ++++++ finished: global end lumi for module: label = 'testmerge' id = 20 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'test' id = 19 ++++++ starting: global end lumi for module: label = 'test' id = 19 ++++++ finished: global end lumi for module: label = 'test' id = 19 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'get' id = 21 ++++++ starting: global end lumi for module: label = 'get' id = 21 ++++++ finished: global end lumi for module: label = 'get' id = 21 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'getInt' id = 22 ++++++ starting: global end lumi for module: label = 'getInt' id = 22 ++++++ finished: global end lumi for module: label = 'getInt' id = 22 +++++++++ finished: prefetching before processing global global end LuminosityBlock for module: label = 'dependsOnNoPut' id = 23 ++++++ starting: global end lumi for module: label = 'dependsOnNoPut' id = 23 ++++++ finished: global end lumi for module: label = 'dependsOnNoPut' id = 23 ++++ finished: global end lumi: run = 3 lumi = 3 time = 145000001 @@ -6624,42 +7366,74 @@ ++++ starting: global end run 3 : time = 0 ++++ finished: global end run 3 : time = 0 ++++ starting: global end run 3 : time = 0 +++++++++ starting: prefetching before processing global global end Run for module: label = 'noPut' id = 11 +++++++++ starting: prefetching before processing global global end Run for module: label = 'getInt' id = 10 +++++++++ starting: prefetching before processing global global end Run for module: label = 'get' id = 6 +++++++++ starting: prefetching before processing global global end Run for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global end Run for module: label = 'thingWithMergeProducer' id = 5 ++++++ starting: global end run for module: label = 'thingWithMergeProducer' id = 5 ++++++ finished: global end run for module: label = 'thingWithMergeProducer' id = 5 +++++++++ finished: prefetching before processing global global end Run for module: label = 'get' id = 6 ++++++ starting: global end run for module: label = 'get' id = 6 ++++++ finished: global end run for module: label = 'get' id = 6 +++++++++ finished: prefetching before processing global global end Run for module: label = 'getInt' id = 10 ++++++ starting: global end run for module: label = 'getInt' id = 10 ++++++ finished: global end run for module: label = 'getInt' id = 10 +++++++++ finished: prefetching before processing global global end Run for module: label = 'noPut' id = 11 ++++++ starting: global end run for module: label = 'noPut' id = 11 ++++++ finished: global end run for module: label = 'noPut' id = 11 ++++ finished: global end run 3 : time = 0 ++++ starting: global end run 3 : time = 0 ++++ finished: global end run 3 : time = 0 ++++ starting: global end run 3 : time = 0 +++++++++ starting: prefetching before processing global global end Run for module: label = 'dependsOnNoPut' id = 23 +++++++++ starting: prefetching before processing global global end Run for module: label = 'getInt' id = 22 +++++++++ starting: prefetching before processing global global end Run for module: label = 'get' id = 21 +++++++++ starting: prefetching before processing global global end Run for module: label = 'testmerge' id = 20 +++++++++ starting: prefetching before processing global global end Run for module: label = 'test' id = 19 +++++++++ starting: prefetching before processing global global end Run for module: label = 'thingWithMergeProducer' id = 18 ++++ starting: global end run 3 : time = 0 +++++++++ starting: prefetching before processing global global end Run for module: label = 'dependsOnNoPut' id = 36 +++++++++ starting: prefetching before processing global global end Run for module: label = 'getInt' id = 35 +++++++++ starting: prefetching before processing global global end Run for module: label = 'get' id = 34 +++++++++ starting: prefetching before processing global global end Run for module: label = 'testmerge' id = 33 +++++++++ starting: prefetching before processing global global end Run for module: label = 'test' id = 32 +++++++++ starting: prefetching before processing global global end Run for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global end Run for module: label = 'thingWithMergeProducer' id = 31 ++++++ starting: global end run for module: label = 'thingWithMergeProducer' id = 31 ++++++ finished: global end run for module: label = 'thingWithMergeProducer' id = 31 +++++++++ finished: prefetching before processing global global end Run for module: label = 'testmerge' id = 33 ++++++ starting: global end run for module: label = 'testmerge' id = 33 ++++++ finished: global end run for module: label = 'testmerge' id = 33 +++++++++ finished: prefetching before processing global global end Run for module: label = 'test' id = 32 ++++++ starting: global end run for module: label = 'test' id = 32 ++++++ finished: global end run for module: label = 'test' id = 32 +++++++++ finished: prefetching before processing global global end Run for module: label = 'get' id = 34 ++++++ starting: global end run for module: label = 'get' id = 34 ++++++ finished: global end run for module: label = 'get' id = 34 +++++++++ finished: prefetching before processing global global end Run for module: label = 'getInt' id = 35 ++++++ starting: global end run for module: label = 'getInt' id = 35 ++++++ finished: global end run for module: label = 'getInt' id = 35 +++++++++ finished: prefetching before processing global global end Run for module: label = 'dependsOnNoPut' id = 36 ++++++ starting: global end run for module: label = 'dependsOnNoPut' id = 36 ++++++ finished: global end run for module: label = 'dependsOnNoPut' id = 36 ++++ finished: global end run 3 : time = 0 +++++++++ finished: prefetching before processing global global end Run for module: label = 'thingWithMergeProducer' id = 18 ++++++ starting: global end run for module: label = 'thingWithMergeProducer' id = 18 ++++++ finished: global end run for module: label = 'thingWithMergeProducer' id = 18 +++++++++ finished: prefetching before processing global global end Run for module: label = 'testmerge' id = 20 ++++++ starting: global end run for module: label = 'testmerge' id = 20 ++++++ finished: global end run for module: label = 'testmerge' id = 20 +++++++++ finished: prefetching before processing global global end Run for module: label = 'test' id = 19 ++++++ starting: global end run for module: label = 'test' id = 19 ++++++ finished: global end run for module: label = 'test' id = 19 +++++++++ finished: prefetching before processing global global end Run for module: label = 'get' id = 21 ++++++ starting: global end run for module: label = 'get' id = 21 ++++++ finished: global end run for module: label = 'get' id = 21 +++++++++ finished: prefetching before processing global global end Run for module: label = 'getInt' id = 22 ++++++ starting: global end run for module: label = 'getInt' id = 22 ++++++ finished: global end run for module: label = 'getInt' id = 22 +++++++++ finished: prefetching before processing global global end Run for module: label = 'dependsOnNoPut' id = 23 ++++++ starting: global end run for module: label = 'dependsOnNoPut' id = 23 ++++++ finished: global end run for module: label = 'dependsOnNoPut' id = 23 ++++ finished: global end run 3 : time = 0 @@ -6684,16 +7458,22 @@ ++++ starting: end process block ++++ finished: end process block ++++ starting: end process block +++++++++ starting: prefetching before processing global end ProcessBlock for module: label = 'getInt' id = 10 +++++++++ finished: prefetching before processing global end ProcessBlock for module: label = 'getInt' id = 10 ++++++ starting: end process block for module: label = 'getInt' id = 10 ++++++ finished: end process block for module: label = 'getInt' id = 10 ++++ finished: end process block ++++ starting: end process block ++++ finished: end process block ++++ starting: end process block +++++++++ starting: prefetching before processing global end ProcessBlock for module: label = 'getInt' id = 22 ++++ starting: end process block +++++++++ starting: prefetching before processing global end ProcessBlock for module: label = 'getInt' id = 35 +++++++++ finished: prefetching before processing global end ProcessBlock for module: label = 'getInt' id = 35 ++++++ starting: end process block for module: label = 'getInt' id = 35 ++++++ finished: end process block for module: label = 'getInt' id = 35 ++++ finished: end process block +++++++++ finished: prefetching before processing global end ProcessBlock for module: label = 'getInt' id = 22 ++++++ starting: end process block for module: label = 'getInt' id = 22 ++++++ finished: end process block for module: label = 'getInt' id = 22 ++++ finished: end process block diff --git a/FWCore/ServiceRegistry/interface/ActivityRegistry.h b/FWCore/ServiceRegistry/interface/ActivityRegistry.h index 3ea625cdfa299..9064969142faf 100644 --- a/FWCore/ServiceRegistry/interface/ActivityRegistry.h +++ b/FWCore/ServiceRegistry/interface/ActivityRegistry.h @@ -727,6 +727,22 @@ namespace edm { } AR_WATCH_USING_METHOD_2(watchPostEventReadFromSource) + /// signal is emitted before the module starts processing a non-Event stream transition and before prefetching has started + typedef signalslot::Signal PreModuleStreamPrefetching; + PreModuleStreamPrefetching preModuleStreamPrefetchingSignal_; + void watchPreModuleStreamPrefetching(PreModuleStreamPrefetching::slot_type const& iSlot) { + preModuleStreamPrefetchingSignal_.connect(iSlot); + } + AR_WATCH_USING_METHOD_2(watchPreModuleStreamPrefetching) + + /// signal is emitted before the module starts processing a non-Event stream transition and after prefetching has finished + typedef signalslot::Signal PostModuleStreamPrefetching; + PostModuleStreamPrefetching postModuleStreamPrefetchingSignal_; + void watchPostModuleStreamPrefetching(PostModuleStreamPrefetching::slot_type const& iSlot) { + postModuleStreamPrefetchingSignal_.connect_front(iSlot); + } + AR_WATCH_USING_METHOD_2(watchPostModuleStreamPrefetching) + typedef signalslot::Signal PreModuleStreamBeginRun; PreModuleStreamBeginRun preModuleStreamBeginRunSignal_; void watchPreModuleStreamBeginRun(PreModuleStreamBeginRun::slot_type const& iSlot) { @@ -826,6 +842,22 @@ namespace edm { } AR_WATCH_USING_METHOD_2(watchPostModuleEndProcessBlock) + /// signal is emitted before the module starts processing a global transition and before prefetching has started + typedef signalslot::Signal PreModuleGlobalPrefetching; + PreModuleGlobalPrefetching preModuleGlobalPrefetchingSignal_; + void watchPreModuleGlobalPrefetching(PreModuleGlobalPrefetching::slot_type const& iSlot) { + preModuleGlobalPrefetchingSignal_.connect(iSlot); + } + AR_WATCH_USING_METHOD_2(watchPreModuleGlobalPrefetching) + + /// signal is emitted before the module starts processing a global transition and after prefetching has finished + typedef signalslot::Signal PostModuleGlobalPrefetching; + PostModuleGlobalPrefetching postModuleGlobalPrefetchingSignal_; + void watchPostModuleGlobalPrefetching(PostModuleGlobalPrefetching::slot_type const& iSlot) { + postModuleGlobalPrefetchingSignal_.connect_front(iSlot); + } + AR_WATCH_USING_METHOD_2(watchPostModuleGlobalPrefetching) + typedef signalslot::Signal PreModuleGlobalBeginRun; PreModuleGlobalBeginRun preModuleGlobalBeginRunSignal_; void watchPreModuleGlobalBeginRun(PreModuleGlobalBeginRun::slot_type const& iSlot) { diff --git a/FWCore/ServiceRegistry/interface/GlobalContext.h b/FWCore/ServiceRegistry/interface/GlobalContext.h index d88077b332a4c..4ec0312a6eddc 100644 --- a/FWCore/ServiceRegistry/interface/GlobalContext.h +++ b/FWCore/ServiceRegistry/interface/GlobalContext.h @@ -21,6 +21,7 @@ information about the current state of global processing. #include "FWCore/Utilities/interface/RunIndex.h" #include +#include namespace edm { @@ -49,6 +50,7 @@ namespace edm { LuminosityBlockIndex const& luminosityBlockIndex, Timestamp const& timestamp, ProcessContext const* processContext); + GlobalContext(Transition transition, ProcessContext const* processContext); Transition transition() const { return transition_; } bool isAtEndTransition() const { @@ -74,5 +76,7 @@ namespace edm { void exceptionContext(std::ostream&, GlobalContext const&); std::ostream& operator<<(std::ostream&, GlobalContext const&); + + std::string_view transitionName(GlobalContext::Transition); } // namespace edm #endif diff --git a/FWCore/ServiceRegistry/interface/StreamContext.h b/FWCore/ServiceRegistry/interface/StreamContext.h index c61460a472ecc..e45b991fd6c86 100644 --- a/FWCore/ServiceRegistry/interface/StreamContext.h +++ b/FWCore/ServiceRegistry/interface/StreamContext.h @@ -23,6 +23,7 @@ #include "FWCore/Utilities/interface/StreamID.h" #include +#include namespace edm { @@ -80,5 +81,7 @@ namespace edm { void exceptionContext(std::ostream&, StreamContext const&); std::ostream& operator<<(std::ostream&, StreamContext const&); + + std::string_view transitionName(StreamContext::Transition); } // namespace edm #endif diff --git a/FWCore/ServiceRegistry/src/ActivityRegistry.cc b/FWCore/ServiceRegistry/src/ActivityRegistry.cc index eae2866b79f70..c0ecece5cbe3d 100644 --- a/FWCore/ServiceRegistry/src/ActivityRegistry.cc +++ b/FWCore/ServiceRegistry/src/ActivityRegistry.cc @@ -228,6 +228,12 @@ namespace edm { preModuleEventPrefetchingSignal_.connect(std::cref(iOther.preModuleEventPrefetchingSignal_)); postModuleEventPrefetchingSignal_.connect(std::cref(iOther.postModuleEventPrefetchingSignal_)); + preModuleStreamPrefetchingSignal_.connect(std::cref(iOther.preModuleStreamPrefetchingSignal_)); + postModuleStreamPrefetchingSignal_.connect(std::cref(iOther.postModuleStreamPrefetchingSignal_)); + + preModuleGlobalPrefetchingSignal_.connect(std::cref(iOther.preModuleGlobalPrefetchingSignal_)); + postModuleGlobalPrefetchingSignal_.connect(std::cref(iOther.postModuleGlobalPrefetchingSignal_)); + preModuleEventSignal_.connect(std::cref(iOther.preModuleEventSignal_)); postModuleEventSignal_.connect(std::cref(iOther.postModuleEventSignal_)); @@ -447,6 +453,12 @@ namespace edm { copySlotsToFrom(preModuleEventPrefetchingSignal_, iOther.preModuleEventPrefetchingSignal_); copySlotsToFromReverse(postModuleEventPrefetchingSignal_, iOther.postModuleEventPrefetchingSignal_); + copySlotsToFrom(preModuleStreamPrefetchingSignal_, iOther.preModuleStreamPrefetchingSignal_); + copySlotsToFromReverse(postModuleStreamPrefetchingSignal_, iOther.postModuleStreamPrefetchingSignal_); + + copySlotsToFrom(preModuleGlobalPrefetchingSignal_, iOther.preModuleGlobalPrefetchingSignal_); + copySlotsToFromReverse(postModuleGlobalPrefetchingSignal_, iOther.postModuleGlobalPrefetchingSignal_); + copySlotsToFrom(preModuleEventSignal_, iOther.preModuleEventSignal_); copySlotsToFromReverse(postModuleEventSignal_, iOther.postModuleEventSignal_); diff --git a/FWCore/ServiceRegistry/src/GlobalContext.cc b/FWCore/ServiceRegistry/src/GlobalContext.cc index 0be7f295641a0..702c04f118476 100644 --- a/FWCore/ServiceRegistry/src/GlobalContext.cc +++ b/FWCore/ServiceRegistry/src/GlobalContext.cc @@ -18,6 +18,14 @@ namespace edm { timestamp_(timestamp), processContext_(processContext) {} + GlobalContext::GlobalContext(Transition transition, ProcessContext const* processContext) + : transition_(transition), + luminosityBlockID_(), + runIndex_(RunIndex::invalidRunIndex()), + luminosityBlockIndex_(LuminosityBlockIndex::invalidLuminosityBlockIndex()), + timestamp_(), + processContext_(processContext) {} + std::ostream& operator<<(std::ostream& os, GlobalContext const& gc) { os << "GlobalContext: transition = "; switch (gc.transition()) { @@ -110,4 +118,33 @@ namespace edm { } } + std::string_view transitionName(GlobalContext::Transition iTrans) { + switch (iTrans) { + case GlobalContext::Transition::kBeginJob: + return "begin Job"; + case GlobalContext::Transition::kBeginProcessBlock: + return "begin ProcessBlock"; + case GlobalContext::Transition::kAccessInputProcessBlock: + return "access input ProcessBlock"; + case GlobalContext::Transition::kBeginRun: + return "global begin Run"; + case GlobalContext::Transition::kBeginLuminosityBlock: + return "global begin LuminosityBlock"; + case GlobalContext::Transition::kEndLuminosityBlock: + return "global end LuminosityBlock"; + case GlobalContext::Transition::kEndRun: + return "global end Run"; + case GlobalContext::Transition::kEndProcessBlock: + return "end ProcessBlock"; + case GlobalContext::Transition::kEndJob: + return "endJob"; + case GlobalContext::Transition::kWriteProcessBlock: + return "write ProcessBlock"; + case GlobalContext::Transition::kWriteRun: + return "write Run"; + case GlobalContext::Transition::kWriteLuminosityBlock: + return "write LuminosityBlock"; + } + return "Unknown"; + } } // namespace edm diff --git a/FWCore/ServiceRegistry/src/StreamContext.cc b/FWCore/ServiceRegistry/src/StreamContext.cc index d5bdacfc0daf8..975ad47b5bd03 100644 --- a/FWCore/ServiceRegistry/src/StreamContext.cc +++ b/FWCore/ServiceRegistry/src/StreamContext.cc @@ -100,4 +100,26 @@ namespace edm { os << " stream: " << sc.streamID(); } + std::string_view transitionName(StreamContext::Transition iTrans) { + switch (iTrans) { + case StreamContext::Transition::kBeginStream: + return "begin Stream"; + case StreamContext::Transition::kBeginRun: + return "stream begin Run"; + case StreamContext::Transition::kBeginLuminosityBlock: + return "stream begin LuminosityBlock"; + case StreamContext::Transition::kEvent: + return "Event"; + case StreamContext::Transition::kEndLuminosityBlock: + return "stream end LuminosityBlock"; + case StreamContext::Transition::kEndRun: + return "stream end Run"; + case StreamContext::Transition::kEndStream: + return "end Stream"; + case StreamContext::Transition::kInvalid: + return "Invalid"; + } + return "Unknown"; + } + } // namespace edm diff --git a/FWCore/Services/plugins/Tracer.cc b/FWCore/Services/plugins/Tracer.cc index 18bd0fac8166f..1652c42552fea 100644 --- a/FWCore/Services/plugins/Tracer.cc +++ b/FWCore/Services/plugins/Tracer.cc @@ -172,6 +172,9 @@ namespace edm { void preEventReadFromSource(StreamContext const&, ModuleCallingContext const&); void postEventReadFromSource(StreamContext const&, ModuleCallingContext const&); + void preModuleStreamPrefetching(StreamContext const&, ModuleCallingContext const&); + void postModuleStreamPrefetching(StreamContext const&, ModuleCallingContext const&); + void preModuleStreamBeginRun(StreamContext const&, ModuleCallingContext const&); void postModuleStreamBeginRun(StreamContext const&, ModuleCallingContext const&); void preModuleStreamEndRun(StreamContext const&, ModuleCallingContext const&); @@ -189,6 +192,9 @@ namespace edm { void preModuleEndProcessBlock(GlobalContext const&, ModuleCallingContext const&); void postModuleEndProcessBlock(GlobalContext const&, ModuleCallingContext const&); + void preModuleGlobalPrefetching(GlobalContext const&, ModuleCallingContext const&); + void postModuleGlobalPrefetching(GlobalContext const&, ModuleCallingContext const&); + void preModuleGlobalBeginRun(GlobalContext const&, ModuleCallingContext const&); void postModuleGlobalBeginRun(GlobalContext const&, ModuleCallingContext const&); void preModuleGlobalEndRun(GlobalContext const&, ModuleCallingContext const&); @@ -358,6 +364,9 @@ Tracer::Tracer(ParameterSet const& iPS, ActivityRegistry& iRegistry) iRegistry.watchPreEventReadFromSource(this, &Tracer::preEventReadFromSource); iRegistry.watchPostEventReadFromSource(this, &Tracer::postEventReadFromSource); + iRegistry.watchPreModuleStreamPrefetching(this, &Tracer::preModuleStreamPrefetching); + iRegistry.watchPostModuleStreamPrefetching(this, &Tracer::postModuleStreamPrefetching); + iRegistry.watchPreModuleStreamBeginRun(this, &Tracer::preModuleStreamBeginRun); iRegistry.watchPostModuleStreamBeginRun(this, &Tracer::postModuleStreamBeginRun); iRegistry.watchPreModuleStreamEndRun(this, &Tracer::preModuleStreamEndRun); @@ -375,6 +384,9 @@ Tracer::Tracer(ParameterSet const& iPS, ActivityRegistry& iRegistry) iRegistry.watchPreModuleEndProcessBlock(this, &Tracer::preModuleEndProcessBlock); iRegistry.watchPostModuleEndProcessBlock(this, &Tracer::postModuleEndProcessBlock); + iRegistry.watchPreModuleGlobalPrefetching(this, &Tracer::preModuleGlobalPrefetching); + iRegistry.watchPostModuleGlobalPrefetching(this, &Tracer::postModuleGlobalPrefetching); + iRegistry.watchPreModuleGlobalBeginRun(this, &Tracer::preModuleGlobalBeginRun); iRegistry.watchPostModuleGlobalBeginRun(this, &Tracer::postModuleGlobalBeginRun); iRegistry.watchPreModuleGlobalEndRun(this, &Tracer::preModuleGlobalEndRun); @@ -1214,6 +1226,38 @@ void Tracer::postEventReadFromSource(StreamContext const& sc, ModuleCallingConte << mcc.moduleDescription()->moduleLabel() << "' id = " << mcc.moduleDescription()->id(); } +void Tracer::preModuleStreamPrefetching(StreamContext const& sc, ModuleCallingContext const& mcc) { + LogAbsolute out("Tracer"); + out << TimeStamper(printTimestamps_); + unsigned int nIndents = mcc.depth() + 4; + for (unsigned int i = 0; i < nIndents; ++i) { + out << indention_; + } + out << " starting: prefetching before processing " << transitionName(sc.transition()) + << " for module: stream = " << sc.streamID() << " label = '" << mcc.moduleDescription()->moduleLabel() + << "' id = " << mcc.moduleDescription()->id(); + if (dumpContextForLabels_.find(mcc.moduleDescription()->moduleLabel()) != dumpContextForLabels_.end()) { + out << "\n" << sc; + out << mcc; + } +} + +void Tracer::postModuleStreamPrefetching(StreamContext const& sc, ModuleCallingContext const& mcc) { + LogAbsolute out("Tracer"); + out << TimeStamper(printTimestamps_); + unsigned int nIndents = mcc.depth() + 4; + for (unsigned int i = 0; i < nIndents; ++i) { + out << indention_; + } + out << " finished: prefetching before processing " << transitionName(sc.transition()) + << " for module: stream = " << sc.streamID() << " label = '" << mcc.moduleDescription()->moduleLabel() + << "' id = " << mcc.moduleDescription()->id(); + if (dumpContextForLabels_.find(mcc.moduleDescription()->moduleLabel()) != dumpContextForLabels_.end()) { + out << "\n" << sc; + out << mcc; + } +} + void Tracer::preModuleStreamBeginRun(StreamContext const& sc, ModuleCallingContext const& mcc) { LogAbsolute out("Tracer"); out << TimeStamper(printTimestamps_); @@ -1334,6 +1378,38 @@ void Tracer::postModuleStreamEndLumi(StreamContext const& sc, ModuleCallingConte } } +void Tracer::preModuleGlobalPrefetching(GlobalContext const& gc, ModuleCallingContext const& mcc) { + LogAbsolute out("Tracer"); + out << TimeStamper(printTimestamps_); + unsigned int nIndents = mcc.depth() + 4; + for (unsigned int i = 0; i < nIndents; ++i) { + out << indention_; + } + out << " starting: prefetching before processing global " << transitionName(gc.transition()) + << " for module: label = '" << mcc.moduleDescription()->moduleLabel() + << "' id = " << mcc.moduleDescription()->id(); + if (dumpContextForLabels_.find(mcc.moduleDescription()->moduleLabel()) != dumpContextForLabels_.end()) { + out << "\n" << gc; + out << mcc; + } +} + +void Tracer::postModuleGlobalPrefetching(GlobalContext const& gc, ModuleCallingContext const& mcc) { + LogAbsolute out("Tracer"); + out << TimeStamper(printTimestamps_); + unsigned int nIndents = mcc.depth() + 4; + for (unsigned int i = 0; i < nIndents; ++i) { + out << indention_; + } + out << " finished: prefetching before processing global " << transitionName(gc.transition()) + << " for module: label = '" << mcc.moduleDescription()->moduleLabel() + << "' id = " << mcc.moduleDescription()->id(); + if (dumpContextForLabels_.find(mcc.moduleDescription()->moduleLabel()) != dumpContextForLabels_.end()) { + out << "\n" << gc; + out << mcc; + } +} + void Tracer::preModuleBeginProcessBlock(GlobalContext const& gc, ModuleCallingContext const& mcc) { LogAbsolute out("Tracer"); unsigned int nIndents = mcc.depth() + 3;