Jobsub ID 258307.1@dunegpschedd02.fnal.gov
| Jobsub ID | 258307.1@dunegpschedd02.fnal.gov |
| Workflow ID | 11052 |
| 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:06:22 |
| Site | CERN |
| Entry | CMSHTPC_T2_CH_CERN_ce514 |
| Last heartbeat | 2025-12-06 04:05:03 |
| From worker node | Hostname | b9p06p2968.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:53:05 |
| Input files | monte-carlo-011052-000001
|
| Jobscript | Exit code | 0 |
| Real time | 3h (10951s) |
| CPU time | 2h (9866s = 90%) |
| Max RSS bytes | 4295544832 (4096 MiB) |
| Outputting started | 2025-12-06 03:55:38 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11052/1/001/reco_stage1.root
|
| Finished | 2025-12-06 04:05:03 |
| Saved logs | justin-logs:258307.1-dunegpschedd02.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
epService: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 117302 traces, 0 summary
Retagger: tagging trace set: gauss with 89583 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 89583 traces tagged "gauss"
FrameSaver: q=3.02761e+06 n=1568970 tag=gauss
wclsFrameSaver: saving 117302 traces tagged "wiener"
FrameSaver: q=3.20755e+06 n=1381616 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 35875 XUs and 37803 XVs -> 459 XUVs
C:0 T:1 68146 XUs and 70514 XVs -> 6027 XUVs
C:0 T:2 60458 XUs and 48778 XVs -> 1883 XUVs
C:0 T:3 35297 XUs and 22544 XVs -> 119 XUVs
C:0 T:4 9410 XUs and 9799 XVs -> 170 XUVs
C:0 T:5 49022 XUs and 63241 XVs -> 7942 XUVs
C:0 T:6 85860 XUs and 70999 XVs -> 5350 XUVs
C:0 T:7 30724 XUs and 23433 XVs -> 236 XUVs
C:0 T:8 9427 XUs and 8262 XVs -> 168 XUVs
C:0 T:9 72293 XUs and 93308 XVs -> 8309 XUVs
C:0 T:10 42911 XUs and 41301 XVs -> 5158 XUVs
C:0 T:11 62 XUs and 30 XVs -> 7 XUVs
35828 XUVs total
10740 collection wire objects
33655 potential space points
Neighbour search...
4306693 tests to find 2045522 neighbours
Iterating with no regularization...
Begin: 7.27167e+07
0 5.83004e+07
1 5.76413e+07
2 5.75563e+07
3 5.75304e+07
Now with regularization...
Begin: 4.93015e+07
0 4.92729e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 410941252
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 410941252
fLifetime: 30000 [us]
06-Dec-2025 04:55:36 CET Closed output file "reco_stage1.root"
06-Dec-2025 04:55:36 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 211.96 254.754 355.109 245.926 39.1905 10
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000835707 0.00318234 0.00513052 0.00328653 0.00140095 10
reco:ophit:OpHitFinder 0.215361 0.246629 0.329488 0.238314 0.0318497 10
reco:opflash:OpFlashFinder 0.132286 0.161718 0.198858 0.159034 0.0190627 10
reco:opslicer:OpSlicer 0.437393 0.504906 0.570868 0.504151 0.0453276 10
reco:caldata:DataPrepModule 3.85103 4.08322 4.30775 4.08072 0.14101 10
reco:wclsdatasp:WireCellToolkit 25.2574 27.9035 32.2459 27.8471 1.83432 10
reco:gaushit:GausHitFinder 0.754191 0.914319 1.1462 0.887762 0.121463 10
reco:nhitsfilter:NumberOfHitsFilter 0.000314233 0.000428528 0.000906479 0.000378169 0.000164696 10
reco:reco3d:SpacePointSolver 7.0985 11.3389 17.5653 10.6833 3.43138 10
reco:hitpdune:DisambigFromSpacePoints 0.900525 1.2906 2.0066 1.2332 0.309088 10
reco:pandora:StandardPandora 15.4118 23.7511 42.863 23.4554 7.33548 10
reco:pandoraWriter:StandardPandora 0.259741 0.349552 0.699104 0.314937 0.121845 10
reco:pandoraTrack:LArPandoraTrackCreation 2.01537 2.64305 3.96644 2.53554 0.609465 10
reco:pandoraShower:LArPandoraShowerCreation 2.04194 2.8612 5.38203 2.56474 0.955865 10
reco:pandoracalo:Calorimetry 1.26674 1.61957 2.16164 1.59327 0.270131 10
reco:pandoracalonosce:Calorimetry 1.08711 1.49628 2.04416 1.47465 0.275795 10
reco:pandorapid:Chi2ParticleID 0.0032683 0.0042979 0.00596521 0.00405878 0.000917792 10
reco:pandoracalinoxyzt:CalibrationdEdXPDSP 0.032629 0.0420937 0.0636883 0.0399746 0.00858131 10
reco:pandoracalipidnoxyzt:Chi2ParticleID 0.00312331 0.00433118 0.007509 0.00395003 0.00125882 10
reco:pandoraShowercalo:ShowerCalorimetry 2.24093 3.34278 6.27813 3.09112 1.11024 10
reco:pandoraShowercalonosce:ShowerCalorimetry 2.33833 3.28582 5.82581 2.95006 1.03874 10
reco:emtrkmichelid:EmTrackMichelId 116.239 136.889 176.103 132.954 17.0084 10
reco:crttag:SingleCRTMatchingProducer 0.00744154 0.0111622 0.0167104 0.0104867 0.00300803 10
reco:crtreco:TwoCRTMatchingProducer 0.00509601 0.0067019 0.00842276 0.00665201 0.00103436 10
reco:anodepiercerst0:T0RecoAnodePiercers 0.620498 0.799641 0.890433 0.799256 0.0753663 10
reco:pandora2Track:LArPandoraTrackCreation 6.24778 8.67911 16.4381 8.14065 2.7788 10
reco:pandora2calo:Calorimetry 3.2511 4.68349 8.81024 4.39316 1.51481 10
reco:pandora2calonosce:Calorimetry 3.10373 4.38481 7.88945 4.17353 1.30455 10
reco:pandora2pid:Chi2ParticleID 0.00778145 0.00902377 0.0126517 0.00852282 0.00145544 10
reco:pandora2calinoxyzt:CalibrationdEdXPDSP 0.0405314 0.046824 0.0636984 0.044465 0.00646885 10
reco:pandora2calipidnoxyzt:Chi2ParticleID 0.0074157 0.00888081 0.0125237 0.00847373 0.00135631 10
reco:pandora2Shower:LArPandoraShowerCreation 2.20846 3.13705 5.11294 2.9652 0.765192 10
reco:pandora2Showercalo:ShowerCalorimetry 2.88273 4.15966 7.03616 3.89791 1.12661 10
reco:pandora2Showercalonosce:ShowerCalorimetry 2.74087 3.79933 6.1418 3.56956 0.942641 10
[art]:TriggerResults:TriggerResultInserter 3.242e-05 5.88984e-05 0.000154401 4.60055e-05 3.38504e-05 10
end_path:out1:RootOutput 8.94e-06 1.22792e-05 1.729e-05 1.12355e-05 2.53295e-06 10
end_path:out1:RootOutput(write) 1.86251 2.21038 2.9677 2.12031 0.313618 10
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5128.54 MB
Peak resident set size usage (VmHWM): 4295.54 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.17 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleAdcToKe: 0.03 sec/event
ToolBasedRawDigitPrepService:dtor: pdspTailPedRemovalZKe: 2.56 sec/event
ToolBasedRawDigitPrepService:dtor: adcKeepAllSignalFinder: 0.10 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 10527376
-rw-r--r--. 1 duneprd np-comp 2451607338 Dec 6 04:10 detsim_stage2.root
-rw-r--r--. 1 duneprd np-comp 2329203933 Dec 6 04:08 detsim_stage1.root
-rw-r--r--. 1 duneprd np-comp 2146998621 Dec 6 04:55 reco_stage1.root
-rw-r--r--. 1 duneprd np-comp 1925524094 Dec 6 02:20 g4_stage2.root
-rw-r--r--. 1 duneprd np-comp 1849372203 Dec 6 02:01 g4_stage1.root
-rw-r--r--. 1 duneprd np-comp 76716110 Dec 6 04:53 Pandora_Events.pndr
-rw-r--r--. 1 duneprd np-comp 242941 Dec 6 04:55 jobscript.log
-rw-r--r--. 1 duneprd np-comp 217088 Dec 6 04:55 mem.db
-rw-r--r--. 1 duneprd np-comp 62376 Dec 6 04:55 Pandora_Geometry.xml
-rw-r--r--. 1 duneprd np-comp 36864 Dec 6 04:55 time.db
-rw-r--r--. 1 duneprd np-comp 519 Dec 6 04:10 detsim_single_protoDUNE_hist.root
-rw-r--r--. 1 duneprd np-comp 519 Dec 6 02:20 g4_protoDUNE_hist.root
-rw-r--r--. 1 duneprd np-comp 519 Dec 6 04:55 protoDUNE_reco1_hist.root
-rw-r--r--. 1 duneprd np-comp 52 Dec 6 01:53 all-input-dids.txt
-rw-r--r--. 1 duneprd np-comp 7 Dec 6 04:55 justin-processed-pfns.txt
-rw-r--r--. 1 duneprd np-comp 0 Dec 6 04:16 ProtoDUNE.log
-rw-r--r--. 1 duneprd np-comp 0 Dec 6 04:10 debugprod.log
