justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 266072.1@dunegpschedd02.fnal.gov

Jobsub ID266072.1@dunegpschedd02.fnal.gov
Workflow ID11528
Stage ID1
User namepmelas@fnal.gov
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2026-01-05 08:00:05
SiteUK_QMUL
EntryDUNE_UK_London_QMUL_arcce03
Last heartbeat2026-01-05 12:34:13
From worker nodeHostnamecn032.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-05 08:26:37
Input filesmonte-carlo-011528-000001
JobscriptExit code0
Real time4h (14462s)
CPU time3h (13133s = 90%)
Max RSS bytes4217794560 (4022 MiB)
Outputting started2026-01-05 12:27:40
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11528/1/001/reco_stage1.root
Finished2026-01-05 12:34:13
Saved logsjustin-logs:266072.1-dunegpschedd02.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

olBasedRawDigitPrepService: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 139514 traces, 0 summary
Retagger: tagging trace set: gauss with 109296 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 109296 traces tagged "gauss"
FrameSaver: q=3.98839e+06 n=1982294 tag=gauss
wclsFrameSaver: saving 139514 traces tagged "wiener"
FrameSaver: q=4.22717e+06 n=1783456 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 37062 XUs and 28772 XVs -> 185 XUVs
C:0 T:1 59083 XUs and 49237 XVs -> 3296 XUVs
C:0 T:2 64417 XUs and 106706 XVs -> 3044 XUVs
C:0 T:3 36557 XUs and 46920 XVs -> 480 XUVs
C:0 T:5 83291 XUs and 59588 XVs -> 9790 XUVs
C:0 T:6 68866 XUs and 58379 XVs -> 2342 XUVs
C:0 T:7 32167 XUs and 26590 XVs -> 131 XUVs
C:0 T:8 11406 XUs and 13134 XVs -> 285 XUVs
C:0 T:9 99581 XUs and 127346 XVs -> 8378 XUVs
C:0 T:10 48778 XUs and 71691 XVs -> 7007 XUVs
C:0 T:11 302 XUs and 241 XVs -> 32 XUVs
34970 XUVs total
11935 collection wire objects
32798 potential space points
Neighbour search...
2437522 tests to find 1220440 neighbours
Iterating with no regularization...
Begin: 1.00441e+08
0 8.64143e+07
1 8.54815e+07
2 8.53573e+07
3 8.5324e+07
Now with regularization...
Begin: 7.36897e+07
0 7.36576e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 411551374
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411551374
fLifetime: 30000 [us]
05-Jan-2026 12:27:27 GMT  Closed output file "reco_stage1.root"
05-Jan-2026 12:27:27 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                                          374.244       644.191       899.659       654.41        165.274        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.00174506    0.00340572    0.00449378    0.00375587    0.000903879      10     
reco:ophit:OpHitFinder                             0.260329      0.562858      0.807462      0.588315      0.159598        10     
reco:opflash:OpFlashFinder                         0.166036      0.229221      0.321275      0.219965      0.0511033       10     
reco:opslicer:OpSlicer                              0.53496      0.859584       1.1456       0.852722      0.182203        10     
reco:caldata:DataPrepModule                         5.94472       7.71197       9.68172       7.54021       1.45808        10     
reco:wclsdatasp:WireCellToolkit                     47.9801       57.975        71.0185       58.1662       7.94411        10     
reco:gaushit:GausHitFinder                          1.27697       1.85864       2.98617       1.71947      0.456717        10     
reco:nhitsfilter:NumberOfHitsFilter               0.000865291    0.0010994    0.00196996    0.000997345   0.000304203      10     
reco:reco3d:SpacePointSolver                        9.86955       19.5807       28.3735       18.7686       5.57065        10     
reco:hitpdune:DisambigFromSpacePoints               1.56744       3.42361       7.22246       2.87911       1.61144        10     
reco:pandora:StandardPandora                        31.8037       60.8009       110.367       56.6488       25.9774        10     
reco:pandoraWriter:StandardPandora                 0.462748      0.643762       1.03617      0.585555      0.163539        10     
reco:pandoraTrack:LArPandoraTrackCreation           8.83168       13.6321       20.8095       13.8807       3.23435        10     
reco:pandoraShower:LArPandoraShowerCreation         7.74793       16.5496       23.9247       17.4785       4.87618        10     
reco:pandoracalo:Calorimetry                        4.32597       6.93925       10.2114       6.93738       1.86283        10     
reco:pandoracalonosce:Calorimetry                   3.59502       6.51064       9.36292       6.40221       1.99084        10     
reco:pandorapid:Chi2ParticleID                    0.00594797    0.00841385     0.0110343    0.00841447    0.00160849       10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0515294     0.0809516     0.118421      0.0739802     0.021282        10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00561858     0.0079798     0.0106702    0.00758919    0.00177045       10     
reco:pandoraShowercalo:ShowerCalorimetry            5.89061       16.1825       26.9428       17.0376       6.21275        10     
reco:pandoraShowercalonosce:ShowerCalorimetry       5.08873       15.6745       26.3386       16.6994       6.21181        10     
reco:emtrkmichelid:EmTrackMichelId                  166.244       272.166       368.48        270.666       70.5669        10     
reco:crttag:SingleCRTMatchingProducer               0.02532      0.0598123     0.256957      0.0393475     0.0659831       10     
reco:crtreco:TwoCRTMatchingProducer                0.0242957     0.0356805     0.0590239     0.0347118    0.00928564       10     
reco:anodepiercerst0:T0RecoAnodePiercers            1.15633       1.88696       2.60248       1.88259      0.459875        10     
reco:pandora2Track:LArPandoraTrackCreation          24.3729       46.3391       58.7467       50.4277       11.1078        10     
reco:pandora2calo:Calorimetry                       10.1111       21.7854       32.9545       21.9219       7.15173        10     
reco:pandora2calonosce:Calorimetry                  8.06865       21.2867        33.42        22.3817       7.77989        10     
reco:pandora2pid:Chi2ParticleID                    0.0128313     0.0196735     0.0296783     0.0167387    0.00577836       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0598113     0.102175      0.140597      0.0942848     0.027211        10     
reco:pandora2calipidnoxyzt:Chi2ParticleID          0.0115026     0.0184865     0.0280047     0.0159566    0.00533538       10     
reco:pandora2Shower:LArPandoraShowerCreation        6.20527       15.0108       25.6165       15.1159       5.61896        10     
reco:pandora2Showercalo:ShowerCalorimetry           5.42879       17.1039       26.9873       18.516        5.8552         10     
reco:pandora2Showercalonosce:ShowerCalorimetry      4.91122       15.6545       24.2767       15.3609       6.07665        10     
[art]:TriggerResults:TriggerResultInserter        4.1129e-05    7.12294e-05   0.000153554   6.0319e-05    3.12357e-05      10     
end_path:out1:RootOutput                           8.704e-06    1.00551e-05   1.3358e-05    9.7125e-06    1.35921e-06      10     
end_path:out1:RootOutput(write)                     2.43334       3.28335       4.35308       3.13043      0.585059        10     
====================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5019.02 MB
  Peak resident set size usage (VmHWM): 4217.79 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.10 sec/event
