justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 265070.0@dunegpschedd02.fnal.gov

Jobsub ID265070.0@dunegpschedd02.fnal.gov
Workflow ID11412
Stage ID1
User namepmelas@fnal.gov
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2025-12-30 06:20:18
SiteUK_Durham
EntryDUNE_UK_SGridDurham_ce3
Last heartbeat2025-12-30 10:04:51
From worker nodeHostnamen180.dur.scotgrid.ac.uk
cpuinfoIntel(R) Xeon(R) Gold 5220 CPU @ 2.20GHz
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-30 06:26:57
Input filesmonte-carlo-011412-000001
JobscriptExit code0
Real time3h (12987s)
CPU time3h (12786s = 98%)
Max RSS bytes4269178880 (4071 MiB)
Outputting started2025-12-30 10:03:26
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11412/1/001/reco_stage1.root
Finished2025-12-30 10:04:51
Saved logsjustin-logs:265070.0-dunegpschedd02.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

g tool adcKeepAllSignalFinder
ToolBasedRawDigitPrepService: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 119725 traces, 0 summary
Retagger: tagging trace set: gauss with 95578 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 95578 traces tagged "gauss"
FrameSaver: q=3.30162e+06 n=1752274 tag=gauss
wclsFrameSaver: saving 119725 traces tagged "wiener"
FrameSaver: q=3.47776e+06 n=1570180 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 41861 XUs and 39752 XVs -> 458 XUVs
C:0 T:1 82421 XUs and 75927 XVs -> 4413 XUVs
C:0 T:2 90879 XUs and 79667 XVs -> 3633 XUVs
C:0 T:3 46181 XUs and 33268 XVs -> 159 XUVs
C:0 T:4 22392 XUs and 13527 XVs -> 552 XUVs
C:0 T:5 47148 XUs and 32090 XVs -> 4310 XUVs
C:0 T:6 88984 XUs and 60585 XVs -> 4246 XUVs
C:0 T:7 30391 XUs and 24702 XVs -> 255 XUVs
C:0 T:8 8466 XUs and 6861 XVs -> 59 XUVs
C:0 T:9 63440 XUs and 59956 XVs -> 7008 XUVs
C:0 T:10 29926 XUs and 20060 XVs -> 2920 XUVs
C:0 T:11 408 XUs and 278 XVs -> 31 XUVs
28044 XUVs total
11220 collection wire objects
26060 potential space points
Neighbour search...
1619088 tests to find 882704 neighbours
Iterating with no regularization...
Begin: 7.10188e+07
0 5.87574e+07
1 5.8099e+07
2 5.80087e+07
3 5.79812e+07
Now with regularization...
Begin: 4.88779e+07
0 4.88523e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 411429310
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411429310
fLifetime: 30000 [us]
30-Dec-2025 10:03:23 GMT  Closed output file "reco_stage1.root"
30-Dec-2025 10:03:23 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                                          337.319       537.889       739.923       528.874       108.214        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.000965202   0.00358136     0.0055373    0.00377816    0.00124752       10     
reco:ophit:OpHitFinder                             0.281925      0.329186      0.410643      0.326707      0.0356457       10     
reco:opflash:OpFlashFinder                         0.179934      0.260261      0.345319      0.250689      0.047361        10     
reco:opslicer:OpSlicer                             0.720925      0.825762      0.955326      0.836224      0.0680433       10     
reco:caldata:DataPrepModule                         6.24696       6.49419       6.73364       6.4878       0.128359        10     
reco:wclsdatasp:WireCellToolkit                     53.6465       56.2247       61.2755       55.4698       2.48165        10     
reco:gaushit:GausHitFinder                          1.25111       1.78835       2.00427       1.85576      0.207744        10     
reco:nhitsfilter:NumberOfHitsFilter               0.000611862   0.000758316   0.00106406    0.000702513   0.000152506      10     
reco:reco3d:SpacePointSolver                        10.301        20.0732       48.0725       18.6487       10.3212        10     
reco:hitpdune:DisambigFromSpacePoints               1.38907       2.78495       4.07126       2.79249      0.670926        10     
reco:pandora:StandardPandora                        23.333        52.0408       78.1481       50.0307       14.643         10     
reco:pandoraWriter:StandardPandora                 0.418251      0.595852       0.70902      0.600286      0.0815753       10     
reco:pandoraTrack:LArPandoraTrackCreation           6.38758       10.6146       16.3461       9.74285       3.20548        10     
reco:pandoraShower:LArPandoraShowerCreation         6.18865       13.0882       21.2766       12.7424       4.52624        10     
reco:pandoracalo:Calorimetry                        2.83765       4.92217       7.95438       4.48797       1.56293        10     
reco:pandoracalonosce:Calorimetry                   2.47549       4.6032        7.57584       4.12939       1.64527        10     
reco:pandorapid:Chi2ParticleID                    0.00565769     0.0071204     0.0109848    0.00651846    0.00150056       10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0534452     0.0784875     0.0993551     0.0772447     0.0114548       10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00559457    0.00686751    0.00946258    0.00641035    0.00114479       10     
reco:pandoraShowercalo:ShowerCalorimetry            4.79705       12.3432       20.8075       12.1295       4.6636         10     
reco:pandoraShowercalonosce:ShowerCalorimetry       4.80776       11.9807       20.6561       11.5042       4.46446        10     
reco:emtrkmichelid:EmTrackMichelId                  157.907       234.492       283.98        234.297       31.8557        10     
reco:crttag:SingleCRTMatchingProducer              0.0200559     0.0294435     0.048131      0.0282251    0.00738054       10     
reco:crtreco:TwoCRTMatchingProducer                0.0161695     0.0241668     0.0403446     0.0231825    0.00738529       10     
reco:anodepiercerst0:T0RecoAnodePiercers           0.917732        1.511        2.06169       1.49059       0.27428        10     
reco:pandora2Track:LArPandoraTrackCreation          18.8032       34.8366       55.0461       34.3999       11.4287        10     
reco:pandora2calo:Calorimetry                       7.40932       15.0391       24.8254       14.8169       5.25677        10     
reco:pandora2calonosce:Calorimetry                  6.81928       14.1958       23.9065       13.6368       5.19838        10     
reco:pandora2pid:Chi2ParticleID                    0.0127445     0.0170221     0.0201674     0.0167511    0.00224765       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0676892     0.0984276     0.113713      0.0987895     0.0121821       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID          0.0126909     0.0169126     0.0198471     0.0165587    0.00219108       10     
reco:pandora2Shower:LArPandoraShowerCreation        6.08513       11.1258       18.9135       10.388        4.09099        10     
reco:pandora2Showercalo:ShowerCalorimetry           5.88715       12.6027        20.75        11.8212       4.65088        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      4.86644       11.3235       18.8994       10.3423       4.35661        10     
[art]:TriggerResults:TriggerResultInserter        4.4145e-05    5.97139e-05   0.000116609   5.6793e-05    1.99019e-05      10     
end_path:out1:RootOutput                           9.127e-06    1.08102e-05   1.5189e-05    1.04255e-05   1.67896e-06      10     
end_path:out1:RootOutput(write)                     2.24685       3.34204       4.25735       3.32263       0.50119        10     
====================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5073.51 MB
  Peak resident set size usage (VmHWM): 4269.18 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.08 sec/event
