Jobsub ID 264146.1@dunegpschedd01.fnal.gov
| Jobsub ID | 264146.1@dunegpschedd01.fnal.gov |
| Workflow ID | 11054 |
| 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 | US_FNAL-FermiGrid |
| Entry | FNAL_GPGrid_ce04_mcore_op_duneonly |
| Last heartbeat | 2025-12-06 03:11:43 |
| From worker node | Hostname | dunegli-7989166-0-fnpc22035.fnal.gov |
| 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 | 172800 (48 hours) |
| GPU | |
| Inner Apptainer? | True |
| Job state | finished |
| Started | 2025-12-06 00:53:45 |
| Input files | monte-carlo-011054-000001
|
| Jobscript | Exit code | 0 |
| Real time | 2h (7246s) |
| CPU time | 1h (7176s = 99%) |
| Max RSS bytes | 4158377984 (3965 MiB) |
| Outputting started | 2025-12-06 02:54:31 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11054/1/001/reco_stage1.root
|
| Finished | 2025-12-06 03:11:43 |
| Saved logs | justin-logs:264146.1-dunegpschedd01.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
vice: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 120163 traces, 0 summary
Retagger: tagging trace set: gauss with 91659 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 91659 traces tagged "gauss"
FrameSaver: q=3.14839e+06 n=1600892 tag=gauss
wclsFrameSaver: saving 120163 traces tagged "wiener"
FrameSaver: q=3.33432e+06 n=1418325 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 25593 XUs and 27177 XVs -> 423 XUVs
C:0 T:1 48032 XUs and 47105 XVs -> 4494 XUVs
C:0 T:2 133677 XUs and 197186 XVs -> 14748 XUVs
C:0 T:3 56356 XUs and 63970 XVs -> 511 XUVs
C:0 T:4 9443 XUs and 9417 XVs -> 137 XUVs
C:0 T:5 37639 XUs and 26358 XVs -> 4695 XUVs
C:0 T:6 57477 XUs and 76834 XVs -> 7426 XUVs
C:0 T:7 21377 XUs and 29113 XVs -> 949 XUVs
C:0 T:8 11023 XUs and 8193 XVs -> 93 XUVs
C:0 T:9 69585 XUs and 72704 XVs -> 4037 XUVs
C:0 T:10 14207 XUs and 10776 XVs -> 1814 XUVs
C:0 T:11 205 XUs and 129 XVs -> 27 XUVs
39354 XUVs total
10654 collection wire objects
34634 potential space points
Neighbour search...
4414090 tests to find 2119328 neighbours
Iterating with no regularization...
Begin: 6.79854e+07
0 5.68446e+07
1 5.61356e+07
2 5.60348e+07
3 5.60061e+07
Now with regularization...
Begin: 4.67966e+07
0 4.67563e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 410941238
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 410941238
fLifetime: 30000 [us]
06-Dec-2025 02:54:30 UTC Closed output file "reco_stage1.root"
06-Dec-2025 02:54:30 UTC 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 131.489 206.053 246.026 212.968 30.3982 10
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00100109 0.00315963 0.00413145 0.00360408 0.00109587 10
reco:ophit:OpHitFinder 0.174552 0.206118 0.24227 0.20357 0.0193707 10
reco:opflash:OpFlashFinder 0.104213 0.141205 0.191623 0.141298 0.025402 10
reco:opslicer:OpSlicer 0.356429 0.419293 0.519885 0.422319 0.0567806 10
reco:caldata:DataPrepModule 3.34544 3.51247 3.80259 3.48269 0.122846 10
reco:wclsdatasp:WireCellToolkit 23.0291 24.9381 26.6739 24.9462 1.32729 10
reco:gaushit:GausHitFinder 0.515277 0.724222 0.864244 0.727001 0.0981449 10
reco:nhitsfilter:NumberOfHitsFilter 0.000287052 0.000605304 0.00101622 0.000515969 0.000269649 10
reco:reco3d:SpacePointSolver 2.7702 9.62568 16.9484 9.79374 3.51905 10
reco:hitpdune:DisambigFromSpacePoints 0.45829 0.929103 1.15055 0.961946 0.18832 10
reco:pandora:StandardPandora 10.4326 18.4957 26.6236 18.6245 4.11412 10
reco:pandoraWriter:StandardPandora 0.200843 0.30621 0.386659 0.339942 0.0639463 10
reco:pandoraTrack:LArPandoraTrackCreation 1.00295 2.55396 4.38916 2.51191 0.904078 10
reco:pandoraShower:LArPandoraShowerCreation 0.973345 2.36752 3.42545 2.44429 0.709237 10
reco:pandoracalo:Calorimetry 0.620103 1.34226 2.32191 1.2992 0.41426 10
reco:pandoracalonosce:Calorimetry 0.535837 1.24088 2.20594 1.17816 0.415565 10
reco:pandorapid:Chi2ParticleID 0.0025301 0.00357753 0.00500728 0.00346576 0.000794506 10
reco:pandoracalinoxyzt:CalibrationdEdXPDSP 0.022611 0.0313904 0.0355258 0.0309597 0.00374526 10
reco:pandoracalipidnoxyzt:Chi2ParticleID 0.00251419 0.00339961 0.00484164 0.00331174 0.00069343 10
reco:pandoraShowercalo:ShowerCalorimetry 0.997354 2.54587 3.71719 2.60726 0.741001 10
reco:pandoraShowercalonosce:ShowerCalorimetry 0.947645 2.49835 3.81191 2.6399 0.748113 10
reco:emtrkmichelid:EmTrackMichelId 72.4233 106.124 118.209 110.375 12.8133 10
reco:crttag:SingleCRTMatchingProducer 0.00555383 0.0106888 0.0171638 0.0103252 0.00328482 10
reco:crtreco:TwoCRTMatchingProducer 0.0034284 0.00592274 0.00895154 0.00583993 0.00147307 10
reco:anodepiercerst0:T0RecoAnodePiercers 0.439912 0.569701 0.724506 0.570116 0.0656407 10
reco:pandora2Track:LArPandoraTrackCreation 3.07457 8.30369 13.7056 7.79163 2.86411 10
reco:pandora2calo:Calorimetry 1.52811 4.0798 6.06657 3.7722 1.28913 10
reco:pandora2calonosce:Calorimetry 1.44579 3.81037 5.6128 3.57797 1.17943 10
reco:pandora2pid:Chi2ParticleID 0.00549708 0.00788844 0.00971683 0.00793161 0.00115301 10
reco:pandora2calinoxyzt:CalibrationdEdXPDSP 0.026603 0.0400321 0.0477261 0.0410869 0.00537934 10
reco:pandora2calipidnoxyzt:Chi2ParticleID 0.00568325 0.00788596 0.00958586 0.00790441 0.00114008 10
reco:pandora2Shower:LArPandoraShowerCreation 1.12434 2.82011 3.90671 2.74855 0.750552 10
reco:pandora2Showercalo:ShowerCalorimetry 1.27174 3.43834 4.71184 3.53161 0.944001 10
reco:pandora2Showercalonosce:ShowerCalorimetry 1.19524 3.02591 4.07275 3.2145 0.820941 10
[art]:TriggerResults:TriggerResultInserter 3.3653e-05 5.47283e-05 0.000118364 4.8216e-05 2.24315e-05 10
end_path:out1:RootOutput 7.845e-06 1.10829e-05 1.603e-05 1.0435e-05 2.21175e-06 10
end_path:out1:RootOutput(write) 1.1612 1.79981 2.16 1.84727 0.256393 10
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4973.88 MB
Peak resident set size usage (VmHWM): 4158.38 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.16 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleAdcToKe: 0.04 sec/event
ToolBasedRawDigitPrepService:dtor: pdspTailPedRemovalZKe: 2.16 sec/event
ToolBasedRawDigitPrepService:dtor: adcKeepAllSignalFinder: 0.08 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 9861360
-rw-r--r-- 1 dunegli fnalgrid 2339355240 Dec 6 02:18 detsim_stage2.root
-rw-r--r-- 1 dunegli fnalgrid 2218411359 Dec 6 02:17 detsim_stage1.root
-rw-r--r-- 1 dunegli fnalgrid 2008466370 Dec 6 02:54 reco_stage1.root
-rw-r--r-- 1 dunegli fnalgrid 1774030982 Dec 6 01:05 g4_stage2.root
-rw-r--r-- 1 dunegli fnalgrid 1686186674 Dec 6 00:57 g4_stage1.root
-rw-r--r-- 1 dunegli fnalgrid 70965200 Dec 6 02:52 Pandora_Events.pndr
-rw-r--r-- 1 dunegli fnalgrid 242748 Dec 6 02:54 jobscript.log
-rw-r--r-- 1 dunegli fnalgrid 217088 Dec 6 02:54 mem.db
-rw-r--r-- 1 dunegli fnalgrid 62376 Dec 6 02:54 Pandora_Geometry.xml
-rw-r--r-- 1 dunegli fnalgrid 36864 Dec 6 02:54 time.db
-rw-r--r-- 1 dunegli fnalgrid 519 Dec 6 02:18 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 dunegli fnalgrid 519 Dec 6 01:05 g4_protoDUNE_hist.root
-rw-r--r-- 1 dunegli fnalgrid 519 Dec 6 02:54 protoDUNE_reco1_hist.root
-rw-r--r-- 1 dunegli fnalgrid 52 Dec 6 00:53 all-input-dids.txt
-rw-r--r-- 1 dunegli fnalgrid 7 Dec 6 02:54 justin-processed-pfns.txt
-rw-r--r-- 1 dunegli fnalgrid 0 Dec 6 02:22 ProtoDUNE.log
-rw-r--r-- 1 dunegli fnalgrid 0 Dec 6 02:19 debugprod.log
