justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 269084.1@dunegpschedd01.fnal.gov

Jobsub ID269084.1@dunegpschedd01.fnal.gov
Workflow ID11258
Stage ID1
User namepmelas@fnal.gov
HTCondor Groupgroup_dune
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2025-12-18 16:44:58
SiteUK_QMUL
EntryDUNE_UK_London_QMUL_arcce03
Last heartbeat2025-12-18 21:21:22
From worker nodeHostnamecn043.htc.esc.qmul
cpuinfoIntel(R) Xeon(R) Gold 6248R CPU @ 3.00GHz
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-18 16:45:52
Input filesmonte-carlo-011258-000001
JobscriptExit code0
Real time4h (16214s)
CPU time4h (15726s = 96%)
Max RSS bytes4646801408 (4431 MiB)
Outputting started2025-12-18 21:16:07
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11258/1/001/reco_stage1.root
Finished2025-12-18 21:21:22
Saved logsjustin-logs:269084.1-dunegpschedd01.fnal.gov.logs.tgz
List job events     (HTCondor job logs unavailable)

Jobscript log (last 10,000 characters)

sp_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 151318 traces, 0 summary
Retagger: tagging trace set: gauss with 116600 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 116600 traces tagged "gauss"
FrameSaver: q=4.0991e+06 n=2060999 tag=gauss
wclsFrameSaver: saving 151318 traces tagged "wiener"
FrameSaver: q=4.31428e+06 n=1822025 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 35287 XUs and 32351 XVs -> 262 XUVs
C:0 T:1 68454 XUs and 66823 XVs -> 5440 XUVs
C:0 T:2 96966 XUs and 136844 XVs -> 4862 XUVs
C:0 T:3 48887 XUs and 57661 XVs -> 278 XUVs
C:0 T:4 12696 XUs and 12525 XVs -> 130 XUVs
C:0 T:5 56922 XUs and 49620 XVs -> 8701 XUVs
C:0 T:6 114329 XUs and 145877 XVs -> 5271 XUVs
C:0 T:7 47599 XUs and 60915 XVs -> 512 XUVs
C:0 T:8 12838 XUs and 11280 XVs -> 153 XUVs
C:0 T:9 78674 XUs and 97671 XVs -> 5938 XUVs
C:0 T:10 24580 XUs and 18805 XVs -> 3048 XUVs
C:0 T:11 442 XUs and 315 XVs -> 40 XUVs
34635 XUVs total
12761 collection wire objects
31716 potential space points
Neighbour search...
2038880 tests to find 1063632 neighbours
Iterating with no regularization...
Begin: 8.62901e+07
0 7.35567e+07
1 7.26466e+07
2 7.25466e+07
3 7.2519e+07
Now with regularization...
Begin: 6.04334e+07
0 6.04174e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
run: 1 ; subrun: 0 ; event: 10
evttime: 411196530
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411196530
fLifetime: 30000 [us]
18-Dec-2025 21:16:02 GMT  Closed output file "reco_stage1.root"
18-Dec-2025 21:16:02 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                                          335.024       666.942       987.358       654.227       173.739        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.00139877    0.00375158    0.00567965    0.00421459    0.00141234       10     
reco:ophit:OpHitFinder                              0.30241      0.472483      0.606915      0.476027      0.103536        10     
reco:opflash:OpFlashFinder                         0.162096      0.294122      0.413141      0.299169      0.0628305       10     
reco:opslicer:OpSlicer                             0.501718      0.914022       1.33117      0.890164       0.24329        10     
reco:caldata:DataPrepModule                         5.61389       7.60767       9.77048       7.43505       1.63923        10     
reco:wclsdatasp:WireCellToolkit                     48.285        55.9348       65.971        52.9938       6.94007        10     
reco:gaushit:GausHitFinder                          1.19038       1.75745       3.08916       1.6242       0.526204        10     
reco:nhitsfilter:NumberOfHitsFilter               0.000704634   0.000983649   0.00137381    0.000924824   0.000198425      10     
reco:reco3d:SpacePointSolver                        11.1441       24.3059       50.1416       22.8128       10.4071        10     
reco:hitpdune:DisambigFromSpacePoints               1.52288       3.26649       6.57732       3.01699       1.32651        10     
reco:pandora:StandardPandora                        20.1712       51.8712       86.9299       49.9743       18.6534        10     
reco:pandoraWriter:StandardPandora                 0.425553      0.639041       1.01706      0.585175      0.176412        10     
reco:pandoraTrack:LArPandoraTrackCreation           6.92805       14.2736       23.4519       13.6244       4.58758        10     
reco:pandoraShower:LArPandoraShowerCreation         5.90662       16.225        27.4958       14.9461       6.24009        10     
reco:pandoracalo:Calorimetry                        2.87596       6.20667       10.0143       5.84481       2.04729        10     
reco:pandoracalonosce:Calorimetry                   2.73349       5.96407       10.147        5.65558       2.06066        10     
reco:pandorapid:Chi2ParticleID                    0.00478615     0.0080424     0.0134056    0.00704814    0.00265489       10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0578399     0.0826452     0.125819      0.0741674     0.0231546       10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00464738     0.0077399     0.0124518    0.00673406    0.00247845       10     
reco:pandoraShowercalo:ShowerCalorimetry            5.57475       14.7054       25.5966       13.3986       5.61126        10     
reco:pandoraShowercalonosce:ShowerCalorimetry       5.19686       13.8838       25.042        12.8339       5.49616        10     
reco:emtrkmichelid:EmTrackMichelId                  156.453       304.518       445.585       314.144       78.8968        10     
reco:crttag:SingleCRTMatchingProducer              0.0275646     0.0433515     0.0598746     0.0436413     0.0099211       10     
reco:crtreco:TwoCRTMatchingProducer                0.0195917     0.0316746     0.0436179     0.0341996    0.00762018       10     
reco:anodepiercerst0:T0RecoAnodePiercers           0.968149       1.73391       2.75267       1.75552      0.494745        10     
reco:pandora2Track:LArPandoraTrackCreation          19.8562       51.3687       78.0228       46.2941       18.4163        10     
reco:pandora2calo:Calorimetry                       8.01498       21.3486       35.3395       21.0291       8.00012        10     
reco:pandora2calonosce:Calorimetry                  7.31549       20.7136       30.3816       20.2223       7.79706        10     
reco:pandora2pid:Chi2ParticleID                    0.0102947     0.0219685     0.0329667     0.0211797    0.00741658       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.067689      0.114128      0.154661      0.112836      0.0304907       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID          0.0105593     0.0223799     0.0321555     0.0225503    0.00670851       10     
reco:pandora2Shower:LArPandoraShowerCreation        5.61922       13.9764       21.8925       13.4505       5.42561        10     
reco:pandora2Showercalo:ShowerCalorimetry           6.54761       16.5431       26.3934       15.8562       6.23052        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      6.19108       13.7673       20.9023       13.603        5.16264        10     
[art]:TriggerResults:TriggerResultInserter         4.582e-05    7.03878e-05   0.00011291    6.9804e-05     1.991e-05       10     
end_path:out1:RootOutput                           6.318e-06    8.3935e-06    1.0965e-05     8.211e-06    1.46707e-06      10     
end_path:out1:RootOutput(write)                     2.70467       4.12635       6.26595       4.23417       1.11925        10     
====================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5455.43 MB
  Peak resident set size usage (VmHWM): 4646.8 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.09 sec/event
