Jobsub ID 250016.1@dunegpschedd02.fnal.gov
| Jobsub ID | 250016.1@dunegpschedd02.fnal.gov |
| Workflow ID | 10540 |
| 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-11-23 12:38:51 |
| Site | CERN |
| Entry | CMSHTPC_T2_CH_CERN_ce508 |
| Last heartbeat | 2025-11-23 15:49:49 |
| From worker node | Hostname | b9p06p0505.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-11-23 12:39:37 |
| Input files | monte-carlo-010540-000001
|
| Jobscript | Exit code | 0 |
| Real time | 3h (10883s) |
| CPU time | 2h (10266s = 94%) |
| Max RSS bytes | 3964211200 (3780 MiB) |
| Outputting started | 2025-11-23 15:41:01 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/10540/1/001/reco_stage1.root
|
| Finished | 2025-11-23 15:49:47 |
| Saved logs | justin-logs:250016.1-dunegpschedd02.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
Service: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 98803 traces, 0 summary
Retagger: tagging trace set: gauss with 76286 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 76286 traces tagged "gauss"
FrameSaver: q=2.55158e+06 n=1320563 tag=gauss
wclsFrameSaver: saving 98803 traces tagged "wiener"
FrameSaver: q=2.70207e+06 n=1172320 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 16961 XUs and 13570 XVs -> 65 XUVs
C:0 T:1 32685 XUs and 25708 XVs -> 1410 XUVs
C:0 T:2 32808 XUs and 34352 XVs -> 1545 XUVs
C:0 T:3 18735 XUs and 16839 XVs -> 158 XUVs
C:0 T:4 13556 XUs and 10371 XVs -> 86 XUVs
C:0 T:5 58080 XUs and 36599 XVs -> 7528 XUVs
C:0 T:6 50392 XUs and 67981 XVs -> 2019 XUVs
C:0 T:7 22296 XUs and 29216 XVs -> 246 XUVs
C:0 T:8 9616 XUs and 7867 XVs -> 122 XUVs
C:0 T:9 136135 XUs and 101212 XVs -> 28942 XUVs
C:0 T:10 27191 XUs and 21582 XVs -> 2451 XUVs
C:0 T:11 930 XUs and 789 XVs -> 92 XUVs
44664 XUVs total
8047 collection wire objects
42457 potential space points
Neighbour search...
12825793 tests to find 4928200 neighbours
Iterating with no regularization...
Begin: 4.9693e+07
0 4.33538e+07
1 4.29226e+07
2 4.28703e+07
3 4.28574e+07
Now with regularization...
Begin: 3.64104e+07
0 3.63945e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 410690239
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 410690239
fLifetime: 30000 [us]
23-Nov-2025 16:40:58 CET Closed output file "reco_stage1.root"
23-Nov-2025 16:40:58 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 206.575 287.463 352.476 275.372 42.5744 10
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00117548 0.00354963 0.00657007 0.00361773 0.00168229 10
reco:ophit:OpHitFinder 0.218865 0.289486 0.324751 0.289267 0.031832 10
reco:opflash:OpFlashFinder 0.125114 0.14738 0.183695 0.146801 0.0190523 10
reco:opslicer:OpSlicer 0.481826 0.672334 0.917998 0.684942 0.125661 10
reco:caldata:DataPrepModule 4.4208 5.75281 7.10991 5.73869 0.911961 10
reco:wclsdatasp:WireCellToolkit 28.6248 34.7887 38.8764 35.2945 3.41772 10
reco:gaushit:GausHitFinder 0.573493 1.05017 1.39851 1.07656 0.205168 10
reco:nhitsfilter:NumberOfHitsFilter 0.000243652 0.000494587 0.000684725 0.000488684 0.000110118 10
reco:reco3d:SpacePointSolver 5.05493 12.1338 18.7179 12.3555 3.85787 10
reco:hitpdune:DisambigFromSpacePoints 0.584159 1.26303 1.83901 1.27576 0.325847 10
reco:pandora:StandardPandora 9.2219 20.9792 31.3367 21.2896 6.72744 10
reco:pandoraWriter:StandardPandora 0.201057 0.402707 0.530391 0.41261 0.0959829 10
reco:pandoraTrack:LArPandoraTrackCreation 1.40357 2.88017 4.67476 2.57055 1.00632 10
reco:pandoraShower:LArPandoraShowerCreation 0.975608 2.46831 4.05764 2.20356 0.883121 10
reco:pandoracalo:Calorimetry 1.26253 1.80339 2.97242 1.48187 0.598162 10
reco:pandoracalonosce:Calorimetry 1.0523 1.61533 2.63113 1.27209 0.583349 10
reco:pandorapid:Chi2ParticleID 0.00418687 0.00594374 0.00782721 0.0055133 0.00117978 10
reco:pandoracalinoxyzt:CalibrationdEdXPDSP 0.03744 0.0562776 0.0711554 0.0564653 0.00982105 10
reco:pandoracalipidnoxyzt:Chi2ParticleID 0.0037307 0.00591719 0.00803095 0.00569443 0.00121282 10
reco:pandoraShowercalo:ShowerCalorimetry 1.50547 2.7315 4.51566 2.23397 1.02126 10
reco:pandoraShowercalonosce:ShowerCalorimetry 1.46909 2.55727 4.31752 2.24668 0.899542 10
reco:emtrkmichelid:EmTrackMichelId 132.27 166.665 199.381 166.002 18.6454 10
reco:crttag:SingleCRTMatchingProducer 0.0100639 0.0131197 0.0169173 0.0124475 0.00207813 10
reco:crtreco:TwoCRTMatchingProducer 0.00644897 0.00830444 0.0102495 0.00839619 0.00108149 10
reco:anodepiercerst0:T0RecoAnodePiercers 0.47895 0.786302 1.00956 0.815805 0.168333 10
reco:pandora2Track:LArPandoraTrackCreation 5.00645 8.32792 14.0921 7.12691 2.79234 10
reco:pandora2calo:Calorimetry 2.16373 4.14325 6.9277 3.74682 1.57767 10
reco:pandora2calonosce:Calorimetry 1.94244 3.79822 6.44591 3.68886 1.41059 10
reco:pandora2pid:Chi2ParticleID 0.0065204 0.0120444 0.0195326 0.0120791 0.00383898 10
reco:pandora2calinoxyzt:CalibrationdEdXPDSP 0.035911 0.0626166 0.0976032 0.0653763 0.0182947 10
reco:pandora2calipidnoxyzt:Chi2ParticleID 0.00691275 0.0127129 0.0171628 0.0126716 0.00317753 10
reco:pandora2Shower:LArPandoraShowerCreation 1.46048 3.00202 4.92809 2.63308 1.01414 10
reco:pandora2Showercalo:ShowerCalorimetry 1.68993 3.5908 5.7761 3.18348 1.34718 10
reco:pandora2Showercalonosce:ShowerCalorimetry 1.475 3.05561 5.69594 2.63172 1.20373 10
[art]:TriggerResults:TriggerResultInserter 4.115e-05 6.96794e-05 0.000161401 6.05905e-05 3.35275e-05 10
end_path:out1:RootOutput 8.88e-06 1.2617e-05 1.838e-05 1.1895e-05 3.04168e-06 10
end_path:out1:RootOutput(write) 1.52355 2.28141 2.6302 2.41291 0.365031 10
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4789.06 MB
Peak resident set size usage (VmHWM): 3964.21 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.08 sec/event
ToolBasedRawDigitPrepService:dtor: adcSampleFiller: 0.27 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleAdcToKe: 0.04 sec/event
ToolBasedRawDigitPrepService:dtor: pdspTailPedRemovalZKe: 3.50 sec/event
ToolBasedRawDigitPrepService:dtor: adcKeepAllSignalFinder: 0.15 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 8946380
-rw-r--r--. 1 duneprd np-comp 2144831832 Nov 23 15:50 detsim_stage2.root
-rw-r--r--. 1 duneprd np-comp 2038632963 Nov 23 15:48 detsim_stage1.root
-rw-r--r--. 1 duneprd np-comp 1774886957 Nov 23 16:40 reco_stage1.root
-rw-r--r--. 1 duneprd np-comp 1606185910 Nov 23 13:57 g4_stage2.root
-rw-r--r--. 1 duneprd np-comp 1534722452 Nov 23 13:47 g4_stage1.root
-rw-r--r--. 1 duneprd np-comp 61212710 Nov 23 16:37 Pandora_Events.pndr
-rw-r--r--. 1 duneprd np-comp 242649 Nov 23 16:41 jobscript.log
-rw-r--r--. 1 duneprd np-comp 217088 Nov 23 16:40 mem.db
-rw-r--r--. 1 duneprd np-comp 62376 Nov 23 16:40 Pandora_Geometry.xml
-rw-r--r--. 1 duneprd np-comp 36864 Nov 23 16:40 time.db
-rw-r--r--. 1 duneprd np-comp 519 Nov 23 15:50 detsim_single_protoDUNE_hist.root
-rw-r--r--. 1 duneprd np-comp 519 Nov 23 13:57 g4_protoDUNE_hist.root
-rw-r--r--. 1 duneprd np-comp 519 Nov 23 16:40 protoDUNE_reco1_hist.root
-rw-r--r--. 1 duneprd np-comp 52 Nov 23 13:39 all-input-dids.txt
-rw-r--r--. 1 duneprd np-comp 7 Nov 23 16:41 justin-processed-pfns.txt
-rw-r--r--. 1 duneprd np-comp 0 Nov 23 15:56 ProtoDUNE.log
-rw-r--r--. 1 duneprd np-comp 0 Nov 23 15:50 debugprod.log
