Jobsub ID 255170.37@dunegpschedd01.fnal.gov

Jobsub ID	255170.37@dunegpschedd01.fnal.gov
Workflow ID	10501
Stage ID	1
User name	calcuttj@fnal.gov
Requested	Processors	1
	GPU	No
	RSS bytes	4193255424 (3999 MiB)
	Wall seconds limit	80000 (22 hours)
Submitted time	2025-11-22 00:20:13
Site	CERN
Entry	CMSHTPC_T2_CH_CERN_ce515
Last heartbeat	2025-11-22 14:21:58
From worker node	Hostname	b9p16p5590.cern.ch
	cpuinfo	Intel(R) Xeon(R) Silver 4216 CPU @ 2.10GHz
	OS release	Scientific Linux release 7.9 (Nitrogen)
	Processors	1
	RSS bytes	4194304000 (4000 MiB)
	Wall seconds limit	343800 (95 hours)
	GPU
	Inner Apptainer?	True
Job state	finished
Started	2025-11-22 00:22:52
Input files	vd-protodune:np02vd_raw_run039305_0013_df-s02-d1_dw_0_20250904T144202.hdf5 vd-protodune:np02vd_raw_run039305_0101_df-s04-d0_dw_0_20250904T184335.hdf5 vd-protodune:np02vd_raw_run039305_0200_df-s05-d5_dw_0_20250904T234830.hdf5 vd-protodune:np02vd_raw_run039305_0384_df-s04-d3_dw_0_20250905T060126.hdf5 vd-protodune:np02vd_raw_run039305_0055_df-s03-d1_dw_0_20250904T162902.hdf5 vd-protodune:np02vd_raw_run039305_0476_df-s05-d3_dw_0_20250905T113516.hdf5 vd-protodune:np02vd_raw_run039305_0062_df-s05-d0_dw_0_20250904T164946.hdf5 vd-protodune:np02vd_raw_run039305_0233_df-s04-d3_dw_0_20250905T005426.hdf5 vd-protodune:np02vd_raw_run039305_0265_df-s05-d5_dw_0_20250905T015848.hdf5 vd-protodune:np02vd_raw_run039305_0445_df-s01-d3_dw_0_20250905T093144.hdf5 vd-protodune:np02vd_raw_run039305_0045_df-s04-d0_dw_0_20250904T160806.hdf5 vd-protodune:np02vd_raw_run039305_0408_df-s04-d3_dw_0_20250905T070849.hdf5 vd-protodune:np02vd_raw_run039305_0438_df-s05-d4_dw_0_20250905T090446.hdf5 vd-protodune:np02vd_raw_run039305_0296_df-s05-d3_dw_0_20250905T030040.hdf5 vd-protodune:np02vd_raw_run039305_0190_df-s02-d3_dw_0_20250904T232636.hdf5 vd-protodune:np02vd_raw_run039305_0422_df-s01-d3_dw_0_20250905T075500.hdf5 vd-protodune:np02vd_raw_run039305_0490_df-s03-d0_dw_0_20250905T123344.hdf5 vd-protodune:np02vd_raw_run039305_0034_df-s03-d2_dw_0_20250904T154309.hdf5 vd-protodune:np02vd_raw_run039305_0267_df-s01-d3_dw_0_20250905T020305.hdf5 vd-protodune:np02vd_raw_run039305_0525_df-s05-d2_dw_0_20250905T135901.hdf5
Jobscript	Exit code	0
	Real time	13h (50239s)
	CPU time	3m (237s = 0%)
	Max RSS bytes	1603661824 (1529 MiB)
Outputting started	2025-11-22 14:20:14
Output files	https://fndcadoor.fnal.gov:2880/dune/scratch/users/calcuttj/pdvd_beam_39305/fnal/10501/1/001/pdhd_255170_37_1_20251122T002316Z_beam_hist.root
Finished	2025-11-22 14:21:58
Saved logs	justin-logs:255170.37-dunegpschedd01.fnal.gov.logs.tgz
List job events Cached HTCondor job logs

