Jobsub ID 270994.0@dunegpschedd01.fnal.gov
| Jobsub ID | 270994.0@dunegpschedd01.fnal.gov |
| Workflow ID | 11431 |
| 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 | 2025-12-30 21:37:07 |
| Site | CERN |
| Entry | CMSHTPC_T2_CH_CERN_ce504 |
| Last heartbeat | 2025-12-31 01:38:39 |
| From worker node | Hostname | b9p12p6573.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 | 2025-12-30 21:37:50 |
| Input files | monte-carlo-011431-000001
|
| Jobscript | Exit code | 0 |
| Real time | 3h (14361s) |
| CPU time | 3h (13483s = 93%) |
| Max RSS bytes | 4198350848 (4003 MiB) |
| Outputting started | 2025-12-31 01:37:12 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11431/1/001/reco_stage1.root
|
| Finished | 2025-12-31 01:38:39 |
| Saved logs | justin-logs:270994.0-dunegpschedd01.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
gitPrepService: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 107882 traces, 0 summary
Retagger: tagging trace set: gauss with 84465 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 84465 traces tagged "gauss"
FrameSaver: q=2.88254e+06 n=1499897 tag=gauss
wclsFrameSaver: saving 107882 traces tagged "wiener"
FrameSaver: q=3.03978e+06 n=1335776 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 41546 XUs and 35740 XVs -> 508 XUVs
C:0 T:1 78945 XUs and 77331 XVs -> 6293 XUVs
C:0 T:2 79740 XUs and 83614 XVs -> 4852 XUVs
C:0 T:3 35696 XUs and 34601 XVs -> 239 XUVs
C:0 T:4 11283 XUs and 9912 XVs -> 115 XUVs
C:0 T:5 46855 XUs and 39814 XVs -> 5665 XUVs
C:0 T:6 95935 XUs and 96213 XVs -> 4360 XUVs
C:0 T:7 39920 XUs and 40083 XVs -> 308 XUVs
C:0 T:8 6967 XUs and 5708 XVs -> 57 XUVs
C:0 T:9 45938 XUs and 61345 XVs -> 4845 XUVs
C:0 T:10 5551 XUs and 2217 XVs -> 626 XUVs
C:0 T:11 33 XUs and 18 XVs -> 5 XUVs
27873 XUVs total
10040 collection wire objects
25129 potential space points
Neighbour search...
1778349 tests to find 959786 neighbours
Iterating with no regularization...
Begin: 7.4661e+07
0 6.44901e+07
1 6.36285e+07
2 6.35386e+07
3 6.35146e+07
Now with regularization...
Begin: 5.49021e+07
0 5.48892e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 411441870
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411441870
fLifetime: 30000 [us]
31-Dec-2025 02:37:09 CET Closed output file "reco_stage1.root"
31-Dec-2025 02:37:09 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 295.255 385.555 503.433 379.367 66.598 10
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00103624 0.00430354 0.00734331 0.0042677 0.00182177 10
reco:ophit:OpHitFinder 0.268093 0.348846 0.459 0.339737 0.0518855 10
reco:opflash:OpFlashFinder 0.154428 0.192855 0.284174 0.186586 0.0359917 10
reco:opslicer:OpSlicer 0.532128 0.84585 1.07643 0.830845 0.1663 10
reco:caldata:DataPrepModule 4.81153 6.42403 7.35098 6.82555 0.887558 10
reco:wclsdatasp:WireCellToolkit 31.3844 36.4719 40.1213 36.5336 2.59682 10
reco:gaushit:GausHitFinder 0.935621 1.34484 1.71442 1.34872 0.233109 10
reco:nhitsfilter:NumberOfHitsFilter 0.000472423 0.00061346 0.000844185 0.000588959 0.000109239 10
reco:reco3d:SpacePointSolver 12.2187 24.5702 50.9298 17.903 12.7976 10
reco:hitpdune:DisambigFromSpacePoints 1.38146 1.80821 3.26065 1.71444 0.515651 10
reco:pandora:StandardPandora 21.3829 39.3503 68.9841 35.6403 13.3684 10
reco:pandoraWriter:StandardPandora 0.294921 0.49252 0.587183 0.535303 0.0992156 10
reco:pandoraTrack:LArPandoraTrackCreation 2.64901 4.08642 5.59173 4.12758 0.899042 10
reco:pandoraShower:LArPandoraShowerCreation 2.76432 4.19035 6.746 3.80555 1.3097 10
reco:pandoracalo:Calorimetry 1.68011 2.48293 3.28136 2.54342 0.46651 10
reco:pandoracalonosce:Calorimetry 1.4486 2.3505 3.33456 2.30344 0.577316 10
reco:pandorapid:Chi2ParticleID 0.00421634 0.00742506 0.00944056 0.00750677 0.00146786 10
reco:pandoracalinoxyzt:CalibrationdEdXPDSP 0.0380102 0.0663155 0.0971305 0.0644474 0.0164576 10
reco:pandoracalipidnoxyzt:Chi2ParticleID 0.00365275 0.00669302 0.00865167 0.00703955 0.0013887 10
reco:pandoraShowercalo:ShowerCalorimetry 3.13674 4.99786 8.52738 4.22326 1.82748 10
reco:pandoraShowercalonosce:ShowerCalorimetry 2.75993 4.87492 8.26496 4.26619 1.79957 10
reco:emtrkmichelid:EmTrackMichelId 166.791 205.616 256.339 206.942 27.3865 10
reco:crttag:SingleCRTMatchingProducer 0.0116938 0.0163794 0.0202324 0.0159078 0.00295493 10
reco:crtreco:TwoCRTMatchingProducer 0.00820053 0.0101558 0.0129092 0.00959286 0.00163796 10
reco:anodepiercerst0:T0RecoAnodePiercers 0.691542 0.974359 1.26328 0.943707 0.160716 10
reco:pandora2Track:LArPandoraTrackCreation 7.1234 12.6324 16.9454 11.6907 3.16455 10
reco:pandora2calo:Calorimetry 3.41757 6.53477 8.45284 6.60823 1.49724 10
reco:pandora2calonosce:Calorimetry 3.65404 6.08966 8.55923 6.05375 1.49499 10
reco:pandora2pid:Chi2ParticleID 0.00847653 0.0159152 0.0245274 0.0165766 0.00449056 10
reco:pandora2calinoxyzt:CalibrationdEdXPDSP 0.0415151 0.074186 0.0950322 0.0824803 0.01911 10
reco:pandora2calipidnoxyzt:Chi2ParticleID 0.00824929 0.0143261 0.0188723 0.0152019 0.00324991 10
reco:pandora2Shower:LArPandoraShowerCreation 2.53695 4.57883 7.64421 4.56043 1.48626 10
reco:pandora2Showercalo:ShowerCalorimetry 3.32953 5.66695 8.64194 5.72199 1.69755 10
reco:pandora2Showercalonosce:ShowerCalorimetry 2.9726 5.14748 7.86246 4.71345 1.66825 10
[art]:TriggerResults:TriggerResultInserter 4.543e-05 9.29515e-05 0.000275581 6.97455e-05 6.44397e-05 10
end_path:out1:RootOutput 1.134e-05 1.6769e-05 3.772e-05 1.478e-05 7.28846e-06 10
end_path:out1:RootOutput(write) 2.16518 3.15338 4.4064 3.40319 0.678073 10
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5061.29 MB
Peak resident set size usage (VmHWM): 4198.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.10 sec/event
ToolBasedRawDigitPrepService:dtor: adcSampleFiller: 0.30 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleAdcToKe: 0.05 sec/event
ToolBasedRawDigitPrepService:dtor: pdspTailPedRemovalZKe: 3.97 sec/event
ToolBasedRawDigitPrepService:dtor: adcKeepAllSignalFinder: 0.17 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 10652768
-rw-r--r--. 1 duneprd np-comp 2480249322 Dec 31 01:30 detsim_stage2.root
-rw-r--r--. 1 duneprd np-comp 2356714595 Dec 31 01:28 detsim_stage1.root
-rw-r--r--. 1 duneprd np-comp 2174517782 Dec 31 02:37 reco_stage1.root
-rw-r--r--. 1 duneprd np-comp 1948100910 Dec 30 23:04 g4_stage2.root
-rw-r--r--. 1 duneprd np-comp 1871580054 Dec 30 22:46 g4_stage1.root
-rw-r--r--. 1 duneprd np-comp 76660340 Dec 31 02:33 Pandora_Events.pndr
-rw-r--r--. 1 duneprd np-comp 243031 Dec 31 02:37 jobscript.log
-rw-r--r--. 1 duneprd np-comp 217088 Dec 31 02:37 mem.db
-rw-r--r--. 1 duneprd np-comp 62376 Dec 31 02:37 Pandora_Geometry.xml
-rw-r--r--. 1 duneprd np-comp 36864 Dec 31 02:37 time.db
-rw-r--r--. 1 duneprd np-comp 519 Dec 31 01:30 detsim_single_protoDUNE_hist.root
-rw-r--r--. 1 duneprd np-comp 519 Dec 30 23:04 g4_protoDUNE_hist.root
-rw-r--r--. 1 duneprd np-comp 519 Dec 31 02:37 protoDUNE_reco1_hist.root
-rw-r--r--. 1 duneprd np-comp 52 Dec 30 22:37 all-input-dids.txt
-rw-r--r--. 1 duneprd np-comp 7 Dec 31 02:37 justin-processed-pfns.txt
-rw-r--r--. 1 duneprd np-comp 0 Dec 31 01:37 ProtoDUNE.log
-rw-r--r--. 1 duneprd np-comp 0 Dec 31 01:30 debugprod.log
