justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 59679.98@justin-prod-sched02.dune.hep.ac.uk

Jobsub ID59679.98@justin-prod-sched02.dune.hep.ac.uk
Workflow ID2869
Stage ID1
User nameamoor@fnal.gov
HTCondor Groupgroup_dune
RequestedProcessors1
RSS bytes4194304000 (4000 MiB)
Wall seconds limit80000 (22 hours)
Submitted time2024-08-19 10:46:53
SiteUS_FNAL-FermiGrid
EntryFNAL_GPGrid_ce03_mcore_op_duneonly
Last heartbeat2024-08-19 14:06:06
From worker nodeHostnamedunegli-3933826-0-fnpc8007.fnal.gov
cpuinfoIntel(R) Xeon(R) CPU E5-2670 v3 @ 2.30GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4194304000 (4000 MiB)
Wall seconds limit172800 (48 hours)
Inner Apptainer?True
Job statejobscript_error
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-08-19 10:59:45
Input filesusertests:000793_reco_data_2024-08-16T_162901Z.root
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-08-19 14:06:06
Saved logsjustin-logs:59679.98-justin-prod-sched02.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

AFM g4 jobscript.
Input PFN = root://fndca1.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/usertests/a9/f1/000793_reco_data_2024-08-16T_162901Z.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:  1280 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  19-Aug-2024 11:23:59 UTC run: 20000031 subRun: 0 event: 335
Random seed for this event, engine 'largeant': 678251670
%MSG
%MSG-i generatePrimaries:  larg4Main:largeant@BeginModule  19-Aug-2024 11:23:59 UTC run: 20000031 subRun: 0 event: 335 MCTruthEventAction.cc:112
Generating 1 particles
%MSG
%MSG-i ParticleListActionService:  larg4Main:largeant@BeginModule  19-Aug-2024 11:27:09 UTC run: 20000031 subRun: 0 event: 335
Not Stored Process summary:
	compt : 1791680
	Pair : 78
	annihil : 86002
	phot : 575211
	Brem : 527959
	conv : 85924
	Ion : 226220
%MSG
%MSG-i endOfEventAction:  larg4Main:largeant@BeginModule  19-Aug-2024 11:27:09 UTC run: 20000031 subRun: 0 event: 335 ParticleListAction.cc:701
MCTruth Handles Size: 1
%MSG
%MSG-i endOfEventAction:  larg4Main:largeant@BeginModule  19-Aug-2024 11:27:09 UTC run: 20000031 subRun: 0 event: 335 ParticleListAction.cc:708
mclistHandle Size: 1
%MSG
%MSG-i endOfEventAction:  larg4Main:largeant@BeginModule  19-Aug-2024 11:27:09 UTC run: 20000031 subRun: 0 event: 335 ParticleListAction.cc:711
Found 1 particles
%MSG
%MSG-i NuRandomService:  IonAndScint:IonAndScint@BeginModule  19-Aug-2024 11:27:09 UTC run: 20000031 subRun: 0 event: 335
Random seed for this event, engine 'IonAndScint.ISCalcAlg': 497143033
%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  19-Aug-2024 11:27:22 UTC run: 20000031 subRun: 0 event: 335
Random seed for this event, engine 'elecDrift': 238155930
%MSG
%MSG-i NuRandomService:  PDFastSimPAR:PDFastSim@BeginModule  19-Aug-2024 11:29:28 UTC run: 20000031 subRun: 0 event: 335
Random seed for this event, engine 'PDFastSim.photon': 159279575
%MSG
%MSG-i NuRandomService:  PDFastSimPAR:PDFastSim@BeginModule  19-Aug-2024 11:29:28 UTC run: 20000031 subRun: 0 event: 335
Random seed for this event, engine 'PDFastSim.scinttime': 710343838
%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.
19-Aug-2024 14:05:49 UTC  Closed input file "root://fndca1.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/usertests/a9/f1/000793_reco_data_2024-08-16T_162901Z.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                    0.00679465      32.4951       9636.02      0.308255       525.735        335    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        6.7459e-05    0.000200201    0.0109609    0.000128294   0.000607098      335    
simulate:rns:RandomNumberSaver                1.7986e-05    2.72805e-05   0.000197717   2.4142e-05    1.15338e-05      335    
simulate:largeant:larg4Main                   0.00596355      1.28757       189.691      0.292428       10.7909        335    
simulate:IonAndScint:IonAndScint              7.8502e-05     0.0415201      13.0011     0.000118182    0.709261        335    
simulate:elecDrift:SimDriftElectrons          4.7673e-05     0.402201       126.385     6.0384e-05      6.89462        335    
simulate:PDFastSim:PDFastSimPAR               6.6568e-05      30.7624       9306.94     9.5441e-05      507.812        335    
simulate:muonfilter:LArG4ParticleFilter       1.3711e-05    6.00785e-05   0.00232762    2.0203e-05    0.000208427      335    
[art]:TriggerResults:TriggerResultInserter    1.1001e-05    1.48822e-05   4.5965e-05    1.3557e-05    3.46139e-06      335    
end_path:out1:RootOutput                       6.385e-06    1.08425e-05   0.000201664    9.416e-06    1.07783e-05      335    
end_path:out1:RootOutput(write)                5.69e-06     0.00048182     0.158671     6.3045e-06     0.0086687       334    
================================================================================================================================
%MSG-i NuRandomService:  RootOutput:out1@EndJob 19-Aug-2024 14:05:49 UTC  ModuleEndJob

Summary of seeds computed by the NuRandomService
Random policy: 'perEvent'
  algorithm version: EventTimestamp_v1
   Configured value          Last value   ModuleLabel.InstanceName
        (per event)           497143033   IonAndScint.ISCalcAlg
        (per event)           159279575   PDFastSim.photon
        (per event)           710343838   PDFastSim.scinttime
        (per event)           238155930   elecDrift
        (per event)           678251670   largeant

%MSG

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

  Peak virtual memory usage (VmPeak)  : 16451.4 MB
  Peak resident set size usage (VmHWM): 13152.2 MB
====================================================================================================

TrigReport ---------- Event summary -------------
TrigReport Events total = 335 passed = 2 failed = 333

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

TimeReport ---------- Time summary [sec] -------
TimeReport CPU = 10883.930022 Real = 10981.269837

MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 16451.4 VmHWM = 13152.2

=== 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 81516
-rw-r--r-- 1 dunegli fnalgrid 82195603 Aug 19 14:05 RootOutput-5d94-bfed-3f8e-1710.root
-rw-r--r-- 1 dunegli fnalgrid  1249587 Aug 19 14:05 000793_reco_data_2024-08-16T_162901Z_reco_2024-08-19T_105949Z.log
-rw-r--r-- 1 dunegli fnalgrid     7900 Aug 19 14:05 jobscript.log
-rw-r--r-- 1 dunegli fnalgrid      274 Aug 19 11:01 TFileService-725f-47c8-8c68-bc40.root
-rw-r--r-- 1 dunegli fnalgrid      104 Aug 19 10:59 all-input-dids.txt
-rw-r--r-- 1 dunegli fnalgrid        0 Aug 19 14:05 000793_reco_data_2024-08-16T_162901Z_reco_data_2024-08-19T_105949Z.root.ext.json
-rw-r--r-- 1 dunegli fnalgrid        0 Aug 19 14:05 000793_reco_data_2024-08-16T_162901Z_reco_data_2024-08-19T_105949Z.root.json
justIN time: 2024-11-17 14:29:36 UTC       justIN version: 01.01.09