justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 298747.1@dunegpschedd01.fnal.gov

Jobsub ID298747.1@dunegpschedd01.fnal.gov
Workflow ID12202
Stage ID1
User namepmelas@fnal.gov
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2026-01-21 21:22:12
SiteUK_QMUL
EntryDUNE_UK_London_QMUL_arcce03
Last heartbeat2026-01-22 00:41:19
From worker nodeHostnamecn111.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-21 21:22:55
Input filesmonte-carlo-012202-000001
JobscriptExit code0
Real time3h (11681s)
CPU time3h (11508s = 98%)
Max RSS bytes4358258688 (4156 MiB)
Outputting started2026-01-22 00:37:38
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/12202/1/001/reco_stage1.root
Finished2026-01-22 00:41:19
Saved logsjustin-logs:298747.1-dunegpschedd01.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

l 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 104910 traces, 0 summary
Retagger: tagging trace set: gauss with 79503 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 79503 traces tagged "gauss"
FrameSaver: q=2.68311e+06 n=1384341 tag=gauss
wclsFrameSaver: saving 104910 traces tagged "wiener"
FrameSaver: q=2.83166e+06 n=1212264 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 26701 XUs and 36077 XVs -> 328 XUVs
C:0 T:1 57171 XUs and 62696 XVs -> 5576 XUVs
C:0 T:2 30540 XUs and 34565 XVs -> 1784 XUVs
C:0 T:3 17346 XUs and 14833 XVs -> 53 XUVs
C:0 T:4 13879 XUs and 15816 XVs -> 296 XUVs
C:0 T:5 53243 XUs and 54180 XVs -> 8263 XUVs
C:0 T:6 32437 XUs and 34131 XVs -> 1116 XUVs
C:0 T:7 14505 XUs and 15490 XVs -> 70 XUVs
C:0 T:8 5339 XUs and 6411 XVs -> 55 XUVs
C:0 T:9 32953 XUs and 46565 XVs -> 3656 XUVs
C:0 T:10 50334 XUs and 57875 XVs -> 6291 XUVs
C:0 T:11 689 XUs and 700 XVs -> 76 XUVs
27564 XUVs total
9779 collection wire objects
25788 potential space points
Neighbour search...
3348940 tests to find 1444682 neighbours
Iterating with no regularization...
Begin: 5.63205e+07
0 4.76714e+07
1 4.70467e+07
2 4.69497e+07
3 4.69203e+07
Now with regularization...
Begin: 3.86475e+07
0 3.85885e+07
1 3.85582e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 411884408
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411884408
fLifetime: 30000 [us]
22-Jan-2026 00:37:35 GMT  Closed output file "reco_stage1.root"
22-Jan-2026 00:37:35 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                                          296.907       462.806       614.927       466.154       89.1619        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.000984875   0.00347429    0.00481043    0.00394904    0.00130359       10     
reco:ophit:OpHitFinder                             0.246119      0.293215      0.344134      0.289703      0.0305075       10     
reco:opflash:OpFlashFinder                         0.158174      0.233305      0.288099      0.233702      0.0353028       10     
reco:opslicer:OpSlicer                             0.551454      0.734001       1.01519      0.704893      0.135143        10     
reco:caldata:DataPrepModule                         5.61936       5.73306       5.85345       5.73053      0.0792833       10     
reco:wclsdatasp:WireCellToolkit                     46.4073       50.5262       55.6468       50.7421       2.3819         10     
reco:gaushit:GausHitFinder                          1.12007       1.63868       2.38715       1.62523      0.368655        10     
reco:nhitsfilter:NumberOfHitsFilter               0.000686027   0.000888494   0.00112805    0.000877206   0.000126776      10     
reco:reco3d:SpacePointSolver                        6.41412       15.8878       24.8955       15.1278       5.9664         10     
reco:hitpdune:DisambigFromSpacePoints               1.42637       2.53123       4.66567       2.33428      0.892951        10     
reco:pandora:StandardPandora                        21.1891       49.6508       97.1787       49.5283       20.9412        10     
reco:pandoraWriter:StandardPandora                 0.386241      0.514426      0.618856      0.518977      0.0671525       10     
reco:pandoraTrack:LArPandoraTrackCreation           5.03897       10.6689       17.7458       10.8161       3.12182        10     
reco:pandoraShower:LArPandoraShowerCreation         4.06696       11.347        17.9717       11.726        4.02877        10     
reco:pandoracalo:Calorimetry                        2.53754       4.61354       7.61797       4.4505        1.24312        10     
reco:pandoracalonosce:Calorimetry                   2.21683       4.35759       7.45459       4.34406       1.28755        10     
reco:pandorapid:Chi2ParticleID                    0.00505712    0.00630556    0.00776488    0.00640819    0.000733375      10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0481393     0.0645427     0.0769884     0.0627632    0.00902525       10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00509183    0.00609198    0.00767518    0.00605903    0.000745989      10     
reco:pandoraShowercalo:ShowerCalorimetry            4.0839        9.54331       15.5514       8.47443       3.73208        10     
reco:pandoraShowercalonosce:ShowerCalorimetry        3.978        9.26782       15.7315       8.51412       3.86741        10     
reco:emtrkmichelid:EmTrackMichelId                  144.791       194.735       233.516       196.758       24.7976        10     
reco:crttag:SingleCRTMatchingProducer              0.0230404     0.0301836     0.0371206     0.0309691    0.00477847       10     
reco:crtreco:TwoCRTMatchingProducer                0.0125916     0.022796      0.0311237     0.0228994    0.00587186       10     
reco:anodepiercerst0:T0RecoAnodePiercers            1.01274       1.24296       1.63368       1.12906      0.205438        10     
reco:pandora2Track:LArPandoraTrackCreation          16.8349       32.8593       54.3967       30.8755       11.7184        10     
reco:pandora2calo:Calorimetry                       4.65912       13.2956       21.6439       12.5605       4.70772        10     
reco:pandora2calonosce:Calorimetry                  4.93199       12.4902       20.5452       12.5149       4.31172        10     
reco:pandora2pid:Chi2ParticleID                    0.0112597     0.0150294     0.0184348     0.0145589    0.00206297       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0607283     0.0836727     0.0995061     0.0835413     0.0116921       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID          0.0114989     0.0149179     0.0180405     0.0144756    0.00192012       10     
reco:pandora2Shower:LArPandoraShowerCreation        4.0736        8.43609       14.8701       8.58031       2.86932        10     
reco:pandora2Showercalo:ShowerCalorimetry           4.73512       10.268        16.3821       10.5184       3.16153        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      3.82612       8.66168       14.2069       9.11614        2.785         10     
[art]:TriggerResults:TriggerResultInserter        4.4627e-05    5.94947e-05   0.000119456    5.141e-05    2.06281e-05      10     
end_path:out1:RootOutput                           7.986e-06    9.3094e-06    1.3467e-05     8.876e-06    1.46254e-06      10     
end_path:out1:RootOutput(write)                     2.10232       2.87257       3.66114       2.79804      0.438587        10     
====================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5169.41 MB
  Peak resident set size usage (VmHWM): 4358.26 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.56 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 11209480
