justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 240230.1@dunegpschedd01.fnal.gov

Jobsub ID240230.1@dunegpschedd01.fnal.gov
Workflow ID9437
Stage ID1
User namepmelas@fnal.gov
HTCondor Groupgroup_dune
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2025-10-29 12:46:29
SiteUK_Brunel
EntryCMSHTPC_T2_UK_London_Brunel_dc2_26
Last heartbeat2025-10-29 16:02:07
From worker nodeHostnamewn-a4-03
cpuinfoAMD EPYC 7452 32-Core Processor
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes10485760000 (10000 MiB)
Wall seconds limit171000 (47 hours)
GPU
Inner Apptainer?True
Job statefinished
Started2025-10-29 12:47:27
Input filesmonte-carlo-009437-000001
JobscriptExit code0
Real time3h (11317s)
CPU time2h (10479s = 92%)
Max RSS bytes3972841472 (3788 MiB)
Outputting started2025-10-29 15:56:06
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/09437/1/001/reco_stage1.root
Finished2025-10-29 16:02:07
Saved logsjustin-logs:240230.1-dunegpschedd01.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

gnalFinder
ToolBasedRawDigitPrepService: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 119626 traces, 0 summary
Retagger: tagging trace set: gauss with 93989 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 93989 traces tagged "gauss"
FrameSaver: q=3.1188e+06 n=1664592 tag=gauss
wclsFrameSaver: saving 119626 traces tagged "wiener"
FrameSaver: q=3.26838e+06 n=1471916 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:1 48191 XUs and 49664 XVs -> 3216 XUVs
C:0 T:2 74236 XUs and 113726 XVs -> 8748 XUVs
C:0 T:3 32040 XUs and 40724 XVs -> 252 XUVs
C:0 T:4 7643 XUs and 10693 XVs -> 32 XUVs
C:0 T:5 26801 XUs and 28421 XVs -> 3361 XUVs
C:0 T:6 121995 XUs and 149484 XVs -> 5749 XUVs
C:0 T:7 45663 XUs and 55525 XVs -> 484 XUVs
C:0 T:8 6065 XUs and 8531 XVs -> 89 XUVs
C:0 T:9 35381 XUs and 62469 XVs -> 3597 XUVs
C:0 T:10 21894 XUs and 16251 XVs -> 2532 XUVs
28060 XUVs total
10738 collection wire objects
26037 potential space points
Neighbour search...
2425689 tests to find 1206688 neighbours
Iterating with no regularization...
Begin: 5.62517e+07
0 4.98085e+07
1 4.93815e+07
2 4.93217e+07
3 4.93041e+07
Now with regularization...
Begin: 4.06111e+07
0 4.05947e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 410186253
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 410186253
fLifetime: 30000 [us]
29-Oct-2025 15:56:04 GMT  Closed output file "reco_stage1.root"
29-Oct-2025 15:56:04 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                                          223.836       341.391       394.783       359.699       50.7016        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.00125691    0.00334546    0.00555824    0.00373371    0.00132732       10     
reco:ophit:OpHitFinder                             0.260992      0.296041      0.333743       0.3001       0.0203967       10     
reco:opflash:OpFlashFinder                         0.152032      0.179598      0.202517      0.185889      0.0182981       10     
reco:opslicer:OpSlicer                             0.576811      0.681363      0.802963       0.66681      0.0807446       10     
reco:caldata:DataPrepModule                         5.08546       5.5237        7.12021       5.24429      0.637564        10     
reco:wclsdatasp:WireCellToolkit                     31.8164       37.0364       42.4467       37.4337       3.08425        10     
reco:gaushit:GausHitFinder                         0.877502       1.09901       1.22065       1.10368      0.100268        10     
reco:nhitsfilter:NumberOfHitsFilter               0.00046919    0.000568626   0.000857199   0.000553577   0.000105733      10     
reco:reco3d:SpacePointSolver                        6.95387       11.9294       17.2105       12.4551       2.88463        10     
reco:hitpdune:DisambigFromSpacePoints              0.739136       1.29165       1.72682       1.36052      0.298626        10     
reco:pandora:StandardPandora                        13.5749       26.999        33.3185       28.9578       6.01441        10     
reco:pandoraWriter:StandardPandora                 0.335735      0.427187      0.488123      0.442191      0.0466216       10     
reco:pandoraTrack:LArPandoraTrackCreation           1.63048       3.55823       5.20913       3.65446       1.13471        10     
reco:pandoraShower:LArPandoraShowerCreation         1.40461       3.66397       5.60341       3.77165       1.20421        10     
reco:pandoracalo:Calorimetry                       0.908563       1.79072       2.58875       1.90776      0.493691        10     
reco:pandoracalonosce:Calorimetry                  0.790699       1.64375       2.4095        1.66054      0.490778        10     
reco:pandorapid:Chi2ParticleID                    0.00424757    0.00540306    0.00662506    0.00530331    0.000632945      10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0373219     0.0492995     0.0579932     0.0522633    0.00650002       10     
reco:pandoracalipidnoxyzt:Chi2ParticleID           0.0038339    0.00512143    0.00649318    0.00512602    0.000735454      10     
reco:pandoraShowercalo:ShowerCalorimetry            1.42018       3.56874       6.11215        3.513        1.28432        10     
reco:pandoraShowercalonosce:ShowerCalorimetry       1.29205       3.41732       5.23403       3.49112       1.15294        10     
reco:emtrkmichelid:EmTrackMichelId                  135.16        200.489       232.471       205.353       28.9351        10     
reco:crttag:SingleCRTMatchingProducer              0.0115134     0.0126454     0.0156114     0.0122372    0.00121384       10     
reco:crtreco:TwoCRTMatchingProducer               0.00665749    0.00852733     0.0104147     0.0087876    0.00110641       10     
reco:anodepiercerst0:T0RecoAnodePiercers           0.695802       0.87522       1.03223      0.879892      0.115668        10     
reco:pandora2Track:LArPandoraTrackCreation          4.65796       11.3143       16.9531       11.5759       3.19726        10     
reco:pandora2calo:Calorimetry                       2.15259       5.11005       7.58779       5.19361       1.66035        10     
reco:pandora2calonosce:Calorimetry                  1.98902       4.72504       6.82442       4.98892       1.41213        10     
reco:pandora2pid:Chi2ParticleID                   0.00876124     0.0130958     0.0158697     0.0134979    0.00195504       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.043338      0.0621803     0.0723454     0.0657104    0.00886818       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID         0.00922479     0.0129259     0.0158746     0.013241     0.00189485       10     
reco:pandora2Shower:LArPandoraShowerCreation        1.80126       4.20001       5.75757       4.44648       1.14788        10     
reco:pandora2Showercalo:ShowerCalorimetry           1.83899       4.31513       6.02471       4.59128       1.25222        10     
reco:pandora2Showercalonosce:ShowerCalorimetry       1.647        3.99659       5.92712       4.19373       1.14533        10     
[art]:TriggerResults:TriggerResultInserter        4.4901e-05    5.80574e-05   0.000123083   4.9781e-05    2.2233e-05       10     
end_path:out1:RootOutput                           9.33e-06     1.24893e-05    1.746e-05    1.23605e-05   1.9921e-06       10     
end_path:out1:RootOutput(write)                     2.34549       2.96304       3.42531       3.00769      0.307211        10     
====================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4798.63 MB
  Peak resident set size usage (VmHWM): 3972.84 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.06 sec/event
