justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 270419.0@dunegpschedd01.fnal.gov

Jobsub ID270419.0@dunegpschedd01.fnal.gov
Workflow ID11360
Stage ID1
User namepmelas@fnal.gov
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2025-12-27 16:54:55
SiteUK_RAL-PPD
EntryCMSHTPC_T2_UK_SGrid_RALPP_hep206
Last heartbeat2025-12-27 21:12:26
From worker nodeHostnameheplnc159.pp.rl.ac.uk
cpuinfoAMD EPYC 7763 64-Core Processor
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes10485760000 (10000 MiB)
Wall seconds limit257400 (71 hours)
GPU
Inner Apptainer?True
Job statefinished
Started2025-12-27 16:57:56
Input filesmonte-carlo-011360-000001
JobscriptExit code0
Real time4h (15182s)
CPU time4h (14545s = 95%)
Max RSS bytes4266582016 (4068 MiB)
Outputting started2025-12-27 21:10:59
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11360/1/001/reco_stage1.root
Finished2025-12-27 21:12:26
Saved logsjustin-logs:270419.0-dunegpschedd01.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

pare:   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 120332 traces, 0 summary
Retagger: tagging trace set: gauss with 86566 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 86566 traces tagged "gauss"
FrameSaver: q=3.02328e+06 n=1442290 tag=gauss
wclsFrameSaver: saving 120332 traces tagged "wiener"
FrameSaver: q=3.22473e+06 n=1248100 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 11882 XUs and 19008 XVs -> 195 XUVs
C:0 T:1 26350 XUs and 33848 XVs -> 2831 XUVs
C:0 T:2 31755 XUs and 44350 XVs -> 2866 XUVs
C:0 T:3 14912 XUs and 21688 XVs -> 155 XUVs
C:0 T:4 16342 XUs and 16110 XVs -> 313 XUVs
C:0 T:5 86559 XUs and 90828 XVs -> 16165 XUVs
C:0 T:6 98260 XUs and 57682 XVs -> 12849 XUVs
C:0 T:8 12948 XUs and 15704 XVs -> 214 XUVs
C:0 T:9 111720 XUs and 174002 XVs -> 15251 XUVs
C:0 T:10 41711 XUs and 22914 XVs -> 6363 XUVs
C:0 T:11 109 XUs and 21 XVs -> 14 XUVs
57216 XUVs total
10159 collection wire objects
54343 potential space points
Neighbour search...
11439763 tests to find 4956484 neighbours
Iterating with no regularization...
Begin: 4.60886e+07
0 3.83078e+07
1 3.76232e+07
2 3.75078e+07
3 3.74731e+07
Now with regularization...
Begin: 2.85528e+07
0 2.85164e+07
1 2.84805e+07
2 2.84526e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 411377776
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411377776
fLifetime: 30000 [us]
27-Dec-2025 21:10:57 GMT  Closed output file "reco_stage1.root"
27-Dec-2025 21:10:57 GMT  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                                          332.739       472.152       588.891       461.953       74.7347        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.00110549     0.0053264     0.0114311    0.00493395    0.00289815       10     
reco:ophit:OpHitFinder                             0.267894      0.419465       0.48633      0.432805      0.0597063       10     
reco:opflash:OpFlashFinder                         0.170734      0.251722      0.307521      0.265492      0.0432122       10     
reco:opslicer:OpSlicer                             0.693375      0.979583       1.27793      0.948646      0.174248        10     
reco:caldata:DataPrepModule                         7.08324       7.49539       7.93067       7.45865      0.271135        10     
reco:wclsdatasp:WireCellToolkit                     36.8056       41.0603       44.7972       41.4495       2.25245        10     
reco:gaushit:GausHitFinder                         0.953906       1.56325       2.1336        1.6485       0.352128        10     
reco:nhitsfilter:NumberOfHitsFilter               0.000543413   0.000707536   0.000928047   0.000684724   0.000124053      10     
reco:reco3d:SpacePointSolver                        17.8481       28.0429       50.9518       25.9196       10.2101        10     
reco:hitpdune:DisambigFromSpacePoints               1.64907       2.54801       3.4592        2.37022      0.614138        10     
reco:pandora:StandardPandora                        30.6117       49.3078       86.7874       45.8241       16.7654        10     
reco:pandoraWriter:StandardPandora                 0.457622      0.670268       1.1805       0.641075      0.192099        10     
reco:pandoraTrack:LArPandoraTrackCreation           3.72744       6.20324       9.29698       6.36991       1.62338        10     
reco:pandoraShower:LArPandoraShowerCreation         4.05014       6.58489       9.4278        6.78543       1.58818        10     
reco:pandoracalo:Calorimetry                        1.45789       3.2693        5.0669        3.33302      0.947276        10     
reco:pandoracalonosce:Calorimetry                   1.33961       2.92692       4.35069       2.93521      0.854941        10     
reco:pandorapid:Chi2ParticleID                    0.00425433    0.00725755     0.0104185    0.00728852    0.00191596       10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0396285     0.0784283     0.114286      0.0823124     0.0236395       10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00413102    0.00784398    0.00987891    0.00853581    0.00194018       10     
reco:pandoraShowercalo:ShowerCalorimetry            3.01755       7.11824       10.7186       6.61597       2.20822        10     
reco:pandoraShowercalonosce:ShowerCalorimetry       3.36506       6.70383       9.48522       6.17247       1.90063        10     
reco:emtrkmichelid:EmTrackMichelId                  178.991       243.628       277.083       245.971       29.5855        10     
reco:crttag:SingleCRTMatchingProducer              0.0105516     0.0207893     0.0397709     0.0191849    0.00728747       10     
reco:crtreco:TwoCRTMatchingProducer               0.00608479     0.0141693     0.0278927     0.0121963    0.00589204       10     
reco:anodepiercerst0:T0RecoAnodePiercers           0.930278       1.18074       1.39663       1.16292      0.150424        10     
reco:pandora2Track:LArPandoraTrackCreation          7.96034       18.8236       25.9251       19.1735       4.92705        10     
reco:pandora2calo:Calorimetry                       4.70417       9.09924       12.6668       8.81425       1.95618        10     
reco:pandora2calonosce:Calorimetry                  4.53575       8.82688       12.3268       8.64885       1.99144        10     
reco:pandora2pid:Chi2ParticleID                    0.0119826     0.020376      0.0256482     0.0202882    0.00408831       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0576008     0.103921      0.128597      0.0994781     0.021868        10     
reco:pandora2calipidnoxyzt:Chi2ParticleID         0.00984797     0.0187618     0.0239174     0.019205     0.00449489       10     
reco:pandora2Shower:LArPandoraShowerCreation        2.92242       6.25302       8.76396       6.25371       1.69107        10     
reco:pandora2Showercalo:ShowerCalorimetry           3.88464       8.00518       10.2764       7.97493       1.79514        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      4.77569       6.90997       8.71404       6.74446       1.1687         10     
[art]:TriggerResults:TriggerResultInserter        5.6646e-05    9.94142e-05   0.000180179   8.67935e-05   3.48333e-05      10     
end_path:out1:RootOutput                           9.148e-06    1.41806e-05    2.121e-05    1.32845e-05   3.69951e-06      10     
end_path:out1:RootOutput(write)                     3.12047       3.81009       4.80267       3.72292       0.51133        10     
====================================================================================================================================

