justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 270420.0@dunegpschedd01.fnal.gov

Jobsub ID270420.0@dunegpschedd01.fnal.gov
Workflow ID11362
Stage ID1
User namepmelas@fnal.gov
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2025-12-27 16:54:55
SiteES_PIC
EntryDUNE_T1_ES_PIC_ce15-multicore
Last heartbeat2025-12-27 20:34:35
From worker nodeHostnamehnode73.pic.es
cpuinfoAMD EPYC 7443P 24-Core Processor
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes10485760000 (10000 MiB)
Wall seconds limit216000 (60 hours)
GPU
Inner Apptainer?True
Job statefinished
Started2025-12-27 16:58:19
Input filesmonte-carlo-011362-000001
JobscriptExit code0
Real time3h (12904s)
CPU time3h (11448s = 88%)
Max RSS bytes4625141760 (4410 MiB)
Outputting started2025-12-27 20:33:24
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11362/1/001/reco_stage1.root
Finished2025-12-27 20:34:35
Saved logsjustin-logs:270420.0-dunegpschedd01.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

are:   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 135500 traces, 0 summary
Retagger: tagging trace set: gauss with 102237 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 102237 traces tagged "gauss"
FrameSaver: q=3.65658e+06 n=1809361 tag=gauss
wclsFrameSaver: saving 135500 traces tagged "wiener"
FrameSaver: q=3.86575e+06 n=1601833 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 27322 XUs and 29152 XVs -> 598 XUVs
C:0 T:1 48536 XUs and 45066 XVs -> 4371 XUVs
C:0 T:2 86254 XUs and 92179 XVs -> 3175 XUVs
C:0 T:3 43357 XUs and 44138 XVs -> 349 XUVs
C:0 T:4 17587 XUs and 16389 XVs -> 181 XUVs
C:0 T:5 71418 XUs and 51387 XVs -> 5986 XUVs
C:0 T:6 145558 XUs and 167159 XVs -> 12514 XUVs
C:0 T:7 55972 XUs and 59080 XVs -> 816 XUVs
C:0 T:8 4997 XUs and 6417 XVs -> 63 XUVs
C:0 T:9 28911 XUs and 47734 XVs -> 2002 XUVs
C:0 T:10 45498 XUs and 29539 XVs -> 5363 XUVs
C:0 T:11 202 XUs and 126 XVs -> 16 XUVs
35434 XUVs total
11195 collection wire objects
32166 potential space points
Neighbour search...
2140828 tests to find 1156874 neighbours
Iterating with no regularization...
Begin: 7.89523e+07
0 6.85862e+07
1 6.78891e+07
2 6.778e+07
3 6.77465e+07
Now with regularization...
Begin: 5.68345e+07
0 5.6811e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 411377752
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411377752
fLifetime: 30000 [us]
27-Dec-2025 21:33:21 CET  Closed output file "reco_stage1.root"
27-Dec-2025 21:33:21 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                                          234.293       365.043       487.431       364.322       75.9589        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.000762997   0.00391022    0.00809088     0.0034689     0.0022068       10     
reco:ophit:OpHitFinder                             0.207232      0.305295      0.445328       0.2941       0.0670148       10     
reco:opflash:OpFlashFinder                         0.144399      0.222938      0.332506      0.224503      0.0507207       10     
reco:opslicer:OpSlicer                             0.418567      0.699284       1.13901      0.646922      0.208207        10     
reco:caldata:DataPrepModule                         3.80882       5.0019        6.4684        4.56599       1.08384        10     
reco:wclsdatasp:WireCellToolkit                     26.831        31.6346       38.2484       30.1872       3.93995        10     
reco:gaushit:GausHitFinder                         0.777304       1.22823       1.83801       1.19104      0.335535        10     
reco:nhitsfilter:NumberOfHitsFilter               0.000309848   0.000502582   0.000759167   0.000536922   0.000140631      10     
reco:reco3d:SpacePointSolver                        5.89991       17.5649       32.5016       17.2481       7.94476        10     
reco:hitpdune:DisambigFromSpacePoints              0.845117       1.8037        2.98863       1.78658      0.668742        10     
reco:pandora:StandardPandora                        18.2081       37.2918       61.8756       35.6612       13.2969        10     
reco:pandoraWriter:StandardPandora                 0.255643      0.435204      0.499814      0.458605      0.0694752       10     
reco:pandoraTrack:LArPandoraTrackCreation           1.85964       5.01647       7.29984       5.00238       1.47757        10     
reco:pandoraShower:LArPandoraShowerCreation         1.84718       5.87728       11.5849       5.60948       2.69325        10     
reco:pandoracalo:Calorimetry                        1.28088       2.7287        4.42219       2.77119      0.933562        10     
reco:pandoracalonosce:Calorimetry                   1.20717       2.75758       4.14938       2.77056      0.942758        10     
reco:pandorapid:Chi2ParticleID                    0.00383523    0.00642731    0.00865854    0.00654384    0.00135811       10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0318559     0.0569063     0.088935      0.0536776     0.0163291       10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00389381    0.00605285    0.00869199    0.00597661     0.0015012       10     
reco:pandoraShowercalo:ShowerCalorimetry            3.15802       6.32818       11.3393       6.18102       2.66059        10     
reco:pandoraShowercalonosce:ShowerCalorimetry       2.32144       6.29094       13.2396       5.87865       3.01047        10     
reco:emtrkmichelid:EmTrackMichelId                  134.318       185.286       237.841       189.531       29.778         10     
reco:crttag:SingleCRTMatchingProducer             0.00736391     0.0149093     0.0263596     0.0139539     0.005324        10     
reco:crtreco:TwoCRTMatchingProducer                0.0050837     0.0117446     0.0221844     0.0101826    0.00527201       10     
reco:anodepiercerst0:T0RecoAnodePiercers            0.69439      0.956718       1.33422      0.907945      0.224311        10     
reco:pandora2Track:LArPandoraTrackCreation          8.28057       16.4786       35.1383       13.5676       7.52214        10     
reco:pandora2calo:Calorimetry                       3.3919        7.93287       12.6567       7.40946       2.96969        10     
reco:pandora2calonosce:Calorimetry                  3.09347       8.17329       13.6555       7.84646       3.31049        10     
reco:pandora2pid:Chi2ParticleID                   0.00750041     0.013646      0.0210465     0.0130011    0.00448937       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0372734     0.0656258     0.111545      0.0623632     0.0239967       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID          0.0078977     0.0140608     0.0211091     0.0143548    0.00449956       10     
reco:pandora2Shower:LArPandoraShowerCreation        2.89842       5.26226       10.2101       4.33192       2.35675        10     
reco:pandora2Showercalo:ShowerCalorimetry           2.60684       6.37028       13.7373       4.96681       3.33346        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      2.46504       6.13687       13.0712       4.78607       3.35836        10     
[art]:TriggerResults:TriggerResultInserter        2.4251e-05    4.3576e-05    0.000120993   3.8101e-05    2.65484e-05      10     
end_path:out1:RootOutput                           4.54e-06     6.0724e-06     1.16e-05     5.6155e-06    1.93817e-06      10     
end_path:out1:RootOutput(write)                     1.72786       2.93013       4.43229       2.77565      0.979507        10     
====================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5432.44 MB
  Peak resident set size usage (VmHWM): 4625.14 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.04 sec/event
