justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 265578.1@dunegpschedd02.fnal.gov

Jobsub ID265578.1@dunegpschedd02.fnal.gov
Workflow ID11474
Stage ID1
User namepmelas@fnal.gov
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2026-01-02 19:12:48
SiteUK_QMUL
EntryDUNE_UK_London_QMUL_arcce03
Last heartbeat2026-01-02 22:24:59
From worker nodeHostnamecn011.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
Started2026-01-02 19:13:52
Input filesmonte-carlo-011474-000001
JobscriptExit code0
Real time3h (11262s)
CPU time3h (11099s = 98%)
Max RSS bytes4167118848 (3974 MiB)
Outputting started2026-01-02 22:21:35
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11474/1/001/reco_stage1.root
Finished2026-01-02 22:24:59
Saved logsjustin-logs:265578.1-dunegpschedd02.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

ice: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 156941 traces, 0 summary
Retagger: tagging trace set: gauss with 117390 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 117390 traces tagged "gauss"
FrameSaver: q=4.1546e+06 n=2151327 tag=gauss
wclsFrameSaver: saving 156941 traces tagged "wiener"
FrameSaver: q=4.41195e+06 n=1914482 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 13364 XUs and 18886 XVs -> 70 XUVs
C:0 T:1 21541 XUs and 22493 XVs -> 1371 XUVs
C:0 T:2 169122 XUs and 137141 XVs -> 9911 XUVs
C:0 T:3 61290 XUs and 47814 XVs -> 514 XUVs
C:0 T:4 14956 XUs and 15740 XVs -> 104 XUVs
C:0 T:5 49121 XUs and 45039 XVs -> 6148 XUVs
C:0 T:6 408869 XUs and 310150 XVs -> 30371 XUVs
C:0 T:7 95518 XUs and 89720 XVs -> 1522 XUVs
C:0 T:8 8834 XUs and 13068 XVs -> 232 XUVs
C:0 T:9 90093 XUs and 166186 XVs -> 23558 XUVs
C:0 T:10 65831 XUs and 40048 XVs -> 6162 XUVs
C:0 T:11 281 XUs and 250 XVs -> 16 XUVs
79979 XUVs total
15249 collection wire objects
72686 potential space points
Neighbour search...
12789840 tests to find 5637688 neighbours
Iterating with no regularization...
Begin: 7.11443e+07
0 5.44674e+07
1 5.33652e+07
2 5.31803e+07
3 5.31185e+07
4 5.30904e+07
Now with regularization...
Begin: 4.2204e+07
0 4.2127e+07
1 4.20748e+07
2 4.20353e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
run: 1 ; subrun: 0 ; event: 10
evttime: 411500460
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411500460
fLifetime: 30000 [us]
02-Jan-2026 22:21:32 GMT  Closed output file "reco_stage1.root"
02-Jan-2026 22:21:32 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                                          331.569       469.916       609.004       469.076       79.5984        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.000946021   0.00333859    0.00510063     0.0034792    0.00134935       10     
reco:ophit:OpHitFinder                              0.23433       0.27214      0.306401      0.277665      0.0207545       10     
reco:opflash:OpFlashFinder                         0.172825      0.206707      0.244943      0.214906      0.0245412       10     
reco:opslicer:OpSlicer                             0.612889      0.708535      0.837668      0.715164      0.066354        10     
reco:caldata:DataPrepModule                         4.95868       5.48359       5.71242       5.56243      0.201805        10     
reco:wclsdatasp:WireCellToolkit                     44.0593       47.0989       49.2386       47.9004       2.06922        10     
reco:gaushit:GausHitFinder                          1.32974       1.56048       1.81709       1.57888      0.193704        10     
reco:nhitsfilter:NumberOfHitsFilter               0.00072792    0.000878548   0.00106185    0.000865205   0.000103372      10     
reco:reco3d:SpacePointSolver                        6.73558       18.107        37.1772       15.0517       8.37531        10     
reco:hitpdune:DisambigFromSpacePoints               1.63594       2.44225       3.82421       2.26854      0.692335        10     
reco:pandora:StandardPandora                        24.2694       45.7051       82.614        38.6405       20.1026        10     
reco:pandoraWriter:StandardPandora                 0.423189      0.503606      0.615467      0.487073      0.0665584       10     
reco:pandoraTrack:LArPandoraTrackCreation           5.88541       10.0603       15.7117       8.84458       3.12784        10     
reco:pandoraShower:LArPandoraShowerCreation         6.32169       11.3214       17.4739       10.8293       3.39047        10     
reco:pandoracalo:Calorimetry                        2.92409       4.39778       6.36683       3.7506        1.37865        10     
reco:pandoracalonosce:Calorimetry                   2.69885       4.1472         5.961        3.56753       1.13438        10     
reco:pandorapid:Chi2ParticleID                    0.00448302    0.00575889    0.00759062    0.00560629    0.000962644      10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0493765     0.0641318     0.0806591     0.0625579     0.0105875       10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00453038    0.00564298    0.00772881    0.00526812    0.000995725      10     
reco:pandoraShowercalo:ShowerCalorimetry            6.88822       10.6863       14.8654       10.5643       2.31032        10     
reco:pandoraShowercalonosce:ShowerCalorimetry       6.35045       10.6778       14.9807       10.1526       2.46287        10     
reco:emtrkmichelid:EmTrackMichelId                  154.821       204.456       280.744       198.808       33.9748        10     
reco:crttag:SingleCRTMatchingProducer              0.0231244     0.0291862     0.037481      0.0286146    0.00418818       10     
reco:crtreco:TwoCRTMatchingProducer                0.0157645     0.023143      0.0303906     0.022736     0.00501146       10     
reco:anodepiercerst0:T0RecoAnodePiercers           0.833594       1.14652       1.49669       1.16434      0.212134        10     
reco:pandora2Track:LArPandoraTrackCreation          21.9183       32.5176       46.2165       30.8414       7.21804        10     
reco:pandora2calo:Calorimetry                       8.2963        13.5515       19.6391       13.0629       3.55193        10     
reco:pandora2calonosce:Calorimetry                  8.53775       12.5905       18.0343       12.1022       2.89191        10     
reco:pandora2pid:Chi2ParticleID                    0.0110661     0.0142521     0.0184877     0.0142191    0.00194057       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0653744     0.0817605     0.105342      0.0797955     0.0124516       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID          0.0112164     0.0141962     0.0182067     0.0141302    0.00179901       10     
reco:pandora2Shower:LArPandoraShowerCreation        5.42013       8.60099       11.6306       8.27822       2.1474         10     
reco:pandora2Showercalo:ShowerCalorimetry            6.827        11.1757       15.1443       11.2518       2.54846        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      6.06732       9.31887       12.9777       9.53572       2.14021        10     
[art]:TriggerResults:TriggerResultInserter        4.0021e-05    5.39826e-05   0.000106007   4.89595e-05   1.76087e-05      10     
end_path:out1:RootOutput                           6.735e-06     8.468e-06    1.0659e-05    7.8935e-06    1.33906e-06      10     
end_path:out1:RootOutput(write)                     2.15968       2.78958       3.54506       2.64558      0.425662        10     
====================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4977.26 MB
  Peak resident set size usage (VmHWM): 4167.12 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.21 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.05 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   3.40 sec/event
