justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID59995.0@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 23:09:18
SiteUS_Colorado
EntryCMSHTPC_T3_US_Colorado_heposg01-colorado
Last heartbeat2024-08-20 01:12:59
From worker nodeHostnamelnxfarm338.colorado.edu
cpuinfoIntel(R) Core(TM) i9-7920X CPU @ 2.90GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4194304000 (4000 MiB)
Wall seconds limit171000 (47 hours)
Inner Apptainer?True
Job statejobscript_error
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-08-19 23:11:06
Input filesusertests:000899_reco_data_2024-08-16T_163024Z.root
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-08-20 01:12:59
Saved logsjustin-logs:59995.0-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/2d/f4/000899_reco_data_2024-08-16T_163024Z.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 ===
	phot : 386403
	Pair : 70
%MSG
%MSG-i endOfEventAction:  larg4Main:largeant@BeginModule  19-Aug-2024 17:56:30 MDT run: 20000031 subRun: 0 event: 715 ParticleListAction.cc:701
MCTruth Handles Size: 1
%MSG
%MSG-i endOfEventAction:  larg4Main:largeant@BeginModule  19-Aug-2024 17:56:30 MDT run: 20000031 subRun: 0 event: 715 ParticleListAction.cc:708
mclistHandle Size: 1
%MSG
%MSG-i endOfEventAction:  larg4Main:largeant@BeginModule  19-Aug-2024 17:56:30 MDT run: 20000031 subRun: 0 event: 715 ParticleListAction.cc:711
Found 1 particles
%MSG
%MSG-i NuRandomService:  IonAndScint:IonAndScint@BeginModule  19-Aug-2024 17:56:30 MDT run: 20000031 subRun: 0 event: 715
Random seed for this event, engine 'IonAndScint.ISCalcAlg': 472279041
%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 17:56:34 MDT run: 20000031 subRun: 0 event: 715
Random seed for this event, engine 'elecDrift': 546873824
%MSG
%MSG-i NuRandomService:  PDFastSimPAR:PDFastSim@BeginModule  19-Aug-2024 17:57:25 MDT run: 20000031 subRun: 0 event: 715
Random seed for this event, engine 'PDFastSim.photon': 49809666
%MSG
%MSG-i NuRandomService:  PDFastSimPAR:PDFastSim@BeginModule  19-Aug-2024 17:57:25 MDT run: 20000031 subRun: 0 event: 715
Random seed for this event, engine 'PDFastSim.scinttime': 411700662
%MSG
IonAndScint endJob.
19-Aug-2024 19:11:55 MDT  Closed input file "root://fndca1.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/usertests/2d/f4/000899_reco_data_2024-08-16T_163024Z.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                     0.0127349      9.99815       4569.7       0.268323       172.961        715    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        9.4095e-05    0.000776543    0.0804453    0.000141334   0.00517997       715    
simulate:rns:RandomNumberSaver                1.7741e-05    3.0556e-05    0.00030519    2.9057e-05    1.35766e-05      715    
simulate:largeant:larg4Main                    0.0119666     0.583622       55.2559       0.23177       2.49832        715    
simulate:IonAndScint:IonAndScint              8.7093e-05     0.0086629      4.49367     0.000128013    0.168804        715    
simulate:elecDrift:SimDriftElectrons          3.1009e-05     0.0978371      50.2701     5.5773e-05      1.88896        715    
simulate:PDFastSim:PDFastSimPAR               4.4381e-05      9.27136       4459.68     7.6593e-05      168.71         715    
simulate:muonfilter:LArG4ParticleFilter       1.2556e-05     5.587e-05    0.00357689     2.158e-05    0.000199724      715    
[art]:TriggerResults:TriggerResultInserter       8e-06      1.20745e-05   4.9607e-05    1.2052e-05    3.16568e-06      715    
end_path:out1:RootOutput                       6.229e-06    9.19056e-06   0.000247921    8.857e-06    9.03919e-06      715    
end_path:out1:RootOutput(write)                2.483e-06     0.0352829      20.2122      3.744e-06      0.75853        714    
================================================================================================================================
%MSG-i NuRandomService:  RootOutput:out1@EndJob 19-Aug-2024 19:11:55 MDT  ModuleEndJob

Summary of seeds computed by the NuRandomService
Random policy: 'perEvent'
  algorithm version: EventTimestamp_v1
   Configured value          Last value   ModuleLabel.InstanceName
        (per event)           472279041   IonAndScint.ISCalcAlg
        (per event)            49809666   PDFastSim.photon
        (per event)           411700662   PDFastSim.scinttime
        (per event)           546873824   elecDrift
        (per event)           204756956   largeant

%MSG

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

  Peak virtual memory usage (VmPeak)  : 12686.1 MB
  Peak resident set size usage (VmHWM): 11103.7 MB
====================================================================================================

TrigReport ---------- Event summary -------------
TrigReport Events total = 715 passed = 12 failed = 703

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

TimeReport ---------- Time summary [sec] -------
TimeReport CPU = 7167.109531 Real = 7183.732491

MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 12686.1 VmHWM = 11103.7

%MSG-s ArtException:  PostEndJob 19-Aug-2024 19:12:45 MDT ModuleEndJob
---- EventProcessorFailure BEGIN
  EventProcessor: an exception occurred during current event processing
  ---- FatalRootError BEGIN
    Fatal Root Error: TBufferFile::WriteByteCount
    bytecount too large (more than 1073741822)
    ROOT severity: 3000
  ---- FatalRootError END
---- EventProcessorFailure END
---- FatalRootError BEGIN
  Fatal Root Error: TTree::SetEntries
  Tree branches have different numbers of entries, eg EventAuxiliary has 11 entries while sim::SimChannels_elecDrift__G4. has 12 entries.
  ROOT severity: 2000
---- FatalRootError END
%MSG
Art has completed and will exit with status 1.
=== 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 1443444
-rw-r--r-- 1 dunepilot gridusers 1475476171 Aug 19 19:12 RootOutput-a59f-2924-605b-a9a2.root
-rw-r--r-- 1 dunepilot gridusers    2591289 Aug 19 19:12 000899_reco_data_2024-08-16T_163024Z_reco_2024-08-19T_231110Z.log
-rw-r--r-- 1 dunepilot gridusers       7613 Aug 19 19:12 jobscript.log
-rw-r--r-- 1 dunepilot gridusers        519 Aug 19 19:12 g4_hist.root
-rw-r--r-- 1 dunepilot gridusers        104 Aug 19 17:11 all-input-dids.txt
-rw-r--r-- 1 dunepilot gridusers          0 Aug 19 19:12 000899_reco_data_2024-08-16T_163024Z_reco_data_2024-08-19T_231110Z.root.ext.json
-rw-r--r-- 1 dunepilot gridusers          0 Aug 19 19:12 000899_reco_data_2024-08-16T_163024Z_reco_data_2024-08-19T_231110Z.root.json
justIN time: 2024-11-17 08:53:25 UTC       justIN version: 01.01.09