justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 270479.1@dunegpschedd01.fnal.gov

Jobsub ID270479.1@dunegpschedd01.fnal.gov
Workflow ID11373
Stage ID1
User namepmelas@fnal.gov
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2025-12-28 08:47:46
SiteIT_CNAF
EntryCMSHTPC_T1_IT_CNAF_condor_ce02
Last heartbeat2025-12-28 11:23:13
From worker nodeHostnamewn-s04-05-09-02.cr.cnaf.infn.it
cpuinfoAMD EPYC 7313 16-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-28 08:48:35
Input filesmonte-carlo-011373-000001
JobscriptExit code0
Real time2h (8960s)
CPU time2h (8565s = 95%)
Max RSS bytes4405272576 (4201 MiB)
Outputting started2025-12-28 11:17:56
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11373/1/001/reco_stage1.root
Finished2025-12-28 11:23:13
Saved logsjustin-logs:270479.1-dunegpschedd01.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

Event: 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 146014 traces, 0 summary
Retagger: tagging trace set: gauss with 114570 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 114570 traces tagged "gauss"
FrameSaver: q=3.85706e+06 n=2084313 tag=gauss
wclsFrameSaver: saving 146014 traces tagged "wiener"
FrameSaver: q=4.0532e+06 n=1866077 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 23292 XUs and 20975 XVs -> 250 XUVs
C:0 T:1 40747 XUs and 38724 XVs -> 2842 XUVs
C:0 T:2 108998 XUs and 96958 XVs -> 5387 XUVs
C:0 T:3 44199 XUs and 40215 XVs -> 319 XUVs
C:0 T:4 16537 XUs and 16639 XVs -> 162 XUVs
C:0 T:5 49935 XUs and 43516 XVs -> 3206 XUVs
C:0 T:6 115892 XUs and 128789 XVs -> 5866 XUVs
C:0 T:7 47631 XUs and 50759 XVs -> 514 XUVs
C:0 T:8 12229 XUs and 13359 XVs -> 156 XUVs
C:0 T:9 77812 XUs and 101838 XVs -> 6209 XUVs
C:0 T:10 53654 XUs and 45965 XVs -> 4452 XUVs
C:0 T:11 294 XUs and 287 XVs -> 30 XUVs
29393 XUVs total
12559 collection wire objects
26844 potential space points
Neighbour search...
1249612 tests to find 676490 neighbours
Iterating with no regularization...
Begin: 8.44204e+07
0 7.46514e+07
1 7.40139e+07
2 7.39308e+07
3 7.39088e+07
Now with regularization...
Begin: 6.31173e+07
0 6.30981e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
run: 1 ; subrun: 0 ; event: 10
evttime: 411391125
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411391125
fLifetime: 30000 [us]
28-Dec-2025 12:17:55 CET  Closed output file "reco_stage1.root"
28-Dec-2025 12:17:55 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                                          163.649       238.436       303.229       249.771       49.1368        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.000729662   0.00345147    0.00525077     0.0037336     0.0013533       10     
reco:ophit:OpHitFinder                             0.199744      0.229288      0.283791      0.228035      0.0237386       10     
reco:opflash:OpFlashFinder                         0.123762      0.173657      0.237007      0.163567      0.0345962       10     
reco:opslicer:OpSlicer                             0.375243      0.490052      0.608317      0.505024      0.0684975       10     
reco:caldata:DataPrepModule                         3.46942       3.60183       3.79633       3.59678      0.0955494       10     
reco:wclsdatasp:WireCellToolkit                     23.5021       25.267        28.649        25.0113       1.62084        10     
reco:gaushit:GausHitFinder                         0.536812      0.787529      0.940389      0.811836      0.141226        10     
reco:nhitsfilter:NumberOfHitsFilter               0.000261762   0.000449983   0.000715887   0.000392293   0.00015644       10     
reco:reco3d:SpacePointSolver                        5.31301       13.5613       33.799        12.4697        7.527         10     
reco:hitpdune:DisambigFromSpacePoints              0.581855       1.15273       1.53577       1.26551      0.345421        10     
reco:pandora:StandardPandora                        11.3872       22.7575       33.024        23.8484       7.56971        10     
reco:pandoraWriter:StandardPandora                 0.197406      0.289854       0.35015      0.312766      0.0577106       10     
reco:pandoraTrack:LArPandoraTrackCreation           1.44925       2.5909        3.5862        2.58174      0.672878        10     
reco:pandoraShower:LArPandoraShowerCreation         1.18014       2.66995       4.13377       2.81658      0.958637        10     
reco:pandoracalo:Calorimetry                       0.811871       1.49073       2.09934       1.5477       0.413315        10     
reco:pandoracalonosce:Calorimetry                  0.732269       1.37567       1.94325       1.45461      0.389712        10     
reco:pandorapid:Chi2ParticleID                    0.00295683     0.0039226     0.0064062    0.00364616    0.000898993      10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0247746     0.0353537     0.0489911     0.0349305    0.00702555       10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00273804    0.00358008    0.00415455    0.00352375    0.000446444      10     
reco:pandoraShowercalo:ShowerCalorimetry            1.20341       2.94107       4.7527        3.21811       1.15565        10     
reco:pandoraShowercalonosce:ShowerCalorimetry       1.14547       2.88434       4.77332       3.14536       1.15459        10     
reco:emtrkmichelid:EmTrackMichelId                  93.0968       126.715       156.822       133.516       22.4932        10     
reco:crttag:SingleCRTMatchingProducer             0.00537381     0.0097109     0.0162716    0.00894575    0.00308707       10     
reco:crtreco:TwoCRTMatchingProducer               0.00375845    0.00590338    0.00892526    0.00623721    0.00154941       10     
reco:anodepiercerst0:T0RecoAnodePiercers           0.438748      0.621607      0.782462      0.651928      0.124113        10     
reco:pandora2Track:LArPandoraTrackCreation          3.89407        8.068        11.7701       8.79585       2.71692        10     
reco:pandora2calo:Calorimetry                       1.94075       4.32341        6.457        4.86968       1.52524        10     
reco:pandora2calonosce:Calorimetry                  1.79836       4.12688       6.18371       4.57202       1.49627        10     
reco:pandora2pid:Chi2ParticleID                    0.0059493    0.00864408     0.0115157     0.008518      0.0016622       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0302865     0.0438629     0.0580462     0.0452386    0.00894419       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID          0.0058178    0.00831447     0.010305     0.00847837    0.00145475       10     
reco:pandora2Shower:LArPandoraShowerCreation        1.44934       2.92644       4.12733       3.05947      0.902289        10     
reco:pandora2Showercalo:ShowerCalorimetry           1.64158       3.70368       5.42429       4.01341       1.29953        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      1.53363       3.39562       4.94988       3.65893       1.16954        10     
[art]:TriggerResults:TriggerResultInserter        3.1279e-05    5.33594e-05   0.000152347   4.16985e-05   3.40815e-05      10     
end_path:out1:RootOutput                           8.126e-06    1.10228e-05   1.7773e-05     9.082e-06    3.35943e-06      10     
end_path:out1:RootOutput(write)                     1.4347        2.08938       2.7153        2.13312      0.408955        10     
====================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5209.91 MB
  Peak resident set size usage (VmHWM): 4405.27 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.05 sec/event
