Jobsub ID 270840.1@dunegpschedd01.fnal.gov
| Jobsub ID | 270840.1@dunegpschedd01.fnal.gov |
| Workflow ID | 11405 |
| Stage ID | 1 |
| User name | pmelas@fnal.gov |
| Requested | Processors | 1 |
| GPU | No |
| RSS bytes | 8388608000 (8000 MiB) |
| Wall seconds limit | 86400 (24 hours) |
| Submitted time | 2025-12-29 21:07:46 |
| Site | IT_CNAF |
| Entry | CMSHTPC_T1_IT_CNAF_condor_ce02 |
| Last heartbeat | 2025-12-29 23:35:58 |
| From worker node | Hostname | wn-s04-05-07-02.cr.cnaf.infn.it |
| cpuinfo | AMD EPYC 7313 16-Core Processor |
| OS release | Scientific Linux release 7.9 (Nitrogen) |
| Processors | 1 |
| RSS bytes | 10485760000 (10000 MiB) |
| Wall seconds limit | 257400 (71 hours) |
| GPU | |
| Inner Apptainer? | True |
| Job state | finished |
| Started | 2025-12-29 21:08:16 |
| Input files | monte-carlo-011405-000001
|
| Jobscript | Exit code | 0 |
| Real time | 2h (8543s) |
| CPU time | 2h (8148s = 95%) |
| Max RSS bytes | 4147802112 (3955 MiB) |
| Outputting started | 2025-12-29 23:30:40 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11405/1/001/reco_stage1.root
|
| Finished | 2025-12-29 23:35:58 |
| Saved logs | justin-logs:270840.1-dunegpschedd01.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
: Running tool adcScaleKeToAdc
ToolBasedRawDigitPrepService:prepare: Running tool pdsp_RemoveBadChannels
ToolBasedRawDigitPrepService:endEvent: End processing run 1 event 10 with 7 tools.
CookedFrameSource: got 15360 recob::Wire objects
input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 101781 traces, 0 summary
Retagger: tagging trace set: gauss with 79322 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 79322 traces tagged "gauss"
FrameSaver: q=2.73521e+06 n=1421197 tag=gauss
wclsFrameSaver: saving 101781 traces tagged "wiener"
FrameSaver: q=2.88239e+06 n=1270298 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 42129 XUs and 44744 XVs -> 915 XUVs
C:0 T:1 122600 XUs and 79909 XVs -> 8519 XUVs
C:0 T:2 53979 XUs and 56145 XVs -> 1927 XUVs
C:0 T:3 29786 XUs and 23918 XVs -> 190 XUVs
C:0 T:4 10513 XUs and 9949 XVs -> 99 XUVs
C:0 T:5 35627 XUs and 24888 XVs -> 2402 XUVs
C:0 T:6 52079 XUs and 45281 XVs -> 3236 XUVs
C:0 T:8 7942 XUs and 8062 XVs -> 145 XUVs
C:0 T:9 49691 XUs and 70070 XVs -> 9262 XUVs
C:0 T:10 17737 XUs and 14286 XVs -> 2746 XUVs
C:0 T:11 9 XUs and 5 XVs -> 2 XUVs
29443 XUVs total
8095 collection wire objects
26478 potential space points
Neighbour search...
3369596 tests to find 1509698 neighbours
Iterating with no regularization...
Begin: 5.04055e+07
0 4.23277e+07
1 4.184e+07
2 4.17705e+07
3 4.17488e+07
Now with regularization...
Begin: 3.4962e+07
0 3.49438e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 411421563
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411421563
fLifetime: 30000 [us]
30-Dec-2025 00:30:38 CET Closed output file "reco_stage1.root"
30-Dec-2025 00:30:38 CET Closed input file "detsim_stage2.root"
DataPrepModule::endJob: # events processed: 10
DataPrepModule::endJob: # events skipped: 0
====================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
====================================================================================================================================
Full event 223.572 274.423 382.326 262.129 45.1947 10
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00115283 0.0029244 0.00408721 0.0029722 0.000977239 10
reco:ophit:OpHitFinder 0.195426 0.261752 0.321941 0.25754 0.0378935 10
reco:opflash:OpFlashFinder 0.0990953 0.147842 0.211633 0.149586 0.0289425 10
reco:opslicer:OpSlicer 0.44365 0.603945 0.777412 0.549893 0.126058 10
reco:caldata:DataPrepModule 3.69254 4.80997 5.83758 4.86727 0.749499 10
reco:wclsdatasp:WireCellToolkit 26.6465 31.4052 36.2971 32.0887 2.89722 10
reco:gaushit:GausHitFinder 0.621876 1.02282 1.34119 1.0518 0.2174 10
reco:nhitsfilter:NumberOfHitsFilter 0.000341612 0.000507164 0.000769466 0.000479616 0.000123609 10
reco:reco3d:SpacePointSolver 8.43396 12.536 20.7133 11.2088 4.16727 10
reco:hitpdune:DisambigFromSpacePoints 1.15657 1.47263 2.16348 1.35579 0.29532 10
reco:pandora:StandardPandora 15.7298 23.9968 37.7204 24.0951 5.90628 10
reco:pandoraWriter:StandardPandora 0.237446 0.355037 0.518983 0.339691 0.0860656 10
reco:pandoraTrack:LArPandoraTrackCreation 1.42818 2.73995 4.58577 2.68623 0.814902 10
reco:pandoraShower:LArPandoraShowerCreation 1.64227 2.84042 5.5528 2.51946 1.10218 10
reco:pandoracalo:Calorimetry 0.80741 1.67027 3.00472 1.49769 0.576034 10
reco:pandoracalonosce:Calorimetry 0.765595 1.46819 2.62443 1.33181 0.493196 10
reco:pandorapid:Chi2ParticleID 0.00315576 0.00461377 0.00567467 0.00497623 0.000861173 10
reco:pandoracalinoxyzt:CalibrationdEdXPDSP 0.0269014 0.0433585 0.0576201 0.0469439 0.0107807 10
reco:pandoracalipidnoxyzt:Chi2ParticleID 0.00292184 0.00440407 0.00568232 0.00470475 0.000985757 10
reco:pandoraShowercalo:ShowerCalorimetry 1.58891 3.12484 6.86675 2.78307 1.43909 10
reco:pandoraShowercalonosce:ShowerCalorimetry 1.29272 3.05754 6.9114 2.87893 1.45942 10
reco:emtrkmichelid:EmTrackMichelId 119.023 150.401 211.348 142.521 25.7177 10
reco:crttag:SingleCRTMatchingProducer 0.00794272 0.0107824 0.0174951 0.00967948 0.00274248 10
reco:crtreco:TwoCRTMatchingProducer 0.00513796 0.00692963 0.0116941 0.00623877 0.00190994 10
reco:anodepiercerst0:T0RecoAnodePiercers 0.592609 0.768193 0.926803 0.768726 0.117674 10
reco:pandora2Track:LArPandoraTrackCreation 5.56297 8.79898 13.2282 7.84579 2.58407 10
reco:pandora2calo:Calorimetry 2.94225 4.81171 7.73568 4.71668 1.46609 10
reco:pandora2calonosce:Calorimetry 2.19226 4.58908 7.98491 4.08376 1.81436 10
reco:pandora2pid:Chi2ParticleID 0.00689094 0.0121696 0.0172893 0.0121406 0.00340988 10
reco:pandora2calinoxyzt:CalibrationdEdXPDSP 0.0372206 0.0617774 0.0882917 0.0624169 0.0164664 10
reco:pandora2calipidnoxyzt:Chi2ParticleID 0.00603506 0.0117036 0.0171967 0.0124066 0.00353943 10
reco:pandora2Shower:LArPandoraShowerCreation 2.21864 3.3612 5.56896 2.82447 1.14743 10
reco:pandora2Showercalo:ShowerCalorimetry 1.98964 4.14753 7.41559 3.54378 1.60431 10
reco:pandora2Showercalonosce:ShowerCalorimetry 1.85586 3.55675 5.1193 3.17566 1.08927 10
[art]:TriggerResults:TriggerResultInserter 3.9253e-05 5.90337e-05 0.000104877 5.4768e-05 1.88113e-05 10
end_path:out1:RootOutput 7.804e-06 1.20618e-05 2.5869e-05 9.5535e-06 5.82795e-06 10
end_path:out1:RootOutput(write) 1.74648 2.23255 2.85783 2.19049 0.376518 10
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4963.54 MB
Peak resident set size usage (VmHWM): 4147.8 MB
Details saved in: 'mem.db'
====================================================================================================
ToolBasedRawDigitPrepService:dtor: Event count: 10
ToolBasedRawDigitPrepService:dtor: Call count: 60
ToolBasedRawDigitPrepService:dtor: Time report for 7 tools.
ToolBasedRawDigitPrepService:dtor: digitReader: 0.06 sec/event
ToolBasedRawDigitPrepService:dtor: adcSampleFiller: 0.22 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleAdcToKe: 0.04 sec/event
ToolBasedRawDigitPrepService:dtor: pdspTailPedRemovalZKe: 3.01 sec/event
ToolBasedRawDigitPrepService:dtor: adcKeepAllSignalFinder: 0.13 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleKeToAdc: 0.04 sec/event
ToolBasedRawDigitPrepService:dtor: pdsp_RemoveBadChannels: 0.00 sec/event
Art has completed and will exit with status 0.
lar exit code 0
.:
total 9681520
-rw-r--r-- 1 neutrino002 neutrino 2279036262 Dec 29 23:43 detsim_stage2.root
-rw-r--r-- 1 neutrino002 neutrino 2157436153 Dec 29 23:41 detsim_stage1.root
-rw-r--r-- 1 neutrino002 neutrino 1951297962 Dec 30 00:30 reco_stage1.root
-rw-r--r-- 1 neutrino002 neutrino 1759304414 Dec 29 22:24 g4_stage2.root
-rw-r--r-- 1 neutrino002 neutrino 1694849599 Dec 29 22:16 g4_stage1.root
-rw-r--r-- 1 neutrino002 neutrino 71320500 Dec 30 00:28 Pandora_Events.pndr
-rw-r--r-- 1 neutrino002 neutrino 242742 Dec 30 00:30 jobscript.log
-rw-r--r-- 1 neutrino002 neutrino 217088 Dec 30 00:30 mem.db
-rw-r--r-- 1 neutrino002 neutrino 62376 Dec 30 00:30 Pandora_Geometry.xml
-rw-r--r-- 1 neutrino002 neutrino 36864 Dec 30 00:30 time.db
-rw-r--r-- 1 neutrino002 neutrino 519 Dec 29 23:43 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 neutrino002 neutrino 519 Dec 29 22:24 g4_protoDUNE_hist.root
-rw-r--r-- 1 neutrino002 neutrino 519 Dec 30 00:30 protoDUNE_reco1_hist.root
-rw-r--r-- 1 neutrino002 neutrino 52 Dec 29 22:08 all-input-dids.txt
-rw-r--r-- 1 neutrino002 neutrino 7 Dec 30 00:30 justin-processed-pfns.txt
-rw-r--r-- 1 neutrino002 neutrino 0 Dec 29 23:47 ProtoDUNE.log
-rw-r--r-- 1 neutrino002 neutrino 0 Dec 29 23:43 debugprod.log
