justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 270993.1@dunegpschedd01.fnal.gov

Jobsub ID270993.1@dunegpschedd01.fnal.gov
Workflow ID11430
Stage ID1
User namepmelas@fnal.gov
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2025-12-30 21:37:07
SiteCERN
EntryCMSHTPC_T2_CH_CERN_ce506
Last heartbeat2025-12-31 01:40:56
From worker nodeHostnameb9p05p8732.cern.ch
cpuinfoAMD EPYC 7543 32-Core Processor
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes10485760000 (10000 MiB)
Wall seconds limit343800 (95 hours)
GPU
Inner Apptainer?True
Job statefinished
Started2025-12-30 21:37:59
Input filesmonte-carlo-011430-000001
JobscriptExit code0
Real time4h (14487s)
CPU time3h (13427s = 92%)
Max RSS bytes4263387136 (4065 MiB)
Outputting started2025-12-31 01:39:27
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11430/1/001/reco_stage1.root
Finished2025-12-31 01:40:56
Saved logsjustin-logs:270993.1-dunegpschedd01.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

igitPrepService: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 111552 traces, 0 summary
Retagger: tagging trace set: gauss with 83099 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 83099 traces tagged "gauss"
FrameSaver: q=2.86146e+06 n=1472764 tag=gauss
wclsFrameSaver: saving 111552 traces tagged "wiener"
FrameSaver: q=3.04621e+06 n=1305565 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 35900 XUs and 40796 XVs -> 492 XUVs
C:0 T:1 58265 XUs and 57784 XVs -> 4725 XUVs
C:0 T:2 198287 XUs and 188181 XVs -> 20840 XUVs
C:0 T:3 71833 XUs and 58250 XVs -> 691 XUVs
C:0 T:4 10444 XUs and 9620 XVs -> 97 XUVs
C:0 T:5 23294 XUs and 18125 XVs -> 2351 XUVs
C:0 T:6 84149 XUs and 76937 XVs -> 5457 XUVs
C:0 T:7 26461 XUs and 28866 XVs -> 143 XUVs
C:0 T:8 5868 XUs and 6319 XVs -> 48 XUVs
C:0 T:9 32432 XUs and 55132 XVs -> 4482 XUVs
C:0 T:10 31134 XUs and 27375 XVs -> 6235 XUVs
C:0 T:11 263 XUs and 134 XVs -> 32 XUVs
45593 XUVs total
10500 collection wire objects
41604 potential space points
Neighbour search...
5460448 tests to find 2670486 neighbours
Iterating with no regularization...
Begin: 4.22616e+07
0 3.29082e+07
1 3.21624e+07
2 3.20442e+07
3 3.20059e+07
4 3.19873e+07
Now with regularization...
Begin: 2.3757e+07
0 2.37002e+07
1 2.36637e+07
2 2.36361e+07
3 2.36133e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
run: 1 ; subrun: 0 ; event: 10
evttime: 411441882
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411441882
fLifetime: 30000 [us]
31-Dec-2025 02:39:25 CET  Closed output file "reco_stage1.root"
31-Dec-2025 02:39:25 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                                          261.575       383.066       557.963       377.47        90.4563        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.00121208     0.0039314    0.00704846    0.00400553    0.00178138       10     
reco:ophit:OpHitFinder                             0.218688      0.318824      0.445193      0.311066      0.0643453       10     
reco:opflash:OpFlashFinder                         0.130468      0.175926       0.2443       0.177318      0.0339218       10     
reco:opslicer:OpSlicer                             0.454424      0.763093       1.14275      0.754472      0.192665        10     
reco:caldata:DataPrepModule                         4.18475       6.59734       7.22927       6.92561      0.880177        10     
reco:wclsdatasp:WireCellToolkit                     32.1233       36.7629       40.4603       37.9456       2.48225        10     
reco:gaushit:GausHitFinder                          1.01327       1.44857       2.08128       1.37637      0.313924        10     
reco:nhitsfilter:NumberOfHitsFilter               0.00034316    0.000593049   0.000908716   0.000582402   0.000145695      10     
reco:reco3d:SpacePointSolver                        10.5878       24.8251       64.6945       20.9445       14.2942        10     
reco:hitpdune:DisambigFromSpacePoints               1.28985       1.96878       2.61566       2.09976      0.487877        10     
reco:pandora:StandardPandora                        18.582        36.1501       74.5719       31.9367       16.7572        10     
reco:pandoraWriter:StandardPandora                 0.346818      0.470362      0.621842      0.473343      0.0951553       10     
reco:pandoraTrack:LArPandoraTrackCreation           2.19126       3.53606       6.53157       3.08318       1.24962        10     
reco:pandoraShower:LArPandoraShowerCreation         1.74854       4.01122       6.8354        3.97544       1.53629        10     
reco:pandoracalo:Calorimetry                        1.36355       2.24072       3.6306        1.95232      0.732586        10     
reco:pandoracalonosce:Calorimetry                   1.06972       2.0867        3.46515       2.06545       0.72063        10     
reco:pandorapid:Chi2ParticleID                    0.00324171    0.00660406    0.00890051    0.00654424    0.00194625       10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0312268     0.0618486     0.084992      0.0639074     0.0167544       10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00309514    0.00593135    0.00854196     0.0061812    0.00180317       10     
reco:pandoraShowercalo:ShowerCalorimetry            1.36847       4.44883       7.53048       4.74627       1.88626        10     
reco:pandoraShowercalonosce:ShowerCalorimetry       1.44343       4.32285       7.11719       4.3836        1.80906        10     
reco:emtrkmichelid:EmTrackMichelId                  143.089       207.057       283.55        208.897       39.4908        10     
reco:crttag:SingleCRTMatchingProducer             0.00618219     0.0150182     0.0271059     0.0146546    0.00509381       10     
reco:crtreco:TwoCRTMatchingProducer               0.00481837    0.00976821     0.0178278    0.00951681    0.00331811       10     
reco:anodepiercerst0:T0RecoAnodePiercers           0.466601      0.950925       1.44637       0.92668      0.264011        10     
reco:pandora2Track:LArPandoraTrackCreation          4.37032       13.1979       25.0733       13.8166       5.47254        10     
reco:pandora2calo:Calorimetry                       2.70949       6.74089       13.5659       6.39496       2.90076        10     
reco:pandora2calonosce:Calorimetry                  2.85218       6.33294       12.6075       6.15459       2.60886        10     
reco:pandora2pid:Chi2ParticleID                   0.00673279     0.0144324     0.0284321     0.0130316    0.00603052       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0369707     0.0741447     0.136698      0.0662864     0.0290131       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID         0.00672814     0.0142231     0.0278676     0.0124869    0.00602461       10     
reco:pandora2Shower:LArPandoraShowerCreation        1.6334        4.56943       9.34815       4.38652       2.15096        10     
reco:pandora2Showercalo:ShowerCalorimetry           2.09291       5.69423       11.4217       5.19949       2.65232        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      1.95796       5.07375       10.5433       4.85299       2.30231        10     
[art]:TriggerResults:TriggerResultInserter        4.0651e-05    6.43558e-05   0.000137274   5.71715e-05   2.66744e-05      10     
end_path:out1:RootOutput                           1.02e-05     1.20852e-05    1.534e-05    1.16955e-05   1.69269e-06      10     
end_path:out1:RootOutput(write)                     1.85289       3.01063       5.06879       2.7694       0.854508        10     
====================================================================================================================================

