Jobsub ID 235526.11@dunegpschedd02.fnal.gov
Jobscript log (last 10,000 characters)
] <Pgrapher:> graph execution complete
[00:38:39.859] I [ timer ] Timer: WireCell::SigProc::OmnibusSigProc : 0 sec
[00:38:39.859] I [ timer ] Timer: WireCell::Aux::Resampler : 0 sec
[00:38:39.859] I [ timer ] Timer: WireCell::SigProc::ChannelSelector : 0 sec
[00:38:39.859] I [ timer ] Timer: WireCell::SigProc::ChannelSelector : 0 sec
[00:38:39.859] I [ timer ] Timer: WireCell::SigProc::OmnibusSigProc : 0 sec
[00:38:39.859] I [ timer ] Timer: WireCell::SigProc::OmnibusSigProc : 0 sec
[00:38:39.859] I [ timer ] Timer: WireCell::SigProc::OmnibusSigProc : 0 sec
[00:38:39.859] I [ timer ] Timer: WireCell::Gen::FrameFanin : 0 sec
[00:38:39.859] I [ timer ] Timer: WireCell::SigProc::ChannelSelector : 0 sec
[00:38:39.859] I [ timer ] Timer: WireCell::SigProc::ChannelSelector : 0 sec
[00:38:39.859] I [ timer ] Timer: WireCell::SigProc::ChannelSelector : 0 sec
[00:38:39.859] I [ timer ] Timer: WireCell::Gen::DumpFrames : 0 sec
[00:38:39.859] I [ timer ] Timer: WireCell::SigProc::ChannelSelector : 0 sec
[00:38:39.859] I [ timer ] Timer: WireCell::SigProc::OmnibusSigProc : 0 sec
[00:38:39.859] I [ timer ] Timer: WireCell::Aux::Resampler : 0 sec
[00:38:39.859] I [ timer ] Timer: WireCell::SigProc::OmnibusSigProc : 0 sec
[00:38:39.859] I [ timer ] Timer: WireCell::SigProc::ChannelSelector : 0 sec
[00:38:39.859] I [ timer ] Timer: WireCell::SigProc::ChannelSelector : 0 sec
[00:38:39.859] I [ timer ] Timer: WireCell::Gen::Retagger : 0 sec
[00:38:39.859] I [ timer ] Timer: WireCell::Gen::FrameFanout : 0 sec
[00:38:39.859] I [ timer ] Timer: WireCell::Aux::Resampler : 0 sec
[00:38:39.859] I [ timer ] Timer: wcls::RawFrameSource : 0 sec
[00:38:39.859] I [ timer ] Timer: WireCell::SigProc::OmnibusSigProc : 0 sec
[00:38:39.859] I [ timer ] Timer: WireCell::Aux::Resampler : 0 sec
[00:38:39.859] I [ timer ] Timer: WireCell::SigProc::OmnibusSigProc : 0 sec
[00:38:39.859] I [ timer ] Timer: wcls::FrameSaver : 0 sec
[00:38:39.859] I [ timer ] Timer: Total node execution : 0 sec
wclsFrameSaver: saving empty frame to art::Event
PandoraContentApi::GetList(*this, m_inputHitListName, pCaloHitList) return STATUS_CODE_NOT_INITIALIZED
in function: GetVolumeIdToHitListMap
in file: /scratch/workspace/build-larsoft/BUILDTYPE/prof/QUAL/s131-e26/label1/swarm/label2/ALMA9/build/larpandoracontent/v04_17_01-buildFW/src/larpandoracontent/LArControlFlow/MasterAlgorithm.cc line#: 271
this->GetVolumeIdToHitListMap(volumeIdToHitListMap) return STATUS_CODE_NOT_INITIALIZED
in function: Run
in file: /scratch/workspace/build-larsoft/BUILDTYPE/prof/QUAL/s131-e26/label1/swarm/label2/ALMA9/build/larpandoracontent/v04_17_01-buildFW/src/larpandoracontent/LArControlFlow/MasterAlgorithm.cc line#: 165
iter->second->Run() throw STATUS_CODE_NOT_INITIALIZED
in function: RunAlgorithm
in file: /scratch/workspace/build-lar-products/BUILDTYPE/prof/QUAL/e26/label1/swarm/label2/ALMA9/build/pandora/v04_16_02/src/pandora-v04-16-02/PandoraSDK-v04-00-02/src/Api/PandoraContentApiImpl.cc line#: 235
Failure in algorithm Alg0003, LArMaster, STATUS_CODE_NOT_INITIALIZED
31-Oct-2025 00:38:41 GMT Closed output file "np02vd_raw_run040330_0026_df-s04-d0_dw_0_20251030T191834_reco_stage1_20251031T003841_keepup.root"
==================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
==================================================================================================================================
Full event 9.05321 276.375 727.802 345.622 198.85 61
----------------------------------------------------------------------------------------------------------------------------------
source:HDF5RawInput3(read) 4.0015e-05 5.3307e-05 0.00010585 5.2192e-05 7.65616e-06 61
produce:tpcrawdecoder:PDVDTPCReader 8.06022 234.882 470.971 290.377 169.592 61
produce:triggerrawdecoder:PDVDTriggerReader4 0.769782 1.51938 3.8129 1.38165 0.571905 61
produce:pdvddaphne:DAPHNEReaderPDVD 0.000355757 0.000419449 0.000621302 0.000416593 3.36491e-05 61
produce:ophit:OpHitFinder 4.23e-05 5.61335e-05 0.000402493 4.7815e-05 4.58718e-05 61
produce:opflash:OpFlashFinderVerticalDrift 3.1229e-05 4.10972e-05 0.000244182 3.5057e-05 2.92893e-05 61
produce:wclsdatavd:WireCellToolkit 0.000396851 26.3833 56.6495 36.9416 18.2266 61
produce:gaushit:GausHitFinder 3.1764e-05 0.341743 0.81187 0.42428 0.264803 61
produce:nhitsfilter:NumberOfHitsFilter 8.667e-06 0.00010086 0.000340972 0.000119736 7.45986e-05 61
produce:reco3d:SpacePointSolver 5.768e-05 2.62681 6.96376 3.22722 2.11708 61
produce:hitpdune:DisambigFromSpacePoints 0.000123369 0.0240571 0.0761083 0.0270744 0.0200515 61
produce:pandora:StandardPandora 0.00054721 9.12401 275.676 4.84154 34.6833 61
produce:pandoraTrack:LArPandoraTrackCreation 9.5e-05 0.111374 0.413719 0.12641 0.0964163 61
produce:pandoraGnocalo:GnocchiCalorimetry 9.1166e-05 0.0074232 0.0152454 0.0094089 0.00561708 61
[art]:TriggerResults:TriggerResultInserter 9.179e-06 1.51022e-05 3.9636e-05 1.3732e-05 5.30514e-06 61
end_path:out1:RootOutput 2.638e-06 6.3727e-06 1.774e-05 7.053e-06 2.6315e-06 61
end_path:out1:RootOutput(write) 0.00884587 1.33355 2.27499 1.98108 0.958624 61
==================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4018.02 MB
Peak resident set size usage (VmHWM): 1979.8 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np02vd_raw_run040330_0026_df-s04-d0_dw_0_20251030T191834_reco_stage1_20251031T003841_keepup.root
\tHists: np02vd_raw_run040330_0026_df-s04-d0_dw_0_20251030T191834_reco_stage1_20251031T003845_keepup_hists.root
Forming reco metadata
Successfully opened file np02vd_raw_run040330_0026_df-s04-d0_dw_0_20251030T191834_reco_stage1_20251031T003841_keepup.root
Ran successfully
{
"name": "np02vd_raw_run040330_0026_df-s04-d0_dw_0_20251030T191834_reco_stage1_20251031T003841_keepup.root",
"namespace": "vd-protodune-det-reco",
"metadata": {
"core.file_format": "artroot",
"core.application.name": "reco",
"core.application.family": "dunesw",
"core.application.version": "v10_11_00d00",
"core.data_tier": "full-reconstructed",
"dune.config_file": "standard_reco_stage1_protodunevd_keepup_all.fcl",
"dune.campaign": "vd-protodune-reco-keepup-v0",
"core.start_time": 1761871126.0,
"core.end_time": 1761871126.0,
"core.events": [
1547,
1548,
1549,
1550,
1551,
1552,
1553,
1554,
1555,
1556,
1557,
1558,
1559,
1560,
1561,
1562,
1563,
1564,
1565,
1566,
1567,
1568,
1569,
1570,
1571,
1572,
1573,
1574,
1575,
1576,
1577,
1578,
1579,
1580,
1581,
1582,
1583,
1584,
1585,
1586,
1587,
1588,
1589,
1590,
1591,
1592,
1593,
1594,
1595,
1596,
1597,
1598,
1599,
1600,
1601,
1602,
1603,
1604,
1605,
1606,
1607
],
"core.event_count": 61,
"core.first_event_number": 1547,
"core.last_event_number": 1607,
"core.data_stream": "cosmics",
"core.file_content_status": "good",
"core.file_type": "detector",
"core.run_type": "vd-protodune",
"core.runs": [
40330
],
"core.runs_subruns": [
4033000001
],
"dune.daq_test": true,
"retention.status": "active",
"retention.class": "physics"
},
"parents": [
{
"did": "vd-protodune:np02vd_raw_run040330_0026_df-s04-d0_dw_0_20251030T191834.hdf5"
}
]
}Forming hist metadata
formed
{
"name": "np02vd_raw_run040330_0026_df-s04-d0_dw_0_20251030T191834_reco_stage1_20251031T003845_keepup_hists.root",
"namespace": "vd-protodune-det-reco",
"metadata": {
"core.file_format": "root",
"core.application.name": "reco",
"core.application.family": "dunesw",
"core.application.version": "v10_11_00d00",
"core.data_tier": "root-tuple-virtual",
"dune.config_file": "standard_reco_stage1_protodunevd_keepup_all.fcl",
"dune.campaign": "vd-protodune-reco-keepup-v0",
"core.start_time": 1761871126.0,
"core.end_time": 1761871126.0,
"core.data_stream": "cosmics",
"core.file_content_status": "good",
"core.file_type": "detector",
"core.run_type": "vd-protodune",
"core.runs": [
40330
],
"core.runs_subruns": [
4033000001
],
"dune.daq_test": true,
"retention.status": "active",
"retention.class": "physics"
},
"parents": [
{
"did": "vd-protodune:np02vd_raw_run040330_0026_df-s04-d0_dw_0_20251030T191834.hdf5"
}
]
}