Jobsub ID 242469.2@dunegpschedd01.fnal.gov
Jobscript log (last 10,000 characters)
DUNE UPS area... /cvmfs/dune.opensciencegrid.org/products/dune/
File: '/cvmfs/fifeuser2.opensciencegrid.org/sw/dune/e5a4dae4a8bc50714f00830299ac9c15a6cca185'
Size: 4096 Blocks: 9 IO Block: 4096 directory
Device: 1000b7h/1048759d Inode: 144691336 Links: 5
Access: (0755/drwxr-xr-x) Uid: (65534/ UNKNOWN) Gid: (65534/ UNKNOWN)
Context: system_u:object_r:fusefs_t:s0
Access: 2025-11-03 11:08:57.000000000 -0600
Modify: 2025-11-03 11:08:57.000000000 -0600
Change: 2025-11-03 11:08:57.000000000 -0600
Birth: -
Set dunesw to /cvmfs/fifeuser2.opensciencegrid.org/sw/dune/e5a4dae4a8bc50714f00830299ac9c15a6cca185
Will use justin-get-file
pfn: root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/vd-protodune-det-reco/19/7e/np02vd_raw_run040183_0006_df-s04-d1_dw_0_20251022T152043_reco_stage1_20251022T164610_keepup.root
did: vd-protodune-det-reco:np02vd_raw_run040183_0006_df-s04-d1_dw_0_20251022T152043_reco_stage1_20251022T164610_keepup.root
%MSG-i MF_INIT_OK: Early 03-Nov-2025 11:48:45 CST JobSetup
Messagelogger initialization complete.
%MSG
Info in <TGeoManager::Import>: Reading geometry from file: /cvmfs/dune.opensciencegrid.org/products/dune/dunecore/v10_10_02d00/gdml/protodunevd_v5_ggd.gdml
Info in <TGeoManager::TGeoManager>: Geometry GDMLImport, Geometry imported from GDML created
Error: Unsupported GDML Tag Used :gdml_simple_extension. Please Check Geometry/Schema.
Info in <TGeoManager::SetTopVolume>: Top volume is volWorld. Master volume is volWorld
Info in <TGeoNavigator::BuildCache>: --- Maximum geometry depth set to 100
Info in <TGeoManager::CheckGeometry>: Fixing runtime shapes...
Info in <TGeoManager::CheckGeometry>: ...Nothing to fix
Info in <TGeoManager::CloseGeometry>: Counting nodes...
Info in <TGeoManager::Voxelize>: Voxelizing...
Info in <TGeoManager::CloseGeometry>: Building cache...
Info in <TGeoManager::CountLevels>: max level = 5, max placements = 292
Info in <TGeoManager::CloseGeometry>: 16484 nodes/ 2469 volume UID's in Geometry imported from GDML
Info in <TGeoManager::CloseGeometry>: ----------------modeler ready----------------
%MSG-i AuxDetGeometryCore: Early 03-Nov-2025 11:48:49 CST JobSetup
New detector geometry loaded from
/cvmfs/dune.opensciencegrid.org/products/dune/dunecore/v10_10_02d00/gdml/protodunevd_v5_ggd.gdml
%MSG
%MSG-i GeometryCore: Early 03-Nov-2025 11:48:49 CST JobSetup
Sorting volumes...
%MSG
%MSG-i GeometryCore: Early 03-Nov-2025 11:48:49 CST JobSetup
New detector geometry loaded from
/cvmfs/dune.opensciencegrid.org/products/dune/dunecore/v10_10_02d00/gdml/protodunevd_v5_ggd.gdml
%MSG
%MSG-i CRPWireReadoutGeom: Early 03-Nov-2025 11:48:49 CST JobSetup
Initializing CRPWireReadoutGeom channel mapping algorithm.
%MSG
%MSG-i CRPWireReadoutGeom: Early 03-Nov-2025 11:48:49 CST JobSetup
Build readout planes for 1 16 3
%MSG
%MSG-i CRPWireReadoutGeom: Early 03-Nov-2025 11:48:49 CST JobSetup
Counted 12288 channels.
%MSG
GeoApaChannelGroupService::ctor: Group 0 (apa0) has 3072 channels from 3/3 readout planes.
GeoApaChannelGroupService::ctor: Group 1 (apa1) has 3072 channels from 3/3 readout planes.
GeoApaChannelGroupService::ctor: Group 2 (apa2) has 3072 channels from 3/3 readout planes.
GeoApaChannelGroupService::ctor: Group 3 (apa3) has 3072 channels from 3/3 readout planes.
%MSG-i SimpleChannelStatusService: Early 03-Nov-2025 11:48:49 CST JobSetup
Loaded from configuration:
- 0 bad channels
- 0 noisy channels
- largest channel ID: 12287, largest present: 12287
%MSG
DAPHNE Channel Map: Building DAPHNE channel map from file PDVD_PDS_Mapping_v07082025.json
%MSG-i setupProvider<DetectorPropertiesStandard>: Early 03-Nov-2025 11:48:49 CST JobSetup
Asked to ignore 1 keys: 'InheritNumberTimeSamples'
%MSG
%MSG-i SignalShapingServiceDUNE: Early 03-Nov-2025 11:48:49 CST JobSetup
Getting Filter from .fcl file
%MSG
%MSG-i SignalShapingServiceDUNE: Early 03-Nov-2025 11:48:49 CST JobSetup
using the field response provided from a .root file
%MSG
Warning in <TFile::Append>: Replacing existing TH1: FieldResponse_U (Potential memory leak).
Warning in <TFile::Append>: Replacing existing TH1: FieldResponse_V (Potential memory leak).
Warning in <TFile::Append>: Replacing existing TH1: FieldResponse_Y (Potential memory leak).
03-Nov-2025 11:48:51 CST Initiating request to open input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/vd-protodune-det-reco/19/7e/np02vd_raw_run040183_0006_df-s04-d1_dw_0_20251022T152043_reco_stage1_20251022T164610_keepup.root"
03-Nov-2025 11:48:54 CST Opened input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/vd-protodune-det-reco/19/7e/np02vd_raw_run040183_0006_df-s04-d1_dw_0_20251022T152043_reco_stage1_20251022T164610_keepup.root"
Begin processing the 1st record. run: 40183 subRun: 1 event: 997 at 03-Nov-2025 11:48:54 CST
Begin processing the 2nd record. run: 40183 subRun: 1 event: 1001 at 03-Nov-2025 11:49:48 CST
Begin processing the 3rd record. run: 40183 subRun: 1 event: 1005 at 03-Nov-2025 11:49:53 CST
Begin processing the 4th record. run: 40183 subRun: 1 event: 1009 at 03-Nov-2025 11:49:58 CST
Begin processing the 5th record. run: 40183 subRun: 1 event: 1013 at 03-Nov-2025 11:50:03 CST
Begin processing the 6th record. run: 40183 subRun: 1 event: 1017 at 03-Nov-2025 11:50:06 CST
Begin processing the 7th record. run: 40183 subRun: 1 event: 1021 at 03-Nov-2025 11:50:16 CST
Begin processing the 8th record. run: 40183 subRun: 1 event: 1025 at 03-Nov-2025 11:50:26 CST
Begin processing the 9th record. run: 40183 subRun: 1 event: 1029 at 03-Nov-2025 11:50:29 CST
Begin processing the 10th record. run: 40183 subRun: 1 event: 1033 at 03-Nov-2025 11:50:32 CST
Begin processing the 11th record. run: 40183 subRun: 1 event: 1037 at 03-Nov-2025 11:50:36 CST
Begin processing the 12th record. run: 40183 subRun: 1 event: 1041 at 03-Nov-2025 11:50:38 CST
Begin processing the 13th record. run: 40183 subRun: 1 event: 1045 at 03-Nov-2025 11:50:43 CST
Begin processing the 14th record. run: 40183 subRun: 1 event: 1049 at 03-Nov-2025 11:50:44 CST
Begin processing the 15th record. run: 40183 subRun: 1 event: 1053 at 03-Nov-2025 11:50:49 CST
Begin processing the 16th record. run: 40183 subRun: 1 event: 1057 at 03-Nov-2025 11:51:07 CST
Begin processing the 17th record. run: 40183 subRun: 1 event: 1061 at 03-Nov-2025 11:51:10 CST
Begin processing the 18th record. run: 40183 subRun: 1 event: 1065 at 03-Nov-2025 11:51:14 CST
Begin processing the 19th record. run: 40183 subRun: 1 event: 1069 at 03-Nov-2025 11:51:33 CST
Begin processing the 20th record. run: 40183 subRun: 1 event: 1073 at 03-Nov-2025 11:51:36 CST
Begin processing the 21st record. run: 40183 subRun: 1 event: 1077 at 03-Nov-2025 11:51:42 CST
Begin processing the 22nd record. run: 40183 subRun: 1 event: 1081 at 03-Nov-2025 11:51:45 CST
Begin processing the 23rd record. run: 40183 subRun: 1 event: 1085 at 03-Nov-2025 11:51:51 CST
Begin processing the 24th record. run: 40183 subRun: 1 event: 1089 at 03-Nov-2025 11:51:58 CST
Begin processing the 25th record. run: 40183 subRun: 1 event: 1093 at 03-Nov-2025 11:52:06 CST
Begin processing the 26th record. run: 40183 subRun: 1 event: 1097 at 03-Nov-2025 11:52:10 CST
Begin processing the 27th record. run: 40183 subRun: 1 event: 1101 at 03-Nov-2025 11:52:23 CST
Begin processing the 28th record. run: 40183 subRun: 1 event: 1105 at 03-Nov-2025 11:52:26 CST
Begin processing the 29th record. run: 40183 subRun: 1 event: 1109 at 03-Nov-2025 11:52:34 CST
Begin processing the 30th record. run: 40183 subRun: 1 event: 1113 at 03-Nov-2025 11:52:39 CST
Begin processing the 31st record. run: 40183 subRun: 1 event: 1117 at 03-Nov-2025 11:52:42 CST
Begin processing the 32nd record. run: 40183 subRun: 1 event: 1121 at 03-Nov-2025 11:52:47 CST
Begin processing the 33rd record. run: 40183 subRun: 1 event: 1125 at 03-Nov-2025 11:52:50 CST
Begin processing the 34th record. run: 40183 subRun: 1 event: 1129 at 03-Nov-2025 11:53:00 CST
Begin processing the 35th record. run: 40183 subRun: 1 event: 1133 at 03-Nov-2025 11:53:01 CST
03-Nov-2025 11:53:01 CST Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/vd-protodune-det-reco/19/7e/np02vd_raw_run040183_0006_df-s04-d1_dw_0_20251022T152043_reco_stage1_20251022T164610_keepup.root"
%MSG-i NuRandomService: CalibAnaTree:calibana@EndJob 03-Nov-2025 11:53:01 CST ModuleEndJob
Summary of seeds computed by the NuRandomService
Random policy: 'random'
master seed: 345781293
seed within: [ 1 ; 900000000 ]
%MSG
TrigReport ---------- Event summary -------------
TrigReport Events total = 35 passed = 35 failed = 0
TrigReport ---------- Modules in End-path ----------
TrigReport Run Success Error Name
TrigReport 35 34 1 calibana
TimeReport ---------- Time summary [sec] -------
TimeReport CPU = 237.012555 Real = 246.743169
MemReport ---------- Memory summary [base-10 MB] ------
MemReport VmPeak = 1550.66 VmHWM = 862.654
%MSG-s ArtException: PostEndJob 03-Nov-2025 11:53:01 CST ModuleEndJob
---- EventProcessorFailure BEGIN
EventProcessor: an exception occurred during current event processing
---- EventProcessorFailure BEGIN
EndPathExecutor: an exception occurred during current event processing
---- ScheduleExecutionFailure BEGIN
Path: ProcessingStopped.
---- ProductNotFound BEGIN
Found zero products matching all selection criteria
C++ type: std::vector<recob::Hit>
Module label: 'hitpdune'
Product instance name: ''
Process name: (empty)
The above exception was thrown while processing module CalibAnaTree/calibana run: 40183 subRun: 1 event: 1133
---- ProductNotFound END
Exception going through path end_path
---- ScheduleExecutionFailure END
---- EventProcessorFailure END
---- EventProcessorFailure END
%MSG
Art has completed and will exit with status 1.
Error running. Exiting with 1 