ToolBasedRawDigitPrepService:dtor:         adcKeepAllSignalFinder:   0.19 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleKeToAdc:   0.05 sec/event
ToolBasedRawDigitPrepService:dtor:         pdsp_RemoveBadChannels:   0.00 sec/event
Art has completed and will exit with status 0.
lar exit code 0
.:
total 10533500
-rw-r--r-- 1 pildune32 pildune 2447880225 Jan  2 21:01 detsim_stage2.root
-rw-r--r-- 1 pildune32 pildune 2323031199 Jan  2 20:59 detsim_stage1.root
-rw-r--r-- 1 pildune32 pildune 2161106194 Jan  2 22:21 reco_stage1.root
-rw-r--r-- 1 pildune32 pildune 1918298369 Jan  2 19:33 g4_stage2.root
-rw-r--r-- 1 pildune32 pildune 1853916925 Jan  2 19:19 g4_stage1.root
-rw-r--r-- 1 pildune32 pildune   81257680 Jan  2 22:14 Pandora_Events.pndr
-rw-r--r-- 1 pildune32 pildune     243089 Jan  2 22:21 jobscript.log
-rw-r--r-- 1 pildune32 pildune     217088 Jan  2 22:21 mem.db
-rw-r--r-- 1 pildune32 pildune      62376 Jan  2 22:21 Pandora_Geometry.xml
-rw-r--r-- 1 pildune32 pildune      36864 Jan  2 22:21 time.db
-rw-r--r-- 1 pildune32 pildune        519 Jan  2 21:01 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 pildune32 pildune        519 Jan  2 19:33 g4_protoDUNE_hist.root
-rw-r--r-- 1 pildune32 pildune        519 Jan  2 22:21 protoDUNE_reco1_hist.root
-rw-r--r-- 1 pildune32 pildune         52 Jan  2 19:13 all-input-dids.txt
-rw-r--r-- 1 pildune32 pildune          7 Jan  2 22:21 justin-processed-pfns.txt
-rw-r--r-- 1 pildune32 pildune          0 Jan  2 21:09 ProtoDUNE.log
-rw-r--r-- 1 pildune32 pildune          0 Jan  2 21:01 debugprod.log
justIN time: 2026-02-06 22:18:13 UTC       justIN version: 01.06.00