Jobsub ID 97128.0@justin-prod-sched02.dune.hep.ac.uk
Jobsub ID | 97128.0@justin-prod-sched02.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-14 17:57:51 |
Site | UK_Lancaster |
Entry | UBoone_UK_Lancaster_HEC_grendel_ce02 |
Last heartbeat | 2024-11-14 18:52:10 |
From worker node | Hostname | comp23-13 |
cpuinfo | Intel(R) Xeon(R) Gold 6248 CPU @ 2.50GHz |
OS release | Scientific Linux release 7.9 (Nitrogen) |
Processors | 1 |
RSS bytes | 8388608000 (8000 MiB) |
Wall seconds limit | 257400 (71 hours) |
Inner Apptainer? | True |
Job state | jobscript_error |
Allocator name | justin-allocator-pro.dune.hep.ac.uk |
Started | 2024-11-14 17:59:53 |
Input files | usertests:000843_reco_data_2024-11-14T_093504Z.root
|
Jobscript | Exit code | 1 |
Real time | 0m (0s) |
CPU time | 0m (0s = 0%) |
Outputting started | |
Output files | |
Finished | 2024-11-14 18:52:10 |
Saved logs | justin-logs:97128.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://xrootd.echo.stfc.ac.uk:1094/dune:/protodune/RSE/usertests/d9/83/000843_reco_data_2024-11-14T_093504Z.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 : 292274
conv : 47684
Ion : 128728
%MSG
%MSG-i endOfEventAction: larg4Main:largeant@BeginModule 14-Nov-2024 18:08:55 GMT run: 20000031 subRun: 0 event: 203 ParticleListAction.cc:701
MCTruth Handles Size: 1
%MSG
%MSG-i endOfEventAction: larg4Main:largeant@BeginModule 14-Nov-2024 18:08:55 GMT run: 20000031 subRun: 0 event: 203 ParticleListAction.cc:708
mclistHandle Size: 1
%MSG
%MSG-i endOfEventAction: larg4Main:largeant@BeginModule 14-Nov-2024 18:08:55 GMT run: 20000031 subRun: 0 event: 203 ParticleListAction.cc:711
Found 1 particles
%MSG
%MSG-i NuRandomService: IonAndScint:IonAndScint@BeginModule 14-Nov-2024 18:08:55 GMT run: 20000031 subRun: 0 event: 203
Random seed for this event, engine 'IonAndScint.ISCalcAlg': 479085335
%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 18:08:58 GMT run: 20000031 subRun: 0 event: 203
Random seed for this event, engine 'elecDrift': 835691049
%MSG
%MSG-i NuRandomService: PDFastSimPAR:PDFastSim@BeginModule 14-Nov-2024 18:09:21 GMT run: 20000031 subRun: 0 event: 203
Random seed for this event, engine 'PDFastSim.photon': 88944450
%MSG
%MSG-i NuRandomService: PDFastSimPAR:PDFastSim@BeginModule 14-Nov-2024 18:09:21 GMT run: 20000031 subRun: 0 event: 203
Random seed for this event, engine 'PDFastSim.scinttime': 20091416
%MSG
IonAndScint endJob.
14-Nov-2024 18:51:17 GMT Closed input file "root://xrootd.echo.stfc.ac.uk:1094/dune:/protodune/RSE/usertests/d9/83/000843_reco_data_2024-11-14T_093504Z.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 0.00984048 14.631 2567.17 0.222637 179.663 203
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 7.0963e-05 0.000552002 0.030109 0.000105578 0.00312023 203
simulate:rns:RandomNumberSaver 1.3579e-05 2.578e-05 0.00040357 2.2502e-05 2.71738e-05 203
simulate:largeant:larg4Main 0.0072916 0.551266 33.0691 0.194912 2.50538 203
simulate:IonAndScint:IonAndScint 5.7847e-05 0.0136829 2.48613 9.1152e-05 0.174007 203
simulate:elecDrift:SimDriftElectrons 2.9307e-05 0.129236 23.3084 3.6885e-05 1.63143 203
simulate:PDFastSim:PDFastSimPAR 4.1518e-05 13.8653 2508.3 5.352e-05 175.565 203
[art]:TriggerResults:TriggerResultInserter 5.958e-06 9.07282e-06 3.466e-05 8.095e-06 2.90051e-06 203
end_path:out1:RootOutput 1.634e-06 3.06079e-06 1.1983e-05 2.783e-06 1.01002e-06 203
end_path:out1:RootOutput(write) 0.00053762 0.0708658 1.0867 0.00288909 0.187855 202
================================================================================================================================
%MSG-i NuRandomService: RootOutput:out1@EndJob 14-Nov-2024 18:51:17 GMT ModuleEndJob
Summary of seeds computed by the NuRandomService
Random policy: 'perEvent'
algorithm version: EventTimestamp_v1
Configured value Last value ModuleLabel.InstanceName
(per event) 479085335 IonAndScint.ISCalcAlg
(per event) 88944450 PDFastSim.photon
(per event) 20091416 PDFastSim.scinttime
(per event) 835691049 elecDrift
(per event) 135924700 largeant
%MSG
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 11191.6 MB
Peak resident set size usage (VmHWM): 8642.42 MB
====================================================================================================
TrigReport ---------- Event summary -------------
TrigReport Events total = 203 passed = 203 failed = 0
TrigReport ---------- Modules in End-path ----------
TrigReport Run Success Error Name
TrigReport 203 203 0 out1
TimeReport ---------- Time summary [sec] -------
TimeReport CPU = 2978.797670 Real = 2990.483095
MemReport ---------- Memory summary [base-10 MB] ------
MemReport VmPeak = 11191.6 VmHWM = 8642.42
%MSG-s ArtException: PostEndJob 14-Nov-2024 18:51:45 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 202 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 938540
-rw-r--r-- 1 pltdune002 pltdune 960259340 Nov 14 18:51 RootOutput-69b4-83c5-96d9-8089.root
-rw-r--r-- 1 pltdune002 pltdune 784276 Nov 14 18:51 000843_reco_data_2024-11-14T_093504Z_reco_2024-11-14T_175958Z.log
-rw-r--r-- 1 pltdune002 pltdune 7488 Nov 14 18:51 jobscript.log
-rw-r--r-- 1 pltdune002 pltdune 519 Nov 14 18:51 g4_hist.root
-rw-r--r-- 1 pltdune002 pltdune 104 Nov 14 17:59 all-input-dids.txt
-rw-r--r-- 1 pltdune002 pltdune 0 Nov 14 18:51 000843_reco_data_2024-11-14T_093504Z_reco_data_2024-11-14T_175958Z.root.ext.json
-rw-r--r-- 1 pltdune002 pltdune 0 Nov 14 18:51 000843_reco_data_2024-11-14T_093504Z_reco_data_2024-11-14T_175958Z.root.json