Jobsub ID 237224.111@dunegpschedd01.fnal.gov
Jobscript log (last 10,000 characters)
10:25:37 CDT  run: 20250627 subRun: 1 event: 53
Rebuild failed to get the OpDetBTRs. This is expected when running on a generation or simulation step.
%MSG
########## EvtNo.53
152
2
 MINUIT WARNING IN MIGRAD  
 ============== Negative diagonal element 1 in Error Matrix
 MINUIT WARNING IN MIGRAD  
 ============== Negative diagonal element 2 in Error Matrix
 MINUIT WARNING IN MIGRAD  
 ============== Negative diagonal element 3 in Error Matrix
 MINUIT WARNING IN MIGRAD  
 ============== Negative diagonal element 4 in Error Matrix
 MINUIT WARNING IN MIGRAD  
 ============== 152.515 added to diagonal of error matrix
 EIGENVALUES OF SECOND-DERIVATIVE MATRIX:
        -5.2179e+00  1.0147e+00  1.0925e+00  7.1107e+00
 MINUIT WARNING IN MIGRAD  
 ============== MATRIX FORCED POS-DEF BY ADDING 5.224967 TO DIAGONAL.
 EIGENVALUES OF SECOND-DERIVATIVE MATRIX:
        -1.9031e-07  2.3741e-06  1.6519e+00  2.3481e+00
 MINUIT WARNING IN HESSE   
 ============== MATRIX FORCED POS-DEF BY ADDING 0.002348 TO DIAGONAL.
 MINUIT WARNING IN MIGRAD  
 ============== Negative diagonal element 1 in Error Matrix
 MINUIT WARNING IN MIGRAD  
 ============== Negative diagonal element 2 in Error Matrix
 MINUIT WARNING IN MIGRAD  
 ============== Negative diagonal element 3 in Error Matrix
 MINUIT WARNING IN MIGRAD  
 ============== Negative diagonal element 4 in Error Matrix
 MINUIT WARNING IN MIGRAD  
 ============== 9.38977e+06 added to diagonal of error matrix
 EIGENVALUES OF SECOND-DERIVATIVE MATRIX:
        -2.8876e+02  1.0000e+00  1.0001e+00  2.9076e+02
 MINUIT WARNING IN MIGRAD  
 ============== MATRIX FORCED POS-DEF BY ADDING 289.045983 TO DIAGONAL.
 MINUIT WARNING IN MIGRAD  
 ============== Negative diagonal element 1 in Error Matrix
 MINUIT WARNING IN MIGRAD  
 ============== Negative diagonal element 2 in Error Matrix
 MINUIT WARNING IN MIGRAD  
 ============== Negative diagonal element 3 in Error Matrix
 MINUIT WARNING IN MIGRAD  
 ============== Negative diagonal element 4 in Error Matrix
 MINUIT WARNING IN MIGRAD  
 ============== 52.624 added to diagonal of error matrix
 EIGENVALUES OF SECOND-DERIVATIVE MATRIX:
        -2.6347e+00  1.0115e+00  1.0793e+00  4.5439e+00
 MINUIT WARNING IN MIGRAD  
 ============== MATRIX FORCED POS-DEF BY ADDING 2.639289 TO DIAGONAL.
 MINUIT WARNING IN MIGRAD  
 ============== Negative diagonal element 1 in Error Matrix
 MINUIT WARNING IN MIGRAD  
 ============== Negative diagonal element 2 in Error Matrix
 MINUIT WARNING IN MIGRAD  
 ============== Negative diagonal element 3 in Error Matrix
 MINUIT WARNING IN MIGRAD  
 ============== Negative diagonal element 4 in Error Matrix
 MINUIT WARNING IN MIGRAD  
 ============== 42328.3 added to diagonal of error matrix
 EIGENVALUES OF SECOND-DERIVATIVE MATRIX:
        -4.3119e+01  1.0000e+00  1.0001e+00  4.5119e+01
 MINUIT WARNING IN MIGRAD  
 ============== MATRIX FORCED POS-DEF BY ADDING 43.164546 TO DIAGONAL.