Jobscript log (last 10,000 characters)

Run: 1 event: 497156 BeamEvent_module.cc:829
Set event T0: 1.75708e+09 4.1596e+08

%MSG
%MSG-i BeamEvent:  BeamEvent:beamevent@BeginModule 22-Nov-2025 15:20:10 CET  run: 39305 subRun: 1 event: 497156 BeamEvent_module.cc:1239
Trigger: 80 1.75708e+09

%MSG
%MSG-i BeamEvent:  BeamEvent:beamevent@BeginModule 22-Nov-2025 15:20:10 CET  run: 39305 subRun: 1 event: 497156 BeamEvent_module.cc:852
Setting beam event for matched event

%MSG
%MSG-i BeamEvent:  BeamEvent:beamevent@BeginModule 22-Nov-2025 15:20:10 CET  run: 39305 subRun: 1 event: 497156 BeamEvent_module.cc:853
SetActiveTrigger 80

%MSG
%MSG-i BeamEvent:  BeamEvent:beamevent@BeginModule 22-Nov-2025 15:20:10 CET  run: 39305 subRun: 1 event: 497156 BeamEvent_module.cc:854
Set T0  1.75708e+09 4.1596e+08


%MSG
%MSG-i BeamEvent:  BeamEvent:beamevent@BeginModule 22-Nov-2025 15:20:10 CET  run: 39305 subRun: 1 event: 497156 BeamEvent_module.cc:879
beamevt has TOF 0 and TOFChan -1

%MSG
%MSG-i BeamEvent:  BeamEvent:beamevent@BeginModule 22-Nov-2025 15:20:10 CET  run: 39305 subRun: 1 event: 497156 BeamEvent_module.cc:883
beamevt has Magnet Current 66.4

%MSG
%MSG-i BeamEvent:  BeamEvent:beamevent@BeginModule 22-Nov-2025 15:20:10 CET  run: 39305 subRun: 1 event: 497156 BeamEvent_module.cc:884
beamevt CKov0: 1 0

%MSG
%MSG-i BeamEvent:  BeamEvent:beamevent@BeginModule 22-Nov-2025 15:20:10 CET  run: 39305 subRun: 1 event: 497156 BeamEvent_module.cc:885
beamevt CKov1: 0 0

%MSG
%MSG-i BeamEvent:  BeamEvent:beamevent@BeginModule 22-Nov-2025 15:20:10 CET  run: 39305 subRun: 1 event: 497156 BeamEvent_module.cc:886
Finished adding info to beamevt 

%MSG
%MSG-i BeamEvent:  BeamEvent:beamevent@BeginModule 22-Nov-2025 15:20:10 CET  run: 39305 subRun: 1 event: 497156 BeamEvent_module.cc:1248
Added 0 tracks to the beam spill

%MSG
%MSG-i BeamEvent:  BeamEvent:beamevent@BeginModule 22-Nov-2025 15:20:10 CET  run: 39305 subRun: 1 event: 497156 BeamEvent_module.cc:2492
Doing momentum spectrometry for trigger 1.75708e+09 4.1596e+08

%MSG
%MSG-i BeamEvent:  BeamEvent:beamevent@BeginModule 22-Nov-2025 15:20:10 CET  run: 39305 subRun: 1 event: 497156 BeamEvent_module.cc:2518
XBPF021655 has 1 active fibers

%MSG
Data: 
	0
	0
	32
	0
	0
	0
%MSG-i BeamEvent:  BeamEvent:beamevent@BeginModule 22-Nov-2025 15:20:10 CET  run: 39305 subRun: 1 event: 497156 BeamEvent_module.cc:2529
69 
%MSG
%MSG-i BeamEvent:  BeamEvent:beamevent@BeginModule 22-Nov-2025 15:20:10 CET  run: 39305 subRun: 1 event: 497156 BeamEvent_module.cc:2531


