Jobsub ID 270479.1@dunegpschedd01.fnal.gov
| Jobsub ID | 270479.1@dunegpschedd01.fnal.gov |
| Workflow ID | 11373 |
| 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-28 08:47:46 |
| Site | IT_CNAF |
| Entry | CMSHTPC_T1_IT_CNAF_condor_ce02 |
| Last heartbeat | 2025-12-28 11:23:13 |
| From worker node | Hostname | wn-s04-05-09-02.cr.cnaf.infn.it |
| cpuinfo | AMD EPYC 7313 16-Core Processor |
| OS release | Scientific Linux release 7.9 (Nitrogen) |
| Processors | 1 |
| RSS bytes | 10485760000 (10000 MiB) |
| Wall seconds limit | 257400 (71 hours) |
| GPU | |
| Inner Apptainer? | True |
| Job state | finished |
| Started | 2025-12-28 08:48:35 |
| Input files | monte-carlo-011373-000001
|
| Jobscript | Exit code | 0 |
| Real time | 2h (8960s) |
| CPU time | 2h (8565s = 95%) |
| Max RSS bytes | 4405272576 (4201 MiB) |
| Outputting started | 2025-12-28 11:17:56 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11373/1/001/reco_stage1.root
|
| Finished | 2025-12-28 11:23:13 |
| Saved logs | justin-logs:270479.1-dunegpschedd01.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
Event: 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 146014 traces, 0 summary
Retagger: tagging trace set: gauss with 114570 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 114570 traces tagged "gauss"
FrameSaver: q=3.85706e+06 n=2084313 tag=gauss
wclsFrameSaver: saving 146014 traces tagged "wiener"
FrameSaver: q=4.0532e+06 n=1866077 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 23292 XUs and 20975 XVs -> 250 XUVs
C:0 T:1 40747 XUs and 38724 XVs -> 2842 XUVs
C:0 T:2 108998 XUs and 96958 XVs -> 5387 XUVs
C:0 T:3 44199 XUs and 40215 XVs -> 319 XUVs
C:0 T:4 16537 XUs and 16639 XVs -> 162 XUVs
C:0 T:5 49935 XUs and 43516 XVs -> 3206 XUVs
C:0 T:6 115892 XUs and 128789 XVs -> 5866 XUVs
C:0 T:7 47631 XUs and 50759 XVs -> 514 XUVs
C:0 T:8 12229 XUs and 13359 XVs -> 156 XUVs
C:0 T:9 77812 XUs and 101838 XVs -> 6209 XUVs
C:0 T:10 53654 XUs and 45965 XVs -> 4452 XUVs
C:0 T:11 294 XUs and 287 XVs -> 30 XUVs
29393 XUVs total
12559 collection wire objects
26844 potential space points
Neighbour search...
1249612 tests to find 676490 neighbours
Iterating with no regularization...
Begin: 8.44204e+07
0 7.46514e+07
1 7.40139e+07
2 7.39308e+07
3 7.39088e+07
Now with regularization...
Begin: 6.31173e+07
0 6.30981e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
run: 1 ; subrun: 0 ; event: 10
evttime: 411391125
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411391125
fLifetime: 30000 [us]
28-Dec-2025 12:17:55 CET Closed output file "reco_stage1.root"
28-Dec-2025 12:17:55 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 163.649 238.436 303.229 249.771 49.1368 10
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000729662 0.00345147 0.00525077 0.0037336 0.0013533 10
reco:ophit:OpHitFinder 0.199744 0.229288 0.283791 0.228035 0.0237386 10
reco:opflash:OpFlashFinder 0.123762 0.173657 0.237007 0.163567 0.0345962 10
reco:opslicer:OpSlicer 0.375243 0.490052 0.608317 0.505024 0.0684975 10
reco:caldata:DataPrepModule 3.46942 3.60183 3.79633 3.59678 0.0955494 10
reco:wclsdatasp:WireCellToolkit 23.5021 25.267 28.649 25.0113 1.62084 10
reco:gaushit:GausHitFinder 0.536812 0.787529 0.940389 0.811836 0.141226 10
reco:nhitsfilter:NumberOfHitsFilter 0.000261762 0.000449983 0.000715887 0.000392293 0.00015644 10
reco:reco3d:SpacePointSolver 5.31301 13.5613 33.799 12.4697 7.527 10
reco:hitpdune:DisambigFromSpacePoints 0.581855 1.15273 1.53577 1.26551 0.345421 10
reco:pandora:StandardPandora 11.3872 22.7575 33.024 23.8484 7.56971 10
reco:pandoraWriter:StandardPandora 0.197406 0.289854 0.35015 0.312766 0.0577106 10
reco:pandoraTrack:LArPandoraTrackCreation 1.44925 2.5909 3.5862 2.58174 0.672878 10
reco:pandoraShower:LArPandoraShowerCreation 1.18014 2.66995 4.13377 2.81658 0.958637 10
reco:pandoracalo:Calorimetry 0.811871 1.49073 2.09934 1.5477 0.413315 10
reco:pandoracalonosce:Calorimetry 0.732269 1.37567 1.94325 1.45461 0.389712 10
reco:pandorapid:Chi2ParticleID 0.00295683 0.0039226 0.0064062 0.00364616 0.000898993 10
reco:pandoracalinoxyzt:CalibrationdEdXPDSP 0.0247746 0.0353537 0.0489911 0.0349305 0.00702555 10
reco:pandoracalipidnoxyzt:Chi2ParticleID 0.00273804 0.00358008 0.00415455 0.00352375 0.000446444 10
reco:pandoraShowercalo:ShowerCalorimetry 1.20341 2.94107 4.7527 3.21811 1.15565 10
reco:pandoraShowercalonosce:ShowerCalorimetry 1.14547 2.88434 4.77332 3.14536 1.15459 10
reco:emtrkmichelid:EmTrackMichelId 93.0968 126.715 156.822 133.516 22.4932 10
reco:crttag:SingleCRTMatchingProducer 0.00537381 0.0097109 0.0162716 0.00894575 0.00308707 10
reco:crtreco:TwoCRTMatchingProducer 0.00375845 0.00590338 0.00892526 0.00623721 0.00154941 10
reco:anodepiercerst0:T0RecoAnodePiercers 0.438748 0.621607 0.782462 0.651928 0.124113 10
reco:pandora2Track:LArPandoraTrackCreation 3.89407 8.068 11.7701 8.79585 2.71692 10
reco:pandora2calo:Calorimetry 1.94075 4.32341 6.457 4.86968 1.52524 10
reco:pandora2calonosce:Calorimetry 1.79836 4.12688 6.18371 4.57202 1.49627 10
reco:pandora2pid:Chi2ParticleID 0.0059493 0.00864408 0.0115157 0.008518 0.0016622 10
reco:pandora2calinoxyzt:CalibrationdEdXPDSP 0.0302865 0.0438629 0.0580462 0.0452386 0.00894419 10
reco:pandora2calipidnoxyzt:Chi2ParticleID 0.0058178 0.00831447 0.010305 0.00847837 0.00145475 10
reco:pandora2Shower:LArPandoraShowerCreation 1.44934 2.92644 4.12733 3.05947 0.902289 10
reco:pandora2Showercalo:ShowerCalorimetry 1.64158 3.70368 5.42429 4.01341 1.29953 10
reco:pandora2Showercalonosce:ShowerCalorimetry 1.53363 3.39562 4.94988 3.65893 1.16954 10
[art]:TriggerResults:TriggerResultInserter 3.1279e-05 5.33594e-05 0.000152347 4.16985e-05 3.40815e-05 10
end_path:out1:RootOutput 8.126e-06 1.10228e-05 1.7773e-05 9.082e-06 3.35943e-06 10
end_path:out1:RootOutput(write) 1.4347 2.08938 2.7153 2.13312 0.408955 10
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5209.91 MB
Peak resident set size usage (VmHWM): 4405.27 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.05 sec/event
ToolBasedRawDigitPrepService:dtor: adcSampleFiller: 0.15 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleAdcToKe: 0.03 sec/event
ToolBasedRawDigitPrepService:dtor: pdspTailPedRemovalZKe: 2.20 sec/event
ToolBasedRawDigitPrepService:dtor: adcKeepAllSignalFinder: 0.08 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleKeToAdc: 0.03 sec/event
ToolBasedRawDigitPrepService:dtor: pdsp_RemoveBadChannels: 0.00 sec/event
Art has completed and will exit with status 0.
lar exit code 0
.:
total 10898176
-rw-r--r-- 1 neutrino002 neutrino 2522482613 Dec 28 11:37 detsim_stage2.root
-rw-r--r-- 1 neutrino002 neutrino 2387602065 Dec 28 11:35 detsim_stage1.root
-rw-r--r-- 1 neutrino002 neutrino 2232463584 Dec 28 12:17 reco_stage1.root
-rw-r--r-- 1 neutrino002 neutrino 2006890927 Dec 28 10:05 g4_stage2.root
-rw-r--r-- 1 neutrino002 neutrino 1929478412 Dec 28 09:56 g4_stage1.root
-rw-r--r-- 1 neutrino002 neutrino 80182430 Dec 28 12:14 Pandora_Events.pndr
-rw-r--r-- 1 neutrino002 neutrino 242923 Dec 28 12:17 jobscript.log
-rw-r--r-- 1 neutrino002 neutrino 217088 Dec 28 12:17 mem.db
-rw-r--r-- 1 neutrino002 neutrino 62376 Dec 28 12:17 Pandora_Geometry.xml
-rw-r--r-- 1 neutrino002 neutrino 36864 Dec 28 12:17 time.db
-rw-r--r-- 1 neutrino002 neutrino 519 Dec 28 11:37 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 neutrino002 neutrino 519 Dec 28 10:05 g4_protoDUNE_hist.root
-rw-r--r-- 1 neutrino002 neutrino 519 Dec 28 12:17 protoDUNE_reco1_hist.root
-rw-r--r-- 1 neutrino002 neutrino 52 Dec 28 09:48 all-input-dids.txt
-rw-r--r-- 1 neutrino002 neutrino 7 Dec 28 12:17 justin-processed-pfns.txt
-rw-r--r-- 1 neutrino002 neutrino 0 Dec 28 11:41 ProtoDUNE.log
-rw-r--r-- 1 neutrino002 neutrino 0 Dec 28 11:37 debugprod.log