justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID97145.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-14 19:32:16
SiteUK_Lancaster
EntryUBoone_UK_Lancaster_HEC_grendel_ce02
Last heartbeat2024-11-14 20:29:49
From worker nodeHostnamecomp23-13
cpuinfoIntel(R) Xeon(R) Gold 6248 CPU @ 2.50GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes8388608000 (8000 MiB)
Wall seconds limit257400 (71 hours)
Inner Apptainer?True
Job statejobscript_error
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-11-14 19:34:11
Input filesusertests:000790_reco_data_2024-11-14T_093429Z.root
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-11-14 20:29:49
Saved logsjustin-logs:97145.1-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://ccxrootdegee.in2p3.fr:1094/pnfs/in2p3.fr/data/dune/disk/usertests/80/cf/000790_reco_data_2024-11-14T_093429Z.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 ===
	Brem : 224241
	conv : 35970
	Ion : 97553
%MSG
%MSG-i endOfEventAction:  larg4Main:largeant@BeginModule  14-Nov-2024 19:39:01 GMT run: 20000031 subRun: 0 event: 77 ParticleListAction.cc:701
MCTruth Handles Size: 1
%MSG
%MSG-i endOfEventAction:  larg4Main:largeant@BeginModule  14-Nov-2024 19:39:01 GMT run: 20000031 subRun: 0 event: 77 ParticleListAction.cc:708
mclistHandle Size: 1
%MSG
%MSG-i endOfEventAction:  larg4Main:largeant@BeginModule  14-Nov-2024 19:39:01 GMT run: 20000031 subRun: 0 event: 77 ParticleListAction.cc:711
Found 1 particles
%MSG
%MSG-i NuRandomService:  IonAndScint:IonAndScint@BeginModule  14-Nov-2024 19:39:02 GMT run: 20000031 subRun: 0 event: 77
Random seed for this event, engine 'IonAndScint.ISCalcAlg': 42050063
%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  14-Nov-2024 19:39:05 GMT run: 20000031 subRun: 0 event: 77
Random seed for this event, engine 'elecDrift': 489545914
%MSG
%MSG-i NuRandomService:  PDFastSimPAR:PDFastSim@BeginModule  14-Nov-2024 19:39:34 GMT run: 20000031 subRun: 0 event: 77
Random seed for this event, engine 'PDFastSim.photon': 566897688
%MSG
%MSG-i NuRandomService:  PDFastSimPAR:PDFastSim@BeginModule  14-Nov-2024 19:39:34 GMT run: 20000031 subRun: 0 event: 77
Random seed for this event, engine 'PDFastSim.scinttime': 212160827
%MSG
IonAndScint endJob.
14-Nov-2024 20:28:52 GMT  Closed input file "root://ccxrootdegee.in2p3.fr:1094/pnfs/in2p3.fr/data/dune/disk/usertests/80/cf/000790_reco_data_2024-11-14T_093429Z.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                     0.0128353      41.3665       3014.33      0.241969       341.048        77     
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.000101835   0.000507037    0.0250685    0.00011847    0.00282161       77     
simulate:rns:RandomNumberSaver                1.7899e-05    3.29944e-05   0.000402759   2.5412e-05    4.35316e-05      77     
simulate:largeant:larg4Main                    0.0112839     0.740778       32.996       0.197395       3.74228        77     
simulate:IonAndScint:IonAndScint              7.6421e-05     0.0404567      2.98685     0.00010002     0.337992        77     
simulate:elecDrift:SimDriftElectrons          3.3163e-05     0.399629       29.4556     4.1721e-05      3.33314        77     
simulate:PDFastSim:PDFastSimPAR               4.9746e-05      40.106        2948.89     6.9068e-05      333.683        77     
[art]:TriggerResults:TriggerResultInserter     7.991e-06    1.03939e-05   3.3292e-05     9.147e-06    3.52403e-06      77     
end_path:out1:RootOutput                       2.385e-06    3.37512e-06    1.341e-05     3.026e-06    1.37915e-06      77     
end_path:out1:RootOutput(write)               0.000674233    0.0795636     0.702361     0.00322196     0.158952        76     
================================================================================================================================
%MSG-i NuRandomService:  RootOutput:out1@EndJob 14-Nov-2024 20:28:52 GMT  ModuleEndJob

Summary of seeds computed by the NuRandomService
Random policy: 'perEvent'
  algorithm version: EventTimestamp_v1
   Configured value          Last value   ModuleLabel.InstanceName
        (per event)            42050063   IonAndScint.ISCalcAlg
        (per event)           566897688   PDFastSim.photon
        (per event)           212160827   PDFastSim.scinttime
        (per event)           489545914   elecDrift
        (per event)           721211580   largeant

%MSG

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

  Peak virtual memory usage (VmPeak)  : 10572.8 MB
  Peak resident set size usage (VmHWM): 8059.85 MB
====================================================================================================

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

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

TimeReport ---------- Time summary [sec] -------
TimeReport CPU = 3194.039213 Real = 3208.861505

MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 10572.8 VmHWM = 8059.85

%MSG-s ArtException:  PostEndJob 14-Nov-2024 20:29:26 GMT 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 76 entries while art::TriggerResults_TriggerResults__MUSUNGen. has 1000 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 829516
-rw-r--r-- 1 pltdune002 pltdune 849067035 Nov 14 20:29 RootOutput-467a-a484-254d-d8d6.root
-rw-r--r-- 1 pltdune002 pltdune    337483 Nov 14 20:29 000790_reco_data_2024-11-14T_093429Z_reco_2024-11-14T_193416Z.log
-rw-r--r-- 1 pltdune002 pltdune      7494 Nov 14 20:29 jobscript.log
-rw-r--r-- 1 pltdune002 pltdune       519 Nov 14 20:29 g4_hist.root
-rw-r--r-- 1 pltdune002 pltdune       104 Nov 14 19:34 all-input-dids.txt
-rw-r--r-- 1 pltdune002 pltdune         0 Nov 14 20:29 000790_reco_data_2024-11-14T_093429Z_reco_data_2024-11-14T_193416Z.root.ext.json
-rw-r--r-- 1 pltdune002 pltdune         0 Nov 14 20:29 000790_reco_data_2024-11-14T_093429Z_reco_data_2024-11-14T_193416Z.root.json
justIN time: 2024-11-21 16:41:10 UTC       justIN version: 01.01.09