justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 265243.0@dunegpschedd02.fnal.gov

Jobsub ID265243.0@dunegpschedd02.fnal.gov
Workflow ID11438
Stage ID1
User namepmelas@fnal.gov
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2025-12-31 09:13:41
SiteUK_QMUL
EntryDUNE_UK_London_QMUL_arcce03
Last heartbeat2025-12-31 12:36:49
From worker nodeHostnamecn002.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-31 09:14:12
Input filesmonte-carlo-011438-000001
JobscriptExit code0
Real time3h (11941s)
CPU time3h (11750s = 98%)
Max RSS bytes4251291648 (4054 MiB)
Outputting started2025-12-31 12:33:14
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11438/1/001/reco_stage1.root
Finished2025-12-31 12:36:49
Saved logsjustin-logs:265243.0-dunegpschedd02.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

nning 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 131435 traces, 0 summary
Retagger: tagging trace set: gauss with 99858 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 99858 traces tagged "gauss"
FrameSaver: q=3.53824e+06 n=1753659 tag=gauss
wclsFrameSaver: saving 131435 traces tagged "wiener"
FrameSaver: q=3.75616e+06 n=1557255 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 31414 XUs and 27942 XVs -> 265 XUVs
C:0 T:1 56175 XUs and 51140 XVs -> 3776 XUVs
C:0 T:2 121626 XUs and 157787 XVs -> 9802 XUVs
C:0 T:3 58891 XUs and 66990 XVs -> 847 XUVs
C:0 T:4 11400 XUs and 13776 XVs -> 429 XUVs
C:0 T:5 41417 XUs and 39693 XVs -> 4956 XUVs
C:0 T:6 91201 XUs and 129617 XVs -> 8960 XUVs
C:0 T:7 34326 XUs and 45665 XVs -> 434 XUVs
C:0 T:8 10034 XUs and 12111 XVs -> 406 XUVs
C:0 T:9 49362 XUs and 70251 XVs -> 4536 XUVs
C:0 T:10 30311 XUs and 11270 XVs -> 3853 XUVs
C:0 T:11 13 XUs and 10 XVs -> 3 XUVs
38267 XUVs total
11447 collection wire objects
34616 potential space points
Neighbour search...
2845548 tests to find 1427946 neighbours
Iterating with no regularization...
Begin: 7.03494e+07
0 6.04571e+07
1 5.96293e+07
2 5.94931e+07
3 5.9455e+07
Now with regularization...
Begin: 4.86518e+07
0 4.86233e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 411451435
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411451435
fLifetime: 30000 [us]
31-Dec-2025 12:33:11 GMT  Closed output file "reco_stage1.root"
31-Dec-2025 12:33:11 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                                          268.27        499.505       745.184       467.859       156.444        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.00173471    0.00362987    0.00487358    0.00327132    0.000979034      10     
reco:ophit:OpHitFinder                             0.250831      0.303912      0.468341      0.279305      0.0631018       10     
reco:opflash:OpFlashFinder                         0.167832      0.221838      0.310237       0.20187      0.0441262       10     
reco:opslicer:OpSlicer                             0.629496      0.761689       1.11843      0.701521      0.148888        10     
reco:caldata:DataPrepModule                         5.32779       6.17304       9.57276       5.42568       1.50301        10     
reco:wclsdatasp:WireCellToolkit                     47.3418       52.1173       66.9876       49.0867       6.35564        10     
reco:gaushit:GausHitFinder                          1.16736       1.58364       2.27269       1.51862      0.363232        10     
reco:nhitsfilter:NumberOfHitsFilter               0.000672144   0.000974636   0.00161628    0.000906301   0.000276532      10     
reco:reco3d:SpacePointSolver                        8.4179        18.681        36.0803       14.5663       10.554         10     
reco:hitpdune:DisambigFromSpacePoints               1.30424       2.53801       4.3179        2.32682       1.03991        10     
reco:pandora:StandardPandora                        17.7206       47.2967       88.4156       36.6797       24.1032        10     
reco:pandoraWriter:StandardPandora                 0.395354      0.571852      0.998364      0.505924      0.174296        10     
reco:pandoraTrack:LArPandoraTrackCreation           5.86203       11.8448       19.1931       10.6152       4.25442        10     
reco:pandoraShower:LArPandoraShowerCreation         5.69107       15.1405       24.8142       14.4789       6.20245        10     
reco:pandoracalo:Calorimetry                        2.66554       5.35493       9.59209       4.83844       2.1537         10     
reco:pandoracalonosce:Calorimetry                   2.38756       5.11737       8.95384       4.64168       2.01059        10     
reco:pandorapid:Chi2ParticleID                    0.00459755    0.00668415     0.0133184    0.00586273    0.00239522       10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0517463     0.0720595     0.112379      0.0686322     0.0186063       10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00481401    0.00632223     0.0108928     0.0056851    0.00171392       10     
reco:pandoraShowercalo:ShowerCalorimetry            4.79239       13.4665       22.7631        12.78        6.0413         10     
reco:pandoraShowercalonosce:ShowerCalorimetry       4.82591       13.0796       22.321        12.312        5.92759        10     
reco:emtrkmichelid:EmTrackMichelId                  109.064       189.591       252.605       187.472       45.0328        10     
reco:crttag:SingleCRTMatchingProducer              0.0211014     0.0337335     0.0558413     0.0336475    0.00965318       10     
reco:crtreco:TwoCRTMatchingProducer                0.0144649     0.0284103     0.0468459     0.0285782    0.00858659       10     
reco:anodepiercerst0:T0RecoAnodePiercers           0.812264       1.26144       1.8562        1.1598       0.317291        10     
reco:pandora2Track:LArPandoraTrackCreation          11.1034       40.1625       64.516        38.6411       16.7967        10     
reco:pandora2calo:Calorimetry                       3.86546       16.9839       30.2003       15.984        8.04605        10     
reco:pandora2calonosce:Calorimetry                  3.59538       15.9254       29.0087       15.1887       7.52841        10     
reco:pandora2pid:Chi2ParticleID                   0.00842536     0.0147537     0.0261382     0.0133687    0.00471532       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0477399     0.0863215     0.137794      0.0797352     0.0247133       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID         0.00807151     0.0145353     0.0255299     0.0133966    0.00459846       10     
reco:pandora2Shower:LArPandoraShowerCreation        3.84552       12.435        21.3938       12.1978       5.17387        10     
reco:pandora2Showercalo:ShowerCalorimetry           3.29855       13.7221       26.2298       13.5599       6.34285        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      3.03889       11.7707       23.7633       11.5324       5.66808        10     
[art]:TriggerResults:TriggerResultInserter        5.2228e-05    7.98698e-05   0.000247963   5.75895e-05   5.7114e-05       10     
end_path:out1:RootOutput                          1.0042e-05    1.24592e-05   2.1315e-05    1.0639e-05    3.85728e-06      10     
end_path:out1:RootOutput(write)                     1.6644        2.95585       5.06988       2.67949      0.991502        10     
====================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5059.01 MB
  Peak resident set size usage (VmHWM): 4251.29 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.24 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.05 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   3.81 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 10078872