====================================================================================================
MemoryTracker summary (base-10 MB units used)

  Peak virtual memory usage (VmPeak)  : 5123.55 MB
  Peak resident set size usage (VmHWM): 4266.58 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.10 sec/event
ToolBasedRawDigitPrepService:dtor:                adcSampleFiller:   0.35 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.06 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   4.72 sec/event
ToolBasedRawDigitPrepService:dtor:         adcKeepAllSignalFinder:   0.20 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleKeToAdc:   0.06 sec/event
ToolBasedRawDigitPrepService:dtor:         pdsp_RemoveBadChannels:   0.00 sec/event
Art has completed and will exit with status 0.
lar exit code 0
.:
total 10754084
-rw-r--r-- 1 pltdune04 pltdune 2505312711 Dec 27 19:49 detsim_stage2.root
-rw-r--r-- 1 pltdune04 pltdune 2373253809 Dec 27 19:47 detsim_stage1.root
-rw-r--r-- 1 pltdune04 pltdune 2221729626 Dec 27 21:10 reco_stage1.root
-rw-r--r-- 1 pltdune04 pltdune 1960699516 Dec 27 17:20 g4_stage2.root
-rw-r--r-- 1 pltdune04 pltdune 1868857442 Dec 27 17:05 g4_stage1.root
-rw-r--r-- 1 pltdune04 pltdune   81711760 Dec 27 21:07 Pandora_Events.pndr
-rw-r--r-- 1 pltdune04 pltdune     242879 Dec 27 21:10 jobscript.log
-rw-r--r-- 1 pltdune04 pltdune     217088 Dec 27 21:10 mem.db
-rw-r--r-- 1 pltdune04 pltdune      62376 Dec 27 21:10 Pandora_Geometry.xml
-rw-r--r-- 1 pltdune04 pltdune      36864 Dec 27 21:10 time.db
-rw-r--r-- 1 pltdune04 pltdune        519 Dec 27 19:49 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 pltdune04 pltdune        519 Dec 27 17:20 g4_protoDUNE_hist.root
-rw-r--r-- 1 pltdune04 pltdune        519 Dec 27 21:10 protoDUNE_reco1_hist.root
-rw-r--r-- 1 pltdune04 pltdune         52 Dec 27 16:57 all-input-dids.txt
-rw-r--r-- 1 pltdune04 pltdune          7 Dec 27 21:10 justin-processed-pfns.txt
-rw-r--r-- 1 pltdune04 pltdune          0 Dec 27 19:57 ProtoDUNE.log
-rw-r--r-- 1 pltdune04 pltdune          0 Dec 27 19:49 debugprod.log
justIN time: 2026-02-07 03:35:43 UTC       justIN version: 01.06.00