ToolBasedRawDigitPrepService:dtor:                adcSampleFiller:   0.23 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.05 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   4.07 sec/event
ToolBasedRawDigitPrepService:dtor:         adcKeepAllSignalFinder:   0.22 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 10484540
-rw-r--r--. 1 dune004 dune 2443855893 Dec 30 08:31 detsim_stage2.root
-rw-r--r--. 1 dune004 dune 2315118424 Dec 30 08:29 detsim_stage1.root
-rw-r--r--. 1 dune004 dune 2168683939 Dec 30 10:03 reco_stage1.root
-rw-r--r--. 1 dune004 dune 1901172512 Dec 30 06:50 g4_stage2.root
-rw-r--r--. 1 dune004 dune 1822783045 Dec 30 06:33 g4_stage1.root
-rw-r--r--. 1 dune004 dune   83924740 Dec 30 09:57 Pandora_Events.pndr
-rw-r--r--. 1 dune004 dune     242814 Dec 30 10:03 jobscript.log
-rw-r--r--. 1 dune004 dune     217088 Dec 30 10:03 mem.db
-rw-r--r--. 1 dune004 dune      62376 Dec 30 10:03 Pandora_Geometry.xml
-rw-r--r--. 1 dune004 dune      36864 Dec 30 10:03 time.db
-rw-r--r--. 1 dune004 dune        519 Dec 30 08:31 detsim_single_protoDUNE_hist.root
-rw-r--r--. 1 dune004 dune        519 Dec 30 06:50 g4_protoDUNE_hist.root
-rw-r--r--. 1 dune004 dune        519 Dec 30 10:03 protoDUNE_reco1_hist.root
-rw-r--r--. 1 dune004 dune         52 Dec 30 06:26 all-input-dids.txt
-rw-r--r--. 1 dune004 dune          7 Dec 30 10:03 justin-processed-pfns.txt
-rw-r--r--. 1 dune004 dune          0 Dec 30 08:41 ProtoDUNE.log
-rw-r--r--. 1 dune004 dune          0 Dec 30 08:31 debugprod.log
justIN time: 2026-02-07 00:51:15 UTC       justIN version: 01.06.00