Jobsub ID 270841.0@dunegpschedd01.fnal.gov
| Jobsub ID | 270841.0@dunegpschedd01.fnal.gov |
| Workflow ID | 11406 |
| 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-29 21:07:46 |
| Site | IT_CNAF |
| Entry | CMSHTPC_T1_IT_CNAF_condor_ce02 |
| Last heartbeat | 2025-12-29 23:34:31 |
| From worker node | Hostname | wn-s04-05-07-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-29 21:08:29 |
| Input files | monte-carlo-011406-000001
|
| Jobscript | Exit code | 0 |
| Real time | 2h (8455s) |
| CPU time | 2h (8061s = 95%) |
| Max RSS bytes | 4135100416 (3943 MiB) |
| Outputting started | 2025-12-29 23:29:24 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11406/1/001/reco_stage1.root
|
| Finished | 2025-12-29 23:34:31 |
| Saved logs | justin-logs:270841.0-dunegpschedd01.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
cks=6000 keeping as is
Retagger: tagging trace set: wiener with 99832 traces, 0 summary
Retagger: tagging trace set: gauss with 70684 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 70684 traces tagged "gauss"
FrameSaver: q=2.39363e+06 n=1142434 tag=gauss
wclsFrameSaver: saving 99832 traces tagged "wiener"
FrameSaver: q=2.57412e+06 n=986263 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 20011 XUs and 19670 XVs -> 141 XUVs
C:0 T:1 38508 XUs and 56617 XVs -> 3883 XUVs
C:0 T:2 64567 XUs and 77606 XVs -> 3283 XUVs
C:0 T:3 32690 XUs and 35130 XVs -> 281 XUVs
C:0 T:4 10018 XUs and 13402 XVs -> 379 XUVs
C:0 T:5 47205 XUs and 37424 XVs -> 6145 XUVs
C:0 T:6 56489 XUs and 74109 XVs -> 5598 XUVs
C:0 T:7 23236 XUs and 27881 XVs -> 395 XUVs
C:0 T:8 3470 XUs and 6038 XVs -> 223 XUVs
C:0 T:9 31375 XUs and 45384 XVs -> 5004 XUVs
C:0 T:10 15642 XUs and 10871 XVs -> 1619 XUVs
C:0 T:11 33 XUs and 17 XVs -> 5 XUVs
26956 XUVs total
7851 collection wire objects
24627 potential space points
Neighbour search...
2109807 tests to find 1117380 neighbours
Iterating with no regularization...
Begin: 5.08608e+07
0 4.02254e+07
1 3.94392e+07
2 3.93156e+07
3 3.92717e+07
4 3.92503e+07
Now with regularization...
Begin: 3.16155e+07
0 3.1577e+07
1 3.15579e+07
TestBeamParticleCreationAlgorithm::SetupTestBeamVertex - Test beam particle has no initial vertex
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
run: 1 ; subrun: 0 ; event: 10
evttime: 411421552
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411421552
fLifetime: 30000 [us]
30-Dec-2025 00:29:23 CET Closed output file "reco_stage1.root"
30-Dec-2025 00:29:23 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 181.771 251.363 317.346 255.031 39.3583 10
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000916982 0.00381909 0.00765043 0.00378941 0.0019194 10
reco:ophit:OpHitFinder 0.180263 0.26617 0.330378 0.271531 0.0390243 10
reco:opflash:OpFlashFinder 0.0896961 0.134238 0.173974 0.13321 0.0273586 10
reco:opslicer:OpSlicer 0.468341 0.632018 0.868521 0.592294 0.135973 10
reco:caldata:DataPrepModule 3.91412 5.11483 6 5.1944 0.675241 10
reco:wclsdatasp:WireCellToolkit 28.4094 31.4455 34.6257 31.9283 2.20625 10
reco:gaushit:GausHitFinder 0.684736 0.985731 1.29387 0.9559 0.216016 10
reco:nhitsfilter:NumberOfHitsFilter 0.000363733 0.000459107 0.000567326 0.000460286 7.32357e-05 10
reco:reco3d:SpacePointSolver 5.6173 14.398 27.2412 13.0382 6.03639 10
reco:hitpdune:DisambigFromSpacePoints 0.778663 1.26838 1.69741 1.23931 0.334274 10
reco:pandora:StandardPandora 12.724 21.8509 41.8237 21.8931 8.22789 10
reco:pandoraWriter:StandardPandora 0.205913 0.350583 0.482583 0.339363 0.0823923 10
reco:pandoraTrack:LArPandoraTrackCreation 1.39141 2.48536 3.41336 2.45934 0.762223 10
reco:pandoraShower:LArPandoraShowerCreation 1.2603 2.45974 4.0684 2.32292 0.938118 10
reco:pandoracalo:Calorimetry 0.738676 1.43756 2.04098 1.50916 0.493297 10
reco:pandoracalonosce:Calorimetry 0.594164 1.29443 1.93736 1.33521 0.462178 10
reco:pandorapid:Chi2ParticleID 0.00252208 0.00411563 0.00642072 0.00389459 0.00141078 10
reco:pandoracalinoxyzt:CalibrationdEdXPDSP 0.0226431 0.0428367 0.0594798 0.0502923 0.0144249 10
reco:pandoracalipidnoxyzt:Chi2ParticleID 0.00248902 0.00435485 0.00634758 0.00498874 0.00143622 10
reco:pandoraShowercalo:ShowerCalorimetry 1.28486 2.63664 4.2418 2.65932 1.06375 10
reco:pandoraShowercalonosce:ShowerCalorimetry 1.19503 2.50055 3.94319 2.44903 1.04748 10
reco:emtrkmichelid:EmTrackMichelId 96.5092 134.435 173.776 128.579 21.6129 10
reco:crttag:SingleCRTMatchingProducer 0.00569233 0.0108929 0.0173124 0.00924821 0.00386757 10
reco:crtreco:TwoCRTMatchingProducer 0.00355182 0.00669556 0.0121904 0.00605711 0.0023814 10
reco:anodepiercerst0:T0RecoAnodePiercers 0.500067 0.701957 0.962808 0.654105 0.163529 10
reco:pandora2Track:LArPandoraTrackCreation 3.26838 7.30996 12.6798 6.78176 2.79599 10
reco:pandora2calo:Calorimetry 1.76617 3.79737 6.79446 3.91846 1.39686 10
reco:pandora2calonosce:Calorimetry 1.63601 3.64979 6.09631 3.79247 1.43573 10
reco:pandora2pid:Chi2ParticleID 0.00537064 0.00987748 0.0166374 0.00902512 0.00404958 10
reco:pandora2calinoxyzt:CalibrationdEdXPDSP 0.0269426 0.0475289 0.0897423 0.0407444 0.0198752 10
reco:pandora2calipidnoxyzt:Chi2ParticleID 0.00563109 0.00974739 0.0165483 0.00851059 0.0038149 10
reco:pandora2Shower:LArPandoraShowerCreation 1.46676 2.88878 4.7649 2.86103 1.01771 10
reco:pandora2Showercalo:ShowerCalorimetry 1.70417 3.48501 5.43143 3.58298 1.20867 10
reco:pandora2Showercalonosce:ShowerCalorimetry 1.69583 3.25672 5.36515 3.24039 1.11566 10
[art]:TriggerResults:TriggerResultInserter 3.2401e-05 7.20574e-05 0.000197751 5.60855e-05 5.00669e-05 10
end_path:out1:RootOutput 8.486e-06 3.58474e-05 0.000240833 9.568e-06 6.86684e-05 10
end_path:out1:RootOutput(write) 1.65936 2.35295 3.47633 2.26005 0.523826 10
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4947.14 MB
Peak resident set size usage (VmHWM): 4135.1 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.07 sec/event
ToolBasedRawDigitPrepService:dtor: adcSampleFiller: 0.24 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleAdcToKe: 0.04 sec/event
ToolBasedRawDigitPrepService:dtor: pdspTailPedRemovalZKe: 3.08 sec/event
ToolBasedRawDigitPrepService:dtor: adcKeepAllSignalFinder: 0.13 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 9736948
-rw-r--r-- 1 neutrino002 neutrino 2298000851 Dec 29 23:45 detsim_stage2.root
-rw-r--r-- 1 neutrino002 neutrino 2183037538 Dec 29 23:44 detsim_stage1.root
-rw-r--r-- 1 neutrino002 neutrino 1947123525 Dec 30 00:29 reco_stage1.root
-rw-r--r-- 1 neutrino002 neutrino 1778095942 Dec 29 22:23 g4_stage2.root
-rw-r--r-- 1 neutrino002 neutrino 1697751290 Dec 29 22:15 g4_stage1.root
-rw-r--r-- 1 neutrino002 neutrino 65994520 Dec 30 00:26 Pandora_Events.pndr
-rw-r--r-- 1 neutrino002 neutrino 243037 Dec 30 00:29 jobscript.log
-rw-r--r-- 1 neutrino002 neutrino 217088 Dec 30 00:29 mem.db
-rw-r--r-- 1 neutrino002 neutrino 62376 Dec 30 00:29 Pandora_Geometry.xml
-rw-r--r-- 1 neutrino002 neutrino 36864 Dec 30 00:29 time.db
-rw-r--r-- 1 neutrino002 neutrino 519 Dec 29 23:45 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 neutrino002 neutrino 519 Dec 29 22:23 g4_protoDUNE_hist.root
-rw-r--r-- 1 neutrino002 neutrino 519 Dec 30 00:29 protoDUNE_reco1_hist.root
-rw-r--r-- 1 neutrino002 neutrino 52 Dec 29 22:08 all-input-dids.txt
-rw-r--r-- 1 neutrino002 neutrino 7 Dec 30 00:29 justin-processed-pfns.txt
-rw-r--r-- 1 neutrino002 neutrino 0 Dec 29 23:50 ProtoDUNE.log
-rw-r--r-- 1 neutrino002 neutrino 0 Dec 29 23:45 debugprod.log
