Jobsub ID 271428.0@dunegpschedd01.fnal.gov
| Jobsub ID | 271428.0@dunegpschedd01.fnal.gov |
| Workflow ID | 11487 |
| 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-03 13:51:50 |
| Site | CERN |
| Entry | CMSHTPC_T2_CH_CERN_ce512 |
| Last heartbeat | 2026-01-03 17:22:30 |
| From worker node | Hostname | b9p09p1103.cern.ch |
| cpuinfo | AMD EPYC 7543 32-Core Processor |
| 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-03 13:52:46 |
| Input files | monte-carlo-011487-000001
|
| Jobscript | Exit code | 0 |
| Real time | 3h (12495s) |
| CPU time | 3h (11307s = 90%) |
| Max RSS bytes | 4147351552 (3955 MiB) |
| Outputting started | 2026-01-03 17:21:02 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11487/1/001/reco_stage1.root
|
| Finished | 2026-01-03 17:22:30 |
| Saved logs | justin-logs:271428.0-dunegpschedd01.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
ice: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 147327 traces, 0 summary
Retagger: tagging trace set: gauss with 115837 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 115837 traces tagged "gauss"
FrameSaver: q=3.99266e+06 n=2066568 tag=gauss
wclsFrameSaver: saving 147327 traces tagged "wiener"
FrameSaver: q=4.22647e+06 n=1845274 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 48738 XUs and 51322 XVs -> 573 XUVs
C:0 T:1 89590 XUs and 94146 XVs -> 6818 XUVs
C:0 T:2 59365 XUs and 91016 XVs -> 3799 XUVs
C:0 T:3 30533 XUs and 38793 XVs -> 271 XUVs
C:0 T:4 12696 XUs and 11312 XVs -> 112 XUVs
C:0 T:5 61957 XUs and 29778 XVs -> 3544 XUVs
C:0 T:6 159025 XUs and 103551 XVs -> 5243 XUVs
C:0 T:7 65073 XUs and 34538 XVs -> 439 XUVs
C:0 T:8 10204 XUs and 11031 XVs -> 89 XUVs
C:0 T:9 66423 XUs and 86911 XVs -> 4177 XUVs
C:0 T:10 51327 XUs and 45220 XVs -> 6174 XUVs
C:0 T:11 101 XUs and 90 XVs -> 18 XUVs
31257 XUVs total
12690 collection wire objects
28676 potential space points
Neighbour search...
1473804 tests to find 733836 neighbours
Iterating with no regularization...
Begin: 8.91384e+07
0 7.28185e+07
1 7.18419e+07
2 7.16905e+07
3 7.16444e+07
Now with regularization...
Begin: 6.0808e+07
0 6.07756e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 411515910
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411515910
fLifetime: 30000 [us]
03-Jan-2026 18:20:59 CET Closed output file "reco_stage1.root"
03-Jan-2026 18:20:59 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 205.201 321.881 473.664 330.592 90.9226 10
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000899706 0.00320707 0.00579801 0.00347541 0.00137564 10
reco:ophit:OpHitFinder 0.198874 0.243195 0.327569 0.241139 0.0373684 10
reco:opflash:OpFlashFinder 0.102723 0.141817 0.178991 0.144638 0.0239949 10
reco:opslicer:OpSlicer 0.414655 0.558528 0.830701 0.494271 0.146455 10
reco:caldata:DataPrepModule 4.2098 5.25696 6.79878 5.27834 0.851684 10
reco:wclsdatasp:WireCellToolkit 28.4533 31.7847 35.8212 31.0763 2.60519 10
reco:gaushit:GausHitFinder 0.738243 1.14412 1.59801 1.06587 0.280223 10
reco:nhitsfilter:NumberOfHitsFilter 0.000278652 0.000474389 0.000808316 0.000441603 0.000140943 10
reco:reco3d:SpacePointSolver 6.59438 18.5185 56.7955 14.2723 14.7431 10
reco:hitpdune:DisambigFromSpacePoints 0.645715 1.35164 2.00997 1.45589 0.494177 10
reco:pandora:StandardPandora 15.1334 37.0723 82.6186 27.5689 22.3498 10
reco:pandoraWriter:StandardPandora 0.215658 0.452921 0.803502 0.434369 0.193531 10
reco:pandoraTrack:LArPandoraTrackCreation 1.34497 3.24122 5.40235 3.35825 1.33671 10
reco:pandoraShower:LArPandoraShowerCreation 1.3936 3.80312 7.23632 3.3106 1.91754 10
reco:pandoracalo:Calorimetry 0.751203 1.92462 3.39945 1.85152 0.756613 10
reco:pandoracalonosce:Calorimetry 0.684729 1.63824 3.11415 1.67478 0.651616 10
reco:pandorapid:Chi2ParticleID 0.00289483 0.00606098 0.00975133 0.00601999 0.00200649 10
reco:pandoracalinoxyzt:CalibrationdEdXPDSP 0.0275806 0.0558449 0.0775932 0.057374 0.0162893 10
reco:pandoracalipidnoxyzt:Chi2ParticleID 0.00284018 0.00549774 0.00790841 0.00557865 0.00177955 10
reco:pandoraShowercalo:ShowerCalorimetry 1.33131 4.12986 7.43115 4.08743 2.04899 10
reco:pandoraShowercalonosce:ShowerCalorimetry 1.39635 3.57609 7.20769 3.40444 1.79667 10
reco:emtrkmichelid:EmTrackMichelId 117.371 169.867 235.344 165.974 40.9056 10
reco:crttag:SingleCRTMatchingProducer 0.00863294 0.013446 0.0206897 0.0138175 0.00398281 10
reco:crtreco:TwoCRTMatchingProducer 0.00466298 0.00800235 0.00980382 0.00896102 0.00185375 10
reco:anodepiercerst0:T0RecoAnodePiercers 0.57144 0.848677 1.25207 0.794518 0.206338 10
reco:pandora2Track:LArPandoraTrackCreation 4.06524 10.5145 18.8477 11.2237 4.58021 10
reco:pandora2calo:Calorimetry 1.88752 5.24136 8.99615 5.08512 2.48721 10
reco:pandora2calonosce:Calorimetry 1.78347 5.10025 9.20343 5.36349 2.4442 10
reco:pandora2pid:Chi2ParticleID 0.00636127 0.0119975 0.0253733 0.0100739 0.00623514 10
reco:pandora2calinoxyzt:CalibrationdEdXPDSP 0.0337487 0.0530197 0.117169 0.0477151 0.0232735 10
reco:pandora2calipidnoxyzt:Chi2ParticleID 0.00625356 0.0110798 0.0240724 0.0101816 0.00503242 10
reco:pandora2Shower:LArPandoraShowerCreation 1.34087 3.67732 6.88776 3.46829 1.84645 10
reco:pandora2Showercalo:ShowerCalorimetry 1.57904 4.69336 8.0317 5.04364 2.19668 10
reco:pandora2Showercalonosce:ShowerCalorimetry 1.67978 4.17548 5.89159 4.86574 1.66611 10
[art]:TriggerResults:TriggerResultInserter 4.8561e-05 7.46257e-05 0.000141471 7.1861e-05 2.55489e-05 10
end_path:out1:RootOutput 1.131e-05 1.64001e-05 4.1551e-05 1.35e-05 8.66319e-06 10
end_path:out1:RootOutput(write) 1.55039 2.66308 3.37197 2.77638 0.544438 10
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4982.99 MB
Peak resident set size usage (VmHWM): 4147.35 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.06 sec/event
ToolBasedRawDigitPrepService:dtor: adcSampleFiller: 0.24 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleAdcToKe: 0.04 sec/event
ToolBasedRawDigitPrepService:dtor: pdspTailPedRemovalZKe: 3.36 sec/event
ToolBasedRawDigitPrepService:dtor: adcKeepAllSignalFinder: 0.14 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleKeToAdc: 0.04 sec/event
ToolBasedRawDigitPrepService:dtor: pdsp_RemoveBadChannels: 0.00 sec/event
Art has completed and will exit with status 0.
lar exit code 0
.:
total 9926844
-rw-r--r--. 1 duneprd np-comp 2365570195 Jan 3 17:23 detsim_stage2.root
-rw-r--r--. 1 duneprd np-comp 2252566467 Jan 3 17:22 detsim_stage1.root
-rw-r--r--. 1 duneprd np-comp 2046087544 Jan 3 18:20 reco_stage1.root
-rw-r--r--. 1 duneprd np-comp 1757129953 Jan 3 15:20 g4_stage2.root
-rw-r--r--. 1 duneprd np-comp 1669017627 Jan 3 15:00 g4_stage1.root
-rw-r--r--. 1 duneprd np-comp 74101740 Jan 3 18:15 Pandora_Events.pndr
-rw-r--r--. 1 duneprd np-comp 243351 Jan 3 18:21 jobscript.log
-rw-r--r--. 1 duneprd np-comp 217088 Jan 3 18:20 mem.db
-rw-r--r--. 1 duneprd np-comp 62376 Jan 3 18:20 Pandora_Geometry.xml
-rw-r--r--. 1 duneprd np-comp 36864 Jan 3 18:20 time.db
-rw-r--r--. 1 duneprd np-comp 519 Jan 3 17:23 detsim_single_protoDUNE_hist.root
-rw-r--r--. 1 duneprd np-comp 519 Jan 3 15:20 g4_protoDUNE_hist.root
-rw-r--r--. 1 duneprd np-comp 519 Jan 3 18:20 protoDUNE_reco1_hist.root
-rw-r--r--. 1 duneprd np-comp 52 Jan 3 14:52 all-input-dids.txt
-rw-r--r--. 1 duneprd np-comp 7 Jan 3 18:21 justin-processed-pfns.txt
-rw-r--r--. 1 duneprd np-comp 0 Jan 3 17:31 ProtoDUNE.log
-rw-r--r--. 1 duneprd np-comp 0 Jan 3 17:24 debugprod.log
