Jobsub ID 264161.0@dunegpschedd01.fnal.gov
| Jobsub ID | 264161.0@dunegpschedd01.fnal.gov |
| Workflow ID | 11050 |
| 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-06 00:52:23 |
| Site | CERN |
| Entry | CMSHTPC_T2_CH_CERN_ce512 |
| Last heartbeat | 2025-12-06 04:23:45 |
| From worker node | Hostname | b9p06p2822.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-06 00:55:34 |
| Input files | monte-carlo-011050-000001
|
| Jobscript | Exit code | 0 |
| Real time | 3h (12027s) |
| CPU time | 3h (11400s = 94%) |
| Max RSS bytes | 4186693632 (3992 MiB) |
| Outputting started | 2025-12-06 04:16:02 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11050/1/001/reco_stage1.root
|
| Finished | 2025-12-06 04:23:45 |
| Saved logs | justin-logs:264161.0-dunegpschedd01.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
pare: 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 127151 traces, 0 summary
Retagger: tagging trace set: gauss with 92804 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 92804 traces tagged "gauss"
FrameSaver: q=3.31309e+06 n=1573001 tag=gauss
wclsFrameSaver: saving 127151 traces tagged "wiener"
FrameSaver: q=3.53012e+06 n=1376730 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 40347 XUs and 46489 XVs -> 632 XUVs
C:0 T:1 77674 XUs and 106143 XVs -> 13665 XUVs
C:0 T:2 57466 XUs and 90509 XVs -> 2687 XUVs
C:0 T:3 32565 XUs and 43556 XVs -> 142 XUVs
C:0 T:4 9390 XUs and 12723 XVs -> 52 XUVs
C:0 T:5 29526 XUs and 28867 XVs -> 3501 XUVs
C:0 T:6 98891 XUs and 97201 XVs -> 6577 XUVs
C:0 T:7 42879 XUs and 38598 XVs -> 374 XUVs
C:0 T:8 6957 XUs and 6969 XVs -> 64 XUVs
C:0 T:9 40780 XUs and 52297 XVs -> 3309 XUVs
C:0 T:10 13248 XUs and 7527 XVs -> 1863 XUVs
C:0 T:11 151 XUs and 111 XVs -> 18 XUVs
32884 XUVs total
9770 collection wire objects
29832 potential space points
Neighbour search...
1677726 tests to find 923322 neighbours
Iterating with no regularization...
Begin: 6.28579e+07
0 5.3346e+07
1 5.24161e+07
2 5.2249e+07
3 5.21952e+07
4 5.21705e+07
Now with regularization...
Begin: 4.14416e+07
0 4.14078e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 410941272
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 410941272
fLifetime: 30000 [us]
06-Dec-2025 05:15:59 CET Closed output file "reco_stage1.root"
06-Dec-2025 05:15:59 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 204.399 321.907 510.715 307.177 84.9014 10
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00117975 0.00380548 0.00729771 0.00395016 0.00178057 10
reco:ophit:OpHitFinder 0.228286 0.295224 0.353142 0.300763 0.0395197 10
reco:opflash:OpFlashFinder 0.116466 0.17564 0.237465 0.17586 0.0327447 10
reco:opslicer:OpSlicer 0.395442 0.61975 0.991856 0.567991 0.18235 10
reco:caldata:DataPrepModule 4.11869 5.20894 6.66973 5.00985 0.873181 10
reco:wclsdatasp:WireCellToolkit 28.8659 31.604 36.9551 30.512 2.37708 10
reco:gaushit:GausHitFinder 0.630311 1.12873 2.18693 1.06853 0.41362 10
reco:nhitsfilter:NumberOfHitsFilter 0.000295112 0.000512373 0.000922674 0.000486791 0.000188193 10
reco:reco3d:SpacePointSolver 8.21986 13.3836 20.3221 13.5113 3.93656 10
reco:hitpdune:DisambigFromSpacePoints 0.885198 1.56519 2.44006 1.60313 0.499088 10
reco:pandora:StandardPandora 14.3194 38.8448 107.118 27.9561 27.5334 10
reco:pandoraWriter:StandardPandora 0.28387 0.366151 0.562909 0.314615 0.0898692 10
reco:pandoraTrack:LArPandoraTrackCreation 2.05018 3.09711 5.01963 2.64899 0.984322 10
reco:pandoraShower:LArPandoraShowerCreation 1.26531 3.43163 7.76012 2.73849 1.83966 10
reco:pandoracalo:Calorimetry 1.14381 1.9929 4.12236 1.74105 0.796145 10
reco:pandoracalonosce:Calorimetry 0.782724 1.74028 2.90553 1.6605 0.549693 10
reco:pandorapid:Chi2ParticleID 0.00338926 0.00539499 0.00762138 0.00551055 0.00148058 10
reco:pandoracalinoxyzt:CalibrationdEdXPDSP 0.0274138 0.048751 0.0805655 0.0469855 0.0153071 10
reco:pandoracalipidnoxyzt:Chi2ParticleID 0.00319774 0.00517959 0.0075705 0.00490361 0.00153218 10
reco:pandoraShowercalo:ShowerCalorimetry 1.04106 3.49159 7.32133 2.95281 1.78341 10
reco:pandoraShowercalonosce:ShowerCalorimetry 1.05764 3.68692 6.71341 2.97043 1.82729 10
reco:emtrkmichelid:EmTrackMichelId 115.822 171.582 237.842 163.319 33.9398 10
reco:crttag:SingleCRTMatchingProducer 0.0101834 0.0132808 0.0166355 0.0132123 0.00209347 10
reco:crtreco:TwoCRTMatchingProducer 0.00547503 0.00795443 0.0107747 0.00821836 0.00150689 10
reco:anodepiercerst0:T0RecoAnodePiercers 0.649117 0.882063 1.06006 0.90154 0.121677 10
reco:pandora2Track:LArPandoraTrackCreation 5.50099 11.241 21.6433 9.76497 4.91648 10
reco:pandora2calo:Calorimetry 2.70711 5.71293 8.16148 5.55222 1.58875 10
reco:pandora2calonosce:Calorimetry 2.25232 5.64004 10.8234 5.55352 2.28697 10
reco:pandora2pid:Chi2ParticleID 0.0067615 0.0142741 0.0268582 0.0135455 0.00573005 10
reco:pandora2calinoxyzt:CalibrationdEdXPDSP 0.0329813 0.0686242 0.124426 0.0667113 0.0264073 10
reco:pandora2calipidnoxyzt:Chi2ParticleID 0.0067748 0.0138956 0.0301573 0.0128596 0.00644713 10
reco:pandora2Shower:LArPandoraShowerCreation 1.46033 3.84267 6.54412 3.80438 1.43153 10
reco:pandora2Showercalo:ShowerCalorimetry 2.05158 4.97329 7.95981 4.84609 1.82638 10
reco:pandora2Showercalonosce:ShowerCalorimetry 1.42709 4.42771 7.43894 3.8311 1.86781 10
[art]:TriggerResults:TriggerResultInserter 4.246e-05 6.99834e-05 0.000160521 5.55005e-05 3.41059e-05 10
end_path:out1:RootOutput 9.83e-06 1.1631e-05 1.574e-05 1.1265e-05 1.56256e-06 10
end_path:out1:RootOutput(write) 1.51174 2.68279 3.65718 2.74368 0.674471 10
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5032.35 MB
Peak resident set size usage (VmHWM): 4186.69 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.06 sec/event
ToolBasedRawDigitPrepService:dtor: adcSampleFiller: 0.23 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleAdcToKe: 0.04 sec/event
ToolBasedRawDigitPrepService:dtor: pdspTailPedRemovalZKe: 3.27 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 10325756
-rw-r--r--. 1 duneprd np-comp 2429076988 Dec 6 04:19 detsim_stage2.root
-rw-r--r--. 1 duneprd np-comp 2309200540 Dec 6 04:17 detsim_stage1.root
-rw-r--r--. 1 duneprd np-comp 2119492977 Dec 6 05:15 reco_stage1.root
-rw-r--r--. 1 duneprd np-comp 1864267841 Dec 6 02:15 g4_stage2.root
-rw-r--r--. 1 duneprd np-comp 1774638443 Dec 6 02:04 g4_stage1.root
-rw-r--r--. 1 duneprd np-comp 76281940 Dec 6 05:12 Pandora_Events.pndr
-rw-r--r--. 1 duneprd np-comp 242810 Dec 6 05:16 jobscript.log
-rw-r--r--. 1 duneprd np-comp 217088 Dec 6 05:15 mem.db
-rw-r--r--. 1 duneprd np-comp 62376 Dec 6 05:15 Pandora_Geometry.xml
-rw-r--r--. 1 duneprd np-comp 36864 Dec 6 05:15 time.db
-rw-r--r--. 1 duneprd np-comp 519 Dec 6 04:19 detsim_single_protoDUNE_hist.root
-rw-r--r--. 1 duneprd np-comp 519 Dec 6 02:15 g4_protoDUNE_hist.root
-rw-r--r--. 1 duneprd np-comp 519 Dec 6 05:16 protoDUNE_reco1_hist.root
-rw-r--r--. 1 duneprd np-comp 52 Dec 6 01:55 all-input-dids.txt
-rw-r--r--. 1 duneprd np-comp 7 Dec 6 05:16 justin-processed-pfns.txt
-rw-r--r--. 1 duneprd np-comp 0 Dec 6 04:24 ProtoDUNE.log
-rw-r--r--. 1 duneprd np-comp 0 Dec 6 04:19 debugprod.log