Getting reco beam calo
No track calorimetry object found... returning empty vector
No shower calorimetry object found... returning empty vector
No track calorimetry object found... returning empty vector
No shower calorimetry object found... returning empty vector
No track calorimetry object found... returning empty vector
No shower calorimetry object found... returning empty vector
No track calorimetry object found... returning empty vector
No shower calorimetry object found... returning empty vector
No track calorimetry object found... returning empty vector
No shower calorimetry object found... returning empty vector
No track calorimetry object found... returning empty vector
No shower calorimetry object found... returning empty vector
No track calorimetry object found... returning empty vector
No shower calorimetry object found... returning empty vector
No track calorimetry object found... returning empty vector
%MSG-w PhotonBackTrackerService:  ProcessEvent 21-Oct-2025 10:25:54 CDT  run: 20250627 subRun: 1 event: 54
Rebuild failed to get the OpDetBTRs. This is expected when running on a generation or simulation step.
%MSG
########## EvtNo.54
21-Oct-2025 10:25:54 CDT  Closed input file "root://dcdndoor.sdcc.bnl.gov:1094//pnfs/sdcc.bnl.gov/data/dune/RSE/usertests/df/ec/pdhd_prod_beam__226206_157_1_20251008T151329Z_gen_g4_IonScintPDExt.root_226551_12_1_20251009T040755Z_PDInt.root_234838_63_1_20251016T155909Z_detsim_reco1.root"
21-Oct-2025 10:25:54 CDT  Closed input file "root://dcdndoor.sdcc.bnl.gov:1094//pnfs/sdcc.bnl.gov/data/dune/RSE/usertests/df/ec/pdhd_prod_beam__226206_157_1_20251008T151329Z_gen_g4_IonScintPDExt.root_226551_12_1_20251009T040755Z_PDInt.root_234838_63_1_20251016T155909Z_detsim_reco1.root"
====================================================================================================================
TimeTracker printout (sec)            Min           Avg           Max         Median          RMS         nEvts   
====================================================================================================================
Full event                         0.0444597      8.7211        13.9285       9.7371        4.81787         5     
--------------------------------------------------------------------------------------------------------------------
source:RootInput(read)            0.000556989    0.0268351     0.0444597     0.0440222     0.0213824        5     
end_path:pduneana:PDSPAnalyzer      7.71063       10.8675       13.8833       10.9379       2.34301         4     
====================================================================================================================
====================================================================================================================
TimeTracker printout (sec)            Min           Avg           Max         Median          RMS         nEvts   
====================================================================================================================
Full event                         0.0444597      8.7211        13.9285       9.7371        4.81787         5     
--------------------------------------------------------------------------------------------------------------------
source:RootInput(read)            0.000556989    0.0268351     0.0444597     0.0440222     0.0213824        5     
end_path:pduneana:PDSPAnalyzer      7.71063       10.8675       13.8833       10.9379       2.34301         4     
====================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
  Peak virtual memory usage (VmPeak)  : 4100.4 MB
  Peak resident set size usage (VmHWM): 3058.68 MB
====================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
  Peak virtual memory usage (VmPeak)  : 4100.4 MB
  Peak resident set size usage (VmHWM): 3058.68 MB
====================================================================================================
TrigReport ---------- Event summary -------------
TrigReport Events total = 5 passed = 5 failed = 0
TrigReport ---------- Modules in End-path ----------
TrigReport        Run    Success      Error Name
TrigReport          5          4          1 pduneana
TimeReport ---------- Time summary [sec] -------
TimeReport CPU = 54.142652 Real = 81.515616
MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 4100.4 VmHWM = 3058.68
ToolBasedRawDigitPrepService:dtor: Event count: 0
ToolBasedRawDigitPrepService:dtor:  Call count: 0
ToolBasedRawDigitPrepService:dtor: Time report for 4 tools.
ToolBasedRawDigitPrepService:dtor:                    digitReader:   0.00 sec
ToolBasedRawDigitPrepService:dtor:                adcSampleFiller:   0.00 sec
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.00 sec
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   0.00 sec
%MSG-s ArtException:  PostEndJob 21-Oct-2025 10:25:55 CDT 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::SpacePoint>
          Module label: 'reco3d'
          Product instance name: ''
          Process name: (empty)
        The above exception was thrown while processing module PDSPAnalyzer/pduneana run: 20250627 subRun: 1 event: 54
      ---- ProductNotFound END
      Exception going through path end_path
    ---- ScheduleExecutionFailure END
  ---- EventProcessorFailure END
---- EventProcessorFailure END
%MSG
%MSG-s ArtException:  PostEndJob 21-Oct-2025 10:25:55 CDT 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::SpacePoint>
          Module label: 'reco3d'
          Product instance name: ''
          Process name: (empty)
        The above exception was thrown while processing module PDSPAnalyzer/pduneana run: 20250627 subRun: 1 event: 54
      ---- ProductNotFound END
      Exception going through path end_path
    ---- ScheduleExecutionFailure END
  ---- EventProcessorFailure END
---- EventProcessorFailure END
%MSG
Art has completed and will exit with status 1.