Jobsub ID 47830.11@dunegpschedd01.fnal.gov
| Jobsub ID | 47830.11@dunegpschedd01.fnal.gov |
| Workflow ID | 2501 |
| Stage ID | 1 |
| User name | pgranger@fnal.gov |
| HTCondor Group | group_dune |
| Requested | Processors | 1 |
| GPU | No |
| RSS bytes | 4194304000 (4000 MiB) |
| Wall seconds limit | 18000 (5 hours) |
| Submitted time | 2025-09-17 22:53:44 |
| Site | NL_NIKHEF |
| Entry | VIRGO_NL_NIKHEF_juk_multicore |
| Last heartbeat | 2025-09-17 23:04:56 |
| From worker node | Hostname | wn-sate-028.farm.nikhef.nl |
| cpuinfo | AMD EPYC 7551P 32-Core Processor |
| OS release | Scientific Linux release 7.9 (Nitrogen) |
| Processors | 1 |
| RSS bytes | 4194304000 (4000 MiB) |
| Wall seconds limit | 129600 (36 hours) |
| GPU | |
| Inner Apptainer? | True |
| Job state | finished |
| Started | 2025-09-17 22:55:17 |
| Input files | fardet-hd:atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50577091_547_20231204T001237Z_gen_g4_detsim_hitreco__20240509T210056Z_reco2.root
|
| Jobscript | Exit code | 0 |
| Real time | 9m (542s) |
| CPU time | 7m (458s = 84%) |
| Max RSS bytes | 2142932992 (2043 MiB) |
| Outputting started | 2025-09-17 23:04:20 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pgranger/cafs/fnal/02501/1/002/caf_fd_hd_atmo_2501_20250917T225526Z.root
|
| Finished | 2025-09-17 23:04:56 |
| Saved logs | justin-logs:47830.11-dunegpschedd01.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
0.0363951 0.0715351 0.0351928 0.0111484 100
reco:pandora:StandardPandora 0.0941386 2.92284 25.5149 1.71773 4.36964 100
reco:pandoraTrack:LArPandoraTrackCreation 0.000138911 0.0086287 0.178239 0.0016896 0.0240149 100
reco:pandoraShower:LArPandoraModularShowerCreation 0.000194566 0.00995294 0.150844 0.00369621 0.0198591 100
reco:pandoracalo:Calorimetry 0.000112682 0.0223994 0.499942 0.00143475 0.0726339 100
reco:pandorapid:Chi2ParticleID 4.5456e-05 0.000167473 0.00138265 0.000122245 0.000172308 100
reco:cvnmap:CVNMapper 2.147e-05 0.0108208 0.0299341 0.0113103 0.00789316 100
reco:cvneva:CVNEvaluator 2.0017e-05 0.471052 2.49567 0.605995 0.342 100
reco:energyrecnumu:EnergyReco 0.000269617 0.06162 0.559034 0.0175052 0.0947651 100
reco:energyrecnue:EnergyReco 0.000183225 0.00302879 0.0604596 0.00066828 0.00826482 100
reco:energyrecnc:EnergyReco 0.00271399 0.0825115 0.246414 0.0957564 0.0553217 100
reco:energyrecnumurange:EnergyReco 0.000252354 0.0297668 0.514048 0.00286108 0.0840783 100
reco:energyrecnumumcs:EnergyReco 0.000555084 0.0308246 0.517753 0.00376342 0.0842833 100
reco:energyrecnumumcsllhd:EnergyReco 0.00044159 0.0308579 0.522151 0.0036823 0.0847941 100
reco:opdec:Deconvolution 0.0542946 0.231374 0.412947 0.239933 0.0774714 100
reco:ophitspe:OpHitFinderDeco 0.128405 0.134116 0.159949 0.1338 0.00381835 100
reco:opflash:OpFlashFinder 0.000144642 0.00125249 0.00264577 0.00119676 0.000581014 100
reco:opslicer:OpSlicer 4.3782e-05 0.250682 0.812034 0.222252 0.196186 100
reco:rns:RandomNumberSaver 2.0358e-05 3.39141e-05 0.000295756 2.9405e-05 2.73784e-05 100
reco:anglereconue:NuAngularReco 0.000151956 0.00199683 0.0478379 0.000385334 0.00616026 100
reco:anglereconumu:NuAngularReco 9.2183e-05 0.0018599 0.0478265 0.000251813 0.00616705 100
reco:anglereconuepfps:NuAngularReco 0.000139231 0.00200315 0.0493682 0.000354456 0.00631073 100
reco:anglereconumupfps:NuAngularReco 0.000133481 0.00194278 0.0483257 0.000316996 0.00622853 100
reco:anglerecohits:NuAngularReco 0.000105117 0.00263127 0.0515068 0.000702982 0.00677626 100
[art]:TriggerResults:TriggerResultInserter 1.0871e-05 1.31407e-05 5.7468e-05 1.19925e-05 4.91495e-06 100
end_path:cafmaker:CAFMaker 0.00114891 0.0252503 0.469251 0.00443467 0.068568 100
========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 3805.5 MB
Peak resident set size usage (VmHWM): 2142.93 MB
====================================================================================================
lar exit code 0
=== Start last 100 lines of lar log file ===
Output 2: 0.779708, 0.215949, 0.00422623, 0.000116747,
Running Ophitfinder with InputDigiType = 'recob'
Found hits: 1456!
Begin processing the 92nd record. run: 50577091 subRun: 1 event: 54792 at 18-Sep-2025 01:03:16 CEST
Running Ophitfinder with InputDigiType = 'recob'
Found hits: 347!
Begin processing the 93rd record. run: 50577091 subRun: 1 event: 54793 at 18-Sep-2025 01:03:18 CEST
Running Ophitfinder with InputDigiType = 'recob'
Found hits: 552!
Begin processing the 94th record. run: 50577091 subRun: 1 event: 54794 at 18-Sep-2025 01:03:20 CEST
Boundary wire vector sizes: 643, 641, 383
minwire 0: 1339
minwire 1: 1253
minwire 2: 1226
Used alternate method to get min and max tdcs due to vertex determination failure: 0, 299
Used alternate method to get min and max tdcs due to vertex determination failure: 0, 299
Used alternate method to get min and max tdcs due to vertex determination failure: 0, 299
Classifier summary:
Output 0: 0.000494613, 0.996639, 0.0028669,
Output 1: 0.991746, 0.00806005, 9.84739e-05, 9.49827e-05,
Output 2: 0.998864, 0.00109063, 3.12707e-05, 1.39185e-05,
Running Ophitfinder with InputDigiType = 'recob'
Found hits: 2506!
Begin processing the 95th record. run: 50577091 subRun: 1 event: 54795 at 18-Sep-2025 01:03:24 CEST
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_16_00-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_16_00-buildFW/src/larpandoracontent/LArControlFlow/MasterAlgorithm.cc line#: 165
iter->second->Run() throw STATUS_CODE_NOT_INITIALIZED
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 Alg0003, LArDLMaster, STATUS_CODE_NOT_INITIALIZED
Running Ophitfinder with InputDigiType = 'recob'
Found hits: 0!
Begin processing the 96th record. run: 50577091 subRun: 1 event: 54796 at 18-Sep-2025 01:03:25 CEST
Boundary wire vector sizes: 1452, 1430, 616
minwire 0: 320
minwire 1: 1657
minwire 2: 314
Used alternate method to get min and max tdcs due to vertex determination failure: 0, 299
Used alternate method to get min and max tdcs due to vertex determination failure: 0, 299
Used alternate method to get min and max tdcs due to vertex determination failure: 0, 299
Classifier summary:
Output 0: 0.0430372, 0.81686, 0.140103,
Output 1: 0.830945, 0.15819, 0.00917793, 0.00168735,
Output 2: 0.157391, 0.821457, 0.0205152, 0.000636111,
Running Ophitfinder with InputDigiType = 'recob'
Found hits: 2332!
Begin processing the 97th record. run: 50577091 subRun: 1 event: 54797 at 18-Sep-2025 01:03:30 CEST
Running Ophitfinder with InputDigiType = 'recob'
Found hits: 550!
Begin processing the 98th record. run: 50577091 subRun: 1 event: 54798 at 18-Sep-2025 01:03:32 CEST
Boundary wire vector sizes: 4598, 4801, 1627
minwire 0: 232
minwire 1: 1592
minwire 2: 6
Used alternate method to get min and max tdcs due to vertex determination failure: 0, 299
Used alternate method to get min and max tdcs due to vertex determination failure: 0, 299
Used alternate method to get min and max tdcs due to vertex determination failure: 0, 299
Classifier summary:
Output 0: 0.00106195, 0.994011, 0.00492688,
Output 1: 0.473271, 0.369791, 0.0819022, 0.075036,
Output 2: 0.155044, 0.366196, 0.314618, 0.164142,
Running Ophitfinder with InputDigiType = 'recob'
Found hits: 3417!
Begin processing the 99th record. run: 50577091 subRun: 1 event: 54799 at 18-Sep-2025 01:03:46 CEST
Running Ophitfinder with InputDigiType = 'recob'
Found hits: 151!
Begin processing the 100th record. run: 50577091 subRun: 1 event: 54800 at 18-Sep-2025 01:03:48 CEST
Boundary wire vector sizes: 5722, 7789, 6005
minwire 0: 118
minwire 1: 1067
minwire 2: 11
Used alternate method to get min and max tdcs due to vertex determination failure: 0, 299
Used alternate method to get min and max tdcs due to vertex determination failure: 0, 299
Used alternate method to get min and max tdcs due to vertex determination failure: 0, 299
Classifier summary:
Output 0: 0.0102176, 0.860331, 0.129451,
Output 1: 0.0261146, 0.105595, 0.184756, 0.683535,
Output 2: 0.0849527, 0.193488, 0.313858, 0.407701,
Running Ophitfinder with InputDigiType = 'recob'
Found hits: 3158!
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===
processed files
root://se1.farm.particle.cz:1094//dune/RSE/fardet-hd/2a/37/atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50577091_547_20231204T001237Z_gen_g4_detsim_hitreco__20240509T210056Z_reco2.root
.:
total 5840
-rw-r--r--. 1 dune012 dune 2277186 Sep 18 01:04 flatcaf.root
-rw-r--r--. 1 dune012 dune 1774467 Sep 18 01:04 caf.root
-rw-r--r--. 1 dune012 dune 1774467 Sep 18 01:04 caf_fd_hd_atmo_2501_20250917T225526Z.root
-rw-r--r--. 1 dune012 dune 74792 Sep 18 01:04 caf_20250917T225526Z.log
-rw-r--r--. 1 dune012 dune 28793 Sep 18 01:04 jobscript.log
-rw-r--r--. 1 dune012 dune 187 Sep 18 01:04 caf_20250917T225526Z.file
-rw-r--r--. 1 dune012 dune 187 Sep 18 01:04 caf_20250917T225526Z.pfns
-rw-r--r--. 1 dune012 dune 187 Sep 18 00:55 file.list
-rw-r--r--. 1 dune012 dune 187 Sep 18 01:04 justin-processed-pfns.txt
-rw-r--r--. 1 dune012 dune 138 Sep 18 00:55 all-input-dids.txt
-rw-r--r--. 1 dune012 dune 138 Sep 18 01:04 caf_20250917T225526Z.did
-rw-r--r--. 1 dune012 dune 138 Sep 18 00:55 did.list
-rw-r--r--. 1 dune012 dune 0 Sep 18 00:55 debugprod.log 