Jobsub ID 296470.0@dunegpschedd02.fnal.gov
| Jobsub ID | 296470.0@dunegpschedd02.fnal.gov |
| Workflow ID | 12506 |
| Stage ID | 1 |
| User name | pmelas@fnal.gov |
| Requested | Processors | 1 |
| GPU | No |
| RSS bytes | 8388608000 (8000 MiB) |
| Wall seconds limit | 86400 (24 hours) |
| Submitted time | 2026-01-29 09:31:46 |
| Site | CERN |
| Entry | CMSHTPC_T2_CH_CERN_ce512 |
| Last heartbeat | 2026-01-29 14:58:43 |
| From worker node | Hostname | b9p19p2088.cern.ch |
| cpuinfo | Intel(R) Xeon(R) Silver 4216 CPU @ 2.10GHz |
| OS release | Scientific Linux release 7.9 (Nitrogen) |
| Processors | 1 |
| RSS bytes | 10485760000 (10000 MiB) |
| Wall seconds limit | 343800 (95 hours) |
| GPU | |
| Inner Apptainer? | True |
| Job state | finished |
| Started | 2026-01-29 09:32:51 |
| Input files | monte-carlo-012506-000001
|
| Jobscript | Exit code | 0 |
| Real time | 5h (19466s) |
| CPU time | 5h (18232s = 93%) |
| Max RSS bytes | 4242362368 (4045 MiB) |
| Outputting started | 2026-01-29 14:57:18 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/12506/1/001/reco_stage1.root
|
| Finished | 2026-01-29 14:58:43 |
| Saved logs | justin-logs:296470.0-dunegpschedd02.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
rvice: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 162089 traces, 0 summary
Retagger: tagging trace set: gauss with 121070 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 121070 traces tagged "gauss"
FrameSaver: q=4.09583e+06 n=2106991 tag=gauss
wclsFrameSaver: saving 162089 traces tagged "wiener"
FrameSaver: q=4.35374e+06 n=1843302 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 48117 XUs and 30984 XVs -> 538 XUVs
C:0 T:1 125416 XUs and 83205 XVs -> 13334 XUVs
C:0 T:2 134426 XUs and 152612 XVs -> 11208 XUVs
C:0 T:3 57908 XUs and 55504 XVs -> 699 XUVs
C:0 T:4 14258 XUs and 11908 XVs -> 161 XUVs
C:0 T:5 94504 XUs and 108440 XVs -> 16436 XUVs
C:0 T:6 152449 XUs and 167296 XVs -> 18489 XUVs
C:0 T:7 44652 XUs and 50944 XVs -> 720 XUVs
C:0 T:8 7100 XUs and 9600 XVs -> 128 XUVs
C:0 T:9 58605 XUs and 94842 XVs -> 5623 XUVs
C:0 T:10 68885 XUs and 57093 XVs -> 10586 XUVs
C:0 T:11 130 XUs and 83 XVs -> 10 XUVs
77932 XUVs total
15276 collection wire objects
71556 potential space points
Neighbour search...
14969088 tests to find 6671392 neighbours
Iterating with no regularization...
Begin: 7.11179e+07
0 5.95549e+07
1 5.88407e+07
2 5.87371e+07
3 5.87038e+07
Now with regularization...
Begin: 4.82792e+07
0 4.82154e+07
1 4.81448e+07
2 4.80855e+07
3 4.80355e+07
4 4.79951e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 412035435
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 412035435
fLifetime: 30000 [us]
29-Jan-2026 15:57:14 CET Closed output file "reco_stage1.root"
29-Jan-2026 15:57:14 CET 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 592.056 763.987 1066.33 745.899 143.832 10
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00161713 0.00427 0.00786326 0.00396736 0.00205748 10
reco:ophit:OpHitFinder 0.283967 0.462 0.58365 0.485533 0.0901151 10
reco:opflash:OpFlashFinder 0.192126 0.30091 0.374505 0.301198 0.0562323 10
reco:opslicer:OpSlicer 1.06752 1.23468 1.45071 1.19085 0.113499 10
reco:caldata:DataPrepModule 7.69283 10.1203 11.515 10.543 1.1984 10
reco:wclsdatasp:WireCellToolkit 54.9518 67.0988 79.3148 66.5151 7.95962 10
reco:gaushit:GausHitFinder 1.85487 2.39822 2.91503 2.40973 0.354009 10
reco:nhitsfilter:NumberOfHitsFilter 0.000727056 0.000884399 0.00106081 0.000887724 0.000109861 10
reco:reco3d:SpacePointSolver 15.6309 29.035 42.333 28.7316 7.9441 10
reco:hitpdune:DisambigFromSpacePoints 2.46704 3.85812 6.15873 3.64489 1.16349 10
reco:pandora:StandardPandora 45.872 75.2543 138.674 63.5575 28.7004 10
reco:pandoraWriter:StandardPandora 0.477589 0.794129 1.17779 0.834636 0.225883 10
reco:pandoraTrack:LArPandoraTrackCreation 8.41566 13.6502 24.3328 12.7776 4.19095 10
reco:pandoraShower:LArPandoraShowerCreation 7.17608 13.7249 26.2217 12.6427 5.26251 10
reco:pandoracalo:Calorimetry 3.07528 5.83783 10.0584 5.55972 1.88066 10
reco:pandoracalonosce:Calorimetry 3.13044 5.49531 9.59961 5.08383 1.77296 10
reco:pandorapid:Chi2ParticleID 0.00648592 0.0110281 0.0164152 0.0110135 0.00271155 10
reco:pandoracalinoxyzt:CalibrationdEdXPDSP 0.0759275 0.110041 0.144835 0.108125 0.0209431 10
reco:pandoracalipidnoxyzt:Chi2ParticleID 0.00628273 0.0104574 0.0155703 0.0107764 0.00240904 10
reco:pandoraShowercalo:ShowerCalorimetry 6.71394 13.3637 23.7811 11.8804 4.7411 10
reco:pandoraShowercalonosce:ShowerCalorimetry 6.04482 13.6302 22.8542 13.1173 4.85147 10
reco:emtrkmichelid:EmTrackMichelId 310.107 375.492 461.383 355.91 52.0984 10
reco:crttag:SingleCRTMatchingProducer 0.0291621 0.0365119 0.0442157 0.0375092 0.00562873 10
reco:crtreco:TwoCRTMatchingProducer 0.0177563 0.0274567 0.0352121 0.0265105 0.00548914 10
reco:anodepiercerst0:T0RecoAnodePiercers 1.44605 1.9299 2.53865 1.90112 0.299181 10
reco:pandora2Track:LArPandoraTrackCreation 23.6266 43.7002 83.8185 43.344 16.8251 10
reco:pandora2calo:Calorimetry 9.33962 18.2081 30.6738 20.1829 6.39402 10
reco:pandora2calonosce:Calorimetry 8.91435 18.19 31.0017 19.5533 6.47506 10
reco:pandora2pid:Chi2ParticleID 0.0158774 0.0279243 0.041488 0.0276251 0.00736227 10
reco:pandora2calinoxyzt:CalibrationdEdXPDSP 0.119553 0.15212 0.196302 0.155181 0.0236193 10
reco:pandora2calipidnoxyzt:Chi2ParticleID 0.0159355 0.028642 0.0406765 0.0287051 0.00641308 10
reco:pandora2Shower:LArPandoraShowerCreation 6.39471 13.6448 23.0732 14.072 4.55463 10
reco:pandora2Showercalo:ShowerCalorimetry 9.31067 16.6141 27.9604 17.258 5.30869 10
reco:pandora2Showercalonosce:ShowerCalorimetry 7.83672 14.2917 24.8114 14.7891 4.87816 10
[art]:TriggerResults:TriggerResultInserter 7.0986e-05 9.39013e-05 0.000140295 8.92595e-05 1.83105e-05 10
end_path:out1:RootOutput 9.996e-06 1.26166e-05 1.4806e-05 1.24955e-05 1.24884e-06 10
end_path:out1:RootOutput(write) 3.10105 5.07944 6.99096 5.13695 1.0673 10
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5058.5 MB
Peak resident set size usage (VmHWM): 4242.36 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.38 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleAdcToKe: 0.06 sec/event
ToolBasedRawDigitPrepService:dtor: pdspTailPedRemovalZKe: 6.45 sec/event
ToolBasedRawDigitPrepService:dtor: adcKeepAllSignalFinder: 0.36 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleKeToAdc: 0.06 sec/event
ToolBasedRawDigitPrepService:dtor: pdsp_RemoveBadChannels: 0.01 sec/event
Art has completed and will exit with status 0.
lar exit code 0
.:
total 10237012
-rw-r--r--. 1 duneprd np-comp 2403580413 Jan 29 13:44 detsim_stage2.root
-rw-r--r--. 1 duneprd np-comp 2280229849 Jan 29 13:41 detsim_stage1.root
-rw-r--r--. 1 duneprd np-comp 2114873043 Jan 29 15:57 reco_stage1.root
-rw-r--r--. 1 duneprd np-comp 1833626097 Jan 29 11:14 g4_stage2.root
-rw-r--r--. 1 duneprd np-comp 1768503736 Jan 29 10:44 g4_stage1.root
-rw-r--r--. 1 duneprd np-comp 81270220 Jan 29 15:46 Pandora_Events.pndr
-rw-r--r--. 1 duneprd np-comp 243006 Jan 29 15:57 jobscript.log
-rw-r--r--. 1 duneprd np-comp 217088 Jan 29 15:57 mem.db
-rw-r--r--. 1 duneprd np-comp 62376 Jan 29 15:57 Pandora_Geometry.xml
-rw-r--r--. 1 duneprd np-comp 36864 Jan 29 15:57 time.db
-rw-r--r--. 1 duneprd np-comp 519 Jan 29 13:44 detsim_single_protoDUNE_hist.root
-rw-r--r--. 1 duneprd np-comp 519 Jan 29 11:14 g4_protoDUNE_hist.root
-rw-r--r--. 1 duneprd np-comp 519 Jan 29 15:57 protoDUNE_reco1_hist.root
-rw-r--r--. 1 duneprd np-comp 52 Jan 29 10:32 all-input-dids.txt
-rw-r--r--. 1 duneprd np-comp 7 Jan 29 15:57 justin-processed-pfns.txt
-rw-r--r--. 1 duneprd np-comp 0 Jan 29 13:56 ProtoDUNE.log
-rw-r--r--. 1 duneprd np-comp 0 Jan 29 13:44 debugprod.log
