Jobsub ID 270368.0@dunegpschedd01.fnal.gov
| Jobsub ID | 270368.0@dunegpschedd01.fnal.gov |
| Workflow ID | 11357 |
| 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-27 10:06:34 |
| Site | UK_QMUL |
| Entry | DUNE_UK_London_QMUL_arcce03 |
| Last heartbeat | 2025-12-27 13:46:46 |
| From worker node | Hostname | cn509.htc.esc.qmul |
| cpuinfo | Intel(R) Xeon(R) Gold 6252 CPU @ 2.10GHz |
| OS release | Scientific Linux release 7.9 (Nitrogen) |
| Processors | 1 |
| RSS bytes | 10485760000 (10000 MiB) |
| Wall seconds limit | 171000 (47 hours) |
| GPU | |
| Inner Apptainer? | True |
| Job state | finished |
| Started | 2025-12-27 10:14:03 |
| Input files | monte-carlo-011357-000001
|
| Jobscript | Exit code | 0 |
| Real time | 3h (12547s) |
| CPU time | 3h (12371s = 98%) |
| Max RSS bytes | 4362940416 (4160 MiB) |
| Outputting started | 2025-12-27 13:43:11 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11357/1/001/reco_stage1.root
|
| Finished | 2025-12-27 13:46:46 |
| Saved logs | justin-logs:270368.0-dunegpschedd01.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
ervice: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 138660 traces, 0 summary
Retagger: tagging trace set: gauss with 101996 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 101996 traces tagged "gauss"
FrameSaver: q=3.56004e+06 n=1752263 tag=gauss
wclsFrameSaver: saving 138660 traces tagged "wiener"
FrameSaver: q=3.81121e+06 n=1531190 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 25878 XUs and 25504 XVs -> 300 XUVs
C:0 T:1 45236 XUs and 49454 XVs -> 2763 XUVs
C:0 T:2 40934 XUs and 43347 XVs -> 2243 XUVs
C:0 T:3 20276 XUs and 18283 XVs -> 85 XUVs
C:0 T:4 18549 XUs and 15334 XVs -> 293 XUVs
C:0 T:5 148860 XUs and 92888 XVs -> 24281 XUVs
C:0 T:6 65752 XUs and 81184 XVs -> 5783 XUVs
C:0 T:7 29481 XUs and 31420 XVs -> 320 XUVs
C:0 T:8 12550 XUs and 10312 XVs -> 335 XUVs
C:0 T:9 175048 XUs and 109772 XVs -> 17242 XUVs
C:0 T:10 71510 XUs and 128995 XVs -> 16669 XUVs
C:0 T:11 86 XUs and 81 XVs -> 8 XUVs
70322 XUVs total
12615 collection wire objects
66370 potential space points
Neighbour search...
14689362 tests to find 6298614 neighbours
Iterating with no regularization...
Begin: 7.59877e+07
0 5.55496e+07
1 5.43851e+07
2 5.42044e+07
3 5.41458e+07
4 5.41191e+07
Now with regularization...
Begin: 4.43127e+07
0 4.42448e+07
1 4.41914e+07
2 4.41477e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 411372059
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411372059
fLifetime: 30000 [us]
27-Dec-2025 13:43:08 GMT Closed output file "reco_stage1.root"
27-Dec-2025 13:43:08 GMT 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 378.524 526.4 708.464 522.586 105.344 10
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00147988 0.00348104 0.00537077 0.00367889 0.00128716 10
reco:ophit:OpHitFinder 0.282863 0.342053 0.556288 0.303216 0.0868637 10
reco:opflash:OpFlashFinder 0.228454 0.264151 0.343426 0.246197 0.0381187 10
reco:opslicer:OpSlicer 0.64272 0.815729 1.32981 0.708529 0.224435 10
reco:caldata:DataPrepModule 6.00146 7.09036 11.0825 6.22909 1.84447 10
reco:wclsdatasp:WireCellToolkit 47.5989 52.1951 54.6175 52.5483 1.94028 10
reco:gaushit:GausHitFinder 1.21985 1.59774 2.26175 1.49714 0.321273 10
reco:nhitsfilter:NumberOfHitsFilter 0.000611581 0.000760652 0.00110976 0.000719054 0.000137135 10
reco:reco3d:SpacePointSolver 8.54763 16.6747 22.313 18.0753 4.28172 10
reco:hitpdune:DisambigFromSpacePoints 1.84577 2.47287 3.78919 2.34168 0.663684 10
reco:pandora:StandardPandora 28.1867 48.7307 90.0471 43.7896 19.2831 10
reco:pandoraWriter:StandardPandora 0.417817 0.528093 0.670832 0.51455 0.0787443 10
reco:pandoraTrack:LArPandoraTrackCreation 7.9437 10.8277 13.7852 9.99072 2.17492 10
reco:pandoraShower:LArPandoraShowerCreation 5.65921 11.375 19.4989 10.5554 3.97628 10
reco:pandoracalo:Calorimetry 2.69093 4.6424 6.24387 4.3685 1.06534 10
reco:pandoracalonosce:Calorimetry 2.54676 4.40498 5.90665 4.34399 1.0777 10
reco:pandorapid:Chi2ParticleID 0.00583968 0.00672762 0.00906159 0.00657924 0.000945055 10
reco:pandoracalinoxyzt:CalibrationdEdXPDSP 0.0571899 0.0719786 0.0935745 0.0697855 0.010375 10
reco:pandoracalipidnoxyzt:Chi2ParticleID 0.00563177 0.00643397 0.00768889 0.00613804 0.000737472 10
reco:pandoraShowercalo:ShowerCalorimetry 5.04888 9.72863 17.4025 8.9876 3.58319 10
reco:pandoraShowercalonosce:ShowerCalorimetry 4.43627 8.94731 17.3247 8.53157 3.33169 10
reco:emtrkmichelid:EmTrackMichelId 178.305 240.381 333.88 230.243 51.0121 10
reco:crttag:SingleCRTMatchingProducer 0.0246832 0.0332631 0.0414318 0.0336707 0.00531478 10
reco:crtreco:TwoCRTMatchingProducer 0.0173961 0.0257841 0.0347659 0.0258617 0.00497276 10
reco:anodepiercerst0:T0RecoAnodePiercers 1.16702 1.68245 2.31656 1.67781 0.331202 10
reco:pandora2Track:LArPandoraTrackCreation 20.2309 36.933 51.2472 36.6049 10.0709 10
reco:pandora2calo:Calorimetry 7.7104 16.1078 23.6488 15.4931 4.83268 10
reco:pandora2calonosce:Calorimetry 7.63613 14.2478 22.4619 13.5615 4.67427 10
reco:pandora2pid:Chi2ParticleID 0.0129635 0.0199213 0.0267266 0.0205838 0.00507198 10
reco:pandora2calinoxyzt:CalibrationdEdXPDSP 0.0712795 0.11155 0.159325 0.111917 0.0286555 10
reco:pandora2calipidnoxyzt:Chi2ParticleID 0.0127107 0.0197815 0.0269548 0.0200357 0.00516473 10
reco:pandora2Shower:LArPandoraShowerCreation 7.03703 10.6362 17.8686 9.63973 3.17843 10
reco:pandora2Showercalo:ShowerCalorimetry 6.56214 12.0696 21.6733 11.6455 4.07773 10
reco:pandora2Showercalonosce:ShowerCalorimetry 5.3048 10.077 19.1233 9.24801 3.71136 10
[art]:TriggerResults:TriggerResultInserter 4.9666e-05 6.24414e-05 0.000111818 5.18465e-05 2.08486e-05 10
end_path:out1:RootOutput 8.534e-06 9.9128e-06 1.2666e-05 9.384e-06 1.40484e-06 10
end_path:out1:RootOutput(write) 2.50972 3.17518 5.11175 2.85803 0.767629 10
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5175.29 MB
Peak resident set size usage (VmHWM): 4362.94 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.08 sec/event
ToolBasedRawDigitPrepService:dtor: adcSampleFiller: 0.26 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleAdcToKe: 0.05 sec/event
ToolBasedRawDigitPrepService:dtor: pdspTailPedRemovalZKe: 4.52 sec/event
ToolBasedRawDigitPrepService:dtor: adcKeepAllSignalFinder: 0.25 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleKeToAdc: 0.05 sec/event
ToolBasedRawDigitPrepService:dtor: pdsp_RemoveBadChannels: 0.00 sec/event
Art has completed and will exit with status 0.
lar exit code 0
.:
total 10616236
-rw-r--r-- 1 pildune32 pildune 2487277558 Dec 27 12:13 detsim_stage2.root
-rw-r--r-- 1 pildune32 pildune 2362065239 Dec 27 12:10 detsim_stage1.root
-rw-r--r-- 1 pildune32 pildune 2187412712 Dec 27 13:43 reco_stage1.root
-rw-r--r-- 1 pildune32 pildune 1921645651 Dec 27 10:37 g4_stage2.root
-rw-r--r-- 1 pildune32 pildune 1833653482 Dec 27 10:21 g4_stage1.root
-rw-r--r-- 1 pildune32 pildune 78352250 Dec 27 13:37 Pandora_Events.pndr
-rw-r--r-- 1 pildune32 pildune 242809 Dec 27 13:43 jobscript.log
-rw-r--r-- 1 pildune32 pildune 217088 Dec 27 13:43 mem.db
-rw-r--r-- 1 pildune32 pildune 62376 Dec 27 13:43 Pandora_Geometry.xml
-rw-r--r-- 1 pildune32 pildune 36864 Dec 27 13:43 time.db
-rw-r--r-- 1 pildune32 pildune 519 Dec 27 12:13 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 pildune32 pildune 519 Dec 27 10:37 g4_protoDUNE_hist.root
-rw-r--r-- 1 pildune32 pildune 519 Dec 27 13:43 protoDUNE_reco1_hist.root
-rw-r--r-- 1 pildune32 pildune 52 Dec 27 10:14 all-input-dids.txt
-rw-r--r-- 1 pildune32 pildune 7 Dec 27 13:43 justin-processed-pfns.txt
-rw-r--r-- 1 pildune32 pildune 0 Dec 27 12:23 ProtoDUNE.log
-rw-r--r-- 1 pildune32 pildune 0 Dec 27 12:13 debugprod.log