====================================================================================================
MemoryTracker summary (base-10 MB units used)

  Peak virtual memory usage (VmPeak)  : 5104.24 MB
  Peak resident set size usage (VmHWM): 4263.39 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.31 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.05 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   4.19 sec/event
ToolBasedRawDigitPrepService:dtor:         adcKeepAllSignalFinder:   0.18 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 10034916
-rw-r--r--. 1 duneprd np-comp 2352800361 Dec 31 01:31 detsim_stage2.root
-rw-r--r--. 1 duneprd np-comp 2235126085 Dec 31 01:29 detsim_stage1.root
-rw-r--r--. 1 duneprd np-comp 2048274445 Dec 31 02:39 reco_stage1.root
-rw-r--r--. 1 duneprd np-comp 1818290842 Dec 30 23:05 g4_stage2.root
-rw-r--r--. 1 duneprd np-comp 1743864537 Dec 30 22:47 g4_stage1.root
-rw-r--r--. 1 duneprd np-comp   76776830 Dec 31 02:35 Pandora_Events.pndr
-rw-r--r--. 1 duneprd np-comp     243125 Dec 31 02:39 jobscript.log
-rw-r--r--. 1 duneprd np-comp     217088 Dec 31 02:39 mem.db
-rw-r--r--. 1 duneprd np-comp      62376 Dec 31 02:39 Pandora_Geometry.xml
-rw-r--r--. 1 duneprd np-comp      36864 Dec 31 02:39 time.db
-rw-r--r--. 1 duneprd np-comp        519 Dec 31 01:31 detsim_single_protoDUNE_hist.root
-rw-r--r--. 1 duneprd np-comp        519 Dec 30 23:05 g4_protoDUNE_hist.root
-rw-r--r--. 1 duneprd np-comp        519 Dec 31 02:39 protoDUNE_reco1_hist.root
-rw-r--r--. 1 duneprd np-comp         52 Dec 30 22:38 all-input-dids.txt
-rw-r--r--. 1 duneprd np-comp          7 Dec 31 02:39 justin-processed-pfns.txt
-rw-r--r--. 1 duneprd np-comp          0 Dec 31 01:39 ProtoDUNE.log
-rw-r--r--. 1 duneprd np-comp          0 Dec 31 01:31 debugprod.log
justIN time: 2026-02-07 00:51:47 UTC       justIN version: 01.06.00