Jobsub ID 37367.0@dunegpschedd02.fnal.gov
| Jobsub ID | 37367.0@dunegpschedd02.fnal.gov |
| Workflow ID | 2388 |
| 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-09-10 06:34:01 |
| Site | UK_QMUL |
| Entry | DUNE_UK_London_QMUL_arcce03 |
| Last heartbeat | 2025-09-10 12:27:53 |
| From worker node | Hostname | cn545.htc.esc.qmul |
| cpuinfo | Intel(R) Xeon(R) Gold 6252 CPU @ 2.10GHz |
| 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-09-10 06:35:31 |
| Input files | monte-carlo-002388-000001
|
| Jobscript | Exit code | 0 |
| Real time | 5h (20892s) |
| CPU time | 5h (20502s = 98%) |
| Max RSS bytes | 4126154752 (3935 MiB) |
| Outputting started | 2025-09-10 12:23:44 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/02388/1/001/reco_stage1.root
|
| Finished | 2025-09-10 12:27:53 |
| Saved logs | justin-logs:37367.0-dunegpschedd02.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
nning 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 129468 traces, 0 summary
Retagger: tagging trace set: gauss with 101118 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 101118 traces tagged "gauss"
FrameSaver: q=3.50309e+06 n=1824705 tag=gauss
wclsFrameSaver: saving 129468 traces tagged "wiener"
FrameSaver: q=3.71108e+06 n=1629372 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 55417 XUs and 54430 XVs -> 999 XUVs
C:0 T:1 125681 XUs and 118671 XVs -> 7100 XUVs
C:0 T:2 78684 XUs and 66719 XVs -> 4283 XUVs
C:0 T:3 35755 XUs and 30099 XVs -> 149 XUVs
C:0 T:4 6019 XUs and 5332 XVs -> 43 XUVs
C:0 T:5 46722 XUs and 23818 XVs -> 4265 XUVs
C:0 T:6 113815 XUs and 135400 XVs -> 6483 XUVs
C:0 T:7 40905 XUs and 47988 XVs -> 486 XUVs
C:0 T:8 8894 XUs and 8656 XVs -> 88 XUVs
C:0 T:9 62990 XUs and 66625 XVs -> 6399 XUVs
C:0 T:10 39190 XUs and 27006 XVs -> 5470 XUVs
C:0 T:11 634 XUs and 397 XVs -> 69 XUVs
35834 XUVs total
12509 collection wire objects
32347 potential space points
Neighbour search...
2619627 tests to find 1317722 neighbours
Iterating with no regularization...
Begin: 7.69162e+07
0 6.59946e+07
1 6.52048e+07
2 6.50773e+07
3 6.50365e+07
Now with regularization...
Begin: 5.48079e+07
0 5.47764e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 409196537
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 409196537
fLifetime: 30000 [us]
10-Sep-2025 13:23:41 BST Closed output file "reco_stage1.root"
10-Sep-2025 13:23:41 BST 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 545.882 836.243 1234.75 830.602 184.382 10
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00130297 0.00466469 0.0089697 0.00417803 0.00223775 10
reco:ophit:OpHitFinder 0.262924 0.494717 0.615701 0.532391 0.115455 10
reco:opflash:OpFlashFinder 0.166385 0.306979 0.37178 0.317017 0.0561166 10
reco:opslicer:OpSlicer 0.620106 1.22359 1.47525 1.37418 0.278404 10
reco:caldata:DataPrepModule 6.62139 11.2571 12.8268 12.2175 2.14483 10
reco:wclsdatasp:WireCellToolkit 54.8437 76.0677 96.5596 78.2023 15.6153 10
reco:gaushit:GausHitFinder 1.24838 2.35141 3.50615 2.24251 0.744306 10
reco:nhitsfilter:NumberOfHitsFilter 0.000779231 0.00104298 0.00135822 0.00104111 0.000205299 10
reco:reco3d:SpacePointSolver 8.03505 33.8632 54.0606 37.7594 15.4805 10
reco:hitpdune:DisambigFromSpacePoints 1.44272 4.43925 8.41264 4.29382 1.92966 10
reco:pandora:StandardPandora 24.923 83.3878 168.745 78.6035 39.7078 10
reco:pandoraWriter:StandardPandora 0.452124 0.918866 1.16914 0.943162 0.221381 10
reco:pandoraTrack:LArPandoraTrackCreation 6.18401 15.7311 22.9567 16.1667 4.93442 10
reco:pandoraShower:LArPandoraShowerCreation 6.80413 19.2311 34.529 18.55 7.95466 10
reco:pandoracalo:Calorimetry 3.54438 7.89168 11.7597 8.16764 2.45404 10
reco:pandoracalonosce:Calorimetry 4.17764 7.40163 10.9123 7.23799 2.26612 10
reco:pandorapid:Chi2ParticleID 0.00684912 0.0126399 0.0168845 0.013002 0.00265174 10
reco:pandoracalinoxyzt:CalibrationdEdXPDSP 0.0743892 0.133883 0.180862 0.129866 0.0339699 10
reco:pandoracalipidnoxyzt:Chi2ParticleID 0.00636757 0.0114481 0.0152734 0.0121409 0.00255269 10
reco:pandoraShowercalo:ShowerCalorimetry 8.85589 20.0754 35.4174 19.096 8.88822 10
reco:pandoraShowercalonosce:ShowerCalorimetry 8.88506 19.122 34.4564 16.4139 8.7028 10
reco:emtrkmichelid:EmTrackMichelId 275.173 359.883 523.13 354.588 65.627 10
reco:crttag:SingleCRTMatchingProducer 0.0305349 0.0456105 0.0723789 0.0421729 0.0124011 10
reco:crtreco:TwoCRTMatchingProducer 0.0267103 0.0383272 0.0571057 0.0342842 0.00897894 10
reco:anodepiercerst0:T0RecoAnodePiercers 1.47099 2.31349 4.12924 2.04619 0.786386 10
reco:pandora2Track:LArPandoraTrackCreation 30.3955 55.2807 99.6828 46.496 22.0419 10
reco:pandora2calo:Calorimetry 12.9026 23.6931 42.2537 20.2217 9.37854 10
reco:pandora2calonosce:Calorimetry 12.4172 23.2426 41.4481 20.8307 9.06498 10
reco:pandora2pid:Chi2ParticleID 0.0206824 0.0307462 0.0445692 0.0293274 0.0075661 10
reco:pandora2calinoxyzt:CalibrationdEdXPDSP 0.110006 0.161332 0.205743 0.163017 0.0284576 10
reco:pandora2calipidnoxyzt:Chi2ParticleID 0.0200929 0.0283492 0.0364659 0.0290915 0.00562106 10
reco:pandora2Shower:LArPandoraShowerCreation 11.099 18.5247 27.6947 18.4987 5.39451 10
reco:pandora2Showercalo:ShowerCalorimetry 11.6503 22.6602 38.5125 23.1716 8.51688 10
reco:pandora2Showercalonosce:ShowerCalorimetry 10.1144 20.9562 35.8254 21.5214 8.02884 10
[art]:TriggerResults:TriggerResultInserter 6.8383e-05 0.000132269 0.000267626 0.00013037 5.24546e-05 10
end_path:out1:RootOutput 9.294e-06 1.57327e-05 2.6724e-05 1.43045e-05 4.89418e-06 10
end_path:out1:RootOutput(write) 2.80024 5.21992 6.5671 5.01779 1.08914 10
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4926.32 MB
Peak resident set size usage (VmHWM): 4126.15 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.13 sec/event
ToolBasedRawDigitPrepService:dtor: adcSampleFiller: 0.43 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleAdcToKe: 0.08 sec/event
ToolBasedRawDigitPrepService:dtor: pdspTailPedRemovalZKe: 7.22 sec/event
ToolBasedRawDigitPrepService:dtor: adcKeepAllSignalFinder: 0.39 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleKeToAdc: 0.08 sec/event
ToolBasedRawDigitPrepService:dtor: pdsp_RemoveBadChannels: 0.01 sec/event
Art has completed and will exit with status 0.
lar exit code 0
.:
total 9876856
-rw-r--r-- 1 pildune32 pildune 2329057811 Sep 10 11:00 detsim_stage2.root
-rw-r--r-- 1 pildune32 pildune 2212200617 Sep 10 10:57 detsim_stage1.root
-rw-r--r-- 1 pildune32 pildune 2016598410 Sep 10 13:23 reco_stage1.root
-rw-r--r-- 1 pildune32 pildune 1776515821 Sep 10 08:14 g4_stage2.root
-rw-r--r-- 1 pildune32 pildune 1704167700 Sep 10 07:46 g4_stage1.root
-rw-r--r-- 1 pildune32 pildune 74746670 Sep 10 13:14 Pandora_Events.pndr
-rw-r--r-- 1 pildune32 pildune 242687 Sep 10 13:23 jobscript.log
-rw-r--r-- 1 pildune32 pildune 217088 Sep 10 13:23 mem.db
-rw-r--r-- 1 pildune32 pildune 62376 Sep 10 13:23 Pandora_Geometry.xml
-rw-r--r-- 1 pildune32 pildune 36864 Sep 10 13:23 time.db
-rw-r--r-- 1 pildune32 pildune 519 Sep 10 11:00 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 pildune32 pildune 519 Sep 10 08:14 g4_protoDUNE_hist.root
-rw-r--r-- 1 pildune32 pildune 519 Sep 10 13:23 protoDUNE_reco1_hist.root
-rw-r--r-- 1 pildune32 pildune 52 Sep 10 07:35 all-input-dids.txt
-rw-r--r-- 1 pildune32 pildune 7 Sep 10 13:23 justin-processed-pfns.txt
-rw-r--r-- 1 pildune32 pildune 0 Sep 10 11:11 ProtoDUNE.log
-rw-r--r-- 1 pildune32 pildune 0 Sep 10 11:00 debugprod.log
