justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 233330.1@dunegpschedd02.fnal.gov

Jobsub ID233330.1@dunegpschedd02.fnal.gov
Workflow ID9389
Stage ID1
User namepmelas@fnal.gov
HTCondor Groupgroup_dune
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2025-10-27 21:19:20
SiteNL_SURFsara
EntryDUNE_SurfSARA_arc03
Last heartbeat2025-10-28 01:21:42
From worker nodeHostnamewn-la-17.gina.surf.nl
cpuinfoAMD EPYC 9754 128-Core Processor
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes10485760000 (10000 MiB)
Wall seconds limit129600 (36 hours)
GPU
Inner Apptainer?True
Job statefinished
Started2025-10-27 21:20:23
Input filesmonte-carlo-009389-000001
JobscriptExit code0
Real time3h (14376s)
CPU time3h (14228s = 98%)
Max RSS bytes4483289088 (4275 MiB)
Outputting started2025-10-28 01:20:00
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/09389/1/001/reco_stage1.root
Finished2025-10-28 01:21:42
Saved logsjustin-logs:233330.1-dunegpschedd02.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

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 129492 traces, 0 summary
Retagger: tagging trace set: gauss with 97267 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 97267 traces tagged "gauss"
FrameSaver: q=3.34129e+06 n=1703076 tag=gauss
wclsFrameSaver: saving 129492 traces tagged "wiener"
FrameSaver: q=3.55203e+06 n=1494725 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 19028 XUs and 25350 XVs -> 290 XUVs
C:0 T:1 28066 XUs and 32837 XVs -> 2041 XUVs
C:0 T:2 88856 XUs and 101006 XVs -> 5722 XUVs
C:0 T:3 37758 XUs and 38218 XVs -> 248 XUVs
C:0 T:4 8907 XUs and 8913 XVs -> 46 XUVs
C:0 T:5 31098 XUs and 24219 XVs -> 3402 XUVs
C:0 T:6 160559 XUs and 171829 XVs -> 9146 XUVs
C:0 T:7 56318 XUs and 55732 XVs -> 640 XUVs
C:0 T:8 6659 XUs and 4221 XVs -> 47 XUVs
C:0 T:9 90285 XUs and 37869 XVs -> 7083 XUVs
C:0 T:10 58974 XUs and 53390 XVs -> 6132 XUVs
C:0 T:11 230 XUs and 158 XVs -> 18 XUVs
34815 XUVs total
12092 collection wire objects
31575 potential space points
Neighbour search...
2901541 tests to find 1408674 neighbours
Iterating with no regularization...
Begin: 7.72505e+07
0 5.52318e+07
1 5.37363e+07
2 5.34767e+07
3 5.33978e+07
4 5.33622e+07
Now with regularization...
Begin: 4.18807e+07
0 4.17945e+07
1 4.1764e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 410154341
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 410154341
fLifetime: 30000 [us]
28-Oct-2025 02:19:58 CET  Closed output file "reco_stage1.root"
28-Oct-2025 02:19:58 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                                          338.345       437.147       514.52        441.399        51.02         10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.00113806    0.00567477    0.00884891    0.00583383    0.00261883       10     
reco:ophit:OpHitFinder                             0.303472      0.333107      0.394913      0.329667      0.0255671       10     
reco:opflash:OpFlashFinder                         0.194452      0.243899      0.281266       0.24584      0.0277588       10     
reco:opslicer:OpSlicer                             0.526252      0.642905      0.781666       0.63106      0.0752081       10     
reco:caldata:DataPrepModule                         4.85744       4.98312       5.40405       4.91531      0.159642        10     
reco:wclsdatasp:WireCellToolkit                     35.4875       48.4049       54.6885       49.6378       5.88294        10     
reco:gaushit:GausHitFinder                         0.936037       1.15945       1.2543        1.19231      0.101933        10     
reco:nhitsfilter:NumberOfHitsFilter               0.000573577   0.000802557   0.00130953    0.00069939    0.000240369      10     
reco:reco3d:SpacePointSolver                        12.6438       20.6928       30.0321       20.8722       5.0154         10     
reco:hitpdune:DisambigFromSpacePoints               1.21296       1.69066       2.24869       1.71924      0.283391        10     
reco:pandora:StandardPandora                        26.6773       41.523        64.5347       40.8337       11.7867        10     
reco:pandoraWriter:StandardPandora                 0.378048      0.477007      0.524824      0.488514      0.0449338       10     
reco:pandoraTrack:LArPandoraTrackCreation           7.1312        9.57216       13.123        9.75028       1.62575        10     
reco:pandoraShower:LArPandoraShowerCreation         6.70859       10.9963       14.6078       11.4508       2.60719        10     
reco:pandoracalo:Calorimetry                        3.97759       5.17621       6.99065       5.1994       0.875213        10     
reco:pandoracalonosce:Calorimetry                   3.95022       4.81056       6.32786       4.63543      0.706671        10     
reco:pandorapid:Chi2ParticleID                    0.00481982     0.0057235    0.00727901    0.00557632    0.000694531      10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0411504     0.0490359     0.0551286     0.0495089    0.00438599       10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00462378    0.00577022     0.0071347    0.00564678    0.000768273      10     
reco:pandoraShowercalo:ShowerCalorimetry            8.04175       11.4269       14.9764       11.1478       2.05485        10     
reco:pandoraShowercalonosce:ShowerCalorimetry       6.62458       10.695        13.6628       11.0605       2.25189        10     
reco:emtrkmichelid:EmTrackMichelId                  141.977       171.877       191.643       177.104       14.8552        10     
reco:crttag:SingleCRTMatchingProducer              0.0110623     0.0224934     0.0279047     0.0233058    0.00438499       10     
reco:crtreco:TwoCRTMatchingProducer                0.0087631     0.020183      0.0296727     0.0199408    0.00602963       10     
reco:anodepiercerst0:T0RecoAnodePiercers            0.81572      0.936737       1.02357      0.963441      0.0719984       10     
reco:pandora2Track:LArPandoraTrackCreation          18.9811       28.489        33.5388       29.0106       4.78317        10     
reco:pandora2calo:Calorimetry                       9.34795       14.4489       18.2325       15.4175       2.89166        10     
reco:pandora2calonosce:Calorimetry                  8.73736       13.8019       17.9101       13.7036       2.6016         10     
reco:pandora2pid:Chi2ParticleID                    0.0095724     0.0123215     0.0145989     0.0123106    0.00137611       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0513776     0.0631523     0.0698737     0.0649181    0.00539298       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID         0.00965325     0.0124038     0.0150921     0.0122275    0.00142177       10     
reco:pandora2Shower:LArPandoraShowerCreation        6.74674       10.7332       14.496        10.8558       2.26495        10     
reco:pandora2Showercalo:ShowerCalorimetry           8.03347       11.762        14.4621       11.7436       1.78386        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      6.46405       8.85648       11.245        9.04274       1.40567        10     
[art]:TriggerResults:TriggerResultInserter         3.332e-05    5.76931e-05   0.000151897   4.2478e-05    3.37528e-05      10     
end_path:out1:RootOutput                           6.77e-06     8.4316e-06    1.4251e-05     7.762e-06    2.04484e-06      10     
end_path:out1:RootOutput(write)                     2.35674       2.93504       3.37008       3.01843      0.282134        10     
====================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5284.52 MB
  Peak resident set size usage (VmHWM): 4483.29 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.23 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.03 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   3.07 sec/event
