justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 264653.0@dunegpschedd02.fnal.gov

Jobsub ID264653.0@dunegpschedd02.fnal.gov
Workflow ID11375
Stage ID1
User namepmelas@fnal.gov
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2025-12-28 08:49:45
SiteUS_UCSD
EntryCMSHTPC_T2_US_UCSD_gw6
Last heartbeat2025-12-28 12:51:25
From worker nodeHostnamesdsc-52.t2.ucsd.edu
cpuinfoIntel(R) Xeon(R) CPU E5-2680 v4 @ 2.40GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes10485760000 (10000 MiB)
Wall seconds limit171000 (47 hours)
GPU
Inner Apptainer?True
Job statefinished
Started2025-12-28 08:57:22
Input filesmonte-carlo-011375-000001
JobscriptExit code0
Real time3h (13989s)
CPU time3h (13609s = 97%)
Max RSS bytes4401123328 (4197 MiB)
Outputting started2025-12-28 12:50:32
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11375/1/001/reco_stage1.root
Finished2025-12-28 12:51:25
Saved logsjustin-logs:264653.0-dunegpschedd02.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

olBasedRawDigitPrepService:prepare:   Running tool adcKeepAllSignalFinder
ToolBasedRawDigitPrepService:prepare:   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 113147 traces, 0 summary
Retagger: tagging trace set: gauss with 89646 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 89646 traces tagged "gauss"
FrameSaver: q=3.41801e+06 n=1674813 tag=gauss
wclsFrameSaver: saving 113147 traces tagged "wiener"
FrameSaver: q=3.61023e+06 n=1517453 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 32101 XUs and 38638 XVs -> 1009 XUVs
C:0 T:1 52137 XUs and 53662 XVs -> 3905 XUVs
C:0 T:2 155189 XUs and 187708 XVs -> 9980 XUVs
C:0 T:3 69653 XUs and 69871 XVs -> 769 XUVs
C:0 T:4 6635 XUs and 8263 XVs -> 43 XUVs
C:0 T:5 19745 XUs and 18212 XVs -> 1547 XUVs
C:0 T:6 97118 XUs and 134847 XVs -> 6113 XUVs
C:0 T:8 4195 XUs and 3256 XVs -> 35 XUVs
C:0 T:9 20235 XUs and 31335 XVs -> 1952 XUVs
C:0 T:10 40902 XUs and 30957 XVs -> 4325 XUVs
C:0 T:11 523 XUs and 361 XVs -> 46 XUVs
29724 XUVs total
10352 collection wire objects
27530 potential space points
Neighbour search...
2553824 tests to find 1085766 neighbours
Iterating with no regularization...
Begin: 1.06335e+08
0 8.26641e+07
1 8.08366e+07
2 8.05929e+07
3 8.05235e+07
Now with regularization...
Begin: 6.69003e+07
0 6.67931e+07
1 6.67564e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 411391104
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411391104
fLifetime: 30000 [us]
28-Dec-2025 04:50:29 PST  Closed output file "reco_stage1.root"
28-Dec-2025 04:50:29 PST  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                                          356.438       583.878       789.274       577.558       141.871        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.000884222   0.00356184     0.0065889     0.0038117    0.00161118       10     
reco:ophit:OpHitFinder                             0.264813      0.453163      0.603947      0.478392      0.116961        10     
reco:opflash:OpFlashFinder                         0.168771      0.269865       0.38896      0.249764      0.0679033       10     
reco:opslicer:OpSlicer                             0.632915       1.06228       1.55363       1.06132       0.34771        10     
reco:caldata:DataPrepModule                         5.71335       6.88006       8.95987       6.23045       1.26153        10     
reco:wclsdatasp:WireCellToolkit                     42.5029       50.959        62.7746       51.4975       5.04922        10     
reco:gaushit:GausHitFinder                          1.29295       1.91617       3.21271       1.72192      0.624141        10     
reco:nhitsfilter:NumberOfHitsFilter               0.000570354   0.000805695   0.00111123    0.00078898    0.000176995      10     
reco:reco3d:SpacePointSolver                        12.0636       23.4253       36.718        21.7642       8.87828        10     
reco:hitpdune:DisambigFromSpacePoints               2.17007       4.61113       7.47193       4.83439       1.78566        10     
reco:pandora:StandardPandora                        44.8759       74.8963       152.997       56.8133       36.4185        10     
reco:pandoraWriter:StandardPandora                 0.407543      0.746424       1.01928      0.725137      0.181299        10     
reco:pandoraTrack:LArPandoraTrackCreation           4.21322       10.6366       18.491        9.51855       4.39058        10     
reco:pandoraShower:LArPandoraShowerCreation         4.38115       10.5051       22.4227       7.83818       5.84799        10     
reco:pandoracalo:Calorimetry                        2.1839        4.67372       7.80267       4.40166       1.73078        10     
reco:pandoracalonosce:Calorimetry                   1.9956        4.44621       7.65797       3.82869       1.86985        10     
reco:pandorapid:Chi2ParticleID                    0.00640475    0.00999413     0.0141248     0.0105017     0.0028318       10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0653083      0.1041       0.139585      0.107907      0.0273487       10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00586311     0.0102337     0.0138444     0.0111382     0.002841        10     
reco:pandoraShowercalo:ShowerCalorimetry            4.20246       8.61154       16.4786       8.04293       3.72317        10     
reco:pandoraShowercalonosce:ShowerCalorimetry       3.9371        8.00786       14.0975       6.47039       3.63288        10     
reco:emtrkmichelid:EmTrackMichelId                  174.303       278.424       355.057       289.071       53.6898        10     
reco:crttag:SingleCRTMatchingProducer              0.0187231     0.0305532     0.0414673     0.0294006    0.00709224       10     
reco:crtreco:TwoCRTMatchingProducer                0.0117219     0.0194595     0.0268878     0.0207515     0.0052573       10     
reco:anodepiercerst0:T0RecoAnodePiercers            1.61094       2.32607       2.99724       2.30682      0.455028        10     
reco:pandora2Track:LArPandoraTrackCreation          15.6763       33.0204       53.7455       30.1969       12.7091        10     
reco:pandora2calo:Calorimetry                       6.60773       13.0269       22.4944       11.0345       4.90402        10     
reco:pandora2calonosce:Calorimetry                  5.48868       11.3981       18.2787       10.1308       4.33607        10     
reco:pandora2pid:Chi2ParticleID                    0.0140367     0.024231      0.0386574     0.0220748     0.0083899       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0798918     0.119727      0.180926      0.113215      0.0327885       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID          0.0136933     0.0237121     0.0385608     0.0214079    0.00856958       10     
reco:pandora2Shower:LArPandoraShowerCreation        4.29177       9.34686       13.9064       8.51525       3.0272         10     
reco:pandora2Showercalo:ShowerCalorimetry           5.13385       10.5119       15.6586       11.2053       3.28819        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      4.67591       9.57824       15.514        9.79729       3.46561        10     
[art]:TriggerResults:TriggerResultInserter        3.7465e-05    5.77194e-05   0.000134746    4.79e-05     2.8305e-05       10     
end_path:out1:RootOutput                           7.334e-06    9.0515e-06    1.3714e-05     8.162e-06    2.01842e-06      10     
end_path:out1:RootOutput(write)                     2.41147       3.66362       5.4981        3.63838      0.932908        10     
====================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5220.42 MB
  Peak resident set size usage (VmHWM): 4401.12 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.27 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.06 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   4.16 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 11179904
