justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID97623.1@justin-prod-sched02.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-15 05:32:01
SiteUS_FNAL-FermiGrid
EntryFNAL_GPGrid_ce04_mcore_op_duneonly
Last heartbeat2024-11-15 09:47:26
From worker nodeHostnamedunegli-4216307-0-fnpc9032.fnal.gov
cpuinfoIntel(R) Xeon(R) CPU E5-2680 v4 @ 2.40GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes8388608000 (8000 MiB)
Wall seconds limit172800 (48 hours)
Inner Apptainer?True
Job stateoutputting_failed
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-11-15 05:33:31
Input filesusertests:000194_reco_data_2024-11-14T_092713Z.root
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-11-15 09:47:26
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/c4/b3/000194_reco_data_2024-11-14T_092713Z.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:  1127 Aborted                 (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 ===
%MSG-i generatePrimaries:  larg4Main:largeant@BeginModule  15-Nov-2024 06:02:56 UTC run: 20000031 subRun: 0 event: 721 MCTruthEventAction.cc:112
Generating 1 particles
%MSG
%MSG-i ParticleListActionService:  larg4Main:largeant@BeginModule  15-Nov-2024 06:06:01 UTC run: 20000031 subRun: 0 event: 721
Not Stored Process summary:
	compt : 4308273
	annihil : 199212
	Pair : 104
	phot : 1311068
	Brem : 1202872
	conv : 199100
	Ion : 483457
%MSG
%MSG-i endOfEventAction:  larg4Main:largeant@BeginModule  15-Nov-2024 06:06:01 UTC run: 20000031 subRun: 0 event: 721 ParticleListAction.cc:701
MCTruth Handles Size: 1
%MSG
%MSG-i endOfEventAction:  larg4Main:largeant@BeginModule  15-Nov-2024 06:06:01 UTC run: 20000031 subRun: 0 event: 721 ParticleListAction.cc:708
mclistHandle Size: 1
%MSG
%MSG-i endOfEventAction:  larg4Main:largeant@BeginModule  15-Nov-2024 06:06:01 UTC run: 20000031 subRun: 0 event: 721 ParticleListAction.cc:711
Found 1 particles
%MSG
%MSG-i NuRandomService:  IonAndScint:IonAndScint@BeginModule  15-Nov-2024 06:06:01 UTC run: 20000031 subRun: 0 event: 721
Random seed for this event, engine 'IonAndScint.ISCalcAlg': 647198573
%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  15-Nov-2024 06:06:14 UTC run: 20000031 subRun: 0 event: 721
Random seed for this event, engine 'elecDrift': 184186539
%MSG
%MSG-i NuRandomService:  PDFastSimPAR:PDFastSim@BeginModule  15-Nov-2024 06:08:23 UTC run: 20000031 subRun: 0 event: 721
Random seed for this event, engine 'PDFastSim.photon': 47091852
%MSG
%MSG-i NuRandomService:  PDFastSimPAR:PDFastSim@BeginModule  15-Nov-2024 06:08:23 UTC run: 20000031 subRun: 0 event: 721
Random seed for this event, engine 'PDFastSim.scinttime': 773342013
%MSG
IonAndScint endJob.
15-Nov-2024 09:47:08 UTC  Closed input file "root://fndca1.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/usertests/c4/b3/000194_reco_data_2024-11-14T_092713Z.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                    0.00749392      20.9066       13436.7      0.307921       500.041        721    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        5.8462e-05    0.00017574    0.00344899    0.000116506   0.000213199      721    
simulate:rns:RandomNumberSaver                1.5754e-05    2.8305e-05    0.000243032   2.5173e-05    1.10927e-05      721    
simulate:largeant:larg4Main                   0.00592545     0.756033       185.517      0.275667       7.00204        721    
simulate:IonAndScint:IonAndScint              6.1397e-05     0.0189254      12.5432     0.00011678     0.466795        721    
simulate:elecDrift:SimDriftElectrons           3.803e-05     0.196819       129.446     5.7017e-05      4.81739        721    
simulate:PDFastSim:PDFastSimPAR               5.2005e-05      19.8193       13109.2     9.0643e-05      487.864        721    
[art]:TriggerResults:TriggerResultInserter     7.129e-06    1.28527e-05    6.495e-05    1.1517e-05    4.34233e-06      721    
end_path:out1:RootOutput                       1.197e-06    3.49358e-06   2.4641e-05     3.29e-06     1.46602e-06      721    
end_path:out1:RootOutput(write)               0.000470959    0.114906       14.8564      0.0033687     0.735098        720    
================================================================================================================================
%MSG-i NuRandomService:  RootOutput:out1@EndJob 15-Nov-2024 09:47:08 UTC  ModuleEndJob

Summary of seeds computed by the NuRandomService
Random policy: 'perEvent'
  algorithm version: EventTimestamp_v1
   Configured value          Last value   ModuleLabel.InstanceName
        (per event)           647198573   IonAndScint.ISCalcAlg
        (per event)            47091852   PDFastSim.photon
        (per event)           773342013   PDFastSim.scinttime
        (per event)           184186539   elecDrift
        (per event)           777949297   largeant

%MSG

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

  Peak virtual memory usage (VmPeak)  : 28040.7 MB
  Peak resident set size usage (VmHWM): 21651.4 MB
====================================================================================================

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

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

TimeReport ---------- Time summary [sec] -------
TimeReport CPU = 15026.314579 Real = 15108.914581

MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 28040.7 VmHWM = 21651.4

terminate called after throwing an instance of 'cet::coded_exception<art::errors::ErrorCodes, &art::ExceptionDetail::translate[abi:cxx11]>'
  what():  ---- FatalRootError BEGIN
  Fatal Root Error: TBufferFile::AutoExpand
  Request to expand to a negative size, likely due to an integer overflow: 0x8000002e for a max of 0x7ffffffe.
  ROOT severity: 6000
---- FatalRootError END

=== 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 1116676
-rw-r--r-- 1 dunegli fnalgrid 1140843482 Nov 15 09:47 RootOutput-2c65-232a-31f3-9ca4.root
-rw-r--r-- 1 dunegli fnalgrid    2612135 Nov 15 09:47 000194_reco_data_2024-11-14T_092713Z_reco_2024-11-15T_053343Z.log
-rw-r--r-- 1 dunegli fnalgrid       7751 Nov 15 09:47 jobscript.log
-rw-r--r-- 1 dunegli fnalgrid        274 Nov 15 05:33 TFileService-0eeb-fc73-6143-2a54.root
-rw-r--r-- 1 dunegli fnalgrid        104 Nov 15 05:33 all-input-dids.txt
-rw-r--r-- 1 dunegli fnalgrid          0 Nov 15 09:47 000194_reco_data_2024-11-14T_092713Z_reco_data_2024-11-15T_053343Z.root.ext.json
-rw-r--r-- 1 dunegli fnalgrid          0 Nov 15 09:47 000194_reco_data_2024-11-14T_092713Z_reco_data_2024-11-15T_053343Z.root.json
justIN time: 2024-11-17 14:46:04 UTC       justIN version: 01.01.09