Jobsub ID 267430.0@dunegpschedd01.fnal.gov
| Jobsub ID | 267430.0@dunegpschedd01.fnal.gov |
| Workflow ID | 11194 |
| Stage ID | 1 |
| User name | pmelas@fnal.gov |
| HTCondor Group | group_dune |
| Requested | Processors | 1 |
| GPU | No |
| RSS bytes | 8388608000 (8000 MiB) |
| Wall seconds limit | 86400 (24 hours) |
| Submitted time | 2025-12-12 18:07:42 |
| Site | UK_QMUL |
| Entry | DUNE_UK_London_QMUL_arcce03 |
| Last heartbeat | 2025-12-12 22:33:43 |
| From worker node | Hostname | cn055.htc.esc.qmul |
| cpuinfo | Intel(R) Xeon(R) Gold 6248R CPU @ 3.00GHz |
| OS release | Scientific Linux release 7.9 (Nitrogen) |
| Processors | 1 |
| RSS bytes | 10485760000 (10000 MiB) |
| Wall seconds limit | 171000 (47 hours) |
| GPU | |
| Inner Apptainer? | True |
| Job state | finished |
| Started | 2025-12-12 18:08:41 |
| Input files | monte-carlo-011194-000001
|
| Jobscript | Exit code | 0 |
| Real time | 4h (15693s) |
| CPU time | 4h (15443s = 98%) |
| Max RSS bytes | 4537602048 (4327 MiB) |
| Outputting started | 2025-12-12 22:30:14 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11194/1/001/reco_stage1.root
|
| Finished | 2025-12-12 22:33:43 |
| Saved logs | justin-logs:267430.0-dunegpschedd01.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
els
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 149792 traces, 0 summary
Retagger: tagging trace set: gauss with 115581 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 115581 traces tagged "gauss"
FrameSaver: q=4.14597e+06 n=2068025 tag=gauss
wclsFrameSaver: saving 149792 traces tagged "wiener"
FrameSaver: q=4.40118e+06 n=1841466 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 40814 XUs and 37510 XVs -> 1932 XUVs
C:0 T:1 106040 XUs and 103798 XVs -> 19388 XUVs
C:0 T:2 128080 XUs and 121826 XVs -> 5429 XUVs
C:0 T:3 64071 XUs and 52889 XVs -> 446 XUVs
C:0 T:4 8481 XUs and 10345 XVs -> 45 XUVs
C:0 T:5 34622 XUs and 40699 XVs -> 3279 XUVs
C:0 T:6 105945 XUs and 141939 XVs -> 4693 XUVs
C:0 T:7 44144 XUs and 55527 XVs -> 409 XUVs
C:0 T:8 6591 XUs and 8199 XVs -> 102 XUVs
C:0 T:9 50384 XUs and 82140 XVs -> 8513 XUVs
C:0 T:10 78096 XUs and 66969 XVs -> 6020 XUVs
C:0 T:11 436 XUs and 373 XVs -> 40 XUVs
50296 XUVs total
13077 collection wire objects
45151 potential space points
Neighbour search...
5042673 tests to find 2512194 neighbours
Iterating with no regularization...
Begin: 9.19427e+07
0 7.16344e+07
1 7.04859e+07
2 7.03054e+07
3 7.02465e+07
Now with regularization...
Begin: 5.79625e+07
0 5.78908e+07
1 5.78373e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
run: 1 ; subrun: 0 ; event: 10
evttime: 411076724
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411076724
fLifetime: 30000 [us]
12-Dec-2025 22:30:11 GMT Closed output file "reco_stage1.root"
12-Dec-2025 22:30: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 525.827 700.826 930.961 683.809 127.127 10
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000854938 0.00385342 0.00596378 0.00425054 0.00152687 10
reco:ophit:OpHitFinder 0.277679 0.383314 0.469175 0.382333 0.0531095 10
reco:opflash:OpFlashFinder 0.237291 0.277454 0.325013 0.281027 0.0264228 10
reco:opslicer:OpSlicer 0.623605 0.990523 1.24054 0.999414 0.165483 10
reco:caldata:DataPrepModule 6.06359 7.10523 7.92295 7.10041 0.646298 10
reco:wclsdatasp:WireCellToolkit 52.9031 57.7498 62.502 57.645 3.26148 10
reco:gaushit:GausHitFinder 1.3945 2.03984 2.65223 1.92996 0.363186 10
reco:nhitsfilter:NumberOfHitsFilter 0.000858968 0.0010731 0.00153956 0.00103831 0.0001923 10
reco:reco3d:SpacePointSolver 13.57 24.5012 42.7432 25.2183 7.95169 10
reco:hitpdune:DisambigFromSpacePoints 2.13692 3.59062 5.12983 3.4525 1.01894 10
reco:pandora:StandardPandora 38.606 71.0318 136.678 63.4723 27.5183 10
reco:pandoraWriter:StandardPandora 0.500197 0.725381 0.941593 0.782199 0.147741 10
reco:pandoraTrack:LArPandoraTrackCreation 10.845 15.589 20.6146 15.3197 3.34219 10
reco:pandoraShower:LArPandoraShowerCreation 12.0727 19.1913 27.0839 20.103 5.14996 10
reco:pandoracalo:Calorimetry 5.00368 7.32872 9.70909 6.9468 1.68419 10
reco:pandoracalonosce:Calorimetry 4.6077 7.13543 10.5655 6.46925 1.89354 10
reco:pandorapid:Chi2ParticleID 0.00513284 0.00932691 0.0126527 0.00887091 0.00243107 10
reco:pandoracalinoxyzt:CalibrationdEdXPDSP 0.0595621 0.0898162 0.113047 0.0921401 0.0172308 10
reco:pandoracalipidnoxyzt:Chi2ParticleID 0.00514013 0.00892207 0.0111407 0.00890921 0.00198187 10
reco:pandoraShowercalo:ShowerCalorimetry 11.9713 19.1073 27.3379 19.1402 5.50239 10
reco:pandoraShowercalonosce:ShowerCalorimetry 11.3818 18.7528 27.129 18.9012 5.54201 10
reco:emtrkmichelid:EmTrackMichelId 229.345 288.471 363.044 283.24 43.9086 10
reco:crttag:SingleCRTMatchingProducer 0.0208695 0.0348715 0.0476108 0.0344781 0.00783824 10
reco:crtreco:TwoCRTMatchingProducer 0.0187667 0.0301446 0.0390868 0.0294155 0.00586392 10
reco:anodepiercerst0:T0RecoAnodePiercers 1.26463 1.49012 1.94698 1.46823 0.193506 10
reco:pandora2Track:LArPandoraTrackCreation 37.5182 53.1639 68.0231 55.1853 10.5332 10
reco:pandora2calo:Calorimetry 16.975 23.3294 29.7377 22.998 4.76043 10
reco:pandora2calonosce:Calorimetry 16.2717 22.4082 28.158 22.6506 4.21298 10
reco:pandora2pid:Chi2ParticleID 0.0153939 0.022426 0.030459 0.021621 0.00502755 10
reco:pandora2calinoxyzt:CalibrationdEdXPDSP 0.0963018 0.117537 0.144326 0.115721 0.0150723 10
reco:pandora2calipidnoxyzt:Chi2ParticleID 0.016918 0.0226812 0.0283903 0.0224632 0.00358174 10
reco:pandora2Shower:LArPandoraShowerCreation 11.3428 15.5922 19.5514 15.3981 2.73348 10
reco:pandora2Showercalo:ShowerCalorimetry 14.6691 19.7744 26.8172 19.2038 3.64675 10
reco:pandora2Showercalonosce:ShowerCalorimetry 12.7527 16.7086 23.0089 16.6495 2.83386 10
[art]:TriggerResults:TriggerResultInserter 4.1636e-05 7.10311e-05 0.000168278 6.4188e-05 3.41587e-05 10
end_path:out1:RootOutput 7.842e-06 1.12903e-05 2.7816e-05 9.7155e-06 5.57466e-06 10
end_path:out1:RootOutput(write) 2.86606 3.85973 5.09073 3.58402 0.654484 10
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5344.78 MB
Peak resident set size usage (VmHWM): 4537.6 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.48 sec/event
ToolBasedRawDigitPrepService:dtor: adcKeepAllSignalFinder: 0.25 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleKeToAdc: 0.06 sec/event
ToolBasedRawDigitPrepService:dtor: pdsp_RemoveBadChannels: 0.00 sec/event
Art has completed and will exit with status 0.
lar exit code 0
.:
total 11590904
-rw-r--r-- 1 pildune32 pildune 2658683887 Dec 12 20:30 detsim_stage2.root
-rw-r--r-- 1 pildune32 pildune 2518913818 Dec 12 20:27 detsim_stage1.root
-rw-r--r-- 1 pildune32 pildune 2390846990 Dec 12 22:30 reco_stage1.root
-rw-r--r-- 1 pildune32 pildune 2147202907 Dec 12 18:33 g4_stage2.root
-rw-r--r-- 1 pildune32 pildune 2067309327 Dec 12 18:15 g4_stage1.root
-rw-r--r-- 1 pildune32 pildune 85512700 Dec 12 22:21 Pandora_Events.pndr
-rw-r--r-- 1 pildune32 pildune 243164 Dec 12 22:30 jobscript.log
-rw-r--r-- 1 pildune32 pildune 217088 Dec 12 22:30 mem.db
-rw-r--r-- 1 pildune32 pildune 62376 Dec 12 22:30 Pandora_Geometry.xml
-rw-r--r-- 1 pildune32 pildune 36864 Dec 12 22:30 time.db
-rw-r--r-- 1 pildune32 pildune 519 Dec 12 20:30 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 pildune32 pildune 519 Dec 12 18:33 g4_protoDUNE_hist.root
-rw-r--r-- 1 pildune32 pildune 519 Dec 12 22:30 protoDUNE_reco1_hist.root
-rw-r--r-- 1 pildune32 pildune 52 Dec 12 18:08 all-input-dids.txt
-rw-r--r-- 1 pildune32 pildune 7 Dec 12 22:30 justin-processed-pfns.txt
-rw-r--r-- 1 pildune32 pildune 0 Dec 12 20:43 ProtoDUNE.log
-rw-r--r-- 1 pildune32 pildune 0 Dec 12 20:30 debugprod.log