Jobsub ID 271684.1@justin-prod-sched01.dune.hep.ac.uk
| Jobsub ID | 271684.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 14:39:15 |
| Site | FR_CCIN2P3 |
| Entry | DUNE_FR_CCIN2P3_cccondorce02 |
| Last heartbeat | 2024-10-08 17:26:16 |
| From worker node | Hostname | ccwcondor0540 |
| cpuinfo | AMD EPYC 7302 16-Core Processor |
| OS release | Scientific Linux release 7.9 (Nitrogen) |
| Processors | 1 |
| RSS bytes | 4194304000 (4000 MiB) |
| Wall seconds limit | 106200 (29 hours) |
| Inner Apptainer? | True |
| Job state | jobscript_error |
| Allocator name | justin-allocator-pro.dune.hep.ac.uk |
| Started | 2024-10-08 14:40:39 |
| Input files | usertests:000135_reco_data_2024-10-07T_114846Z.root
|
| Jobscript | Exit code | 1 |
| Real time | 0m (0s) |
| CPU time | 0m (0s = 0%) |
| Outputting started | |
| Output files | |
| Finished | 2024-10-08 17:26:16 |
| Saved logs | justin-logs:271684.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/fa/2f/000135_reco_data_2024-10-07T_114846Z.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
../justin-jobscript: line 72: 993 Segmentation fault lar -c $FCL_FILE $events_option -o $outFile "$pfn" > ${fname}_reco_${now}.log 2>&1
=== Start last 100 lines of lar log file ===
%MSG-w PhotonBackTrackerService: ProcessEvent 08-Oct-2024 16:57:12 CEST run: 20000031 subRun: 0 event: 606
Rebuild failed to get the OpDetBTRs. This is expected when running on a generation or simulation step.
%MSG
%MSG-i NuRandomService: larg4Main:largeant@BeginModule 08-Oct-2024 16:57:12 CEST run: 20000031 subRun: 0 event: 606
Random seed for this event, engine 'largeant': 445097953
%MSG
%MSG-i generatePrimaries: larg4Main:largeant@BeginModule 08-Oct-2024 16:57:12 CEST run: 20000031 subRun: 0 event: 606 MCTruthEventAction.cc:112
Generating 1 particles
%MSG
%MSG-i ParticleListActionService: larg4Main:largeant@BeginModule 08-Oct-2024 16:58:56 CEST run: 20000031 subRun: 0 event: 606
Not Stored Process summary:
compt : 2130912
Pair : 46
annihil : 102810
phot : 688406
Brem : 632712
conv : 102764
Ion : 272450
%MSG
%MSG-i endOfEventAction: larg4Main:largeant@BeginModule 08-Oct-2024 16:58:56 CEST run: 20000031 subRun: 0 event: 606 ParticleListAction.cc:701
MCTruth Handles Size: 1
%MSG
%MSG-i endOfEventAction: larg4Main:largeant@BeginModule 08-Oct-2024 16:58:56 CEST run: 20000031 subRun: 0 event: 606 ParticleListAction.cc:708
mclistHandle Size: 1
%MSG
%MSG-i endOfEventAction: larg4Main:largeant@BeginModule 08-Oct-2024 16:58:56 CEST run: 20000031 subRun: 0 event: 606 ParticleListAction.cc:711
Found 1 particles
%MSG
%MSG-i NuRandomService: IonAndScint:IonAndScint@BeginModule 08-Oct-2024 16:58:57 CEST run: 20000031 subRun: 0 event: 606
Random seed for this event, engine 'IonAndScint.ISCalcAlg': 255580107
%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 16:59:07 CEST run: 20000031 subRun: 0 event: 606
Random seed for this event, engine 'elecDrift': 871989058
%MSG
%MSG-i NuRandomService: PDFastSimPAR:PDFastSim@BeginModule 08-Oct-2024 17:00:19 CEST run: 20000031 subRun: 0 event: 606
Random seed for this event, engine 'PDFastSim.photon': 67775451
%MSG
%MSG-i NuRandomService: PDFastSimPAR:PDFastSim@BeginModule 08-Oct-2024 17:00:19 CEST run: 20000031 subRun: 0 event: 606
Random seed for this event, engine 'PDFastSim.scinttime': 386506785
%MSG
IonAndScint endJob.
08-Oct-2024 19:25:45 CEST Closed input file "root://mover.pp.rl.ac.uk:1094/pnfs/pp.rl.ac.uk/data/dune/usertests/fa/2f/000135_reco_data_2024-10-07T_114846Z.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 0.00636519 16.1744 8899.39 0.227236 361.18 606
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 4.1248e-05 0.000521886 0.0249569 0.000128352 0.00274664 606
simulate:rns:RandomNumberSaver 1.0439e-05 2.46371e-05 0.000417468 2.1356e-05 1.81288e-05 606
simulate:largeant:larg4Main 0.00566797 0.560854 104.609 0.214082 4.3115 606
simulate:IonAndScint:IonAndScint 4.9062e-05 0.0191351 10.8839 0.000123168 0.441733 606
simulate:elecDrift:SimDriftElectrons 2.5578e-05 0.127678 71.3877 4.06015e-05 2.89737 606
simulate:PDFastSim:PDFastSimPAR 3.703e-05 15.463 8712.5 6.1291e-05 353.61 606
simulate:muonfilter:LArG4ParticleFilter 7.474e-06 4.8575e-05 0.00375091 1.98025e-05 0.000184876 606
[art]:TriggerResults:TriggerResultInserter 5.751e-06 1.08578e-05 5.5355e-05 9.8785e-06 3.77646e-06 606
end_path:out1:RootOutput 3.767e-06 9.92293e-06 0.00024877 8.571e-06 1.04165e-05 606
end_path:out1:RootOutput(write) 2.154e-06 0.00263077 1.08875 2.775e-06 0.04649 605
================================================================================================================================
%MSG-i NuRandomService: RootOutput:out1@EndJob 08-Oct-2024 19:25:45 CEST ModuleEndJob
Summary of seeds computed by the NuRandomService
Random policy: 'perEvent'
algorithm version: EventTimestamp_v1
Configured value Last value ModuleLabel.InstanceName
(per event) 255580107 IonAndScint.ISCalcAlg
(per event) 67775451 PDFastSim.photon
(per event) 386506785 PDFastSim.scinttime
(per event) 871989058 elecDrift
(per event) 445097953 largeant
%MSG
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 17554.2 MB
Peak resident set size usage (VmHWM): 14472 MB
====================================================================================================
TrigReport ---------- Event summary -------------
TrigReport Events total = 606 passed = 4 failed = 602
TrigReport ---------- Modules in End-path ----------
TrigReport Run Success Error Name
TrigReport 4 4 0 out1
TimeReport ---------- Time summary [sec] -------
TimeReport CPU = 9800.684262 Real = 9830.361691
MemReport ---------- Memory summary [base-10 MB] ------
MemReport VmPeak = 17554.2 VmHWM = 14472
=== 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 90588
-rw-r--r-- 1 dune100 lbno 90529759 Oct 8 19:25 RootOutput-1fa0-546a-1c7d-43ac.root
-rw-r--r-- 1 dune100 lbno 2215372 Oct 8 19:25 000135_reco_data_2024-10-07T_114846Z_reco_2024-10-08T_144043Z.log
-rw-r--r-- 1 dune100 lbno 7858 Oct 8 19:25 jobscript.log
-rw-r--r-- 1 dune100 lbno 274 Oct 8 16:40 TFileService-18af-9c78-113f-cba9.root
-rw-r--r-- 1 dune100 lbno 104 Oct 8 16:40 all-input-dids.txt
-rw-r--r-- 1 dune100 lbno 0 Oct 8 19:25 000135_reco_data_2024-10-07T_114846Z_reco_data_2024-10-08T_144043Z.root.ext.json
-rw-r--r-- 1 dune100 lbno 0 Oct 8 19:25 000135_reco_data_2024-10-07T_114846Z_reco_data_2024-10-08T_144043Z.root.json 