justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID289742.26@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_ce510
Last heartbeat2024-11-14 15:20:21
From worker nodeHostnameb9p19p0571.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:49:00
Input filesusertests:000661_reco_data_2024-11-14T_093343Z.root
JobscriptExit code0
Real time1h (5410s)
CPU time1h (5284s = 97%)
Outputting started2024-11-14 15:19:11
Output filesusertests:000661_reco_data_2024-11-14T_093343Z_reco_data_2024-11-14T_134919Z.root
Finished2024-11-14 15:20:21
Saved logsjustin-logs:289742.26-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/4d/5e/000661_reco_data_2024-11-14T_093343Z.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 ===
%MSG-w PhotonBackTrackerService:  ProcessEvent 14-Nov-2024 16:19:03 CET  run: 20000031 subRun: 0 event: 1000
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 16:19:03 CET run: 20000031 subRun: 0 event: 1000
Random seed for this event, engine 'largeant': 874867261
%MSG
%MSG-i generatePrimaries:  larg4Main:largeant@BeginModule  14-Nov-2024 16:19:03 CET run: 20000031 subRun: 0 event: 1000 MCTruthEventAction.cc:112
Generating 1 particles
%MSG
%MSG-i ParticleListActionService:  larg4Main:largeant@BeginModule  14-Nov-2024 16:19:03 CET run: 20000031 subRun: 0 event: 1000
Not Stored Process summary:
	Brem : 135
	conv : 6
	Ion : 356
	compt : 388
	phot : 140
	annihil : 8
%MSG
%MSG-i endOfEventAction:  larg4Main:largeant@BeginModule  14-Nov-2024 16:19:03 CET run: 20000031 subRun: 0 event: 1000 ParticleListAction.cc:701
MCTruth Handles Size: 1
%MSG
%MSG-i endOfEventAction:  larg4Main:largeant@BeginModule  14-Nov-2024 16:19:03 CET run: 20000031 subRun: 0 event: 1000 ParticleListAction.cc:708
mclistHandle Size: 1
%MSG
%MSG-i endOfEventAction:  larg4Main:largeant@BeginModule  14-Nov-2024 16:19:03 CET run: 20000031 subRun: 0 event: 1000 ParticleListAction.cc:711
Found 1 particles
%MSG
%MSG-i NuRandomService:  IonAndScint:IonAndScint@BeginModule  14-Nov-2024 16:19:03 CET run: 20000031 subRun: 0 event: 1000
Random seed for this event, engine 'IonAndScint.ISCalcAlg': 806838296
%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 16:19:03 CET run: 20000031 subRun: 0 event: 1000
Random seed for this event, engine 'elecDrift': 357852423
%MSG
%MSG-i NuRandomService:  PDFastSimPAR:PDFastSim@BeginModule  14-Nov-2024 16:19:03 CET run: 20000031 subRun: 0 event: 1000
Random seed for this event, engine 'PDFastSim.photon': 134032723
%MSG
%MSG-i NuRandomService:  PDFastSimPAR:PDFastSim@BeginModule  14-Nov-2024 16:19:03 CET run: 20000031 subRun: 0 event: 1000
Random seed for this event, engine 'PDFastSim.scinttime': 195235689
%MSG
14-Nov-2024 16:19:04 CET  Closed output file "000661_reco_data_2024-11-14T_093343Z_reco_data_2024-11-14T_134919Z.root"
14-Nov-2024 16:19:04 CET  Closed input file "root://eospublic.cern.ch:1094//eos/experiment/neutplatform/protodune/dune/usertests/4d/5e/000661_reco_data_2024-11-14T_093343Z.root"
IonAndScint endJob.

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                     0.0140244      5.19236       614.528      0.431515       25.4844       1000    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.00012322    0.000574519    0.0261454    0.000218668   0.00240411      1000    
simulate:rns:RandomNumberSaver                2.6254e-05    5.18329e-05   0.000466307   4.8896e-05    1.99772e-05     1000    
simulate:largeant:larg4Main                    0.0105529     0.697772       30.6676      0.384477       1.49853       1000    
simulate:IonAndScint:IonAndScint              0.000117294   0.00391876     0.518002     0.000179465    0.022151       1000    
simulate:elecDrift:SimDriftElectrons          4.6109e-05     0.0428715      5.16438     8.0725e-05     0.227611       1000    
simulate:PDFastSim:PDFastSimPAR               7.0062e-05      4.28819       587.434     0.000120476     24.2785       1000    
[art]:TriggerResults:TriggerResultInserter    1.0319e-05    1.69888e-05   7.0366e-05    1.61215e-05   6.21705e-06     1000    
end_path:out1:RootOutput                       3.065e-06    4.73066e-06   6.1674e-05    4.2945e-06    2.47792e-06     1000    
end_path:out1:RootOutput(write)               0.000724718    0.158144       14.6838     0.00678159     0.671603       1000    
================================================================================================================================
%MSG-i NuRandomService:  RootOutput:out1@EndJob 14-Nov-2024 16:19:04 CET  ModuleEndJob

Summary of seeds computed by the NuRandomService
Random policy: 'perEvent'
  algorithm version: EventTimestamp_v1
   Configured value          Last value   ModuleLabel.InstanceName
        (per event)           806838296   IonAndScint.ISCalcAlg
        (per event)           134032723   PDFastSim.photon
        (per event)           195235689   PDFastSim.scinttime
        (per event)           357852423   elecDrift
        (per event)           874867261   largeant

%MSG

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

  Peak virtual memory usage (VmPeak)  : 3322.94 MB
  Peak resident set size usage (VmHWM): 2262.93 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 = 5153.957232 Real = 5234.855154

MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 3322.94 VmHWM = 2262.93

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": 1731597544.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": 1731592329.0
    },
    "parents": [
        {
            "did": "usertests:000661_reco_data_2024-11-14T_093343Z.root"
        }
    ]
}
===================
.:
total 1842476
-rw-r--r--. 1 duneprd np-comp 1883065979 Nov 14 16:19 000661_reco_data_2024-11-14T_093343Z_reco_data_2024-11-14T_134919Z.root
-rw-r--r--. 1 duneprd np-comp    3596242 Nov 14 16:19 000661_reco_data_2024-11-14T_093343Z_reco_2024-11-14T_134919Z.log
-rw-r--r--. 1 duneprd np-comp       8061 Nov 14 16:19 jobscript.log
-rw-r--r--. 1 duneprd np-comp       1072 Nov 14 16:19 000661_reco_data_2024-11-14T_093343Z_reco_data_2024-11-14T_134919Z.root.json
-rw-r--r--. 1 duneprd np-comp        857 Nov 14 16:19 000661_reco_data_2024-11-14T_093343Z_reco_data_2024-11-14T_134919Z.root.ext.json
-rw-r--r--. 1 duneprd np-comp        519 Nov 14 16:19 g4_hist.root
-rw-r--r--. 1 duneprd np-comp        132 Nov 14 16:19 justin-processed-pfns.txt
-rw-r--r--. 1 duneprd np-comp        104 Nov 14 14:49 all-input-dids.txt
justIN time: 2024-11-17 05:18:33 UTC       justIN version: 01.01.09