ToolBasedRawDigitPrepService:dtor:                adcSampleFiller:   0.28 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.06 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   4.58 sec/event
ToolBasedRawDigitPrepService:dtor:         adcKeepAllSignalFinder:   0.26 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 11649368
-rw-r--r-- 1 pildune32 pildune 2675928773 Dec 18 19:22 detsim_stage2.root
-rw-r--r-- 1 pildune32 pildune 2538445089 Dec 18 19:18 detsim_stage1.root
-rw-r--r-- 1 pildune32 pildune 2407997587 Dec 18 21:16 reco_stage1.root
-rw-r--r-- 1 pildune32 pildune 2159388282 Dec 18 17:22 g4_stage2.root
-rw-r--r-- 1 pildune32 pildune 2061445641 Dec 18 16:58 g4_stage1.root
-rw-r--r-- 1 pildune32 pildune   85132760 Dec 18 21:07 Pandora_Events.pndr
-rw-r--r-- 1 pildune32 pildune     243071 Dec 18 21:16 jobscript.log
-rw-r--r-- 1 pildune32 pildune     217088 Dec 18 21:16 mem.db
-rw-r--r-- 1 pildune32 pildune      62376 Dec 18 21:16 Pandora_Geometry.xml
-rw-r--r-- 1 pildune32 pildune      36864 Dec 18 21:16 time.db
-rw-r--r-- 1 pildune32 pildune        519 Dec 18 19:22 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 pildune32 pildune        519 Dec 18 17:22 g4_protoDUNE_hist.root
-rw-r--r-- 1 pildune32 pildune        519 Dec 18 21:16 protoDUNE_reco1_hist.root
-rw-r--r-- 1 pildune32 pildune         52 Dec 18 16:45 all-input-dids.txt
-rw-r--r-- 1 pildune32 pildune          7 Dec 18 21:16 justin-processed-pfns.txt
-rw-r--r-- 1 pildune32 pildune          0 Dec 18 19:33 ProtoDUNE.log
-rw-r--r-- 1 pildune32 pildune          0 Dec 18 19:22 debugprod.log
justIN time: 2025-12-19 07:16:02 UTC       justIN version: 01.05.03