Jobsub ID 264667.190@justin-prod-sched01.dune.hep.ac.uk
| Jobsub ID | 264667.190@justin-prod-sched01.dune.hep.ac.uk | |
| Workflow ID | 3511 | |
| Stage ID | 1 | |
| User name | calcuttj@fnal.gov | |
| HTCondor Group | group_dune.prod_mcsim | |
| Requested | Processors | 1 |
| RSS bytes | 4193255424 (3999 MiB) | |
| Wall seconds limit | 18000 (5 hours) | |
| Submitted time | 2024-09-27 05:32:22 | |
| Site | US_Wisconsin | |
| Entry | HCCHTPC_US_Wisconsin_osg01_rhel7 | |
| Last heartbeat | 2024-09-27 10:53:09 | |
| From worker node | Hostname | herringa2001 |
| cpuinfo | AMD EPYC 7763 64-Core Processor | |
| OS release | Scientific Linux release 7.9 (Nitrogen) | |
| Processors | 1 | |
| RSS bytes | 4193255424 (3999 MiB) | |
| Wall seconds limit | 82800 (23 hours) | |
| Inner Apptainer? | True | |
| Job state | finished | |
| Allocator name | justin-allocator-pro.dune.hep.ac.uk | |
| Started | 2024-09-27 06:55:03 | |
| Input files | hd-protodune:np04hd_raw_run027332_0069_dataflow0_datawriter_0_20240620T230031.hdf5 | |
| Jobscript | Exit code | 0 |
| Real time | 3h (13878s) | |
| CPU time | 2h (7695s = 55%) | |
| Outputting started | 2024-09-27 10:46:22 | |
| Output files | hd-protodune-det-reco:np04hd_raw_run027332_0069_dataflow0_datawriter_0_20240620T230031_reco_stage1_reco_stage2_20240927T104559_keepup.root hd-protodune-det-reco:np04hd_raw_run027332_0069_dataflow0_datawriter_0_20240620T230031_reco_stage1_reco_stage2_20240927T104559_keepup_hists.root | |
| Finished | 2024-09-27 10:53:09 | |
| Saved logs | justin-logs:264667.190-justin-prod-sched01.dune.hep.ac.uk.logs.tgz | |
| List job events Wrapper job log | ||
Jobscript log (last 10,000 characters)
n...
Begin: 9.39653e+07
0 7.79195e+07
1 7.68025e+07
2 7.66668e+07
3 7.66318e+07
Now with regularization...
Begin: 7.29466e+07
0 7.29153e+07
PandoraContentApi::Delete(*this, &vertexList) return STATUS_CODE_NOT_FOUND
in function: RunCosmicRayHitRemoval
in file: /scratch/workspace/build-larsoft/BUILDTYPE/prof/QUAL/s131-e26/label1/swarm/label2/AlmaLinux-9.4/build/larpandoracontent/v04_09_00-buildFW/src/larpandoracontent/LArControlFlow/MasterAlgorithm.cc line#: 449
this->RunCosmicRayHitRemoval(ambiguousPfos) return STATUS_CODE_NOT_FOUND
in function: Run
in file: /scratch/workspace/build-larsoft/BUILDTYPE/prof/QUAL/s131-e26/label1/swarm/label2/AlmaLinux-9.4/build/larpandoracontent/v04_09_00-buildFW/src/larpandoracontent/LArControlFlow/MasterAlgorithm.cc line#: 182
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 Alg0002, LArMaster, STATUS_CODE_NOT_FOUND
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
27-Sep-2024 05:45:59 CDT Closed output file "np04hd_raw_run027332_0069_dataflow0_datawriter_0_20240620T230031_reco_stage1_reco_stage2_20240927T104559_keepup.root"
27-Sep-2024 05:45:59 CDT Closed input file "np04hd_raw_run027332_0069_dataflow0_datawriter_0_20240620T230031_reco_stage1.root"
========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
========================================================================================================================================
Full event 60.3184 193.091 353.843 175.408 66.0116 35
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000715523 0.00395651 0.0116041 0.00312693 0.00273195 35
produce:fembfilter:PDHDFEMBFilter 0.671237 0.919355 1.14066 0.965192 0.107713 35
produce:wclsdatahd:WireCellToolkit 38.1229 49.2546 57.2653 48.9933 5.24064 35
produce:gaushit:GausHitFinder 0.58074 1.18099 1.95552 1.16394 0.310325 35
produce:nhitsfilter:NumberOfHitsFilter 0.000380755 0.000809804 0.00208742 0.00060702 0.000419037 35
[art]:TriggerResults:TriggerResultInserter 2.0548e-05 6.382e-05 0.0001277 6.5192e-05 2.71658e-05 35
end_path:out1:RootOutput 1.0951e-05 1.96149e-05 3.9104e-05 1.6611e-05 7.30625e-06 35
end_path:michelremoving:michelremoving 0.000371969 0.0914246 0.589878 0.0453876 0.107869 35
end_path:michelremovinggnocchi:michelremoving 9.4798e-05 0.0876737 0.67464 0.0425434 0.119163 35
end_path:calibanagnocchi:CalibAnaTree 8.4679e-05 1.37001 2.64716 1.27324 0.624381 35
end_path:out1:RootOutput(write) 0.548516 1.24601 1.83713 1.23792 0.293802 35
produce:reco3d:SpacePointSolver 0.318446 2.66903 7.3237 2.24576 1.71567 34
produce:hitpdune:DisambigFromSpacePoints 0.288528 1.31145 2.99011 1.34758 0.586139 34
produce:pandora:StandardPandora 11.7176 67.5425 225.919 59.1497 45.363 34
produce:pandoraWriter:StandardPandora 0.120151 0.268658 0.427799 0.26846 0.0804941 34
produce:pandoraTrack:LArPandoraTrackCreation 1.44628 4.77652 13.7828 4.40638 2.55478 34
produce:pandoraShower:LArPandoraShowerCreation 1.24815 4.57544 13.4268 3.93497 3.14416 34
produce:pandoracalo:Calorimetry 0.667395 2.10294 7.49082 1.7075 1.27607 34
produce:pandoracalonosce:Calorimetry 0.711624 1.91032 5.72 1.67107 1.02349 34
produce:pandorapid:Chi2ParticleID 0.00205071 0.00371027 0.00745336 0.00349908 0.0011439 34
produce:pandoraShowercalo:ShowerCalorimetry 1.13604 3.84459 11.5136 3.13161 2.4932 34
produce:pandoraShowercalonosce:ShowerCalorimetry 1.04754 3.62982 10.5002 2.94922 2.31203 34
produce:pandoraGnocchiCalo:GnocchiCalorimetry 0.0878476 0.194179 0.402547 0.181657 0.0729609 34
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry 0.0363779 0.0687614 0.12992 0.0647419 0.0250948 34
produce:emtrkmichelid:EmTrackMichelId 29.3469 49.8559 68.1528 49.8254 9.94929 34
========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5042.49 MB
Peak resident set size usage (VmHWM): 2690.61 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run027332_0069_dataflow0_datawriter_0_20240620T230031_reco_stage1_reco_stage2_20240927T104559_keepup.root
\tHists: np04hd_raw_run027332_0069_dataflow0_datawriter_0_20240620T230031_reco_stage1_reco_stage2_20240927T104559_keepup_hists.root
Forming reco metadata
Successfully opened file np04hd_raw_run027332_0069_dataflow0_datawriter_0_20240620T230031_reco_stage1_reco_stage2_20240927T104559_keepup.root
Ran successfully
{
"name": "np04hd_raw_run027332_0069_dataflow0_datawriter_0_20240620T230031_reco_stage1_reco_stage2_20240927T104559_keepup.root",
"namespace": "hd-protodune-det-reco",
"metadata": {
"core.file_format": "artroot",
"core.application.name": "reco",
"core.application.family": "dunesw",
"core.application.version": "v09_91_02d01",
"core.data_tier": "full-reconstructed",
"dune.config_file": "standard_reco_stage2_calibration_protodunehd_keepup.fcl",
"dune.campaign": "hd-protodune-reco-keepup-v0",
"core.start_time": 1727427136.0,
"core.end_time": 1727433960.0,
"core.events": [
9664,
9668,
9672,
9676,
9680,
9684,
9688,
9692,
9696,
9700,
9704,
9708,
9712,
9716,
9720,
9724,
9728,
9732,
9736,
9740,
9744,
9748,
9752,
9756,
9760,
9764,
9768,
9772,
9776,
9780,
9784,
9788,
9792,
9796,
9800
],
"core.event_count": 35,
"core.first_event_number": 9664,
"core.last_event_number": 9800,
"core.data_stream": "physics",
"core.file_content_status": "good",
"core.file_type": "detector",
"core.run_type": "hd-protodune",
"core.runs": [
27332
],
"core.runs_subruns": [
2733200001
],
"dune.daq_test": false,
"retention.status": "active",
"retention.class": "physics",
"origin.applications.config_files": {
"reco1": "standard_reco_stage1_protodunehd_keepup.fcl"
},
"origin.applications.versions": {
"reco1": "v09_91_02d01"
},
"origin.applications.names": [
"reco1"
]
},
"parents": [
{
"did": "hd-protodune:np04hd_raw_run027332_0069_dataflow0_datawriter_0_20240620T230031.hdf5"
}
]
}Forming hist metadata
formed
{
"name": "np04hd_raw_run027332_0069_dataflow0_datawriter_0_20240620T230031_reco_stage1_reco_stage2_20240927T104559_keepup_hists.root",
"namespace": "hd-protodune-det-reco",
"metadata": {
"core.file_format": "root",
"core.application.name": "reco",
"core.application.family": "dunesw",
"core.application.version": "v09_91_02d01",
"core.data_tier": "root-tuple-virtual",
"dune.config_file": "standard_reco_stage2_calibration_protodunehd_keepup.fcl",
"dune.campaign": "hd-protodune-reco-keepup-v0",
"core.start_time": 1727427136.0,
"core.end_time": 1727433960.0,
"core.data_stream": "physics",
"core.file_content_status": "good",
"core.file_type": "detector",
"core.run_type": "hd-protodune",
"core.runs": [
27332
],
"core.runs_subruns": [
2733200001
],
"dune.daq_test": false,
"retention.status": "active",
"retention.class": "physics",
"origin.applications.config_files": {
"reco1": "standard_reco_stage1_protodunehd_keepup.fcl"
},
"origin.applications.versions": {
"reco1": "v09_91_02d01"
},
"origin.applications.names": [
"reco1"
]
},
"parents": [
{
"did": "hd-protodune:np04hd_raw_run027332_0069_dataflow0_datawriter_0_20240620T230031.hdf5"
}
]
}