justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID271787.1@justin-prod-sched01.dune.hep.ac.uk
Workflow ID3652
Stage ID1
User nameamoor@fnal.gov
HTCondor Groupgroup_dune
RequestedProcessors1
RSS bytes4194304000 (4000 MiB)
Wall seconds limit80000 (22 hours)
Submitted time2024-10-08 17:28:38
SiteUK_Lancaster
EntryUBoone_UK_Lancaster_HEC_grendel_ce02
Last heartbeat2024-10-08 20:53:38
From worker nodeHostnamecomp14-25
cpuinfoIntel(R) Xeon(R) CPU E5-2650 v2 @ 2.60GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4194304000 (4000 MiB)
Wall seconds limit257400 (71 hours)
Inner Apptainer?True
Job statejobscript_error
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-10-08 17:30:49
Input filesusertests:000135_reco_data_2024-10-07T_114846Z.root
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-10-08 20:53:38
Saved logsjustin-logs:271787.1-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://mover.pp.rl.ac.uk:1094/pnfs/pp.rl.ac.uk/data/dune/usertests/fa/2f/000135_reco_data_2024-10-07T_114846Z.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
../justin-jobscript: line 72:  1282 Segmentation fault      (core dumped) lar -c $FCL_FILE $events_option -o $outFile "$pfn" > ${fname}_reco_${now}.log 2>&1
=== 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  08-Oct-2024 18:56:19 BST run: 20000031 subRun: 0 event: 606
Random seed for this event, engine 'largeant': 445097953
%MSG
%MSG-i generatePrimaries:  larg4Main:largeant@BeginModule  08-Oct-2024 18:56:19 BST run: 20000031 subRun: 0 event: 606 MCTruthEventAction.cc:112
Generating 1 particles
%MSG
%MSG-i ParticleListActionService:  larg4Main:largeant@BeginModule  08-Oct-2024 18:59:48 BST run: 20000031 subRun: 0 event: 606
Not Stored Process summary:
	compt : 2130912
	Pair : 46
	annihil : 102810
	phot : 688406
	Brem : 632712
	conv : 102764
	Ion : 272450
%MSG
%MSG-i endOfEventAction:  larg4Main:largeant@BeginModule  08-Oct-2024 18:59:48 BST run: 20000031 subRun: 0 event: 606 ParticleListAction.cc:701
MCTruth Handles Size: 1
%MSG
%MSG-i endOfEventAction:  larg4Main:largeant@BeginModule  08-Oct-2024 18:59:48 BST run: 20000031 subRun: 0 event: 606 ParticleListAction.cc:708
mclistHandle Size: 1
%MSG
%MSG-i endOfEventAction:  larg4Main:largeant@BeginModule  08-Oct-2024 18:59:48 BST run: 20000031 subRun: 0 event: 606 ParticleListAction.cc:711
Found 1 particles
%MSG
%MSG-i NuRandomService:  IonAndScint:IonAndScint@BeginModule  08-Oct-2024 18:59:49 BST run: 20000031 subRun: 0 event: 606
Random seed for this event, engine 'IonAndScint.ISCalcAlg': 255580107
%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  08-Oct-2024 19:00:00 BST run: 20000031 subRun: 0 event: 606
Random seed for this event, engine 'elecDrift': 871989058
%MSG
%MSG-i NuRandomService:  PDFastSimPAR:PDFastSim@BeginModule  08-Oct-2024 19:01:25 BST run: 20000031 subRun: 0 event: 606
Random seed for this event, engine 'PDFastSim.photon': 67775451
%MSG
%MSG-i NuRandomService:  PDFastSimPAR:PDFastSim@BeginModule  08-Oct-2024 19:01:25 BST run: 20000031 subRun: 0 event: 606
Random seed for this event, engine 'PDFastSim.scinttime': 386506785
%MSG
Plugin version SecClnt v5.4.3 is incompatible with secztn v5.6.8 (must be <= 5.4.x) in sec.protocol libXrdSecztn-5.so
IonAndScint endJob.
08-Oct-2024 21:52:53 BST  Closed input file "root://mover.pp.rl.ac.uk:1094/pnfs/pp.rl.ac.uk/data/dune/usertests/fa/2f/000135_reco_data_2024-10-07T_114846Z.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                     0.0125711      19.6288       10504.3      0.465486       426.306        606    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.000110167   0.000359241    0.0127877    0.000129523   0.00140799       606    
simulate:rns:RandomNumberSaver                 2.248e-05    2.9423e-05    0.000212182   2.59425e-05   1.05403e-05      606    
simulate:largeant:larg4Main                    0.0115653      1.14893       209.729      0.431061       8.66355        606    
simulate:IonAndScint:IonAndScint              0.000115708    0.0200317      11.3367     0.000132055    0.460109        606    
simulate:elecDrift:SimDriftElectrons          5.5122e-05      0.15244       84.6163     6.45085e-05     3.43428        606    
simulate:PDFastSim:PDFastSimPAR               7.3219e-05      18.3046       10198.6     9.54985e-05     413.928        606    
simulate:muonfilter:LArG4ParticleFilter        1.806e-05    4.94031e-05   0.00385199    2.2144e-05    0.000177018      606    
[art]:TriggerResults:TriggerResultInserter     1.395e-05    1.58548e-05   4.5229e-05    1.5104e-05    2.48646e-06      606    
end_path:out1:RootOutput                       9.829e-06    1.1723e-05    0.000232012   1.0729e-05    9.16366e-06      606    
end_path:out1:RootOutput(write)                6.076e-06    0.00177924     0.663384      6.617e-06     0.0293953       605    
================================================================================================================================
%MSG-i NuRandomService:  RootOutput:out1@EndJob 08-Oct-2024 21:52:53 BST  ModuleEndJob