%MSG
Got 1 Fibers before Fix
After fix: 1
Got 1 Fibers before Fix
After Fix 1
%MSG-i BeamEvent:  BeamEvent:beamevent@BeginModule 22-Nov-2025 15:20:10 CET  run: 39305 subRun: 1 event: 497156 BeamEvent_module.cc:2568
XBPF021659 has 1 active fibers at time 0

%MSG
%MSG-i BeamEvent:  BeamEvent:beamevent@BeginModule 22-Nov-2025 15:20:10 CET  run: 39305 subRun: 1 event: 497156 BeamEvent_module.cc:2570
66 
%MSG
%MSG-i BeamEvent:  BeamEvent:beamevent@BeginModule 22-Nov-2025 15:20:10 CET  run: 39305 subRun: 1 event: 497156 BeamEvent_module.cc:2572


%MSG
Got 1 Fibers before Fix
After Fix 1
%MSG-i BeamEvent:  BeamEvent:beamevent@BeginModule 22-Nov-2025 15:20:10 CET  run: 39305 subRun: 1 event: 497156 BeamEvent_module.cc:2594
XBPF021660 has 1 active fibers at time 0

%MSG
%MSG-i BeamEvent:  BeamEvent:beamevent@BeginModule 22-Nov-2025 15:20:10 CET  run: 39305 subRun: 1 event: 497156 BeamEvent_module.cc:2596
63 
%MSG
%MSG-i BeamEvent:  BeamEvent:beamevent@BeginModule 22-Nov-2025 15:20:10 CET  run: 39305 subRun: 1 event: 497156 BeamEvent_module.cc:2598


%MSG
%MSG-i BeamEvent:  BeamEvent:beamevent@BeginModule 22-Nov-2025 15:20:10 CET  run: 39305 subRun: 1 event: 497156 BeamEvent_module.cc:2602
Getting all trio-wise hits

%MSG
%MSG-i BeamEvent:  BeamEvent:beamevent@BeginModule 22-Nov-2025 15:20:10 CET  run: 39305 subRun: 1 event: 497156 BeamEvent_module.cc:2603
N1,N2,N3 1 1 1

%MSG
%MSG-i BeamEvent:  BeamEvent:beamevent@BeginModule 22-Nov-2025 15:20:10 CET  run: 39305 subRun: 1 event: 497156 BeamEvent_module.cc:2631
	0 0 0

%MSG
69 66 63
-0.026499999999999999251 -0.029499999999999998446 -0.03250000000000000111
%MSG-i BeamEvent:  BeamEvent:beamevent@BeginModule 22-Nov-2025 15:20:10 CET  run: 39305 subRun: 1 event: 497156 BeamEvent_module.cc:1256
Got NRecoBeamMomenta: 1

%MSG
Timing trigger: 12
Matched: 1
CKovs: 1 0
TOF, P: -1 2.5047308064693685203
22-Nov-2025 15:20:11 CET  Closed output file "pdhd_255170_37_1_20251122T002316Z_beam.root"
22-Nov-2025 15:20:11 CET  Closed output file "pdhd_255170_37_1_20251122T002316Z_beam.root"

===================================================================================================================================
TimeTracker printout (sec)                           Min           Avg           Max         Median          RMS         nEvts   
===================================================================================================================================
Full event                                       0.00378178      53.679        4899.7       0.0149806      335.934        934    
-----------------------------------------------------------------------------------------------------------------------------------
source:HDF5RawInput3(read)                       1.2491e-05    1.84991e-05   0.000112839   1.66735e-05   5.33664e-06      934    
produce:triggerrawdecoder:PDVDTriggerReader4     0.000629515   0.00644155     0.0510609    0.00568702    0.00616129       934    
produce:timingrawdecoder:PDHDTimingRawDecoder    0.000302446   0.00050755    0.00135817    0.000476563   0.000147509      934    
produce:ctbrawdecoder:PDHDCTBRawDecoder          0.00120662    0.00521011     0.119512     0.00190995    0.00820461       934    
produce:beamevent:BeamEvent                      0.000264124     53.6657       4899.7       0.0021671      335.933        934    
[art]:TriggerResults:TriggerResultInserter       1.0096e-05    1.56001e-05   7.4226e-05    1.43115e-05   5.1303e-06       934    
end_path:out1:RootOutput                          2.424e-06    4.04746e-06   3.8029e-05     3.779e-06    1.93958e-06      934    
end_path:out1:RootOutput(write)                  0.000158277   0.000953291     0.5021      0.000270124    0.0164106       934    
===================================================================================================================================

