justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 289742.16@justin-prod-sched01.dune.hep.ac.uk

Jobsub ID289742.16@justin-prod-sched01.dune.hep.ac.uk
Workflow ID4103
Stage ID1
User nameamoor@fnal.gov
HTCondor Groupgroup_dune
RequestedProcessors1
RSS bytes8388608000 (8000 MiB)
Wall seconds limit80000 (22 hours)
Submitted time2024-11-14 13:39:00
SiteCERN
EntryCMSHTPC_T2_CH_CERN_ce505
Last heartbeat2024-11-14 14:39:56
From worker nodeHostnameb9p16p2609.cern.ch
cpuinfoIntel(R) Xeon(R) Silver 4216 CPU @ 2.10GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes8388608000 (8000 MiB)
Wall seconds limit171000 (47 hours)
Inner Apptainer?True
Job statefinished
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-11-14 13:48:52
Input filesusertests:000659_reco_data_2024-11-14T_093316Z.root
JobscriptExit code0
Real time50m (3018s)
CPU time49m (2946s = 97%)
Outputting started2024-11-14 14:39:10
Output filesusertests:000659_reco_data_2024-11-14T_093316Z_reco_data_2024-11-14T_134904Z.root
Finished2024-11-14 14:39:56
Saved logsjustin-logs:289742.16-justin-prod-sched01.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

AFM g4 jobscript.
Input PFN = root://eospublic.cern.ch:1094//eos/experiment/neutplatform/protodune/dune/usertests/be/fc/000659_reco_data_2024-11-14T_093316Z.root
Setting up larsoft UPS area... /cvmfs/larsoft.opensciencegrid.org
Setting up DUNE UPS area... /cvmfs/dune.opensciencegrid.org/products/dune/
/cvmfs/larsoft.opensciencegrid.org/products/xrootd/v5_4_3b/Linux64bit+3.10-2.17-e20-p3913-prof/lib/libXrdPosixPreload.so
=== Start last 100 lines of lar log file ===
Rebuild failed to get the OpDetBTRs. This is expected when running on a generation or simulation step.
%MSG
%MSG-i NuRandomService:  larg4Main:largeant@BeginModule  14-Nov-2024 15:39:03 CET run: 20000031 subRun: 0 event: 1000
Random seed for this event, engine 'largeant': 521772276
%MSG
%MSG-i generatePrimaries:  larg4Main:largeant@BeginModule  14-Nov-2024 15:39:03 CET run: 20000031 subRun: 0 event: 1000 MCTruthEventAction.cc:112
Generating 1 particles
%MSG
%MSG-i ParticleListActionService:  larg4Main:largeant@BeginModule  14-Nov-2024 15:39:04 CET run: 20000031 subRun: 0 event: 1000
Not Stored Process summary:
	compt : 30630
	Pair : 78
	annihil : 1198
	phot : 8175
	Brem : 7505
	conv : 1120
	Ion : 4532
%MSG
%MSG-i endOfEventAction:  larg4Main:largeant@BeginModule  14-Nov-2024 15:39:04 CET run: 20000031 subRun: 0 event: 1000 ParticleListAction.cc:701
MCTruth Handles Size: 1
%MSG
%MSG-i endOfEventAction:  larg4Main:largeant@BeginModule  14-Nov-2024 15:39:04 CET run: 20000031 subRun: 0 event: 1000 ParticleListAction.cc:708
mclistHandle Size: 1
%MSG
%MSG-i endOfEventAction:  larg4Main:largeant@BeginModule  14-Nov-2024 15:39:04 CET run: 20000031 subRun: 0 event: 1000 ParticleListAction.cc:711
Found 1 particles
%MSG
%MSG-i NuRandomService:  IonAndScint:IonAndScint@BeginModule  14-Nov-2024 15:39:04 CET run: 20000031 subRun: 0 event: 1000
Random seed for this event, engine 'IonAndScint.ISCalcAlg': 46254203
%MSG
IonAndScint Module Producer
SimEnergyDeposit input module: largeant, instance name: LArG4DetectorServicevolTPCPlaneUInner
SimEnergyDeposit input module: largeant, instance name: LArG4DetectorServicevolTPCActiveInner
SimEnergyDeposit input module: largeant, instance name: LArG4DetectorServicevolTPCInner
SimEnergyDeposit input module: largeant, instance name: LArG4DetectorServicevolTPCPlaneVInner
SimEnergyDeposit input module: largeant, instance name: LArG4DetectorServicevolTPCPlaneZInner
SimEnergyDeposit input module: largeant, instance name: LArG4DetectorServicevolTPCActiveOuter
%MSG-i NuRandomService:  SimDriftElectrons:elecDrift@BeginModule  14-Nov-2024 15:39:04 CET run: 20000031 subRun: 0 event: 1000
Random seed for this event, engine 'elecDrift': 698314495
%MSG
%MSG-i NuRandomService:  PDFastSimPAR:PDFastSim@BeginModule  14-Nov-2024 15:39:04 CET run: 20000031 subRun: 0 event: 1000
Random seed for this event, engine 'PDFastSim.photon': 681837490
%MSG
%MSG-i NuRandomService:  PDFastSimPAR:PDFastSim@BeginModule  14-Nov-2024 15:39:04 CET run: 20000031 subRun: 0 event: 1000
Random seed for this event, engine 'PDFastSim.scinttime': 585153674
%MSG
14-Nov-2024 15:39:05 CET  Closed output file "000659_reco_data_2024-11-14T_093316Z_reco_data_2024-11-14T_134904Z.root"
14-Nov-2024 15:39:05 CET  Closed input file "root://eospublic.cern.ch:1094//eos/experiment/neutplatform/protodune/dune/usertests/be/fc/000659_reco_data_2024-11-14T_093316Z.root"
IonAndScint endJob.

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                     0.0098569      2.84085       262.034      0.303566       12.4846       1000    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.000103183   0.00044994     0.0825807    0.00015405    0.00362105      1000    
simulate:rns:RandomNumberSaver                2.1497e-05     3.494e-05    0.000326918   3.2277e-05    1.26267e-05     1000    
simulate:largeant:larg4Main                   0.00783863     0.478341       15.6945      0.278251      0.914281       1000    
simulate:IonAndScint:IonAndScint              9.5823e-05    0.00204761     0.206909     0.000118869    0.0105355      1000    
simulate:elecDrift:SimDriftElectrons          3.8011e-05     0.0239874      3.16551      5.543e-05     0.145719       1000    
simulate:PDFastSim:PDFastSimPAR               5.7617e-05      2.24464       248.907     8.5077e-05      11.8222       1000    
[art]:TriggerResults:TriggerResultInserter     9.083e-06    1.25716e-05   6.2782e-05    1.08715e-05   4.02493e-06     1000    
end_path:out1:RootOutput                       2.518e-06    3.61905e-06   2.4405e-05     3.199e-06    1.43914e-06     1000    
end_path:out1:RootOutput(write)               0.000674333    0.0907088      6.78035      0.0041793     0.371997       1000    
================================================================================================================================
%MSG-i NuRandomService:  RootOutput:out1@EndJob 14-Nov-2024 15:39:05 CET  ModuleEndJob