ToolBasedRawDigitPrepService:dtor:                adcSampleFiller:   0.28 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.06 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   4.34 sec/event
ToolBasedRawDigitPrepService:dtor:         adcKeepAllSignalFinder:   0.23 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleKeToAdc:   0.07 sec/event
ToolBasedRawDigitPrepService:dtor:         pdsp_RemoveBadChannels:   0.00 sec/event
Art has completed and will exit with status 0.
lar exit code 0
.:
total 10166528
-rw-r--r-- 1 pildune32 pildune 2385822013 Jan  5 10:36 detsim_stage2.root
-rw-r--r-- 1 pildune32 pildune 2260395835 Jan  5 10:18 detsim_stage1.root
-rw-r--r-- 1 pildune32 pildune 2086923778 Jan  5 12:27 reco_stage1.root
-rw-r--r-- 1 pildune32 pildune 1835058952 Jan  5 08:51 g4_stage2.root
-rw-r--r-- 1 pildune32 pildune 1763653366 Jan  5 08:32 g4_stage1.root
-rw-r--r-- 1 pildune32 pildune   78055140 Jan  5 12:17 Pandora_Events.pndr
-rw-r--r-- 1 pildune32 pildune     243039 Jan  5 12:27 jobscript.log
-rw-r--r-- 1 pildune32 pildune     217088 Jan  5 12:27 mem.db
-rw-r--r-- 1 pildune32 pildune      62376 Jan  5 12:27 Pandora_Geometry.xml
-rw-r--r-- 1 pildune32 pildune      36864 Jan  5 12:27 time.db
-rw-r--r-- 1 pildune32 pildune        519 Jan  5 10:36 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 pildune32 pildune        519 Jan  5 08:51 g4_protoDUNE_hist.root
-rw-r--r-- 1 pildune32 pildune        519 Jan  5 12:27 protoDUNE_reco1_hist.root
-rw-r--r-- 1 pildune32 pildune         52 Jan  5 08:26 all-input-dids.txt
-rw-r--r-- 1 pildune32 pildune          7 Jan  5 12:27 justin-processed-pfns.txt
-rw-r--r-- 1 pildune32 pildune          0 Jan  5 10:42 ProtoDUNE.log
-rw-r--r-- 1 pildune32 pildune          0 Jan  5 10:36 debugprod.log
justIN time: 2026-02-06 23:49:37 UTC       justIN version: 01.06.00