Jobsub ID 44666.136@dunegpschedd01.fnal.gov
Jobscript log (last 10,000 characters)
Fanin : 0.02 sec
[04:54:46.003] I [ timer ] Timer: WireCell::SigProc::ChannelSelector : 0.02 sec
[04:54:46.003] I [ timer ] Timer: WireCell::SigProc::ChannelSelector : 0 sec
[04:54:46.003] I [ timer ] Timer: WireCell::SigProc::ChannelSelector : 0 sec
[04:54:46.003] I [ timer ] Timer: WireCell::SigProc::ChannelSelector : 0 sec
[04:54:46.003] I [ timer ] Timer: WireCell::SigProc::ChannelSelector : 0 sec
[04:54:46.003] I [ timer ] Timer: WireCell::SigProc::ChannelSelector : 0 sec
[04:54:46.003] I [ timer ] Timer: WireCell::Gen::DumpFrames : 0 sec
[04:54:46.003] I [ timer ] Timer: WireCell::SigProc::ChannelSelector : 0 sec
[04:54:46.003] I [ timer ] Timer: WireCell::SigProc::ChannelSelector : 0 sec
[04:54:46.003] I [ timer ] Timer: WireCell::Gen::Retagger : 0 sec
[04:54:46.003] I [ timer ] Timer: WireCell::Gen::FrameFanout : 0 sec
[04:54:46.003] I [ timer ] Timer: wcls::RawFrameSource : 0 sec
[04:54:46.003] I [ timer ] Timer: wcls::FrameSaver : 0 sec
[04:54:46.003] I [ timer ] Timer: Total node execution : 65.48999933153391 sec
wclsFrameSaver saving cooked to 10000 ticks
wclsFrameSaver: saving 66583 traces tagged "gauss"
FrameSaver: q=1.5621e+07 n=1538628 tag=gauss
wclsFrameSaver: saving 81142 traces tagged "wiener"
FrameSaver: q=1.6274e+07 n=1484709 tag=wiener
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 1008 XUs and 991 XVs -> 37 XUVs
C:0 T:1 3591 XUs and 3611 XVs -> 93 XUVs
C:0 T:2 1359 XUs and 1285 XVs -> 64 XUVs
C:0 T:3 343 XUs and 374 XVs -> 17 XUVs
C:0 T:4 2115 XUs and 2265 XVs -> 79 XUVs
C:0 T:5 990 XUs and 1388 XVs -> 58 XUVs
C:0 T:6 132 XUs and 167 XVs -> 3 XUVs
C:0 T:7 651 XUs and 609 XVs -> 30 XUVs
C:0 T:8 11529 XUs and 28654 XVs -> 5351 XUVs
C:0 T:9 6265 XUs and 6894 XVs -> 546 XUVs
C:0 T:10 3148 XUs and 3674 XVs -> 301 XUVs
C:0 T:11 1527 XUs and 1608 XVs -> 171 XUVs
C:0 T:12 26289 XUs and 45361 XVs -> 2129 XUVs
C:0 T:13 1240 XUs and 2072 XVs -> 184 XUVs
C:0 T:14 1697 XUs and 1376 XVs -> 55 XUVs
C:0 T:15 13402 XUs and 17561 XVs -> 4549 XUVs
13667 XUVs total
2523 collection wire objects
13667 potential space points
Neighbour search...
2276187 tests to find 878156 neighbours
Iterating with no regularization...
Begin: 9.27015e+09
0 9.05045e+09
1 9.04565e+09
Now with regularization...
Begin: 9.02425e+09
0 9.02391e+09
this->SetupTestBeamPfo(pNuPfo, pTestBeamPfo, testBeamStartVertex) return STATUS_CODE_NOT_FOUND
in function: Run
in file: /scratch/workspace/build-larsoft/BUILDTYPE/prof/QUAL/s131-e26/label1/swarm/label2/ALMA9/build/larpandoracontent/v04_16_00-buildFW/src/larpandoracontent/LArThreeDReco/LArEventBuilding/TestBeamParticleCreationAlgorithm.cc line#: 43
iter->second->Run() throw STATUS_CODE_NOT_FOUND
in function: RunAlgorithm
in file: /scratch/workspace/build-larbase/BUILDTYPE/prof/QUAL/s131-e26/label1/swarm/label2/SLF7/build/pandora/v03_16_00l/src/pandora-v03-16-00/PandoraSDK-v03-04-01/src/Api/PandoraContentApiImpl.cc line#: 235
Failure in algorithm Alg0079, LArTestBeamParticleCreation, STATUS_CODE_NOT_FOUND
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
11-Sep-2025 04:57:19 CEST Closed output file "np02vd_raw_run039255_1625_df-s05-d0_dw_0_20250831T043821_reco_stage1_20250911T025719_keepup.root"
==================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
==================================================================================================================================
Full event 113.431 220.466 425.252 204.015 88.5723 18
----------------------------------------------------------------------------------------------------------------------------------
source:HDF5RawInput3(read) 6.063e-05 0.000105641 0.000154261 0.00010487 3.0209e-05 18
produce:tpcrawdecoder:PDVDTPCReader 5.36273 6.4133 6.88544 6.41046 0.326205 18
produce:triggerrawdecoder:PDVDTriggerReader4 0.000869426 0.0049154 0.0498843 0.00132824 0.0111907 18
produce:pdvddaphne:DAPHNEReaderPDVD 3.50031 4.23818 5.08876 4.38145 0.491916 18
produce:ophit:OpHitFinder 0.0351001 0.0501426 0.0686889 0.0520524 0.00752532 18
produce:opflash:OpFlashFinderVerticalDrift 0.00657522 0.0152938 0.026155 0.0151656 0.00534131 18
produce:wclsdatavd:WireCellToolkit 60.4315 74.1241 96.7156 69.1405 10.3095 18
produce:gaushit:GausHitFinder 0.66893 1.64522 2.42692 1.63166 0.446784 18
produce:nhitsfilter:NumberOfHitsFilter 0.000181061 0.00037896 0.000535212 0.000378693 0.000100339 18
produce:reco3d:SpacePointSolver 7.31692 21.1531 39.3597 19.3797 9.04698 18
produce:hitpdune:DisambigFromSpacePoints 0.079474 0.376624 0.991422 0.300743 0.273094 18
produce:pandora:StandardPandora 25.7217 105.342 269.855 98.6151 69.256 18
produce:pandoraTrack:LArPandoraTrackCreation 0.461886 1.49618 2.86471 1.32004 0.725919 18
produce:pandoraGnocalo:GnocchiCalorimetry 0.0118114 0.0358754 0.0644243 0.0379327 0.0127976 18
[art]:TriggerResults:TriggerResultInserter 1.787e-05 3.03763e-05 9.2961e-05 2.5545e-05 1.73491e-05 18
end_path:out1:RootOutput 4.01e-06 1.02102e-05 3.059e-05 9.08e-06 5.41545e-06 18
end_path:out1:RootOutput(write) 4.47314 5.52891 7.04731 5.59785 0.708596 18
==================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5761.01 MB
Peak resident set size usage (VmHWM): 3800.41 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np02vd_raw_run039255_1625_df-s05-d0_dw_0_20250831T043821_reco_stage1_20250911T025719_keepup.root
\tHists: np02vd_raw_run039255_1625_df-s05-d0_dw_0_20250831T043821_reco_stage1_20250911T025719_keepup_hists.root
Forming reco metadata
Successfully opened file np02vd_raw_run039255_1625_df-s05-d0_dw_0_20250831T043821_reco_stage1_20250911T025719_keepup.root
Ran successfully
{
"name": "np02vd_raw_run039255_1625_df-s05-d0_dw_0_20250831T043821_reco_stage1_20250911T025719_keepup.root",
"namespace": "vd-protodune-det-reco",
"metadata": {
"core.file_format": "artroot",
"core.application.name": "reco",
"core.application.family": "dunesw",
"core.application.version": "v10_10_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": 1757559439.0,
"core.end_time": 1757559439.0,
"core.events": [
585007,
585027,
585047,
585067,
585087,
585107,
585127,
585147,
585167,
585187,
585207,
585227,
585247,
585267,
585287,
585307,
585327,
585347
],
"core.event_count": 18,
"core.first_event_number": 585007,
"core.last_event_number": 585347,
"core.data_stream": "physics",
"core.file_content_status": "good",
"core.file_type": "detector",
"core.run_type": "vd-protodune",
"core.runs": [
39255
],
"core.runs_subruns": [
3925500001
],
"dune.daq_test": false,
"retention.status": "active",
"retention.class": "physics"
},
"parents": [
{
"did": "vd-protodune:np02vd_raw_run039255_1625_df-s05-d0_dw_0_20250831T043821.hdf5"
}
]
}Forming hist metadata
formed
{
"name": "np02vd_raw_run039255_1625_df-s05-d0_dw_0_20250831T043821_reco_stage1_20250911T025719_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_10_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": 1757559439.0,
"core.end_time": 1757559439.0,
"core.data_stream": "physics",
"core.file_content_status": "good",
"core.file_type": "detector",
"core.run_type": "vd-protodune",
"core.runs": [
39255
],
"core.runs_subruns": [
3925500001
],
"dune.daq_test": false,
"retention.status": "active",
"retention.class": "physics"
},
"parents": [
{
"did": "vd-protodune:np02vd_raw_run039255_1625_df-s05-d0_dw_0_20250831T043821.hdf5"
}
]
} 