Jobsub ID 289860.1@justin-prod-sched01.dune.hep.ac.uk
| Jobsub ID | 289860.1@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-14 20:38:21 |
| Site | US_Colorado |
| Entry | CMSHTPC_T3_US_Colorado_heposg01-colorado |
| Last heartbeat | 2024-11-14 21:59:37 |
| From worker node | Hostname | lnxfarm326.colorado.edu |
| cpuinfo | Intel(R) Core(TM) i7-7820X CPU @ 3.60GHz |
| OS release | Scientific Linux release 7.9 (Nitrogen) |
| Processors | 1 |
| RSS bytes | 8388608000 (8000 MiB) |
| Wall seconds limit | 171000 (47 hours) |
| Inner Apptainer? | True |
| Job state | jobscript_error |
| Allocator name | justin-allocator-pro.dune.hep.ac.uk |
| Started | 2024-11-14 20:40:32 |
| Input files | usertests:000958_reco_data_2024-11-14T_093606Z.root
|
| Jobscript | Exit code | 1 |
| Real time | 0m (0s) |
| CPU time | 0m (0s = 0%) |
| Outputting started | |
| Output files | |
| Finished | 2024-11-14 21:59:37 |
| Saved logs | justin-logs:289860.1-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://fndca1.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/usertests/2f/4e/000958_reco_data_2024-11-14T_093606Z.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 : 189862
conv : 30868
Ion : 82729
%MSG
%MSG-i endOfEventAction: larg4Main:largeant@BeginModule 14-Nov-2024 14:16:03 MST run: 20000031 subRun: 0 event: 552 ParticleListAction.cc:701
MCTruth Handles Size: 1
%MSG
%MSG-i endOfEventAction: larg4Main:largeant@BeginModule 14-Nov-2024 14:16:03 MST run: 20000031 subRun: 0 event: 552 ParticleListAction.cc:708
mclistHandle Size: 1
%MSG
%MSG-i endOfEventAction: larg4Main:largeant@BeginModule 14-Nov-2024 14:16:03 MST run: 20000031 subRun: 0 event: 552 ParticleListAction.cc:711
Found 1 particles
%MSG
%MSG-i NuRandomService: IonAndScint:IonAndScint@BeginModule 14-Nov-2024 14:16:03 MST run: 20000031 subRun: 0 event: 552
Random seed for this event, engine 'IonAndScint.ISCalcAlg': 363878259
%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 14:16:06 MST run: 20000031 subRun: 0 event: 552
Random seed for this event, engine 'elecDrift': 85925006
%MSG
%MSG-i NuRandomService: PDFastSimPAR:PDFastSim@BeginModule 14-Nov-2024 14:16:50 MST run: 20000031 subRun: 0 event: 552
Random seed for this event, engine 'PDFastSim.photon': 755649865
%MSG
%MSG-i NuRandomService: PDFastSimPAR:PDFastSim@BeginModule 14-Nov-2024 14:16:50 MST run: 20000031 subRun: 0 event: 552
Random seed for this event, engine 'PDFastSim.scinttime': 661254723
%MSG
IonAndScint endJob.
14-Nov-2024 14:58:58 MST Closed input file "root://fndca1.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/usertests/2f/4e/000958_reco_data_2024-11-14T_093606Z.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 0.0114059 8.31879 2592.56 0.275423 111.979 552
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 8.3212e-05 0.000543699 0.0260556 0.000136313 0.00298607 552
simulate:rns:RandomNumberSaver 1.8613e-05 3.01583e-05 0.000259361 2.90535e-05 1.13658e-05 552
simulate:largeant:larg4Main 0.0101767 0.646487 31.3097 0.242692 2.40136 552
simulate:IonAndScint:IonAndScint 8.5286e-05 0.00763295 2.71041 0.000119055 0.116761 552
simulate:elecDrift:SimDriftElectrons 3.0383e-05 0.112216 44.4249 4.89395e-05 1.90119 552
simulate:PDFastSim:PDFastSimPAR 4.5259e-05 7.44732 2520.58 6.94055e-05 108.811 552
[art]:TriggerResults:TriggerResultInserter 7.47e-06 1.05741e-05 5.3001e-05 1.08125e-05 2.56821e-06 552
end_path:out1:RootOutput 2.315e-06 3.06244e-06 1.9254e-05 2.9925e-06 7.90896e-07 552
end_path:out1:RootOutput(write) 0.000590839 0.104225 7.84395 0.00366352 0.476512 551
================================================================================================================================
%MSG-i NuRandomService: RootOutput:out1@EndJob 14-Nov-2024 14:58:58 MST ModuleEndJob
Summary of seeds computed by the NuRandomService
Random policy: 'perEvent'
algorithm version: EventTimestamp_v1
Configured value Last value ModuleLabel.InstanceName
(per event) 363878259 IonAndScint.ISCalcAlg
(per event) 755649865 PDFastSim.photon
(per event) 661254723 PDFastSim.scinttime
(per event) 85925006 elecDrift
(per event) 752665758 largeant
%MSG
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 10445.3 MB
Peak resident set size usage (VmHWM): 7742.56 MB
====================================================================================================
TrigReport ---------- Event summary -------------
TrigReport Events total = 552 passed = 552 failed = 0
TrigReport ---------- Modules in End-path ----------
TrigReport Run Success Error Name
TrigReport 552 552 0 out1
TimeReport ---------- Time summary [sec] -------
TimeReport CPU = 4609.212212 Real = 4621.712743
MemReport ---------- Memory summary [base-10 MB] ------
MemReport VmPeak = 10445.3 VmHWM = 7742.56
%MSG-s ArtException: PostEndJob 14-Nov-2024 14:59:24 MST 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 551 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 1795872
-rw-r--r-- 1 dunepilot gridusers 1836933194 Nov 14 14:59 RootOutput-4f29-2915-18f0-db11.root
-rw-r--r-- 1 dunepilot gridusers 2016172 Nov 14 14:59 000958_reco_data_2024-11-14T_093606Z_reco_2024-11-14T_204036Z.log
-rw-r--r-- 1 dunepilot gridusers 7518 Nov 14 14:59 jobscript.log
-rw-r--r-- 1 dunepilot gridusers 519 Nov 14 14:59 g4_hist.root
-rw-r--r-- 1 dunepilot gridusers 104 Nov 14 13:40 all-input-dids.txt
-rw-r--r-- 1 dunepilot gridusers 0 Nov 14 14:59 000958_reco_data_2024-11-14T_093606Z_reco_data_2024-11-14T_204036Z.root.ext.json
-rw-r--r-- 1 dunepilot gridusers 0 Nov 14 14:59 000958_reco_data_2024-11-14T_093606Z_reco_data_2024-11-14T_204036Z.root.json 