-rw-r--r--. 1 cuser cuser 2587006814 Dec 28 03:10 detsim_stage2.root
-rw-r--r--. 1 cuser cuser 2446288364 Dec 28 03:08 detsim_stage1.root
-rw-r--r--. 1 cuser cuser 2319193204 Dec 28 04:50 reco_stage1.root
-rw-r--r--. 1 cuser cuser 2055941893 Dec 28 01:22 g4_stage2.root
-rw-r--r--. 1 cuser cuser 1952929520 Dec 28 01:05 g4_stage1.root
-rw-r--r--. 1 cuser cuser   86247060 Dec 28 04:44 Pandora_Events.pndr
-rw-r--r--. 1 cuser cuser     242776 Dec 28 04:50 jobscript.log
-rw-r--r--. 1 cuser cuser     217088 Dec 28 04:50 mem.db
-rw-r--r--. 1 cuser cuser      62376 Dec 28 04:50 Pandora_Geometry.xml
-rw-r--r--. 1 cuser cuser      36864 Dec 28 04:50 time.db
-rw-r--r--. 1 cuser cuser        519 Dec 28 03:10 detsim_single_protoDUNE_hist.root
-rw-r--r--. 1 cuser cuser        519 Dec 28 01:22 g4_protoDUNE_hist.root
-rw-r--r--. 1 cuser cuser        519 Dec 28 04:50 protoDUNE_reco1_hist.root
-rw-r--r--. 1 cuser cuser         52 Dec 28 00:57 all-input-dids.txt
-rw-r--r--. 1 cuser cuser          7 Dec 28 04:50 justin-processed-pfns.txt
-rw-r--r--. 1 cuser cuser          0 Dec 28 03:16 ProtoDUNE.log
-rw-r--r--. 1 cuser cuser          0 Dec 28 03:10 debugprod.log
justIN time: 2026-02-07 02:17:41 UTC       justIN version: 01.06.00