justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID271906.2@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 21:43:29
SiteUK_RAL-Tier1
EntryLIGO_UK_RAL_arc_ce04
Last heartbeat2024-10-09 01:05:37
From worker nodeHostnamedune001-2466541.0-lcg2561.gridpp.rl.ac.uk
cpuinfoAMD EPYC 7452 32-Core Processor
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4194304000 (4000 MiB)
Wall seconds limit216000 (60 hours)
Inner Apptainer?True
Job statejobscript_error
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-10-08 21:48:53
Input filesusertests:000894_reco_data_2024-10-07T_120201Z.root
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-10-09 01:05:37
Saved logsjustin-logs:271906.2-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/ec/81/000894_reco_data_2024-10-07T_120201Z.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 ===
	conv : 56766
	Ion : 151944
%MSG
%MSG-i endOfEventAction:  larg4Main:largeant@BeginModule  08-Oct-2024 23:00:54 UTC run: 20000031 subRun: 0 event: 998 ParticleListAction.cc:701
MCTruth Handles Size: 1
%MSG
%MSG-i endOfEventAction:  larg4Main:largeant@BeginModule  08-Oct-2024 23:00:54 UTC run: 20000031 subRun: 0 event: 998 ParticleListAction.cc:708
mclistHandle Size: 1
%MSG
%MSG-i endOfEventAction:  larg4Main:largeant@BeginModule  08-Oct-2024 23:00:54 UTC run: 20000031 subRun: 0 event: 998 ParticleListAction.cc:711
Found 1 particles
%MSG
%MSG-i NuRandomService:  IonAndScint:IonAndScint@BeginModule  08-Oct-2024 23:00:54 UTC run: 20000031 subRun: 0 event: 998
Random seed for this event, engine 'IonAndScint.ISCalcAlg': 303164900
%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 23:01:03 UTC run: 20000031 subRun: 0 event: 998
Random seed for this event, engine 'elecDrift': 338367077
%MSG
%MSG-i NuRandomService:  PDFastSimPAR:PDFastSim@BeginModule  08-Oct-2024 23:02:12 UTC run: 20000031 subRun: 0 event: 998
Random seed for this event, engine 'PDFastSim.photon': 540501548
%MSG
%MSG-i NuRandomService:  PDFastSimPAR:PDFastSim@BeginModule  08-Oct-2024 23:02:12 UTC run: 20000031 subRun: 0 event: 998
Random seed for this event, engine 'PDFastSim.scinttime': 580728261
%MSG
IonAndScint endJob.
09-Oct-2024 01:03:54 UTC  Closed input file "root://eospublic.cern.ch:1094//eos/experiment/neutplatform/protodune/dune/usertests/ec/81/000894_reco_data_2024-10-07T_120201Z.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                    0.00961954      11.514        7448.07      0.414184       236.122        998    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.000111632   0.000751257    0.0444931    0.000157902   0.00398987       998    
simulate:rns:RandomNumberSaver                 1.929e-05    3.48435e-05   0.000366574   3.08555e-05   1.54518e-05      998    
simulate:largeant:larg4Main                   0.00840518     0.761486       91.448       0.359817       3.29655        998    
simulate:IonAndScint:IonAndScint              0.000113442    0.0127868      9.4703      0.000162963    0.299897        998    
simulate:elecDrift:SimDriftElectrons           3.985e-05     0.102041       68.4719     6.24905e-05     2.17237        998    
simulate:PDFastSim:PDFastSimPAR               5.6831e-05      10.6198       7278.68     8.9186e-05      230.751        998    
simulate:muonfilter:LArG4ParticleFilter        1.468e-05    7.15441e-05    0.0038519    2.41755e-05   0.000252266      998    
[art]:TriggerResults:TriggerResultInserter     1.008e-05    1.58121e-05   8.8041e-05     1.522e-05    4.9272e-06       998    
end_path:out1:RootOutput                       8.19e-06     1.25386e-05   0.000375135    1.163e-05    1.1969e-05       998    
end_path:out1:RootOutput(write)                3.21e-06      0.0162602      10.3391      5.13e-06      0.341887        997    
================================================================================================================================
%MSG-i NuRandomService:  RootOutput:out1@EndJob 09-Oct-2024 01:03:54 UTC  ModuleEndJob

Summary of seeds computed by the NuRandomService
Random policy: 'perEvent'
  algorithm version: EventTimestamp_v1
   Configured value          Last value   ModuleLabel.InstanceName
        (per event)           303164900   IonAndScint.ISCalcAlg
        (per event)           540501548   PDFastSim.photon
        (per event)           580728261   PDFastSim.scinttime
        (per event)           338367077   elecDrift
        (per event)           502101633   largeant

%MSG

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

  Peak virtual memory usage (VmPeak)  : 12482.6 MB
  Peak resident set size usage (VmHWM): 10781.1 MB
====================================================================================================

TrigReport ---------- Event summary -------------
TrigReport Events total = 998 passed = 8 failed = 990

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

TimeReport ---------- Time summary [sec] -------
TimeReport CPU = 11409.537345 Real = 11545.811606

MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 12482.6 VmHWM = 10781.1

%MSG-s ArtException:  PostEndJob 09-Oct-2024 01:05:05 UTC 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 7 entries while sim::SimChannels_elecDrift__G4. has 8 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 1254664
-rw-r--r-- 1 dune001 dune 1281167236 Oct  9 01:05 RootOutput-c74b-a531-33c6-c1e7.root
-rw-r--r-- 1 dune001 dune    3589957 Oct  9 01:05 000894_reco_data_2024-10-07T_120201Z_reco_2024-10-08T_214912Z.log
-rw-r--r-- 1 dune001 dune       7623 Oct  9 01:05 jobscript.log
-rw-r--r-- 1 dune001 dune        519 Oct  9 01:05 g4_hist.root
-rw-r--r-- 1 dune001 dune        104 Oct  8 21:48 all-input-dids.txt
-rw-r--r-- 1 dune001 dune          0 Oct  9 01:05 000894_reco_data_2024-10-07T_120201Z_reco_data_2024-10-08T_214912Z.root.ext.json
-rw-r--r-- 1 dune001 dune          0 Oct  9 01:05 000894_reco_data_2024-10-07T_120201Z_reco_data_2024-10-08T_214912Z.root.json
justIN time: 2024-11-24 07:51:32 UTC       justIN version: 01.01.09