ToolBasedRawDigitPrepService:dtor:                adcSampleFiller:   0.15 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.03 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   2.20 sec/event
ToolBasedRawDigitPrepService:dtor:         adcKeepAllSignalFinder:   0.08 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 10898176
-rw-r--r-- 1 neutrino002 neutrino 2522482613 Dec 28 11:37 detsim_stage2.root
-rw-r--r-- 1 neutrino002 neutrino 2387602065 Dec 28 11:35 detsim_stage1.root
-rw-r--r-- 1 neutrino002 neutrino 2232463584 Dec 28 12:17 reco_stage1.root
-rw-r--r-- 1 neutrino002 neutrino 2006890927 Dec 28 10:05 g4_stage2.root
-rw-r--r-- 1 neutrino002 neutrino 1929478412 Dec 28 09:56 g4_stage1.root
-rw-r--r-- 1 neutrino002 neutrino   80182430 Dec 28 12:14 Pandora_Events.pndr
-rw-r--r-- 1 neutrino002 neutrino     242923 Dec 28 12:17 jobscript.log
-rw-r--r-- 1 neutrino002 neutrino     217088 Dec 28 12:17 mem.db
-rw-r--r-- 1 neutrino002 neutrino      62376 Dec 28 12:17 Pandora_Geometry.xml
-rw-r--r-- 1 neutrino002 neutrino      36864 Dec 28 12:17 time.db
-rw-r--r-- 1 neutrino002 neutrino        519 Dec 28 11:37 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 neutrino002 neutrino        519 Dec 28 10:05 g4_protoDUNE_hist.root
-rw-r--r-- 1 neutrino002 neutrino        519 Dec 28 12:17 protoDUNE_reco1_hist.root
-rw-r--r-- 1 neutrino002 neutrino         52 Dec 28 09:48 all-input-dids.txt
-rw-r--r-- 1 neutrino002 neutrino          7 Dec 28 12:17 justin-processed-pfns.txt
-rw-r--r-- 1 neutrino002 neutrino          0 Dec 28 11:41 ProtoDUNE.log
-rw-r--r-- 1 neutrino002 neutrino          0 Dec 28 11:37 debugprod.log
justIN time: 2026-02-07 03:36:51 UTC       justIN version: 01.06.00