Summary of seeds computed by the NuRandomService
Random policy: 'perEvent'
  algorithm version: EventTimestamp_v1
   Configured value          Last value   ModuleLabel.InstanceName
        (per event)           255580107   IonAndScint.ISCalcAlg
        (per event)            67775451   PDFastSim.photon
        (per event)           386506785   PDFastSim.scinttime
        (per event)           871989058   elecDrift
        (per event)           445097953   largeant

%MSG

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

  Peak virtual memory usage (VmPeak)  : 17557.2 MB
  Peak resident set size usage (VmHWM): 14876.5 MB
====================================================================================================

TrigReport ---------- Event summary -------------
TrigReport Events total = 606 passed = 4 failed = 602

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

TimeReport ---------- Time summary [sec] -------
TimeReport CPU = 11880.337826 Real = 12005.333945

MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 17557.2 VmHWM = 14876.5

=== End last 100 lines of lar log file ===
lar exit code 0
Traceback (most recent call last):
  File "/cvmfs/dune.opensciencegrid.org/products/dune/duneutil/v09_75_03d00/bin/extractor_prod.py", line 434, in <module>
    main()
  File "/cvmfs/dune.opensciencegrid.org/products/dune/duneutil/v09_75_03d00/bin/extractor_prod.py", line 373, in main
    mddict = expSpecificMetadata.getmetadata()
  File "/cvmfs/dune.opensciencegrid.org/products/dune/duneutil/v09_75_03d00/bin/extractor_prod.py", line 344, in getmetadata
    jobt = self.get_job(proc)
  File "/cvmfs/dune.opensciencegrid.org/products/dune/duneutil/v09_75_03d00/bin/extractor_prod.py", line 69, in get_job
    raise RuntimeError('sam_metadata_dumper returned nonzero exit status {}.'.format(rc))
RuntimeError: sam_metadata_dumper returned nonzero exit status 1.
extractor_prod.py exit code 1
Error reading metadata from file: Expecting value: line 1 column 1 (char 0)
pdjson2metadata exit code 1
.:
total 90580
-rw-r--r-- 1 pltdune002 pltdune 90529758 Oct  8 21:52 RootOutput-11e7-8b46-5a2d-5f70.root
-rw-r--r-- 1 pltdune002 pltdune  2206234 Oct  8 21:52 000135_reco_data_2024-10-07T_114846Z_reco_2024-10-08T_173055Z.log
-rw-r--r-- 1 pltdune002 pltdune     7875 Oct  8 21:53 jobscript.log
-rw-r--r-- 1 pltdune002 pltdune      274 Oct  8 18:31 TFileService-b17e-69eb-7931-ae3d.root
-rw-r--r-- 1 pltdune002 pltdune      104 Oct  8 18:30 all-input-dids.txt
-rw-r--r-- 1 pltdune002 pltdune        0 Oct  8 21:53 000135_reco_data_2024-10-07T_114846Z_reco_data_2024-10-08T_173055Z.root.ext.json
-rw-r--r-- 1 pltdune002 pltdune        0 Oct  8 21:53 000135_reco_data_2024-10-07T_114846Z_reco_data_2024-10-08T_173055Z.root.json
justIN time: 2024-11-24 09:58:30 UTC       justIN version: 01.01.09