Jobsub ID 59995.0@justin-prod-sched02.dune.hep.ac.uk
Jobsub ID | 59995.0@justin-prod-sched02.dune.hep.ac.uk |
Workflow ID | 2869 |
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-08-19 23:09:18 |
Site | US_Colorado |
Entry | CMSHTPC_T3_US_Colorado_heposg01-colorado |
Last heartbeat | 2024-08-20 01:12:59 |
From worker node | Hostname | lnxfarm338.colorado.edu |
cpuinfo | Intel(R) Core(TM) i9-7920X CPU @ 2.90GHz |
OS release | Scientific Linux release 7.9 (Nitrogen) |
Processors | 1 |
RSS bytes | 4194304000 (4000 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-08-19 23:11:06 |
Input files | usertests:000899_reco_data_2024-08-16T_163024Z.root
|
Jobscript | Exit code | 1 |
Real time | 0m (0s) |
CPU time | 0m (0s = 0%) |
Outputting started | |
Output files | |
Finished | 2024-08-20 01:12:59 |
Saved logs | justin-logs:59995.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://fndca1.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/usertests/2d/f4/000899_reco_data_2024-08-16T_163024Z.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 : 386403
Pair : 70
%MSG
%MSG-i endOfEventAction: larg4Main:largeant@BeginModule 19-Aug-2024 17:56:30 MDT run: 20000031 subRun: 0 event: 715 ParticleListAction.cc:701
MCTruth Handles Size: 1
%MSG
%MSG-i endOfEventAction: larg4Main:largeant@BeginModule 19-Aug-2024 17:56:30 MDT run: 20000031 subRun: 0 event: 715 ParticleListAction.cc:708
mclistHandle Size: 1
%MSG
%MSG-i endOfEventAction: larg4Main:largeant@BeginModule 19-Aug-2024 17:56:30 MDT run: 20000031 subRun: 0 event: 715 ParticleListAction.cc:711
Found 1 particles
%MSG
%MSG-i NuRandomService: IonAndScint:IonAndScint@BeginModule 19-Aug-2024 17:56:30 MDT run: 20000031 subRun: 0 event: 715
Random seed for this event, engine 'IonAndScint.ISCalcAlg': 472279041
%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 19-Aug-2024 17:56:34 MDT run: 20000031 subRun: 0 event: 715
Random seed for this event, engine 'elecDrift': 546873824
%MSG
%MSG-i NuRandomService: PDFastSimPAR:PDFastSim@BeginModule 19-Aug-2024 17:57:25 MDT run: 20000031 subRun: 0 event: 715
Random seed for this event, engine 'PDFastSim.photon': 49809666
%MSG
%MSG-i NuRandomService: PDFastSimPAR:PDFastSim@BeginModule 19-Aug-2024 17:57:25 MDT run: 20000031 subRun: 0 event: 715
Random seed for this event, engine 'PDFastSim.scinttime': 411700662
%MSG
IonAndScint endJob.
19-Aug-2024 19:11:55 MDT Closed input file "root://fndca1.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/usertests/2d/f4/000899_reco_data_2024-08-16T_163024Z.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 0.0127349 9.99815 4569.7 0.268323 172.961 715
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 9.4095e-05 0.000776543 0.0804453 0.000141334 0.00517997 715
simulate:rns:RandomNumberSaver 1.7741e-05 3.0556e-05 0.00030519 2.9057e-05 1.35766e-05 715
simulate:largeant:larg4Main 0.0119666 0.583622 55.2559 0.23177 2.49832 715
simulate:IonAndScint:IonAndScint 8.7093e-05 0.0086629 4.49367 0.000128013 0.168804 715
simulate:elecDrift:SimDriftElectrons 3.1009e-05 0.0978371 50.2701 5.5773e-05 1.88896 715
simulate:PDFastSim:PDFastSimPAR 4.4381e-05 9.27136 4459.68 7.6593e-05 168.71 715
simulate:muonfilter:LArG4ParticleFilter 1.2556e-05 5.587e-05 0.00357689 2.158e-05 0.000199724 715
[art]:TriggerResults:TriggerResultInserter 8e-06 1.20745e-05 4.9607e-05 1.2052e-05 3.16568e-06 715
end_path:out1:RootOutput 6.229e-06 9.19056e-06 0.000247921 8.857e-06 9.03919e-06 715
end_path:out1:RootOutput(write) 2.483e-06 0.0352829 20.2122 3.744e-06 0.75853 714
================================================================================================================================
%MSG-i NuRandomService: RootOutput:out1@EndJob 19-Aug-2024 19:11:55 MDT ModuleEndJob
Summary of seeds computed by the NuRandomService
Random policy: 'perEvent'
algorithm version: EventTimestamp_v1
Configured value Last value ModuleLabel.InstanceName
(per event) 472279041 IonAndScint.ISCalcAlg
(per event) 49809666 PDFastSim.photon
(per event) 411700662 PDFastSim.scinttime
(per event) 546873824 elecDrift
(per event) 204756956 largeant
%MSG
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 12686.1 MB
Peak resident set size usage (VmHWM): 11103.7 MB
====================================================================================================
TrigReport ---------- Event summary -------------
TrigReport Events total = 715 passed = 12 failed = 703
TrigReport ---------- Modules in End-path ----------
TrigReport Run Success Error Name
TrigReport 12 12 0 out1
TimeReport ---------- Time summary [sec] -------
TimeReport CPU = 7167.109531 Real = 7183.732491
MemReport ---------- Memory summary [base-10 MB] ------
MemReport VmPeak = 12686.1 VmHWM = 11103.7
%MSG-s ArtException: PostEndJob 19-Aug-2024 19:12:45 MDT 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 1443444
-rw-r--r-- 1 dunepilot gridusers 1475476171 Aug 19 19:12 RootOutput-a59f-2924-605b-a9a2.root
-rw-r--r-- 1 dunepilot gridusers 2591289 Aug 19 19:12 000899_reco_data_2024-08-16T_163024Z_reco_2024-08-19T_231110Z.log
-rw-r--r-- 1 dunepilot gridusers 7613 Aug 19 19:12 jobscript.log
-rw-r--r-- 1 dunepilot gridusers 519 Aug 19 19:12 g4_hist.root
-rw-r--r-- 1 dunepilot gridusers 104 Aug 19 17:11 all-input-dids.txt
-rw-r--r-- 1 dunepilot gridusers 0 Aug 19 19:12 000899_reco_data_2024-08-16T_163024Z_reco_data_2024-08-19T_231110Z.root.ext.json
-rw-r--r-- 1 dunepilot gridusers 0 Aug 19 19:12 000899_reco_data_2024-08-16T_163024Z_reco_data_2024-08-19T_231110Z.root.json