ToolBasedRawDigitPrepService:dtor:                adcSampleFiller:   0.22 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.04 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   3.45 sec/event
ToolBasedRawDigitPrepService:dtor:         adcKeepAllSignalFinder:   0.13 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 9461572
-rw-r--r--. 1 pildune003 dunepil 2251810366 Oct 29 14:56 detsim_stage2.root
-rw-r--r--. 1 pildune003 dunepil 2135816437 Oct 29 14:54 detsim_stage1.root
-rw-r--r--. 1 pildune003 dunepil 1915080487 Oct 29 15:56 reco_stage1.root
-rw-r--r--. 1 pildune003 dunepil 1692111587 Oct 29 13:12 g4_stage2.root
-rw-r--r--. 1 pildune003 dunepil 1624052020 Oct 29 13:01 g4_stage1.root
-rw-r--r--. 1 pildune003 dunepil   69162300 Oct 29 15:51 Pandora_Events.pndr
-rw-r--r--. 1 pildune003 dunepil     242635 Oct 29 15:56 jobscript.log
-rw-r--r--. 1 pildune003 dunepil     217088 Oct 29 15:56 mem.db
-rw-r--r--. 1 pildune003 dunepil      62376 Oct 29 15:56 Pandora_Geometry.xml
-rw-r--r--. 1 pildune003 dunepil      36864 Oct 29 15:56 time.db
-rw-r--r--. 1 pildune003 dunepil        519 Oct 29 14:56 detsim_single_protoDUNE_hist.root
-rw-r--r--. 1 pildune003 dunepil        519 Oct 29 13:12 g4_protoDUNE_hist.root
-rw-r--r--. 1 pildune003 dunepil        519 Oct 29 15:56 protoDUNE_reco1_hist.root
-rw-r--r--. 1 pildune003 dunepil         52 Oct 29 12:55 all-input-dids.txt
-rw-r--r--. 1 pildune003 dunepil          7 Oct 29 15:56 justin-processed-pfns.txt
-rw-r--r--. 1 pildune003 dunepil          0 Oct 29 15:01 ProtoDUNE.log
-rw-r--r--. 1 pildune003 dunepil          0 Oct 29 14:56 debugprod.log
justIN time: 2025-11-03 18:30:42 UTC       justIN version: 01.05.01