Summary of seeds computed by the NuRandomService
Random policy: 'perEvent'
  algorithm version: EventTimestamp_v1
   Configured value          Last value   ModuleLabel.InstanceName
        (per event)            46254203   IonAndScint.ISCalcAlg
        (per event)           681837490   PDFastSim.photon
        (per event)           585153674   PDFastSim.scinttime
        (per event)           698314495   elecDrift
        (per event)           521772276   largeant

%MSG

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

  Peak virtual memory usage (VmPeak)  : 2967.86 MB
  Peak resident set size usage (VmHWM): 1864.99 MB
====================================================================================================

TrigReport ---------- Event summary -------------
TrigReport Events total = 1000 passed = 1000 failed = 0

TrigReport ---------- Modules in End-path ----------
TrigReport        Run    Success      Error Name
TrigReport       1000       1000          0 out1

TimeReport ---------- Time summary [sec] -------
TimeReport CPU = 2835.688706 Real = 2869.765522

MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 2967.86 VmHWM = 1864.99

Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===
lar exit code 0
extractor_prod.py exit code 0
pdjson2metadata exit code 0
Metadata extraction succeeds
===Metadata JSON===
{
    "metadata": {
        "DUNE.campaign": "justIN.w4103s1",
        "art.file_format_era": "ART_2011a",
        "art.file_format_version": 15,
        "art.first_event": 1,
        "art.last_event": 1000,
        "art.process_name": "G4",
        "art.run_type": "physics",
        "core.application": "art.reco",
        "core.application.family": "art",
        "core.application.name": "reco",
        "core.application.version": "v09_75_03d00",
        "core.data_stream": "out1",
        "core.data_tier": "simulated",
        "core.end_time": 1731595145.0,
        "core.event_count": 1000,
        "core.file_format": "artroot",
        "core.file_type": "mc",
        "core.first_event_number": 1,
        "core.last_event_number": 1000,
        "core.run_type": "physics",
        "core.runs": [
            20000031
        ],
        "core.runs_subruns": [
            2000003100000
        ],
        "core.start_time": 1731592291.0
    },
    "parents": [
        {
            "did": "usertests:000659_reco_data_2024-11-14T_093316Z.root"
        }
    ]
}
===================
.:
total 1334936
-rw-r--r--. 1 duneprd np-comp 1363348217 Nov 14 15:39 000659_reco_data_2024-11-14T_093316Z_reco_data_2024-11-14T_134904Z.root
-rw-r--r--. 1 duneprd np-comp    3596065 Nov 14 15:39 000659_reco_data_2024-11-14T_093316Z_reco_2024-11-14T_134904Z.log
-rw-r--r--. 1 duneprd np-comp       7973 Nov 14 15:39 jobscript.log
-rw-r--r--. 1 duneprd np-comp       1072 Nov 14 15:39 000659_reco_data_2024-11-14T_093316Z_reco_data_2024-11-14T_134904Z.root.json
-rw-r--r--. 1 duneprd np-comp        857 Nov 14 15:39 000659_reco_data_2024-11-14T_093316Z_reco_data_2024-11-14T_134904Z.root.ext.json
-rw-r--r--. 1 duneprd np-comp        519 Nov 14 15:39 g4_hist.root
-rw-r--r--. 1 duneprd np-comp        132 Nov 14 15:39 justin-processed-pfns.txt
-rw-r--r--. 1 duneprd np-comp        104 Nov 14 14:48 all-input-dids.txt
justIN time: 2024-11-17 06:16:59 UTC       justIN version: 01.01.09