Jobsub ID 290119.0@justin-prod-sched01.dune.hep.ac.uk
| Jobsub ID | 290119.0@justin-prod-sched01.dune.hep.ac.uk |
| Workflow ID | 4103 |
| Stage ID | 1 |
| User name | amoor@fnal.gov |
| HTCondor Group | group_dune |
| Requested | Processors | 1 |
| RSS bytes | 8388608000 (8000 MiB) |
| Wall seconds limit | 80000 (22 hours) |
| Submitted time | 2024-11-15 01:09:58 |
| Site | UK_RAL-Tier1 |
| Entry | LIGO_UK_RAL_arc_ce04 |
| Last heartbeat | 2024-11-15 02:57:04 |
| From worker node | Hostname | dune001-2910002.0-lcg2725.gridpp.rl.ac.uk |
| cpuinfo | AMD EPYC 9654 96-Core Processor |
| OS release | Scientific Linux release 7.9 (Nitrogen) |
| Processors | 1 |
| RSS bytes | 8388608000 (8000 MiB) |
| Wall seconds limit | 216000 (60 hours) |
| Inner Apptainer? | True |
| Job state | outputting_failed |
| Allocator name | justin-allocator-pro.dune.hep.ac.uk |
| Started | 2024-11-15 01:12:18 |
| Input files | usertests:000852_reco_data_2024-11-14T_093508Z.root
|
| Jobscript | Exit code | 1 |
| Real time | 0m (0s) |
| CPU time | 0m (0s = 0%) |
| Outputting started | |
| Output files | |
| Finished | 2024-11-15 02:57:04 |
| 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/51/17/000852_reco_data_2024-11-14T_093508Z.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 : 280312
conv : 45346
Ion : 121089
%MSG
%MSG-i endOfEventAction: larg4Main:largeant@BeginModule 15-Nov-2024 01:58:16 UTC run: 20000031 subRun: 0 event: 847 ParticleListAction.cc:701
MCTruth Handles Size: 1
%MSG
%MSG-i endOfEventAction: larg4Main:largeant@BeginModule 15-Nov-2024 01:58:16 UTC run: 20000031 subRun: 0 event: 847 ParticleListAction.cc:708
mclistHandle Size: 1
%MSG
%MSG-i endOfEventAction: larg4Main:largeant@BeginModule 15-Nov-2024 01:58:16 UTC run: 20000031 subRun: 0 event: 847 ParticleListAction.cc:711
Found 1 particles
%MSG
%MSG-i NuRandomService: IonAndScint:IonAndScint@BeginModule 15-Nov-2024 01:58:16 UTC run: 20000031 subRun: 0 event: 847
Random seed for this event, engine 'IonAndScint.ISCalcAlg': 212310818
%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 01:58:19 UTC run: 20000031 subRun: 0 event: 847
Random seed for this event, engine 'elecDrift': 618930817
%MSG
%MSG-i NuRandomService: PDFastSimPAR:PDFastSim@BeginModule 15-Nov-2024 01:58:50 UTC run: 20000031 subRun: 0 event: 847
Random seed for this event, engine 'PDFastSim.photon': 166905747
%MSG
%MSG-i NuRandomService: PDFastSimPAR:PDFastSim@BeginModule 15-Nov-2024 01:58:50 UTC run: 20000031 subRun: 0 event: 847
Random seed for this event, engine 'PDFastSim.scinttime': 512777870
%MSG
IonAndScint endJob.
15-Nov-2024 02:56:06 UTC Closed input file "root://eospublic.cern.ch:1094//eos/experiment/neutplatform/protodune/dune/usertests/51/17/000852_reco_data_2024-11-14T_093508Z.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 0.00530293 7.24775 3497.17 0.243071 120.727 847
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 7.1948e-05 0.000678198 0.0426173 0.000140903 0.00379222 847
simulate:rns:RandomNumberSaver 1.4963e-05 3.17422e-05 0.000333123 2.9224e-05 1.33897e-05 847
simulate:largeant:larg4Main 0.00422256 0.397877 36.2221 0.207273 1.40048 847
simulate:IonAndScint:IonAndScint 7.7507e-05 0.00588049 2.86397 0.000141644 0.0989927 847
simulate:elecDrift:SimDriftElectrons 2.6059e-05 0.0645365 30.4807 4.4668e-05 1.06342 847
simulate:PDFastSim:PDFastSimPAR 3.8648e-05 6.67697 3427.6 6.8233e-05 118.291 847
[art]:TriggerResults:TriggerResultInserter 5.869e-06 1.12762e-05 4.1853e-05 1.0997e-05 3.5928e-06 847
end_path:out1:RootOutput 2.484e-06 4.56922e-06 2.1232e-05 4.537e-06 7.5795e-07 847
end_path:out1:RootOutput(write) 0.000484052 0.101339 5.6656 0.00346253 0.368632 846
================================================================================================================================
%MSG-i NuRandomService: RootOutput:out1@EndJob 15-Nov-2024 02:56:06 UTC ModuleEndJob
Summary of seeds computed by the NuRandomService
Random policy: 'perEvent'
algorithm version: EventTimestamp_v1
Configured value Last value ModuleLabel.InstanceName
(per event) 212310818 IonAndScint.ISCalcAlg
(per event) 166905747 PDFastSim.photon
(per event) 512777870 PDFastSim.scinttime
(per event) 618930817 elecDrift
(per event) 173096556 largeant
%MSG
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 12202.6 MB
Peak resident set size usage (VmHWM): 10042.1 MB
====================================================================================================
TrigReport ---------- Event summary -------------
TrigReport Events total = 847 passed = 847 failed = 0
TrigReport ---------- Modules in End-path ----------
TrigReport Run Success Error Name
TrigReport 847 847 0 out1
TimeReport ---------- Time summary [sec] -------
TimeReport CPU = 6097.194939 Real = 6173.114843
MemReport ---------- Memory summary [base-10 MB] ------
MemReport VmPeak = 12202.6 VmHWM = 10042.1
%MSG-s ArtException: PostEndJob 15-Nov-2024 02:56:43 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 846 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 2693748
-rw-r--r-- 1 dune001 dune 2755320834 Nov 15 02:56 RootOutput-6d0b-3399-9210-8b1e.root
-rw-r--r-- 1 dune001 dune 3057048 Nov 15 02:56 000852_reco_data_2024-11-14T_093508Z_reco_2024-11-15T_011221Z.log
-rw-r--r-- 1 dune001 dune 7528 Nov 15 02:56 jobscript.log
-rw-r--r-- 1 dune001 dune 519 Nov 15 02:56 g4_hist.root
-rw-r--r-- 1 dune001 dune 104 Nov 15 01:12 all-input-dids.txt
-rw-r--r-- 1 dune001 dune 0 Nov 15 02:56 000852_reco_data_2024-11-14T_093508Z_reco_data_2024-11-15T_011221Z.root.ext.json
-rw-r--r-- 1 dune001 dune 0 Nov 15 02:56 000852_reco_data_2024-11-14T_093508Z_reco_data_2024-11-15T_011221Z.root.json 