Jobsub ID 271906.1@justin-prod-sched01.dune.hep.ac.uk
| Jobsub ID | 271906.1@justin-prod-sched01.dune.hep.ac.uk |
| Workflow ID | 3652 |
| Stage ID | 1 |
| User name | amoor@fnal.gov |
| HTCondor Group | group_dune |
| Requested | Processors | 1 |
| RSS bytes | 4194304000 (4000 MiB) |
| Wall seconds limit | 80000 (22 hours) |
| Submitted time | 2024-10-08 21:43:29 |
| Site | UK_RAL-Tier1 |
| Entry | LIGO_UK_RAL_arc_ce05 |
| Last heartbeat | 2024-10-09 00:12:24 |
| From worker node | Hostname | dune001-2319331.0-lcg2580.gridpp.rl.ac.uk |
| cpuinfo | AMD EPYC 7452 32-Core Processor |
| OS release | Scientific Linux release 7.9 (Nitrogen) |
| Processors | 1 |
| RSS bytes | 4194304000 (4000 MiB) |
| Wall seconds limit | 216000 (60 hours) |
| Inner Apptainer? | True |
| Job state | jobscript_error |
| Allocator name | justin-allocator-pro.dune.hep.ac.uk |
| Started | 2024-10-08 21:48:13 |
| Input files | usertests:000730_reco_data_2024-10-07T_120024Z.root
|
| Jobscript | Exit code | 1 |
| Real time | 0m (0s) |
| CPU time | 0m (0s = 0%) |
| Outputting started | |
| Output files | |
| Finished | 2024-10-09 00:12:24 |
| Saved logs | justin-logs:271906.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://mover.pp.rl.ac.uk:1094/pnfs/pp.rl.ac.uk/data/dune/usertests/54/f7/000730_reco_data_2024-10-07T_120024Z.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 ===
phot : 274848
Pair : 140
%MSG
%MSG-i endOfEventAction: larg4Main:largeant@BeginModule 08-Oct-2024 22:58:26 UTC run: 20000031 subRun: 0 event: 987 ParticleListAction.cc:701
MCTruth Handles Size: 1
%MSG
%MSG-i endOfEventAction: larg4Main:largeant@BeginModule 08-Oct-2024 22:58:26 UTC run: 20000031 subRun: 0 event: 987 ParticleListAction.cc:708
mclistHandle Size: 1
%MSG
%MSG-i endOfEventAction: larg4Main:largeant@BeginModule 08-Oct-2024 22:58:26 UTC run: 20000031 subRun: 0 event: 987 ParticleListAction.cc:711
Found 1 particles
%MSG
%MSG-i NuRandomService: IonAndScint:IonAndScint@BeginModule 08-Oct-2024 22:58:26 UTC run: 20000031 subRun: 0 event: 987
Random seed for this event, engine 'IonAndScint.ISCalcAlg': 629402845
%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 22:58:32 UTC run: 20000031 subRun: 0 event: 987
Random seed for this event, engine 'elecDrift': 380387599
%MSG
%MSG-i NuRandomService: PDFastSimPAR:PDFastSim@BeginModule 08-Oct-2024 22:59:30 UTC run: 20000031 subRun: 0 event: 987
Random seed for this event, engine 'PDFastSim.photon': 641413249
%MSG
%MSG-i NuRandomService: PDFastSimPAR:PDFastSim@BeginModule 08-Oct-2024 22:59:30 UTC run: 20000031 subRun: 0 event: 987
Random seed for this event, engine 'PDFastSim.scinttime': 430477681
%MSG
IonAndScint endJob.
09-Oct-2024 00:11:08 UTC Closed input file "root://mover.pp.rl.ac.uk:1094/pnfs/pp.rl.ac.uk/data/dune/usertests/54/f7/000730_reco_data_2024-10-07T_120024Z.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 0.00752887 8.5096 4398.82 0.369363 140.621 987
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000108292 0.000327673 0.0495581 0.000150023 0.00167113 987
simulate:rns:RandomNumberSaver 1.957e-05 3.26322e-05 0.000363167 2.908e-05 1.48988e-05 987
simulate:largeant:larg4Main 0.00638983 0.656772 54.2179 0.327355 2.04905 987
simulate:IonAndScint:IonAndScint 0.000105302 0.0088173 5.35646 0.000146403 0.170945 987
simulate:elecDrift:SimDriftElectrons 3.813e-05 0.0938829 57.9772 5.8762e-05 1.85003 987
simulate:PDFastSim:PDFastSimPAR 5.5831e-05 7.73813 4281.27 8.6251e-05 136.872 987
simulate:muonfilter:LArG4ParticleFilter 1.6401e-05 7.53798e-05 0.00464419 2.532e-05 0.000298575 987
[art]:TriggerResults:TriggerResultInserter 9.681e-06 1.44094e-05 5.7641e-05 1.335e-05 5.1347e-06 987
end_path:out1:RootOutput 7.35e-06 1.10418e-05 0.000321866 1.003e-05 1.05308e-05 987
end_path:out1:RootOutput(write) 3.06e-06 0.0108436 6.73443 4.62e-06 0.221078 986
================================================================================================================================
%MSG-i NuRandomService: RootOutput:out1@EndJob 09-Oct-2024 00:11:08 UTC ModuleEndJob
Summary of seeds computed by the NuRandomService
Random policy: 'perEvent'
algorithm version: EventTimestamp_v1
Configured value Last value ModuleLabel.InstanceName
(per event) 629402845 IonAndScint.ISCalcAlg
(per event) 641413249 PDFastSim.photon
(per event) 430477681 PDFastSim.scinttime
(per event) 380387599 elecDrift
(per event) 764115810 largeant
%MSG
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 10962.3 MB
Peak resident set size usage (VmHWM): 8350.83 MB
====================================================================================================
TrigReport ---------- Event summary -------------
TrigReport Events total = 987 passed = 12 failed = 975
TrigReport ---------- Modules in End-path ----------
TrigReport Run Success Error Name
TrigReport 12 12 0 out1
TimeReport ---------- Time summary [sec] -------
TimeReport CPU = 8342.406343 Real = 8449.118695
MemReport ---------- Memory summary [base-10 MB] ------
MemReport VmPeak = 10962.3 VmHWM = 8350.83
%MSG-s ArtException: PostEndJob 09-Oct-2024 00:11:52 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 11 entries while sim::SimChannels_elecDrift__G4. has 12 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 804364
-rw-r--r-- 1 dune001 dune 820099466 Oct 9 00:11 RootOutput-84b8-3104-a7f4-c878.root
-rw-r--r-- 1 dune001 dune 3551047 Oct 9 00:11 000730_reco_data_2024-10-07T_120024Z_reco_2024-10-08T_214822Z.log
-rw-r--r-- 1 dune001 dune 7589 Oct 9 00:11 jobscript.log
-rw-r--r-- 1 dune001 dune 519 Oct 9 00:11 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 00:11 000730_reco_data_2024-10-07T_120024Z_reco_data_2024-10-08T_214822Z.root.ext.json
-rw-r--r-- 1 dune001 dune 0 Oct 9 00:11 000730_reco_data_2024-10-07T_120024Z_reco_data_2024-10-08T_214822Z.root.json 