ToolBasedRawDigitPrepService:dtor:         adcKeepAllSignalFinder:   0.13 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleKeToAdc:   0.03 sec/event
ToolBasedRawDigitPrepService:dtor:         pdsp_RemoveBadChannels:   0.00 sec/event
Art has completed and will exit with status 0.
lar exit code 0
.:
total 11059112
-rw-r--r--. 1 dune009 dune 2557990492 Oct 28 01:05 detsim_stage2.root
-rw-r--r--. 1 dune009 dune 2426494983 Oct 28 01:03 detsim_stage1.root
-rw-r--r--. 1 dune009 dune 2284782426 Oct 28 02:19 reco_stage1.root
-rw-r--r--. 1 dune009 dune 2031127438 Oct 27 22:41 g4_stage2.root
-rw-r--r--. 1 dune009 dune 1939103590 Oct 27 22:26 g4_stage1.root
-rw-r--r--. 1 dune009 dune   84418200 Oct 28 02:15 Pandora_Events.pndr
-rw-r--r--. 1 dune009 dune     242859 Oct 28 02:19 jobscript.log
-rw-r--r--. 1 dune009 dune     217088 Oct 28 02:19 mem.db
-rw-r--r--. 1 dune009 dune      62376 Oct 28 02:19 Pandora_Geometry.xml
-rw-r--r--. 1 dune009 dune      36864 Oct 28 02:19 time.db
-rw-r--r--. 1 dune009 dune        519 Oct 28 01:05 detsim_single_protoDUNE_hist.root
-rw-r--r--. 1 dune009 dune        519 Oct 27 22:41 g4_protoDUNE_hist.root
-rw-r--r--. 1 dune009 dune        519 Oct 28 02:19 protoDUNE_reco1_hist.root
-rw-r--r--. 1 dune009 dune         52 Oct 27 22:20 all-input-dids.txt
-rw-r--r--. 1 dune009 dune          7 Oct 28 02:19 justin-processed-pfns.txt
-rw-r--r--. 1 dune009 dune          0 Oct 28 01:12 ProtoDUNE.log
-rw-r--r--. 1 dune009 dune          0 Oct 28 01:05 debugprod.log
justIN time: 2025-11-05 19:15:36 UTC       justIN version: 01.05.01