-rw-r--r-- 1 pildune32 pildune 2599209150 Jan 21 23:18 detsim_stage2.root
-rw-r--r-- 1 pildune32 pildune 2470467292 Jan 21 23:16 detsim_stage1.root
-rw-r--r-- 1 pildune32 pildune 2302505120 Jan 22 00:37 reco_stage1.root
-rw-r--r-- 1 pildune32 pildune 2059353704 Jan 21 21:46 g4_stage2.root
-rw-r--r-- 1 pildune32 pildune 1966718545 Jan 21 21:29 g4_stage1.root
-rw-r--r-- 1 pildune32 pildune   79573800 Jan 22 00:34 Pandora_Events.pndr
-rw-r--r-- 1 pildune32 pildune     242813 Jan 22 00:37 jobscript.log
-rw-r--r-- 1 pildune32 pildune     217088 Jan 22 00:37 mem.db
-rw-r--r-- 1 pildune32 pildune      62376 Jan 22 00:37 Pandora_Geometry.xml
-rw-r--r-- 1 pildune32 pildune      36864 Jan 22 00:37 time.db
-rw-r--r-- 1 pildune32 pildune        519 Jan 21 23:18 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 pildune32 pildune        519 Jan 21 21:46 g4_protoDUNE_hist.root
-rw-r--r-- 1 pildune32 pildune        519 Jan 22 00:37 protoDUNE_reco1_hist.root
-rw-r--r-- 1 pildune32 pildune         52 Jan 21 21:22 all-input-dids.txt
-rw-r--r-- 1 pildune32 pildune          7 Jan 22 00:37 justin-processed-pfns.txt
-rw-r--r-- 1 pildune32 pildune          0 Jan 21 23:24 ProtoDUNE.log
-rw-r--r-- 1 pildune32 pildune          0 Jan 21 23:18 debugprod.log
justIN time: 2026-02-05 11:17:59 UTC       justIN version: 01.06.00