Jobsub ID 296469.0@dunegpschedd02.fnal.gov
| Jobsub ID | 296469.0@dunegpschedd02.fnal.gov |
| Workflow ID | 12505 |
| 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 | 2026-01-29 09:31:46 |
| Site | CERN |
| Entry | CMSHTPC_T2_CH_CERN_ce512 |
| Last heartbeat | 2026-01-29 13:39:08 |
| From worker node | Hostname | b9p17p7907.cern.ch |
| cpuinfo | Intel(R) Xeon(R) Silver 4216 CPU @ 2.10GHz |
| 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 | 2026-01-29 09:32:44 |
| Input files | monte-carlo-012505-000001
|
| Jobscript | Exit code | 0 |
| Real time | 4h (14707s) |
| CPU time | 3h (13574s = 92%) |
| Max RSS bytes | 3810353152 (3633 MiB) |
| Outputting started | 2026-01-29 13:37:53 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/12505/1/001/reco_stage1.root
|
| Finished | 2026-01-29 13:39:08 |
| Saved logs | justin-logs:296469.0-dunegpschedd02.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
: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 132310 traces, 0 summary
Retagger: tagging trace set: gauss with 98891 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 98891 traces tagged "gauss"
FrameSaver: q=3.33873e+06 n=1728180 tag=gauss
wclsFrameSaver: saving 132310 traces tagged "wiener"
FrameSaver: q=3.53985e+06 n=1520268 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 29965 XUs and 21450 XVs -> 536 XUVs
C:0 T:1 51978 XUs and 40954 XVs -> 3830 XUVs
C:0 T:2 105461 XUs and 169254 XVs -> 11510 XUVs
C:0 T:3 43244 XUs and 56790 XVs -> 450 XUVs
C:0 T:5 88143 XUs and 28543 XVs -> 4774 XUVs
C:0 T:6 115281 XUs and 127970 XVs -> 10285 XUVs
C:0 T:7 34201 XUs and 43873 XVs -> 524 XUVs
C:0 T:8 7856 XUs and 7084 XVs -> 63 XUVs
C:0 T:9 65720 XUs and 60084 XVs -> 4793 XUVs
C:0 T:10 51332 XUs and 83509 XVs -> 20226 XUVs
C:0 T:11 595 XUs and 593 XVs -> 112 XUVs
57103 XUVs total
12019 collection wire objects
53731 potential space points
Neighbour search...
11090909 tests to find 4797508 neighbours
Iterating with no regularization...
Begin: 6.02411e+07
0 4.83251e+07
1 4.7651e+07
2 4.75385e+07
3 4.75005e+07
Now with regularization...
Begin: 3.88554e+07
0 3.87913e+07
1 3.87413e+07
2 3.87005e+07
3 3.86657e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 412035447
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 412035447
fLifetime: 30000 [us]
29-Jan-2026 14:37:49 CET Closed output file "reco_stage1.root"
29-Jan-2026 14:37:49 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 394.207 506.478 664.089 467.314 95.5624 10
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00151606 0.0033819 0.00654404 0.00334785 0.0013071 10
reco:ophit:OpHitFinder 0.247855 0.374048 0.496327 0.358936 0.0825612 10
reco:opflash:OpFlashFinder 0.154092 0.213605 0.344002 0.211171 0.0578915 10
reco:opslicer:OpSlicer 0.541367 0.864349 1.29015 0.79212 0.245665 10
reco:caldata:DataPrepModule 6.65215 8.51674 11.0584 8.32145 1.69409 10
reco:wclsdatasp:WireCellToolkit 52.4369 62.2112 82.9938 57.7834 9.04117 10
reco:gaushit:GausHitFinder 1.1654 1.82105 2.35631 1.79797 0.380359 10
reco:nhitsfilter:NumberOfHitsFilter 0.000616409 0.000758917 0.000930842 0.000749573 9.8308e-05 10
reco:reco3d:SpacePointSolver 7.23962 15.8938 31.6662 12.2167 8.1532 10
reco:hitpdune:DisambigFromSpacePoints 1.22609 2.51269 5.07316 2.15553 1.15102 10
reco:pandora:StandardPandora 18.6313 36.4623 51.6552 35.2693 9.26441 10
reco:pandoraWriter:StandardPandora 0.381474 0.516957 0.741174 0.483149 0.109953 10
reco:pandoraTrack:LArPandoraTrackCreation 3.1551 5.78011 9.75801 5.45708 1.84611 10
reco:pandoraShower:LArPandoraShowerCreation 2.5876 5.2107 8.87984 4.49635 2.21688 10
reco:pandoracalo:Calorimetry 1.63009 2.88482 4.63368 2.73546 0.998516 10
reco:pandoracalonosce:Calorimetry 1.44431 2.59066 4.28596 2.40311 0.962098 10
reco:pandorapid:Chi2ParticleID 0.00521931 0.00772251 0.0114142 0.00658238 0.00238581 10
reco:pandoracalinoxyzt:CalibrationdEdXPDSP 0.0506086 0.0747903 0.101706 0.0742765 0.0180325 10
reco:pandoracalipidnoxyzt:Chi2ParticleID 0.00527783 0.0078207 0.012552 0.0067336 0.00248321 10
reco:pandoraShowercalo:ShowerCalorimetry 2.50121 5.43251 9.33412 4.93191 2.351 10
reco:pandoraShowercalonosce:ShowerCalorimetry 2.27306 5.42526 9.62114 5.00843 2.43006 10
reco:emtrkmichelid:EmTrackMichelId 232.037 286.605 348.417 277.648 45.2693 10
reco:crttag:SingleCRTMatchingProducer 0.0192615 0.0259606 0.0310592 0.0271671 0.00387809 10
reco:crtreco:TwoCRTMatchingProducer 0.0139974 0.0186867 0.0240483 0.0191588 0.00334612 10
reco:anodepiercerst0:T0RecoAnodePiercers 1.2707 1.50401 1.82999 1.41987 0.210556 10
reco:pandora2Track:LArPandoraTrackCreation 10.0566 21.8764 33.1215 20.8914 7.27625 10
reco:pandora2calo:Calorimetry 3.7794 8.67699 14.2514 7.09573 3.64798 10
reco:pandora2calonosce:Calorimetry 3.55509 8.25717 14.1894 6.76253 3.72394 10
reco:pandora2pid:Chi2ParticleID 0.0119913 0.0175299 0.0275279 0.0165434 0.00417478 10
reco:pandora2calinoxyzt:CalibrationdEdXPDSP 0.0611774 0.0917036 0.142618 0.0875871 0.022252 10
reco:pandora2calipidnoxyzt:Chi2ParticleID 0.0121382 0.0174815 0.0261642 0.016751 0.00384323 10
reco:pandora2Shower:LArPandoraShowerCreation 3.03198 5.84352 9.12965 5.20993 2.02679 10
reco:pandora2Showercalo:ShowerCalorimetry 3.33061 7.13523 11.0552 6.04642 2.81076 10
reco:pandora2Showercalonosce:ShowerCalorimetry 3.0109 6.16128 9.55864 5.33623 2.25532 10
[art]:TriggerResults:TriggerResultInserter 5.0131e-05 8.24884e-05 0.000141786 8.3581e-05 2.64141e-05 10
end_path:out1:RootOutput 8.409e-06 1.17778e-05 1.5014e-05 1.15545e-05 2.06555e-06 10
end_path:out1:RootOutput(write) 2.32093 3.28794 4.50915 3.24598 0.655267 10
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4614.82 MB
Peak resident set size usage (VmHWM): 3810.35 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.10 sec/event
ToolBasedRawDigitPrepService:dtor: adcSampleFiller: 0.32 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleAdcToKe: 0.06 sec/event
ToolBasedRawDigitPrepService:dtor: pdspTailPedRemovalZKe: 5.28 sec/event
ToolBasedRawDigitPrepService:dtor: adcKeepAllSignalFinder: 0.30 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleKeToAdc: 0.06 sec/event
ToolBasedRawDigitPrepService:dtor: pdsp_RemoveBadChannels: 0.01 sec/event
Art has completed and will exit with status 0.
lar exit code 0
.:
total 8806392
-rw-r--r--. 1 duneprd np-comp 2123068687 Jan 29 13:08 detsim_stage2.root
-rw-r--r--. 1 duneprd np-comp 2019061964 Jan 29 13:05 detsim_stage1.root
-rw-r--r--. 1 duneprd np-comp 1757388717 Jan 29 14:37 reco_stage1.root
-rw-r--r--. 1 duneprd np-comp 1562797229 Jan 29 11:07 g4_stage2.root
-rw-r--r--. 1 duneprd np-comp 1492486522 Jan 29 10:42 g4_stage1.root
-rw-r--r--. 1 duneprd np-comp 62325360 Jan 29 14:29 Pandora_Events.pndr
-rw-r--r--. 1 duneprd np-comp 242614 Jan 29 14:37 jobscript.log
-rw-r--r--. 1 duneprd np-comp 217088 Jan 29 14:37 mem.db
-rw-r--r--. 1 duneprd np-comp 62376 Jan 29 14:37 Pandora_Geometry.xml
-rw-r--r--. 1 duneprd np-comp 36864 Jan 29 14:37 time.db
-rw-r--r--. 1 duneprd np-comp 519 Jan 29 13:08 detsim_single_protoDUNE_hist.root
-rw-r--r--. 1 duneprd np-comp 519 Jan 29 11:07 g4_protoDUNE_hist.root
-rw-r--r--. 1 duneprd np-comp 519 Jan 29 14:37 protoDUNE_reco1_hist.root
-rw-r--r--. 1 duneprd np-comp 52 Jan 29 10:32 all-input-dids.txt
-rw-r--r--. 1 duneprd np-comp 7 Jan 29 14:37 justin-processed-pfns.txt
-rw-r--r--. 1 duneprd np-comp 0 Jan 29 13:18 ProtoDUNE.log
-rw-r--r--. 1 duneprd np-comp 0 Jan 29 13:08 debugprod.log
