justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 236606.1@dunegpschedd02.fnal.gov

Jobsub ID236606.1@dunegpschedd02.fnal.gov
Workflow ID9543
Stage ID1
User namepmelas@fnal.gov
HTCondor Groupgroup_dune
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2025-11-03 10:56:44
SiteUK_Lancaster
EntryUBoone_UK_Lancaster_HEC_grendel_ce02
Last heartbeat2025-11-03 15:27:07
From worker nodeHostnamecomp19-17
cpuinfoIntel(R) Xeon(R) Gold 6148 CPU @ 2.40GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes10485760000 (10000 MiB)
Wall seconds limit257400 (71 hours)
GPU
Inner Apptainer?True
Job statefinished
Started2025-11-03 10:58:10
Input filesmonte-carlo-009543-000001
JobscriptExit code0
Real time4h (16022s)
CPU time4h (15807s = 98%)
Max RSS bytes4978843648 (4748 MiB)
Outputting started2025-11-03 15:25:13
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/09543/1/001/reco_stage1.root
Finished2025-11-03 15:27:07
Saved logsjustin-logs:236606.1-dunegpschedd02.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

ent: 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 168512 traces, 0 summary
Retagger: tagging trace set: gauss with 125910 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 125910 traces tagged "gauss"
FrameSaver: q=4.31776e+06 n=2169839 tag=gauss
wclsFrameSaver: saving 168512 traces tagged "wiener"
FrameSaver: q=4.59546e+06 n=1899657 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 42564 XUs and 45188 XVs -> 825 XUVs
C:0 T:1 135264 XUs and 199743 XVs -> 23033 XUVs
C:0 T:2 79339 XUs and 107451 XVs -> 10035 XUVs
C:0 T:3 30919 XUs and 40153 XVs -> 285 XUVs
C:0 T:4 14754 XUs and 10812 XVs -> 186 XUVs
C:0 T:5 118522 XUs and 64773 XVs -> 12255 XUVs
C:0 T:6 152268 XUs and 144927 XVs -> 13041 XUVs
C:0 T:7 46886 XUs and 45423 XVs -> 502 XUVs
C:0 T:8 10126 XUs and 13394 XVs -> 188 XUVs
C:0 T:9 68567 XUs and 103321 XVs -> 7901 XUVs
C:0 T:10 97131 XUs and 66585 XVs -> 22757 XUVs
C:0 T:11 59 XUs and 38 XVs -> 8 XUVs
91016 XUVs total
15836 collection wire objects
84046 potential space points
Neighbour search...
18780170 tests to find 7896020 neighbours
Iterating with no regularization...
Begin: 8.57688e+07
0 7.09824e+07
1 6.99895e+07
2 6.98247e+07
3 6.97775e+07
Now with regularization...
Begin: 5.71079e+07
0 5.70315e+07
1 5.69704e+07
2 5.69196e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
run: 1 ; subrun: 0 ; event: 10
evttime: 410286449
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 410286449
fLifetime: 30000 [us]
03-Nov-2025 15:25:07 GMT  Closed output file "reco_stage1.root"
03-Nov-2025 15:25:07 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                                          416.768       547.735       783.22        527.625       110.694        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.000955808   0.00375139    0.00515635    0.00431131    0.00144406       10     
reco:ophit:OpHitFinder                             0.285786       0.3311        0.39466      0.336926      0.0322096       10     
reco:opflash:OpFlashFinder                         0.242077      0.308029      0.359304      0.314329      0.0347709       10     
reco:opslicer:OpSlicer                              0.60745      0.856682       1.0417       0.876814      0.131618        10     
reco:caldata:DataPrepModule                         5.35317       5.73391       6.06848       5.74001      0.236579        10     
reco:wclsdatasp:WireCellToolkit                     44.7276       48.1041       50.6939       48.5841       1.79877        10     
reco:gaushit:GausHitFinder                          1.42472       1.83185       2.59379       1.81666      0.321585        10     
reco:nhitsfilter:NumberOfHitsFilter               0.000685518   0.000883925   0.00123461    0.000863417   0.000141815      10     
reco:reco3d:SpacePointSolver                        15.4386       22.5615       32.1037       22.3268       5.22544        10     
reco:hitpdune:DisambigFromSpacePoints               2.33714       3.32732       4.84582       3.16817      0.781712        10     
reco:pandora:StandardPandora                        45.5197       69.778        151.488       59.9926       30.3058        10     
reco:pandoraWriter:StandardPandora                 0.553994      0.804783       2.36494      0.637213      0.522292        10     
reco:pandoraTrack:LArPandoraTrackCreation           6.61297       12.5603       19.4461       12.0924       4.03405        10     
reco:pandoraShower:LArPandoraShowerCreation         6.40144       15.1036       25.2349       14.8714       6.28974        10     
reco:pandoracalo:Calorimetry                        3.29671       5.63546       9.21661       5.20519       1.77989        10     
reco:pandoracalonosce:Calorimetry                   2.9885        5.36226       8.80933       5.07183       1.7693         10     
reco:pandorapid:Chi2ParticleID                    0.00601653    0.00701975     0.0101142    0.00655954    0.00118294       10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0646337     0.409937       3.40052      0.0784383     0.996896        10     
reco:pandoracalipidnoxyzt:Chi2ParticleID           0.0056827    0.00669468    0.00832908    0.00653855    0.000765891      10     
reco:pandoraShowercalo:ShowerCalorimetry            6.54816       14.0393       23.2662       13.7615       5.45711        10     
reco:pandoraShowercalonosce:ShowerCalorimetry       6.42592       13.4257       22.4078       12.5367       5.23585        10     
reco:emtrkmichelid:EmTrackMichelId                  176.688       209.966       263.681       205.968       24.6105        10     
reco:crttag:SingleCRTMatchingProducer              0.0230072     0.0326841     0.0429999     0.0314661    0.00556197       10     
reco:crtreco:TwoCRTMatchingProducer                0.0116899     0.0238641     0.0345908     0.0248718    0.00694225       10     
reco:anodepiercerst0:T0RecoAnodePiercers            1.27877       1.44879       1.74763       1.40789      0.144045        10     
reco:pandora2Track:LArPandoraTrackCreation          20.5958       41.7337       66.9965       39.7582       13.7567        10     
reco:pandora2calo:Calorimetry                       9.17541       17.837        28.4357       17.4735       6.03163        10     
reco:pandora2calonosce:Calorimetry                  8.71279       16.6095       27.6091       15.5255       5.6893         10     
reco:pandora2pid:Chi2ParticleID                    0.0147114     0.0184714     0.0248717     0.0179319    0.00317681       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0939948     0.154879      0.415622       0.11927      0.0921378       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID          0.0146906     0.0176354     0.0222352     0.0173099    0.00244918       10     
reco:pandora2Shower:LArPandoraShowerCreation        6.82171       11.5888       22.9355       10.5146       4.33156        10     
reco:pandora2Showercalo:ShowerCalorimetry           7.99827       13.0666       19.6834       12.3173       3.67955        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      7.16072       11.2964       18.7174       10.6397       3.27318        10     
[art]:TriggerResults:TriggerResultInserter        5.5216e-05    7.97404e-05   0.000147963   6.86175e-05   3.03026e-05      10     
end_path:out1:RootOutput                           8.959e-06    1.13016e-05   1.7743e-05     1.021e-05    2.55021e-06      10     
end_path:out1:RootOutput(write)                     2.93106       3.56036       5.20277       3.21725      0.718089        10     
====================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5880.36 MB
  Peak resident set size usage (VmHWM): 4978.84 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.08 sec/event