-rw-r--r-- 1 pildune32 pildune 2371834182 Dec 31 11:07 detsim_stage2.root
-rw-r--r-- 1 pildune32 pildune 2245620697 Dec 31 11:05 detsim_stage1.root
-rw-r--r-- 1 pildune32 pildune 2077160668 Dec 31 12:33 reco_stage1.root
-rw-r--r-- 1 pildune32 pildune 1814321838 Dec 31 09:38 g4_stage2.root
-rw-r--r-- 1 pildune32 pildune 1731796774 Dec 31 09:22 g4_stage1.root
-rw-r--r-- 1 pildune32 pildune   79409900 Dec 31 12:27 Pandora_Events.pndr
-rw-r--r-- 1 pildune32 pildune     242798 Dec 31 12:33 jobscript.log
-rw-r--r-- 1 pildune32 pildune     217088 Dec 31 12:33 mem.db
-rw-r--r-- 1 pildune32 pildune      62376 Dec 31 12:33 Pandora_Geometry.xml
-rw-r--r-- 1 pildune32 pildune      36864 Dec 31 12:33 time.db
-rw-r--r-- 1 pildune32 pildune        519 Dec 31 11:07 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 pildune32 pildune        519 Dec 31 09:38 g4_protoDUNE_hist.root
-rw-r--r-- 1 pildune32 pildune        519 Dec 31 12:33 protoDUNE_reco1_hist.root
-rw-r--r-- 1 pildune32 pildune         52 Dec 31 09:14 all-input-dids.txt
-rw-r--r-- 1 pildune32 pildune          7 Dec 31 12:33 justin-processed-pfns.txt
-rw-r--r-- 1 pildune32 pildune          0 Dec 31 11:17 ProtoDUNE.log
-rw-r--r-- 1 pildune32 pildune          0 Dec 31 11:07 debugprod.log
justIN time: 2026-02-06 23:33:08 UTC       justIN version: 01.06.00