===================================================================================================================================
TimeTracker printout (sec)                           Min           Avg           Max         Median          RMS         nEvts   
===================================================================================================================================
Full event                                       0.00378178      53.679        4899.7       0.0149806      335.934        934    
-----------------------------------------------------------------------------------------------------------------------------------
source:HDF5RawInput3(read)                       1.2491e-05    1.84991e-05   0.000112839   1.66735e-05   5.33664e-06      934    
produce:triggerrawdecoder:PDVDTriggerReader4     0.000629515   0.00644155     0.0510609    0.00568702    0.00616129       934    
produce:timingrawdecoder:PDHDTimingRawDecoder    0.000302446   0.00050755    0.00135817    0.000476563   0.000147509      934    
produce:ctbrawdecoder:PDHDCTBRawDecoder          0.00120662    0.00521011     0.119512     0.00190995    0.00820461       934    
produce:beamevent:BeamEvent                      0.000264124     53.6657       4899.7       0.0021671      335.933        934    
[art]:TriggerResults:TriggerResultInserter       1.0096e-05    1.56001e-05   7.4226e-05    1.43115e-05   5.1303e-06       934    
end_path:out1:RootOutput                          2.424e-06    4.04746e-06   3.8029e-05     3.779e-06    1.93958e-06      934    
end_path:out1:RootOutput(write)                  0.000158277   0.000953291     0.5021      0.000270124    0.0164106       934    
===================================================================================================================================

====================================================================================================
MemoryTracker summary (base-10 MB units used)

  Peak virtual memory usage (VmPeak)  : 2928.74 MB
  Peak resident set size usage (VmHWM): 1603.66 MB
====================================================================================================

====================================================================================================
MemoryTracker summary (base-10 MB units used)

  Peak virtual memory usage (VmPeak)  : 2928.74 MB
  Peak resident set size usage (VmHWM): 1603.66 MB
====================================================================================================

TrigReport ---------- Event summary -------------
TrigReport Events total = 934 passed = 934 failed = 0

TrigReport ---------- Modules in End-path ----------
TrigReport        Run    Success      Error Name
TrigReport        934        934          0 out1

TimeReport ---------- Time summary [sec] -------
TimeReport CPU = 230.516270 Real = 50201.109209

MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 2928.74 VmHWM = 1603.66

Art has completed and will exit with status 0.
gen lar returns 0
==== Start *.json ====
cat: *.json: No such file or directory
==== End *.json ====
.:
total 2043640
-rw-r--r--. 1 duneprd np-comp 1374624428 Nov 22 15:20 jobscript.log
-rw-r--r--. 1 duneprd np-comp       3100 Nov 22 15:20 justin-processed-pfns.txt
-rw-r--r--. 1 duneprd np-comp    9696329 Nov 22 15:20 pdhd_255170_37_1_20251122T002316Z_beam_hist.root
-rw-r--r--. 1 duneprd np-comp  707658226 Nov 22 15:20 debug.log
-rw-r--r--. 1 duneprd np-comp     615318 Nov 22 15:20 pdhd_255170_37_1_20251122T002316Z_beam.root
-rw-r--r--. 1 duneprd np-comp       1500 Nov 22 01:23 all-input-dids.txt