ToolBasedRawDigitPrepService:dtor:                adcSampleFiller:   0.21 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.04 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   3.51 sec/event
ToolBasedRawDigitPrepService:dtor:         adcKeepAllSignalFinder:   0.19 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 12921717
-rw-r--r-- 1 pltdune004 pltdune 2934283434 Nov  3 13:51 detsim_stage2.root
-rw-r--r-- 1 pltdune004 pltdune 2783645630 Nov  3 13:49 detsim_stage1.root
-rw-r--r-- 1 pltdune004 pltdune 2712406787 Nov  3 15:25 reco_stage1.root
-rw-r--r-- 1 pltdune004 pltdune 2394039350 Nov  3 11:25 g4_stage2.root
-rw-r--r-- 1 pltdune004 pltdune 2309649701 Nov  3 11:05 g4_stage1.root
-rw-r--r-- 1 pltdune004 pltdune   97247170 Nov  3 15:20 Pandora_Events.pndr
-rw-r--r-- 1 pltdune004 pltdune     243412 Nov  3 15:25 jobscript.log
-rw-r--r-- 1 pltdune004 pltdune     217088 Nov  3 15:25 mem.db
-rw-r--r-- 1 pltdune004 pltdune      62376 Nov  3 15:25 Pandora_Geometry.xml
-rw-r--r-- 1 pltdune004 pltdune      36864 Nov  3 15:25 time.db
-rw-r--r-- 1 pltdune004 pltdune        519 Nov  3 13:51 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 pltdune004 pltdune        519 Nov  3 11:25 g4_protoDUNE_hist.root
-rw-r--r-- 1 pltdune004 pltdune        519 Nov  3 15:25 protoDUNE_reco1_hist.root
-rw-r--r-- 1 pltdune004 pltdune         52 Nov  3 10:58 all-input-dids.txt
-rw-r--r-- 1 pltdune004 pltdune          7 Nov  3 15:25 justin-processed-pfns.txt
-rw-r--r-- 1 pltdune004 pltdune          0 Nov  3 14:02 ProtoDUNE.log
-rw-r--r-- 1 pltdune004 pltdune          0 Nov  3 13:51 debugprod.log
justIN time: 2025-11-03 18:30:44 UTC       justIN version: 01.05.01