ToolBasedRawDigitPrepService:dtor:                adcSampleFiller:   0.22 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.04 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   3.20 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 11455508
-rw-r--r-- 1 dune001 dune 2641499914 Dec 27 20:30 detsim_stage2.root
-rw-r--r-- 1 dune001 dune 2504105596 Dec 27 20:28 detsim_stage1.root
-rw-r--r-- 1 dune001 dune 2351048000 Dec 27 21:33 reco_stage1.root
-rw-r--r-- 1 dune001 dune 2118940559 Dec 27 18:28 g4_stage2.root
-rw-r--r-- 1 dune001 dune 2033747155 Dec 27 18:07 g4_stage1.root
-rw-r--r-- 1 dune001 dune   80469310 Dec 27 21:28 Pandora_Events.pndr
-rw-r--r-- 1 dune001 dune     242932 Dec 27 21:33 jobscript.log
-rw-r--r-- 1 dune001 dune     217088 Dec 27 21:33 mem.db
-rw-r--r-- 1 dune001 dune      62376 Dec 27 21:33 Pandora_Geometry.xml
-rw-r--r-- 1 dune001 dune      36864 Dec 27 21:33 time.db
-rw-r--r-- 1 dune001 dune        519 Dec 27 20:30 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 dune001 dune        519 Dec 27 18:28 g4_protoDUNE_hist.root
-rw-r--r-- 1 dune001 dune        519 Dec 27 21:33 protoDUNE_reco1_hist.root
-rw-r--r-- 1 dune001 dune         52 Dec 27 17:58 all-input-dids.txt
-rw-r--r-- 1 dune001 dune          7 Dec 27 21:33 justin-processed-pfns.txt
-rw-r--r-- 1 dune001 dune          0 Dec 27 20:36 ProtoDUNE.log
-rw-r--r-- 1 dune001 dune          0 Dec 27 20:30 debugprod.log
justIN time: 2026-02-07 03:36:09 UTC       justIN version: 01.06.00